Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 01.01.2023 16:39
Common Performance Final Results
  1. Hardware and OS info
  2. Test configuration
  3. Test Finish details
  4. Test workload details
  5. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score:    as table     as chart
  2. Performance per MINUTE, during test_time phase:    as table     as chart
  3. Performance, DETAILS per units
  4. Memory consumption, metadata cache, attachments activity    as table    as chart
  5. Monitoring data: STATEMENTS activity, as chart
  6. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database statistics was not gathered. Change config parameter 'run_db_statistics' to 1.
  3. Database validation was not performed. Change config parameter 'run_db_validation' to 1.
  4. New in firebird.log while test was run
  5. Final processing of ISQL logs

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15615516 kB
MemAvailable 30417492 kB
Buffers 0 kB
Cached 16124208 kB
SwapCached 9232 kB
Command: fdisk -l
WARNING: fdisk GPT support is currently new, and therefore in an experimental phase. Use at your own discretion.
Disk /dev/sda: 599.9 GB, 599932581888 bytes, 1171743324 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk label type: gpt
Disk identifier: 919DACA4-2F35-4CBB-BAA7-2A8CD8F7168C
# Start End Size Type Name
1 2048 411647 200M EFI System EFI System Partition
2 411648 2508799 1G Microsoft basic
3 2508800 1171742719 557.5G Linux LVM
Disk /dev/mapper/centos_mscs--test--161-root: 53.7 GB, 53687091200 bytes, 104857600 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/mapper/centos_mscs--test--161-swap: 16.8 GB, 16844324864 bytes, 32899072 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/sdb: 536 MB, 536870912 bytes, 1048576 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk label type: dos
Disk identifier: 0x00000046
Device Boot Start End Blocks Id System
/dev/sdb1 63 514079 257008+ c W95 FAT32 (LBA)
Disk /dev/mapper/centos_mscs--test--161-home: 528.1 GB, 528109010944 bytes, 1031462912 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes

Server and database settinfs

SERVER_MODE                     SuperServer 3.0.11
DB_NAME                         /home/bases/oltp30-etalone.fdb
FORCED_WRITES                   ON
SWEEP_INT                       0
PAGE_BUFFERS                    1000000
PAGE_SIZE                       8192


Test configuration settings

param=actions_todo_before_reconnect, val=300
param=create_with_compound_columns_order, val=most_selective_first
param=create_with_debug_objects, val=1
param=create_with_fw, val=sync
param=create_with_separate_qdistr_idx, val=0
param=create_with_split_heavy_tabs, val=1
param=create_with_sweep, val=0
param=dbnm, val=/home/bases/oltp30-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp30-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb30/bin
param=file_name_this_host_info, val=bz_cpu24_ram32
param=file_name_with_test_params, val=regular
param=gather_hardware_info, val=1
param=halt_test_on_errors, val=/CK/
param=host, val=localhost
param=init_buff, val=10000
param=init_docs, val=0
param=is_embed, val=0
param=make_html, val=1
param=max_cps, val=25
param=mon_query_interval, val=60
param=mon_query_role, val=tmp$oemul$worker
param=mon_unit_list, val=//
param=mon_unit_perf, val=2
param=mon_usr_prefix, val=tmp$oemul$user_
param=no_auto_undo, val=1
param=port, val=3333
param=pwd, val=masterkey
param=qmism_verify_bitset, val=1
param=recalc_idx_min_interval, val=30
param=remove_isql_logs, val=if_no_severe_errors
param=replace_instance, val=1
param=report_compress_cmd, val=/usr/bin/7za
param=results_storage_fbk, val=/home/bases/oltp30-results-storage.fbk
param=run_db_statistics, val=0
param=run_db_validation, val=0
param=separate_workers, val=1
param=sleep_ddl, val=./oltp_sleepUDF_nix.sql
param=sleep_max, val=0
param=test_intervals, val=60
param=test_time, val=120
param=tmpdir, val=/var/tmp/logs-oltp30
param=unit_selection_method, val=random
param=update_conflict_percent, val=0
param=used_in_replication, val=0
param=use_mtee, val=0
param=usr, val=SYSDBA
param=wait_after_create, val=0
param=wait_for_copy, val=1
param=wait_if_not_exists, val=0
param=warm_time, val=30
param=working_mode, val=small_03
Custom name of interactive SQL utility: parameter: 'clu', value: |isql|

