Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 11.08.2022 07: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 15905488 kB
MemAvailable 30960424 kB
Buffers 0 kB
Cached 15838964 kB
SwapCached 2508 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 4.0.2
DB_NAME                         /home/bases/oltp40-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/oltp40-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp40-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb40/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=3400
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/oltp40-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-oltp40
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 2022-08-11 07:37:20
DTS_END                         2022-08-11 07:37:20.9550
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(68:17)
IP                              ::1/56258
TRN_ID                          213571
ATT_ID                          582
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: 8705.31 22498 1044637
customer order: creation 161.44 482 19373
customer order: refuse 13.50 389 1620
order to supplier: creation 43.63 1387 5235
order to supplier: removal 3.24 159458 389
invoice (draft): creation 43.78 3078 5254
invoice (draft): removal 49.97 933 5996
invoice accept: apply 39.47 25435 4736
invoice accept: cancel 44.74 1179 5369
customer reserve: creation 3652.92 243 438350
customer reserve: removal 4376.98 92 525237
realization accept: apply 78.21 270 9385
realization accept: cancel 75.08 162 9009
payment from customer: creation 56.03 155 6723
payment from customer: removal 5.25 115 630
payment to supplier: creation 46.53 209 5583
payment to supplier: removal 3.23 135 388
service: total inventory turnovers 3.92 3790 470
service: total monetary turnovers 6.52 341 782
service: aggregate perf. data 0.87 15263 104
service: refresh index statistics 0.03 236840 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 11-08-2022 07:40:00 to 11-08-2022 07:40:02.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6444
TEST_TIME 2 4461
TEST_TIME 3 5054
TEST_TIME 4 5684
TEST_TIME 5 5634
TEST_TIME 6 6065
TEST_TIME 7 6280
TEST_TIME 8 6327
TEST_TIME 9 6177
TEST_TIME 10 6301
TEST_TIME 11 6520
TEST_TIME 12 6852
TEST_TIME 13 6860
TEST_TIME 14 6960
TEST_TIME 15 7054
TEST_TIME 16 7044
TEST_TIME 17 7049
TEST_TIME 18 7071
TEST_TIME 19 7114
TEST_TIME 20 7142
TEST_TIME 21 7445
TEST_TIME 22 7779
TEST_TIME 23 8283
TEST_TIME 24 8546
TEST_TIME 25 8646
TEST_TIME 26 8846
TEST_TIME 27 9337
TEST_TIME 28 10048
TEST_TIME 29 10539
TEST_TIME 30 10673
TEST_TIME 31 10727
TEST_TIME 32 10951
TEST_TIME 33 10963
TEST_TIME 34 10803
TEST_TIME 35 10507
TEST_TIME 36 10450
TEST_TIME 37 10309
TEST_TIME 38 10130
TEST_TIME 39 10091
TEST_TIME 40 9945
TEST_TIME 41 9789
TEST_TIME 42 9779
TEST_TIME 43 9650
TEST_TIME 44 9576
TEST_TIME 45 9461
TEST_TIME 46 9506
TEST_TIME 47 9378
TEST_TIME 48 9348
TEST_TIME 49 9270
TEST_TIME 50 9143
TEST_TIME 51 9056
TEST_TIME 52 9029
TEST_TIME 53 9128
TEST_TIME 54 9045
TEST_TIME 55 9030
TEST_TIME 56 9000
TEST_TIME 57 8965
TEST_TIME 58 8928
TEST_TIME 59 8971
TEST_TIME 60 8965
TEST_TIME 61 8958
TEST_TIME 62 8965
TEST_TIME 63 8976
TEST_TIME 64 9000
TEST_TIME 65 9057
TEST_TIME 66 9127
TEST_TIME 67 9136
TEST_TIME 68 9106
TEST_TIME 69 9126
TEST_TIME 70 9251
TEST_TIME 71 9239
TEST_TIME 72 9234
TEST_TIME 73 9255
TEST_TIME 74 9137
TEST_TIME 75 9079
TEST_TIME 76 9068
TEST_TIME 77 9046
TEST_TIME 78 9005
TEST_TIME 79 8972
TEST_TIME 80 8961
TEST_TIME 81 8945
TEST_TIME 82 8872
TEST_TIME 83 8838
TEST_TIME 84 8813
TEST_TIME 85 8878
TEST_TIME 86 8853
TEST_TIME 87 8870
TEST_TIME 88 8876
TEST_TIME 89 8898
TEST_TIME 90 8879
TEST_TIME 91 8926
TEST_TIME 92 9030
TEST_TIME 93 9008
TEST_TIME 94 8981
TEST_TIME 95 8961
TEST_TIME 96 8981
TEST_TIME 97 9057
TEST_TIME 98 8971
TEST_TIME 99 8972
TEST_TIME 100 8958
TEST_TIME 101 8913
TEST_TIME 102 8868
TEST_TIME 103 8820
TEST_TIME 104 8789
TEST_TIME 105 8742
TEST_TIME 106 8711
TEST_TIME 107 8730
TEST_TIME 108 8718
TEST_TIME 109 8727
TEST_TIME 110 8719
TEST_TIME 111 8701
TEST_TIME 112 8708
TEST_TIME 113 8729
TEST_TIME 114 8720
TEST_TIME 115 8758
TEST_TIME 116 8754
TEST_TIME 117 8836
TEST_TIME 118 8859
TEST_TIME 119 8804
TEST_TIME 120 8731

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 11-08-2022 07:40:04 to 11-08-2022 07:40:07.

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 1448551 1448551 0 0.00 0 36813 13 0 0
doc_list_biud 1448540 1448540 0 0.00 0 42664 39 0 0
sp_add_invoice_to_stock 4833 4736 97 2.00 35 202204 25436 0 97
sp_cancel_adding_invoice 5369 5369 0 0.00 6 113491 1180 0 0
sp_cancel_client_order 1620 1620 0 0.00 6 12512 389 0 0
sp_cancel_customer_reserve 525237 525237 0 0.00 1 21940 93 0 0
sp_cancel_pay_from_customer 630 630 0 0.00 3 5725 115 0 0
sp_cancel_pay_to_supplier 388 388 0 0.00 4 7179 136 0 0
sp_cancel_supplier_invoice 5998 5996 2 0.03 3 33933 933 0 2
sp_cancel_supplier_order 389 389 0 0.00 16 1307906 159458 0 0
sp_cancel_write_off 9009 9009 0 0.00 2 36834 162 0 0
sp_client_order 19373 19373 0 0.00 6 18086 482 0 0
sp_customer_reserve 438350 438350 0 0.00 1 78975 244 0 0
sp_fill_shopping_cart 29856 29856 0 0.00 1 16843 83 0 0
sp_fill_shopping_cart_clo_res 438317 438317 0 0.00 0 15579 18 0 0
sp_get_clo_for_invoice 4699 4699 0 0.00 0 34030 344 0 0
sp_kill_cost_storno 15396 15396 0 0.00 0 36811 69 0 0
sp_kill_qstorno_ret_qs2qd 1065868 1065868 0 0.00 0 33994 40 0 0
sp_kill_qty_storno 561701 561701 0 0.00 0 42655 93 0 0
sp_lock_selected_doc 19513 19513 0 0.00 0 9515 7 0 0
sp_make_cost_storno 26390 26390 0 0.00 0 14283 78 0 0
sp_multiply_rows_for_pdistr 26390 26390 0 0.00 0 8415 36 0 0
sp_multiply_rows_for_qdistr 19373 19373 0 0.00 0 14540 195 0 0
sp_pay_from_customer 6723 6723 0 0.00 5 12191 155 0 0
sp_pay_to_supplier 5583 5583 0 0.00 6 15158 209 0 0
sp_payment_common 12306 12306 0 0.00 2 12412 46 0 0
sp_qd_handle_on_cancel_clo 1620 1620 0 0.00 0 12501 323 0 0
sp_qd_handle_on_invoice_upd_sts 10067 10067 0 0.00 0 42646 488 0 0
sp_qd_handle_on_reserve_upd_sts 9383 9383 0 0.00 0 8569 62 0 0
sp_reserve_write_off 9385 9385 0 0.00 8 18305 270 0 0
sp_supplier_invoice 5254 5254 0 0.00 7 80295 3079 0 0
sp_supplier_order 5235 5235 0 0.00 7 56833 1387 0 0
srv_aggregate_perf_data 104 104 0 0.00 2593 152750 15263 0 0
srv_fill_mon_cache_memory 67 67 0 0.00 776 117905 37287 0 0
srv_find_qd_qs_mism 998473 998473 0 0.00 0 14441 10 0 0
srv_make_invnt_saldo 470 470 0 0.00 34 86730 3790 0 0
srv_make_money_saldo 782 782 0 0.00 1 29281 342 0 0
srv_recalc_idx_stat 4 4 0 0.00 102468 474421 236841 0 0
t$perf-abend:sp_add_invoice_to_stock 97 97 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 2 2 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4739 4739 0 0.00 1 25889 865 0 0
t$perf-norm:sp_cancel_adding_invoice 386 386 0 0.00 1 7938 435 0 0
t$perf-norm:sp_cancel_client_order 1620 1620 0 0.00 0 3462 29 0 0
t$perf-norm:sp_cancel_customer_reserve 692 692 0 0.00 0 9596 54 0 0
t$perf-norm:sp_cancel_pay_from_customer 630 630 0 0.00 0 2873 21 0 0
t$perf-norm:sp_cancel_pay_to_supplier 388 388 0 0.00 0 884 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 410 410 0 0.00 0 3165 45 0 0
t$perf-norm:sp_cancel_supplier_order 389 389 0 0.00 0 99482 6387 0 0
t$perf-norm:sp_cancel_write_off 919 919 0 0.00 0 8551 23 0 0
t$perf-norm:sp_client_order 19373 19373 0 0.00 0 15308 37 0 0
t$perf-norm:sp_customer_reserve 922 922 0 0.00 0 4837 17 0 0
t$perf-norm:sp_pay_from_customer 6723 6723 0 0.00 0 15638 26 0 0
t$perf-norm:sp_pay_to_supplier 5583 5583 0 0.00 0 10246 24 0 0
t$perf-norm:sp_reserve_write_off 9385 9385 0 0.00 0 19072 27 0 0
t$perf-norm:sp_supplier_invoice 5254 5254 0 0.00 0 27360 32 0 0
t$perf-norm:sp_supplier_order 5235 5235 0 0.00 0 8864 36 0 0
t$perf-norm:srv_aggregate_perf_data 104 104 0 0.00 0 313 12 0 0
t$perf-norm:srv_fill_mon_cache_memory 67 67 0 0.00 0 292 8 0 0
t$perf-norm:srv_make_invnt_saldo 470 470 0 0.00 0 3868 29 0 0
t$perf-norm:srv_make_money_saldo 782 782 0 0.00 0 2535 7 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 7 317 94 0 0
v_add_invoice_to_stock 9586 9392 194 2.02 0 11763 26 0 194
v_all_customers 35600 35600 0 0.00 0 125 3 0 0
v_all_suppliers 29390 29390 0 0.00 0 90 4 0 0
v_all_wares 38740 38740 0 0.00 0 83 4 0 0
v_cancel_adding_invoice 772 772 0 0.00 0 1031 14 0 0
v_cancel_client_order 3240 3240 0 0.00 0 2257 9 0 0
v_cancel_customer_prepayment 1260 1260 0 0.00 0 1462 10 0 0
v_cancel_customer_reserve 1384 1384 0 0.00 0 11991 20 0 0
v_cancel_payment_to_supplier 776 776 0 0.00 0 997 12 0 0
v_cancel_supplier_invoice 824 820 4 0.48 0 4224 34 0 4
v_cancel_supplier_order 778 778 0 0.00 0 4126 20 0 0
v_cancel_write_off 1838 1838 0 0.00 0 1711 24 0 0
v_max_id_clo_ord 5232 5232 0 0.00 0 7590 6 0 0
v_max_id_clo_res 922 922 0 0.00 0 4249 13 0 0
v_max_id_ord_sup 5252 5252 0 0.00 0 6347 9 0 0
v_max_non_paid_invoice 1372 1372 0 0.00 0 70 7 0 0
v_max_non_paid_realizn 3434 3434 0 0.00 0 3440 8 0 0
v_min_id_clo_ord 5232 5232 0 0.00 0 10678 10 0 0
v_min_id_clo_res 922 922 0 0.00 0 5181 13 0 0
v_min_id_ord_sup 5252 5252 0 0.00 0 6957 19 0 0
v_min_non_paid_invoice 5583 5583 0 0.00 0 6864 20 0 0
v_min_non_paid_realizn 6723 6723 0 0.00 0 5134 16 0 0
v_our_firm 9716 9716 0 0.00 0 48 4 0 0
v_reserve_write_off 18766 18766 0 0.00 0 14997 13 0 0
x_lock_depdocs_on_canc_invoice 10955 10955 0 0.00 0 20799 118 0 0
x_lock_depdocs_on_canc_sup_ord 389 389 0 0.00 0 29126 421 0 0
x_make_qstorno_1000_1200 5235 5235 0 0.00 2 56777 1234 0 0
x_make_qstorno_1200_2000 5253 5253 0 0.00 3 77947 2839 0 0
x_make_qstorno_2100_3300 438350 438350 0 0.00 0 78972 214 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 11-08-2022 07:40:08 to 11-08-2022 07:40:12.

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
05:07:24 2 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
05:08:24 19307 8192000000 9739430336 10044719104 820518624 9.104 100 85 170 0 848484784 7711712 20254448
05:09:53 20942 8192000000 9786750048 10099507200 857607424 9.476 100 90 180 0 890995136 12386512 21001200
05:11:16 14561 8192000000 9817915440 10136829952 878964608 9.689 100 87 174 0 924078448 25223936 19889904
05:12:40 9787 8192000000 9878818752 10213949440 921686256 10.113 100 81 160 0 985107856 46177168 17244432
05:13:54 3126 8192000000 9927528544 10274656256 968429136 10.571 100 83 159 0 1048520720 63590224 16501360
05:15:01 2519 8192000000 9974168768 10331275264 1001497648 10.893 100 89 173 0 1087532752 68251648 17783456
05:16:06 1218 8192000000 9998570336 10365321216 1028793264 11.157 100 90 173 0 1120117424 74034192 17289968
05:17:10 1055 8192000000 10037702896 10407682048 1061514576 11.471 100 96 181 1 1159187248 79284896 18387776
05:18:13 941 8192000000 10033931392 10414055424 1067210192 11.525 100 95 182 1 1156585008 70098992 19275824
05:19:15 848 8192000000 10064009920 10444734464 1070062176 11.553 100 98 183 5 1182890608 94614224 18214208
05:20:19 1227 8192000000 10056249088 10439102464 1073945536 11.590 100 92 180 0 1177574736 86682768 16946432
05:21:21 1058 8192000000 10045898208 10429632512 1077524304 11.624 100 93 177 0 1168162240 72294704 18343232
05:22:23 1075 8192000000 10068652032 10458271744 1086265088 11.707 100 92 167 3 1193925632 89294640 18365904
05:23:25 1176 8192000000 10059662672 10446782464 1093388304 11.775 100 97 188 0 1179493312 67771808 18333200
05:24:27 4827 8192000000 10040046000 10431852544 1095603760 11.796 100 73 137 1 1165005792 55835024 13567008
05:25:33 1082 8192000000 10060623040 10450841600 1101232144 11.849 100 89 173 1 1180621264 62164064 17225056
05:26:35 1642 8192000000 10049366816 10441490432 1097589872 11.815 100 70 127 1 1167400512 57241040 12569600
05:27:37 2464 8192000000 10056031088 10451214336 1091914944 11.761 100 74 140 1 1183185888 77441664 13829280
05:28:40 875 8192000000 10048953632 10442387456 1085499296 11.700 99 89 171 2 1170867696 67457280 17911120
05:29:42 1266 8192000000 10043218192 10424958976 1081319040 11.660 100 100 192 1 1165720800 64875872 19525888
05:30:44 2749 8192000000 10027501088 10415673344 1077057648 11.619 100 68 133 1 1150125216 59903472 13164096
05:31:48 1099 8192000000 10031358608 10416386048 1068954032 11.542 100 94 173 3 1155465712 68489120 18022560
05:32:50 1963 8192000000 9995003168 10377166848 1052023088 11.380 100 78 148 1 1116324000 49665920 14634992
05:33:52 1425 8192000000 9994078048 10373410816 1042021472 11.284 99 72 129 0 1115619552 60589392 13008688
05:34:55 929 8192000000 10003978016 10382196736 1054192464 11.401 100 90 172 1 1127805040 55217312 18395264
05:35:57 4990 8192000000 9970616432 10346110976 1034793264 11.215 99 59 115 1 1099254880 52469696 11991920
05:37:03 1346 8192000000 9996254864 10375745536 1035332032 11.220 99 72 140 1 1121542544 72229680 13980832
05:38:09 1373 8192000000 10030054768 10408734720 1065931120 11.513 100 79 150 0 1147046528 66020192 15095216
05:39:16 3885 8192000000 10030068352 10411003904 1081821360 11.665 100 75 143 0 1149892320 54358256 13712704
05:40:30 2269 8192000000 10061299168 10445602816 1093080608 11.772 100 78 146 1 1186247760 77999376 15167776
05:41:37 3237 8192000000 10145424064 10535649280 1117406896 12.002 100 89 161 0 1250662624 118345280 14910448
05:42:43 5204 8192000000 10152503104 10548129792 1124193408 12.067 100 75 136 2 1273221632 134792528 14235696
05:43:57 4049 8192000000 10159477152 10553622528 1133302576 12.152 100 89 169 3 1271266352 119045200 18918576
05:45:05 1095 8192000000 10201677200 10598690816 1143145728 12.245 100 89 165 0 1316393872 156864544 16383600
05:46:10 1461 8192000000 10220873536 10621181952 1147326096 12.284 100 78 153 2 1336120896 171281712 17513088
05:47:16 1134 8192000000 10274470736 10675052544 1160299968 12.406 100 98 194 0 1383445024 201225904 21919152
05:48:21 5387 8192000000 10281178112 10699681792 1169856320 12.495 100 78 156 0 1396489088 209266176 17366592
05:49:31 1549 8192000000 10315981952 10722074624 1188175712 12.666 100 95 179 1 1425039472 216481120 20382640
05:50:34 1734 8192000000 10341836432 10745982976 1182624112 12.615 100 85 157 3 1457987776 256735600 18628064
05:51:39 2325 8192000000 10369170960 10792833024 1202757776 12.802 100 93 184 0 1475937552 251135184 22044592
05:52:45 1233 8192000000 10435148704 10839134208 1220488208 12.966 100 99 193 1 1541837152 299362064 21986880
05:53:49 1003 8192000000 10489914672 10899382272 1222763232 12.987 100 96 192 0 1597920560 353033024 22124304
05:54:54 762 8192000000 10542486432 10953068544 1235161200 13.102 100 99 189 0 1649989120 391496864 23331056
05:55:57 1338 8192000000 10576752816 11003219968 1224310928 13.002 100 94 183 0 1679492256 432732784 22448544
05:57:03 774 8192000000 10611795296 11056795648 1231702544 13.070 100 97 192 0 1717411472 461007328 24701600
05:58:07 911 8192000000 10630090400 11067813888 1226014864 13.017 100 100 196 3 1734303088 484018208 24270016
05:59:10 2690 8192000000 10584236208 11063586816 1205327120 12.826 99 77 149 1 1682274352 458254128 18693104
06:00:15 12400 8192000000 10539189440 11007635456 1209570528 12.865 100 53 102 2 1644135808 421483440 13081840
06:01:36 32597 8192000000 10522564512 10981199872 1198838384 12.766 100 37 70 0 1634024800 425002608 10183808
06:03:20 18346 8192000000 10504133920 10999918592 1165131904 12.451 99 34 66 0 1620890896 446511664 9247328
06:05:05 15239 8192000000 10251084368 10768203776 1132425904 12.144 98 30 58 1 1406383600 266563408 7394288
06:06:22 38621 8192000000 10193928576 10674601984 1148164752 12.292 99 20 40 0 1320965088 167922944 4877392
06:08:01 94229 8192000000 10094610976 10602942464 1100902320 11.846 95 16 31 0 1237817088 133427904 3486864
06:10:36 29906 8192000000 10077287984 10507935744 1135824960 12.176 99 41 67 1 1175012288 32472480 6714848
06:12:08 49693 8192000000 10072753168 10517241856 1135483472 12.173 100 40 66 2 1167140080 25000016 6656592
06:14:01 93587 8192000000 10093624160 10531950592 1119968432 12.027 97 30 59 1 1175357088 49623840 5764816
06:16:35 66383 8192000000 10050232384 10490757120 1108797872 11.921 97 22 40 2 1135330320 22964896 3567552
06:18:47 99173 8192000000 10022567968 10455998464 1045175632 11.314 93 23 46 0 1099845360 49593856 5075872
06:21:39 62419 8192000000 10072008720 10510848000 1101115808 11.848 98 19 35 2 1160128208 54961680 4050720
06:24:58 61757 8192000000 10055254608 10520002560 1092679984 11.768 97 29 58 0 1140638848 41884432 6074432
06:27:14 19869 8192000000 10076577280 10530701312 1131384400 12.134 100 27 50 1 1179140288 42437312 5318576
06:28:37 22589 8192000000 10130670800 10575519744 1143195376 12.246 100 57 108 0 1226843376 72423776 11224224
06:30:07 65832 8192000000 10118019408 10632323072 1122735472 12.053 98 18 36 0 1237950992 110936752 4278768
06:32:50 50727 8192000000 10063693280 10560106496 1113821024 11.969 99 12 23 0 1196695696 80285536 2589136
06:34:42 77017 8192000000 10086489632 10569752576 1124615040 12.071 99 21 42 1 1193340032 64462880 4262112
06:37:13 29693 8192000000 10046006176 10470539264 1087529296 11.719 96 41 73 1 1121798352 26830176 7438880
06:38:43 22445 8192000000 10085280928 10530914304 1133920528 12.158 100 26 52 0 1182780144 43800016 5059600
06:40:06 41964 8192000000 10095105920 10554978304 1085143232 11.696 95 36 65 0 1143836336 50618752 8074352
06:41:48 28344 8192000000 10141354592 10624487424 1133988688 12.159 100 25 50 1 1239185376 99912448 5284240
06:43:24 68005 8192000000 10054784912 10513473536 1104482816 11.880 97 16 32 1 1154903488 47135840 3284832
06:45:32 28060 8192000000 10142529536 10599260160 1144793616 12.261 100 55 110 0 1229571152 73891888 10885648
06:47:07 79172 8192000000 10100377168 10558205952 1125342912 12.077 99 23 46 0 1195900544 66085632 4472000
06:49:29 88117 8192000000 10091106032 10581856256 1142235696 12.237 100 12 24 0 1188575408 43933600 2406112
06:53:10 47982 8192000000 10088763392 10553888768 1140422608 12.220 99 27 54 0 1191944656 46261744 5260304
06:55:00 40787 8192000000 10076430880 10541023232 1127373392 12.097 99 27 54 0 1183458976 50406336 5679248
06:56:40 55290 8192000000 10082687056 10551750656 1133986944 12.159 99 17 34 0 1192202992 54375664 3840384
06:58:36 65831 8192000000 10085442688 10540228608 1132922944 12.149 99 9 18 0 1185817616 50894304 2000368
07:00:42 80227 8192000000 10100963920 10570637312 1109236128 11.925 97 14 28 0 1176594384 64220528 3137728
07:03:30 63210 8192000000 10085442496 10541862912 1094235216 11.783 96 25 50 0 1143891296 44133248 5522832
07:05:34 64147 8192000000 10099947792 10584322048 1115577376 11.985 98 19 36 0 1202677360 83159680 3940304
07:07:40 42641 8192000000 10140444064 10577764352 1138765360 12.204 99 39 78 0 1235363904 88523760 8074784
07:09:23 83873 8192000000 10078523824 10525392896 1083667616 11.682 94 31 60 3 1116589296 27437936 5483744
07:11:52 3376 8192000000 10087622128 10505666560 1116294432 11.992 100 68 132 0 1183673120 54398512 12980176
07:13:00 25762 8192000000 10166774976 10595553280 1132559552 12.145 100 62 124 0 1253733728 107134512 14039664
07:14:34 117904 8192000000 10081504256 10550792192 1083021856 11.676 96 18 36 0 1160453552 73930480 3501216
07:18:14 87725 8192000000 10053859728 10509631488 1120607840 12.033 99 13 21 0 1155901168 33096464 2196864
07:20:45 50896 8192000000 10085302128 10568548352 1135934384 12.177 100 6 12 0 1199535888 62415104 1186400
07:24:31 97524 8192000000 10055695488 10534187008 1087526752 11.719 96 15 30 1 1142962896 52555360 2880784
07:27:11 24836 8192000000 10065184304 10513674240 1101265888 11.850 98 26 52 0 1154038960 47146912 5626160
07:28:40 29726 8192000000 10131563952 10575450112 1118934944 12.017 100 41 80 0 1216069328 88148736 8985648
07:30:12 62923 8192000000 10102688896 10542735360 1067381440 11.527 95 26 48 0 1179005504 106267280 5356784
07:32:31 41102 8192000000 10099936768 10578370560 1121339184 12.040 100 39 78 0 1247275680 117835904 8100592
07:34:13 64824 8192000000 10092378736 10596917248 1114422352 11.974 99 39 78 0 1247987504 125330288 8234864
07:36:49 7833 8192000000 10079655680 10503872512 1121614608 12.042 100 76 148 1 1177896112 40122096 16159408

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 11-08-2022 07:40:14 to 11-08-2022 07:40:30.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 97 v_add_invoice_to_stock 335544517
except 2 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 11-08-2022 07:40:30 to 11-08-2022 07:40:32.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp40-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   13
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          212893
MON$OLDEST_ACTIVE               214632
MON$OLDEST_SNAPSHOT             214632
MON$NEXT_TRANSACTION            214632
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-30 07:30:08.6030 GMT
MON$PAGES                       2040544
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             773
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2816 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2816 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2816 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2816 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
on disk structure version 13.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 ---
:98: 
:99: mscs-test-161.budzdorov.ru    Thu Aug 11 07:37:32 2022
:100:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:101: 
:102: 
:103: mscs-test-161.budzdorov.ru    Thu Aug 11 07:38:09 2022
:104:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:105: 
--- end of diff output ---

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

11.08.22 07:40:33. There are 3 logs in /var/tmp/logs-oltp40 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
2022-08-11 07:40:36 No severe PSQL-related problems occured
11.08.22 07:40:37. End of report.