Test finish info

FINISH_STATE                    NORMAL: TEST_TIME EXPIRED AT 2023-01-01 16:38:35
DTS_END                         2023-01-01 16:38:35.3110
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_ADD_INVOICE_TO_STOCK(190:30) ==> SP_CUSTOMER_RESERVE(47:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/41960
TRN_ID                          236998
ATT_ID                          661
EXC_UNIT                        2


Test workload details

SETTING_NAME SETTING_VALUE
WORKING_MODE SMALL_03
C_WARES_MAX_ID 400
C_CUSTOMER_DOC_MAX_ROWS 10
C_SUPPLIER_DOC_MAX_ROWS 50
C_CUSTOMER_DOC_MAX_QTY 15
C_SUPPLIER_DOC_MAX_QTY 50
C_NUMBER_OF_AGENTS 50

Indexes for heavy-loaded tables

TAB_NAME IDX_NAME IDX_KEY
XQD_1000_1200 XQD_1000_1200_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_1000_3300 XQD_1000_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_1000_3300 XQD_1000_3300_WKR_DOC_ASC WORKER_ID,DOC_ID
XQD_1000_3300 XQD_1000_3300_WKR_DOC_DEC WORKER_ID,DOC_ID
XQD_1200_2000 XQD_1200_2000_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_2000_3300 XQD_2000_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_2100_3300 XQD_2100_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_3300_3400 XQD_3300_3400_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID

Performance in TOTAL

ACTION AVG_TIMES_PER_MINUTE AVG_ELAPSED_MS SUCCESSFUL_TIMES_DONE
*** OVERALL *** for 120 minutes: 8963.24 23117 1075589
customer order: creation 170.00 377 20400
customer order: refuse 14.89 347 1787
order to supplier: creation 45.63 1376 5475
order to supplier: removal 3.45 101819 414
invoice (draft): creation 45.25 3596 5430
invoice (draft): removal 50.76 839 6091
invoice accept: apply 41.63 18905 4995
invoice accept: cancel 44.94 892 5393
customer reserve: creation 3852.95 188 462354
customer reserve: removal 4412.34 63 529481
realization accept: apply 82.93 174 9952
realization accept: cancel 70.58 108 8469
payment from customer: creation 58.96 117 7075
payment from customer: removal 6.02 80 722
payment to supplier: creation 48.66 142 5839
payment to supplier: removal 2.99 52 359
service: total inventory turnovers 4.30 1195 516
service: total monetary turnovers 6.16 26 739
service: aggregate perf. data 0.78 22712 94
service: refresh index statistics 0.03 309328 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 01-01-2023 16:40:20 to 01-01-2023 16:40:23.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4137
TEST_TIME 2 6313
TEST_TIME 3 5200
TEST_TIME 4 5145
TEST_TIME 5 4613
TEST_TIME 6 4631
TEST_TIME 7 4960
TEST_TIME 8 5046
TEST_TIME 9 5018
TEST_TIME 10 5547
TEST_TIME 11 5309
TEST_TIME 12 5358
TEST_TIME 13 5845
TEST_TIME 14 6428
TEST_TIME 15 6554
TEST_TIME 16 6939
TEST_TIME 17 7010
TEST_TIME 18 7161
TEST_TIME 19 7916
TEST_TIME 20 8285
TEST_TIME 21 8554
TEST_TIME 22 9156
TEST_TIME 23 9109
TEST_TIME 24 9532
TEST_TIME 25 9422
TEST_TIME 26 9684
TEST_TIME 27 9986
TEST_TIME 28 10200
TEST_TIME 29 10165
TEST_TIME 30 10445
TEST_TIME 31 10118
TEST_TIME 32 10217
TEST_TIME 33 10155
TEST_TIME 34 10090
TEST_TIME 35 9899
TEST_TIME 36 9730
TEST_TIME 37 9693
TEST_TIME 38 9691
TEST_TIME 39 9721
TEST_TIME 40 9548
TEST_TIME 41 9387
TEST_TIME 42 9502
TEST_TIME 43 9423
TEST_TIME 44 9248
TEST_TIME 45 9187
TEST_TIME 46 9215
TEST_TIME 47 9113
TEST_TIME 48 9169
TEST_TIME 49 9276
TEST_TIME 50 9171
TEST_TIME 51 9207
TEST_TIME 52 9140
TEST_TIME 53 9103
TEST_TIME 54 9052
TEST_TIME 55 9133
TEST_TIME 56 9121
TEST_TIME 57 9074
TEST_TIME 58 9142
TEST_TIME 59 9156
TEST_TIME 60 9171
TEST_TIME 61 9194
TEST_TIME 62 9242
TEST_TIME 63 9210
TEST_TIME 64 9228
TEST_TIME 65 9347
TEST_TIME 66 9313
TEST_TIME 67 9257
TEST_TIME 68 9179
TEST_TIME 69 9107
TEST_TIME 70 9178
TEST_TIME 71 9131
TEST_TIME 72 9125
TEST_TIME 73 9081
TEST_TIME 74 9016
TEST_TIME 75 8982
TEST_TIME 76 8916
TEST_TIME 77 8872
TEST_TIME 78 8847
TEST_TIME 79 8994
TEST_TIME 80 9009
TEST_TIME 81 9024
TEST_TIME 82 9073
TEST_TIME 83 9096
TEST_TIME 84 9073
TEST_TIME 85 9111
TEST_TIME 86 9172
TEST_TIME 87 9129
TEST_TIME 88 9187
TEST_TIME 89 9161
TEST_TIME 90 9200
TEST_TIME 91 9140
TEST_TIME 92 9097
TEST_TIME 93 9043
TEST_TIME 94 9049
TEST_TIME 95 9015
TEST_TIME 96 9029
TEST_TIME 97 8989
TEST_TIME 98 8963
TEST_TIME 99 9016
TEST_TIME 100 9004
TEST_TIME 101 9022
TEST_TIME 102 9028
TEST_TIME 103 9012
TEST_TIME 104 9095
TEST_TIME 105 9069
TEST_TIME 106 9091
TEST_TIME 107 9088
TEST_TIME 108 9107
TEST_TIME 109 9098
TEST_TIME 110 9122
TEST_TIME 111 9132
TEST_TIME 112 9061
TEST_TIME 113 9047
TEST_TIME 114 9034
TEST_TIME 115 9038
TEST_TIME 116 8993
TEST_TIME 117 8948
TEST_TIME 118 8930
TEST_TIME 119 8907
TEST_TIME 120 8965

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 01-01-2023 16:40:24 to 01-01-2023 16:40:28.

Performance in DETAILS

UNIT CNT_ALL CNT_OK CNT_ERR ERR_PRC OK_MIN_MS OK_MAX_MS OK_AVG_MS CNT_LK_CONFL CNT_USER_EXC
doc_list_aiud 1502800 1502800 0 0.00 0 28352 7 0 0
doc_list_biud 1502800 1502800 0 0.00 0 91408 28 0 0
sp_add_invoice_to_stock 5096 4995 101 1.98 40 201665 18905 0 101
sp_cancel_adding_invoice 5393 5393 0 0.00 4 83403 892 0 0
sp_cancel_client_order 1787 1787 0 0.00 4 9637 348 0 0
sp_cancel_customer_reserve 529481 529481 0 0.00 0 24321 64 0 0
sp_cancel_pay_from_customer 722 722 0 0.00 2 6328 80 0 0
sp_cancel_pay_to_supplier 359 359 0 0.00 3 1404 53 0 0
sp_cancel_supplier_invoice 6098 6091 7 0.11 1 91419 839 0 7
sp_cancel_supplier_order 414 414 0 0.00 6 966703 101819 0 0
sp_cancel_write_off 8469 8469 0 0.00 1 8132 109 0 0
sp_client_order 20400 20400 0 0.00 3 20173 377 0 0
sp_customer_reserve 462354 462354 0 0.00 0 77674 188 0 0
sp_fill_shopping_cart 31299 31299 0 0.00 1 15191 42 0 0
sp_fill_shopping_cart_clo_res 462350 462350 0 0.00 0 18020 15 0 0
sp_get_clo_for_invoice 4991 4991 0 0.00 0 20901 300 0 0
sp_kill_cost_storno 14943 14943 0 0.00 0 9373 61 0 0
sp_kill_qstorno_ret_qs2qd 1073936 1073936 0 0.00 0 91404 35 0 0
sp_kill_qty_storno 566578 566578 0 0.00 0 91406 74 0 0
sp_lock_selected_doc 20685 20685 0 0.00 0 5139 4 0 0
sp_make_cost_storno 27857 27857 0 0.00 0 28349 58 0 0
sp_multiply_rows_for_pdistr 27857 27857 0 0.00 0 20648 30 0 0
sp_multiply_rows_for_qdistr 20400 20400 0 0.00 0 20163 170 0 0
sp_pay_from_customer 7075 7075 0 0.00 4 28641 118 0 0
sp_pay_to_supplier 5839 5839 0 0.00 4 20671 143 0 0
sp_payment_common 12914 12914 0 0.00 2 19709 33 0 0
sp_qd_handle_on_cancel_clo 1787 1787 0 0.00 0 9631 324 0 0
sp_qd_handle_on_invoice_upd_sts 10384 10384 0 0.00 0 31599 333 0 0
sp_qd_handle_on_reserve_upd_sts 9952 9952 0 0.00 0 13003 54 0 0
sp_reserve_write_off 9952 9952 0 0.00 6 28348 175 0 0
sp_supplier_invoice 5430 5430 0 0.00 6 82370 3597 0 0
sp_supplier_order 5475 5475 0 0.00 4 49106 1377 0 0
srv_aggregate_perf_data 94 94 0 0.00 2629 294331 22713 0 0
srv_fill_mon_cache_memory 64 64 0 0.00 1108 136423 45263 0 0
srv_find_qd_qs_mism 1027696 1027696 0 0.00 0 16859 6 0 0
srv_make_invnt_saldo 516 516 0 0.00 27 93657 1195 0 0
srv_make_money_saldo 739 739 0 0.00 1 1210 27 0 0
srv_recalc_idx_stat 4 4 0 0.00 98245 540443 309328 0 0
t$perf-abend:sp_add_invoice_to_stock 102 102 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 7 7 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4995 4995 0 0.00 0 10307 158 0 0
t$perf-norm:sp_cancel_adding_invoice 398 398 0 0.00 0 2785 78 0 0
t$perf-norm:sp_cancel_client_order 1787 1787 0 0.00 0 1947 10 0 0
t$perf-norm:sp_cancel_customer_reserve 674 674 0 0.00 0 1402 9 0 0
t$perf-norm:sp_cancel_pay_from_customer 722 722 0 0.00 0 3516 7 0 0
t$perf-norm:sp_cancel_pay_to_supplier 359 359 0 0.00 0 1637 10 0 0
t$perf-norm:sp_cancel_supplier_invoice 448 448 0 0.00 0 709 11 0 0
t$perf-norm:sp_cancel_supplier_order 414 414 0 0.00 0 21693 1599 0 0
t$perf-norm:sp_cancel_write_off 940 940 0 0.00 0 445 4 0 0
t$perf-norm:sp_client_order 20400 20400 0 0.00 0 17944 18 0 0
t$perf-norm:sp_customer_reserve 989 989 0 0.00 0 3033 7 0 0
t$perf-norm:sp_pay_from_customer 7075 7075 0 0.00 0 14528 10 0 0
t$perf-norm:sp_pay_to_supplier 5839 5839 0 0.00 0 2622 8 0 0
t$perf-norm:sp_reserve_write_off 9952 9952 0 0.00 0 8418 9 0 0
t$perf-norm:sp_supplier_invoice 5430 5430 0 0.00 0 7691 14 0 0
t$perf-norm:sp_supplier_order 5475 5475 0 0.00 0 3847 15 0 0
t$perf-norm:srv_aggregate_perf_data 94 94 0 0.00 0 290 8 0 0
t$perf-norm:srv_fill_mon_cache_memory 64 64 0 0.00 0 23 1 0 0
t$perf-norm:srv_make_invnt_saldo 516 516 0 0.00 0 15567 53 0 0
t$perf-norm:srv_make_money_saldo 739 739 0 0.00 0 2308 17 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 9 4 0 0
v_add_invoice_to_stock 10184 9982 202 1.98 0 5898 19 0 202
v_all_customers 36978 36978 0 0.00 0 17 1 0 0
v_all_suppliers 30612 30612 0 0.00 0 23 1 0 0
v_all_wares 40800 40800 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 796 796 0 0.00 0 249 6 0 0
v_cancel_client_order 3574 3574 0 0.00 0 4397 7 0 0
v_cancel_customer_prepayment 1444 1444 0 0.00 0 5881 10 0 0
v_cancel_customer_reserve 1348 1348 0 0.00 0 2412 7 0 0
v_cancel_payment_to_supplier 718 718 0 0.00 0 639 4 0 0
v_cancel_supplier_invoice 910 896 14 1.53 0 5336 23 0 14
v_cancel_supplier_order 828 828 0 0.00 0 5564 10 0 0
v_cancel_write_off 1880 1880 0 0.00 0 5441 18 0 0
v_max_id_clo_ord 5474 5474 0 0.00 0 3895 2 0 0
v_max_id_clo_res 989 989 0 0.00 0 5598 19 0 0
v_max_id_ord_sup 5425 5425 0 0.00 0 2939 6 0 0
v_max_non_paid_invoice 1432 1432 0 0.00 0 4231 5 0 0
v_max_non_paid_realizn 3917 3917 0 0.00 0 4511 6 0 0
v_min_id_clo_ord 5474 5474 0 0.00 0 1673 6 0 0
v_min_id_clo_res 989 989 0 0.00 0 4077 8 0 0
v_min_id_ord_sup 5425 5425 0 0.00 0 3603 4 0 0
v_min_non_paid_invoice 5839 5839 0 0.00 0 19706 27 0 0
v_min_non_paid_realizn 7075 7075 0 0.00 0 10202 23 0 0
v_our_firm 10138 10138 0 0.00 0 18 1 0 0
v_reserve_write_off 19904 19904 0 0.00 0 7195 8 0 0
x_lock_depdocs_on_canc_invoice 11036 11036 0 0.00 0 18746 122 0 0
x_lock_depdocs_on_canc_sup_ord 414 414 0 0.00 0 19317 412 0 0
x_make_qstorno_1000_1200 5475 5475 0 0.00 1 49080 1301 0 0
x_make_qstorno_1200_2000 5430 5430 0 0.00 2 82162 3440 0 0
x_make_qstorno_2100_3300 462354 462354 0 0.00 0 77670 171 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 01-01-2023 16:40:29 to 01-01-2023 16:40:33.

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
14:08:39 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
14:09:40 28749 8192000000 9912906032 10221527040 990241392 10.784 100 87 174 0 1018396912 5807264 22348256
14:11:15 8333 8192000000 9946613904 10265698304 1026924320 11.139 100 92 184 0 1058572720 7866240 23782160
14:12:33 16506 8192000000 9982437504 10311868416 1067154592 11.525 100 88 176 0 1098705824 9516080 22035152
14:13:51 13459 8192000000 10040916864 10383781888 1116600992 11.995 100 78 156 0 1145389680 10197328 18591360
14:15:07 5979 8192000000 10079538224 10436198400 1162444624 12.426 100 79 155 0 1192769440 12723936 17600880
14:16:18 4228 8192000000 10122534000 10485633024 1207287024 12.844 100 83 166 0 1238107680 12898112 17922544
14:17:24 2105 8192000000 10155851856 10528419840 1239773040 13.144 100 84 168 1 1272640320 14334832 18532448
14:18:28 1749 8192000000 10180511856 10556801024 1264086832 13.367 100 90 181 0 1298234416 14657904 19489680
14:19:31 1033 8192000000 10209143104 10593157120 1292664576 13.628 100 86 171 2 1323820640 12530896 18625168
14:20:33 1047 8192000000 10222803584 10611204096 1309902240 13.785 100 82 163 0 1339610080 12044880 17662960
14:21:35 5105 8192000000 10223429136 10623946752 1321490304 13.890 100 44 88 0 1343802784 12945008 9367472
14:22:41 44669 8192000000 10225265152 10631626752 1324881200 13.921 100 34 65 2 1337134480 5134224 7119056
14:24:29 5530 8192000000 10220946704 10636759040 1329491264 13.963 100 20 40 1 1339264544 5386672 4386608
14:25:37 9987 8192000000 10224997840 10645876736 1336520928 14.026 100 22 45 1 1347832128 6312400 4998800
14:26:49 60946 8192000000 10214069152 10632953856 1319639072 13.873 99 25 50 0 1334829792 9202592 5988128
14:28:52 7789 8192000000 10215725808 10634743808 1323693920 13.910 100 20 40 0 1338216448 10024016 4498512
14:30:02 9052 8192000000 10147864096 10552287232 1229661744 13.051 95 21 41 0 1239264416 5205600 4397072
14:31:12 11694 8192000000 10155455856 10548293632 1243194112 13.176 98 27 53 0 1252947552 4536064 5217376
14:32:26 20226 8192000000 10147156672 10550304768 1235796192 13.108 97 16 32 0 1244908896 5148848 3963856
14:33:48 4847 8192000000 10168887008 10571862016 1276933552 13.485 100 35 70 0 1290661968 5040320 8688096
14:34:56 8540 8192000000 10182510208 10586955776 1285958272 13.567 100 26 51 2 1297375232 5853344 5563616
14:36:12 66162 8192000000 10194366912 10607632384 1303645920 13.728 100 20 40 0 1312775632 4879520 4250192
14:38:20 7211 8192000000 10215572512 10630406144 1326593968 13.936 100 25 50 1 1337151824 5286784 5271072
14:39:34 15402 8192000000 10256425664 10667614208 1346251904 14.114 100 51 104 0 1366507264 8841792 11413568
14:40:59 5210 8192000000 10286801968 10699972608 1372286048 14.348 100 62 122 1 1395846560 10038096 13522416
14:42:12 8308 8192000000 10298410112 10716737536 1388096256 14.489 100 62 123 1 1416888080 14279232 14512592
14:43:36 23347 8192000000 10311088944 10735362048 1397804192 14.575 100 42 84 0 1425108224 17352944 9951088
14:45:02 8617 8192000000 10320347552 10741510144 1390822144 14.513 99 45 90 0 1422234272 20370512 11041616
14:46:16 11591 8192000000 10336589904 10759462912 1414194944 14.721 100 56 105 3 1448664176 21826960 12642272
14:47:42 20742 8192000000 10333268000 10761105408 1399963728 14.595 99 47 94 1 1442473648 30568992 11940928
14:49:09 13796 8192000000 10332207984 10762641408 1405880656 14.647 99 29 58 0 1437832016 24775344 7176016
14:50:51 20852 8192000000 10357337984 10786127872 1424219472 14.810 100 49 98 0 1467509248 30993264 12296512
14:52:19 5148 8192000000 10365460736 10784747520 1424210576 14.810 100 70 141 0 1474526672 33046416 17269680
14:53:37 4054 8192000000 10351150752 10773061632 1403400992 14.625 99 57 114 0 1451443504 33270160 14772352
14:54:51 1107 8192000000 10379007568 10797293568 1430061664 14.862 100 88 175 2 1486068448 34126912 21879872
14:56:00 2203 8192000000 10369435376 10784931840 1417320400 14.749 100 69 135 0 1470928896 36378144 17230352
14:57:08 1969 8192000000 10359284096 10771730432 1392448896 14.528 100 76 152 3 1455034416 43468912 19116608
14:58:20 4645 8192000000 10335526192 10755854336 1393424096 14.536 100 75 151 1 1446587168 33886848 19276224
14:59:32 13161 8192000000 10302284784 10735353856 1379212608 14.410 100 31 63 0 1412901440 24660896 9027936
15:00:55 18427 8192000000 10269511600 10711437312 1342464080 14.080 98 24 48 0 1368421952 19895040 6062832
15:02:21 18810 8192000000 10271813024 10707443712 1353279456 14.177 100 28 56 0 1387517792 26904560 7333776
15:03:43 24139 8192000000 10278343920 10713468928 1334944816 14.012 98 25 50 1 1367533856 25566832 7022208
15:05:14 23903 8192000000 10285880784 10719617024 1355718992 14.199 100 19 38 1 1388154928 27059952 5375984
15:06:38 16017 8192000000 10280913744 10726989824 1359514208 14.233 100 31 62 0 1393542256 26475776 7552272
15:08:06 49737 8192000000 10261730112 10711539712 1317673232 13.856 97 13 26 0 1348765888 27792112 3300544
15:10:58 54853 8192000000 10274346736 10708205568 1344502864 14.098 98 43 86 1 1367753248 13988928 9261456
15:13:14 79860 8192000000 10273902368 10723971072 1349414384 14.142 98 14 26 0 1364582784 12044976 3123424
15:15:37 56223 8192000000 10292953824 10734600192 1369140528 14.319 99 21 40 0 1386906944 13365024 4401392
15:17:40 93424 8192000000 10294786448 10742689792 1371617088 14.342 99 24 45 0 1387200128 9696736 5886304
15:20:29 95490 8192000000 10286407984 10743607296 1377381984 14.393 99 9 18 0 1393204944 13916512 1906448
15:23:06 3732 8192000000 10320242464 10759065600 1404166576 14.632 100 61 120 1 1428738064 10411840 14159648
15:24:11 47610 8192000000 10311168016 10773098496 1394516336 14.546 99 25 50 0 1421746528 20755536 6474656
15:25:59 26278 8192000000 10318873648 10774282240 1409490000 14.679 100 31 62 0 1439459760 22595008 7374752
15:27:27 63906 8192000000 10287267200 10757210112 1380339392 14.420 99 7 14 0 1401911264 19784944 1786928
15:29:32 67134 8192000000 10280689712 10745442304 1378704208 14.405 99 16 32 1 1396793776 14439296 3650272
15:31:44 47623 8192000000 10300652432 10746290176 1392640400 14.529 100 34 68 3 1407218160 7153248 7424512
15:33:33 84455 8192000000 10295724512 10753679360 1385642720 14.467 99 11 23 0 1398298272 10289984 2365568
15:35:58 47553 8192000000 10301295344 10765664256 1397615680 14.574 99 19 38 2 1411862304 9759072 4487552
15:37:54 93226 8192000000 10321855552 10775867392 1371351472 14.339 97 16 32 2 1385038880 10138896 3548512
15:40:27 82781 8192000000 10304764160 10751287296 1309488416 13.781 93 22 41 2 1325423344 11857088 4077840
15:42:53 72796 8192000000 10267867616 10731810816 1337568672 14.035 98 26 52 0 1360512016 17081792 5861552
15:45:07 12291 8192000000 10268485024 10708258816 1336614816 14.027 98 30 61 0 1350942400 7900048 6427536
15:46:21 136422 8192000000 10265866480 10728734720 1359250176 14.231 99 33 62 0 1379865472 13378880 7236416
15:50:04 16411 8192000000 10233617856 10676170752 1318001936 13.859 97 12 20 1 1326201728 6268320 1931472
15:51:22 89791 8192000000 10246784832 10695835648 1319894128 13.876 97 14 28 0 1330440928 7129792 3417008
15:54:18 102965 8192000000 10250610656 10699137024 1335736960 14.019 98 21 42 0 1356655760 15960176 4958624
15:57:03 67511 8192000000 10236253520 10695376896 1293083856 13.632 96 13 27 1 1317086432 20616928 3385648
15:59:13 50407 8192000000 10261879920 10701492224 1338800336 14.047 99 19 37 0 1351173424 8465488 3907600
16:01:11 45233 8192000000 10260799024 10706001920 1324950000 13.922 98 24 47 0 1340733008 10638976 5144032
16:02:56 9056 8192000000 10266276256 10693406720 1340744992 14.064 100 62 121 2 1367275408 11980176 14550240
16:04:06 51746 8192000000 10240225456 10685665280 1307942208 13.767 97 15 30 0 1323228192 11892880 3393104
16:05:59 41848 8192000000 10287966368 10727845888 1360510528 14.242 100 39 78 0 1387841168 18977216 8353424
16:07:45 17540 8192000000 10292565376 10719727616 1362511824 14.260 100 40 78 0 1381549952 10767680 8270448
16:09:04 118728 8192000000 10277634576 10719825920 1355142736 14.194 99 28 56 1 1375340944 14110336 6087872
16:12:13 33133 8192000000 10272826784 10728382464 1371592128 14.341 100 11 22 0 1383696912 9869104 2235680
16:13:52 70489 8192000000 10271949136 10733182976 1373594656 14.359 100 18 35 0 1389403760 11854624 3954480
16:16:16 71549 8192000000 10298926560 10748764160 1380152672 14.418 99 22 44 0 1394413424 9541632 4719120
16:18:30 68958 8192000000 10301631344 10756005888 1385654976 14.467 99 16 33 0 1403078656 14072672 3351008
16:20:50 24361 8192000000 10307431984 10756198400 1393882896 14.540 100 34 66 1 1413581232 11547136 8151200
16:22:17 57960 8192000000 10287288960 10752139264 1364312352 14.276 98 13 26 1 1382053056 14916800 2823904
16:24:15 65027 8192000000 10293368496 10727706624 1335962160 14.021 96 34 69 1 1353477152 10761024 6753968
16:26:22 54758 8192000000 10282015136 10732015616 1340806720 14.065 97 15 26 1 1352151952 8594560 2750672
16:28:27 96173 8192000000 10280181296 10741702656 1346407632 14.115 97 14 28 0 1360401696 10924464 3069600
16:31:04 83389 8192000000 10277888944 10733195264 1336902848 14.029 97 13 27 1 1360082832 20126560 3053424
16:33:30 32220 8192000000 10246101696 10702860288 1334317248 14.006 98 19 38 0 1345957872 7582224 4058400
16:35:07 78237 8192000000 10272835088 10710102016 1345383264 14.106 99 27 54 0 1363264816 11529296 6352256
16:37:33 72340 8192000000 9749686384 10142068736 883348208 9.733 65 15 31 1 901516480 14490032 3678240

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 01-01-2023 16:40:35 to 01-01-2023 16:40:50.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 101 v_add_invoice_to_stock 335544517
except 7 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 01-01-2023 16:40:51 to 01-01-2023 16:40:53.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp30-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   12
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          236771
MON$OLDEST_ACTIVE               237233
MON$OLDEST_SNAPSHOT             237233
MON$NEXT_TRANSACTION            237233
MON$PAGE_BUFFERS                1000000
MON$SQL_DIALECT                 3
MON$SHUTDOWN_MODE               0
MON$SWEEP_INTERVAL              0
MON$READ_ONLY                   0
MON$FORCED_WRITES               1
MON$RESERVE_SPACE               1
MON$CREATION_DATE               2020-04-03 16:41:55.3470
MON$PAGES                       1999808
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


ISQL Version: LI-V3.0.11.33650 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33650 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33650 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33650 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
on disk structure version 12.0

Database statistics

Database statistics was not gathered, see config parameter 'run_db_statistics'.
===============================================================================

Database validation

Database validation was not performed, see config parameter 'run_db_validation'
===============================================================================

Comparison of old and new firebird.log: get messages that appeared during test

--- start of diff output ---
:1512: 
:1513: mscs-test-161.budzdorov.ru    Sun Jan  1 16:38:58 2023
:1514:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3333
:1515: 
:1516: 
:1517: mscs-test-161.budzdorov.ru    Sun Jan  1 16:38:58 2023
:1518:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3333
:1519: 
--- end of diff output ---

Final processing ISQL logs in /var/tmp/logs-oltp30 according to config parameter 'remove_isql_logs'

01.01.23 16:40:54. There are 3 logs in /var/tmp/logs-oltp30 that can be removed if no severe errors occured, see config setting 'remove_isql_logs' Following values of gdscode are considered as SEVERE: 0 Unidentified error in PSQL code: gdscode=0 within WHEN block when exception raised. 335544321 'string truncation'. Attempt to assign too long text into string variable. 335544347 'not_valid'. Validation error for column. 335544349 'no_dup'. Attempt to store duplicate value visible to active transactions. 335544558 'check_constraint'. Operation violates CHECK constraint on view or table. 335544665 'unique_key_violation'. Violation of PRIMARY or UNIQUE KEY constraint. 335544838 'foreign_key_target_doesnt_exist'. Foreign key reference target does not exist. 335544839 'foreign_key_references_present'. Foreign key references are present for the record.
FINISHED_AT ERRORS_RESULT
2023-01-01 16:40:56 No severe PSQL-related problems occured
01.01.23 16:40:58. End of report.