Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 24.06.2022 13: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 15862848 kB
MemAvailable 31252892 kB
Buffers 0 kB
Cached 15870616 kB
SwapCached 2488 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-06-24 13:37:16
DTS_END                         2022-06-24 13:37:16.6240
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/49596
TRN_ID                          224682
ATT_ID                          673
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: 9216.08 23763 1105929
customer order: creation 174.91 444 20989
customer order: refuse 15.03 385 1803
order to supplier: creation 47.38 1430 5685
order to supplier: removal 3.46 168099 415
invoice (draft): creation 47.88 3257 5745
invoice (draft): removal 53.43 1078 6411
invoice accept: apply 41.98 26510 5038
invoice accept: cancel 47.53 1196 5703
customer reserve: creation 3869.79 255 464375
customer reserve: removal 4609.28 97 553114
realization accept: apply 85.91 279 10309
realization accept: cancel 87.86 158 10543
payment from customer: creation 60.44 172 7253
payment from customer: removal 5.55 120 666
payment to supplier: creation 49.51 208 5941
payment to supplier: removal 3.49 147 419
service: total inventory turnovers 4.05 3943 486
service: total monetary turnovers 7.60 364 912
service: aggregate perf. data 0.98 15243 118
service: refresh index statistics 0.03 251881 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 24-06-2022 13:39:34 to 24-06-2022 13:39:36.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 8323
TEST_TIME 2 8436
TEST_TIME 3 7810
TEST_TIME 4 7096
TEST_TIME 5 6528
TEST_TIME 6 6524
TEST_TIME 7 7137
TEST_TIME 8 7437
TEST_TIME 9 7595
TEST_TIME 10 7755
TEST_TIME 11 7535
TEST_TIME 12 7589
TEST_TIME 13 7415
TEST_TIME 14 7512
TEST_TIME 15 7514
TEST_TIME 16 7418
TEST_TIME 17 7399
TEST_TIME 18 7297
TEST_TIME 19 7518
TEST_TIME 20 7458
TEST_TIME 21 7464
TEST_TIME 22 7794
TEST_TIME 23 7831
TEST_TIME 24 7798
TEST_TIME 25 7834
TEST_TIME 26 7858
TEST_TIME 27 8327
TEST_TIME 28 8741
TEST_TIME 29 8995
TEST_TIME 30 9366
TEST_TIME 31 10365
TEST_TIME 32 10457
TEST_TIME 33 10845
TEST_TIME 34 11193
TEST_TIME 35 11072
TEST_TIME 36 11161
TEST_TIME 37 11082
TEST_TIME 38 10986
TEST_TIME 39 10827
TEST_TIME 40 10685
TEST_TIME 41 10733
TEST_TIME 42 10743
TEST_TIME 43 10575
TEST_TIME 44 10398
TEST_TIME 45 10277
TEST_TIME 46 10203
TEST_TIME 47 10125
TEST_TIME 48 10048
TEST_TIME 49 10016
TEST_TIME 50 9974
TEST_TIME 51 9973
TEST_TIME 52 9922
TEST_TIME 53 9866
TEST_TIME 54 9824
TEST_TIME 55 9848
TEST_TIME 56 9888
TEST_TIME 57 9751
TEST_TIME 58 9699
TEST_TIME 59 9737
TEST_TIME 60 9754
TEST_TIME 61 9866
TEST_TIME 62 9816
TEST_TIME 63 9842
TEST_TIME 64 9822
TEST_TIME 65 9762
TEST_TIME 66 9839
TEST_TIME 67 9847
TEST_TIME 68 9843
TEST_TIME 69 9841
TEST_TIME 70 9876
TEST_TIME 71 9910
TEST_TIME 72 9908
TEST_TIME 73 9890
TEST_TIME 74 9790
TEST_TIME 75 9754
TEST_TIME 76 9769
TEST_TIME 77 9674
TEST_TIME 78 9667
TEST_TIME 79 9629
TEST_TIME 80 9616
TEST_TIME 81 9582
TEST_TIME 82 9529
TEST_TIME 83 9436
TEST_TIME 84 9394
TEST_TIME 85 9403
TEST_TIME 86 9412
TEST_TIME 87 9386
TEST_TIME 88 9375
TEST_TIME 89 9398
TEST_TIME 90 9398
TEST_TIME 91 9364
TEST_TIME 92 9404
TEST_TIME 93 9440
TEST_TIME 94 9440
TEST_TIME 95 9434
TEST_TIME 96 9534
TEST_TIME 97 9484
TEST_TIME 98 9478
TEST_TIME 99 9445
TEST_TIME 100 9394
TEST_TIME 101 9374
TEST_TIME 102 9376
TEST_TIME 103 9327
TEST_TIME 104 9311
TEST_TIME 105 9249
TEST_TIME 106 9209
TEST_TIME 107 9181
TEST_TIME 108 9197
TEST_TIME 109 9197
TEST_TIME 110 9180
TEST_TIME 111 9175
TEST_TIME 112 9192
TEST_TIME 113 9215
TEST_TIME 114 9217
TEST_TIME 115 9204
TEST_TIME 116 9262
TEST_TIME 117 9236
TEST_TIME 118 9277
TEST_TIME 119 9311
TEST_TIME 120 9243

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 24-06-2022 13:39:38 to 24-06-2022 13:39:41.

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 1535604 1535604 0 0.00 0 15688 14 0 0
doc_list_biud 1535597 1535597 0 0.00 0 80185 41 0 0
sp_add_invoice_to_stock 5141 5038 103 2.00 57 207809 26510 0 103
sp_cancel_adding_invoice 5703 5703 0 0.00 6 96198 1196 0 0
sp_cancel_client_order 1803 1803 0 0.00 6 11788 385 0 0
sp_cancel_customer_reserve 553114 553114 0 0.00 1 19766 97 0 0
sp_cancel_pay_from_customer 666 666 0 0.00 3 3652 120 0 0
sp_cancel_pay_to_supplier 419 419 0 0.00 4 10245 147 0 0
sp_cancel_supplier_invoice 6425 6411 14 0.21 4 80200 1079 0 14
sp_cancel_supplier_order 415 415 0 0.00 9 1513285 168099 0 0
sp_cancel_write_off 10543 10543 0 0.00 2 13581 158 0 0
sp_client_order 20989 20989 0 0.00 6 24556 444 0 0
sp_customer_reserve 464375 464375 0 0.00 0 66973 256 0 0
sp_fill_shopping_cart 32416 32416 0 0.00 1 15792 84 0 0
sp_fill_shopping_cart_clo_res 464347 464347 0 0.00 0 15368 18 0 0
sp_get_clo_for_invoice 5003 5003 0 0.00 0 22442 247 0 0
sp_kill_cost_storno 17331 17331 0 0.00 0 9606 67 0 0
sp_kill_qstorno_ret_qs2qd 1123597 1123597 0 0.00 0 80183 42 0 0
sp_kill_qty_storno 593300 593300 0 0.00 0 80184 98 0 0
sp_lock_selected_doc 21171 21171 0 0.00 0 7500 7 0 0
sp_make_cost_storno 28505 28505 0 0.00 0 15571 80 0 0
sp_multiply_rows_for_pdistr 28504 28504 0 0.00 0 7905 36 0 0
sp_multiply_rows_for_qdistr 20989 20989 0 0.00 0 9296 157 0 0
sp_pay_from_customer 7253 7253 0 0.00 5 12938 172 0 0
sp_pay_to_supplier 5941 5941 0 0.00 6 29448 209 0 0
sp_payment_common 13192 13192 0 0.00 2 9147 43 0 0
sp_qd_handle_on_cancel_clo 1803 1803 0 0.00 0 11770 314 0 0
sp_qd_handle_on_invoice_upd_sts 10705 10705 0 0.00 0 17280 500 0 0
sp_qd_handle_on_reserve_upd_sts 10309 10309 0 0.00 0 16946 69 0 0
sp_reserve_write_off 10309 10309 0 0.00 9 17017 280 0 0
sp_supplier_invoice 5745 5745 0 0.00 9 97917 3257 0 0
sp_supplier_order 5685 5685 0 0.00 8 44074 1430 0 0
srv_aggregate_perf_data 119 118 1 0.84 2369 127075 15244 0 1
srv_fill_mon_cache_memory 70 70 0 0.00 905 161700 37789 0 0
srv_find_qd_qs_mism 1057317 1057317 0 0.00 0 9657 12 0 0
srv_make_invnt_saldo 486 486 0 0.00 89 83586 3944 0 0
srv_make_money_saldo 912 912 0 0.00 1 14832 364 0 0
srv_recalc_idx_stat 4 4 0 0.00 80158 494748 251881 0 0
t$perf-abend:sp_add_invoice_to_stock 103 103 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 14 14 0 0.00 0 0 0 0 0
t$perf-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5042 5042 0 0.00 1 13553 917 0 0
t$perf-norm:sp_cancel_adding_invoice 410 410 0 0.00 2 6370 497 0 0
t$perf-norm:sp_cancel_client_order 1803 1803 0 0.00 0 1204 28 0 0
t$perf-norm:sp_cancel_customer_reserve 714 714 0 0.00 0 559 24 0 0
t$perf-norm:sp_cancel_pay_from_customer 666 666 0 0.00 0 1402 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 419 419 0 0.00 0 1053 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 410 410 0 0.00 0 1582 34 0 0
t$perf-norm:sp_cancel_supplier_order 415 415 0 0.00 0 96679 7007 0 0
t$perf-norm:sp_cancel_write_off 1026 1026 0 0.00 0 2723 19 0 0
t$perf-norm:sp_client_order 20989 20989 0 0.00 0 8922 38 0 0
t$perf-norm:sp_customer_reserve 1021 1021 0 0.00 0 7676 29 0 0
t$perf-norm:sp_pay_from_customer 7253 7253 0 0.00 0 9163 22 0 0
t$perf-norm:sp_pay_to_supplier 5941 5941 0 0.00 0 4899 19 0 0
t$perf-norm:sp_reserve_write_off 10310 10310 0 0.00 0 11741 26 0 0
t$perf-norm:sp_supplier_invoice 5746 5746 0 0.00 0 6641 33 0 0
t$perf-norm:sp_supplier_order 5685 5685 0 0.00 0 5524 32 0 0
t$perf-norm:srv_aggregate_perf_data 118 118 0 0.00 0 490 17 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 478 15 0 0
t$perf-norm:srv_make_invnt_saldo 486 486 0 0.00 0 8306 37 0 0
t$perf-norm:srv_make_money_saldo 912 912 0 0.00 0 2140 7 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 5 177 61 0 0
v_add_invoice_to_stock 10206 10000 206 2.01 0 10338 27 0 206
v_all_customers 39096 39096 0 0.00 0 66 3 0 0
v_all_suppliers 31760 31760 0 0.00 0 69 4 0 0
v_all_wares 41976 41976 0 0.00 0 61 4 0 0
v_cancel_adding_invoice 820 820 0 0.00 0 1126 17 0 0
v_cancel_client_order 3606 3606 0 0.00 0 10301 14 0 0
v_cancel_customer_prepayment 1332 1332 0 0.00 0 2839 16 0 0
v_cancel_customer_reserve 1428 1428 0 0.00 0 6452 13 0 0
v_cancel_payment_to_supplier 838 838 0 0.00 0 3868 14 0 0
v_cancel_supplier_invoice 848 820 28 3.30 0 4605 29 0 28
v_cancel_supplier_order 830 830 0 0.00 0 29899 46 0 0
v_cancel_write_off 2052 2052 0 0.00 0 13483 29 0 0
v_max_id_clo_ord 5685 5685 0 0.00 0 442 5 0 0
v_max_id_clo_res 1021 1021 0 0.00 0 2223 13 0 0
v_max_id_ord_sup 5742 5742 0 0.00 0 5089 7 0 0
v_max_non_paid_invoice 1488 1488 0 0.00 0 803 8 0 0
v_max_non_paid_realizn 3524 3524 0 0.00 0 1454 8 0 0
v_min_id_clo_ord 5685 5685 0 0.00 0 2586 9 0 0
v_min_id_clo_res 1021 1021 0 0.00 0 1198 8 0 0
v_min_id_ord_sup 5742 5742 0 0.00 0 8371 12 0 0
v_min_non_paid_invoice 5941 5941 0 0.00 0 4281 13 0 0
v_min_non_paid_realizn 7251 7251 0 0.00 0 8357 17 0 0
v_our_firm 10334 10334 0 0.00 0 121 4 0 0
v_reserve_write_off 20616 20616 0 0.00 0 13836 13 0 0
x_lock_depdocs_on_canc_invoice 11704 11704 0 0.00 0 30451 114 0 0
x_lock_depdocs_on_canc_sup_ord 415 415 0 0.00 0 6344 345 0 0
x_make_qstorno_1000_1200 5685 5685 0 0.00 2 44054 1262 0 0
x_make_qstorno_1200_2000 5745 5745 0 0.00 4 85717 3026 0 0
x_make_qstorno_2100_3300 464374 464374 0 0.00 0 66723 226 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 24-06-2022 13:39:42 to 24-06-2022 13:39:46.

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
11:07:20 15 8192000000 8801095744 8813203456 5770864 0.070 3 1 2 0 5872592 65952 35776
11:08:21 22513 8192000000 9723206688 10022502400 803723632 8.934 100 87 174 0 832013296 7409584 20880080
11:09:46 20387 8192000000 9759086704 10066780160 833647040 9.236 100 90 180 1 868109456 12453504 22008912
11:11:10 19180 8192000000 9803752528 10125869056 869746992 9.598 100 78 156 1 911301872 23703744 17851136
11:12:34 12340 8192000000 9868803008 10206633984 919294336 10.089 100 75 149 0 971848880 36628112 15926432
11:13:50 3985 8192000000 9932057968 10276577280 958803936 10.477 100 81 160 2 1037590288 61932576 16853776
11:14:59 2210 8192000000 9969073744 10322694144 994663264 10.827 100 87 166 0 1086251712 74199616 17388832
11:16:03 1071 8192000000 10002567328 10366640128 1020492384 11.077 100 97 193 2 1122531200 82955568 19083248
11:17:07 1262 8192000000 10001016112 10372714496 1043403248 11.297 100 90 177 0 1127007536 65472688 18131600
11:18:10 1119 8192000000 10035696176 10413768704 1061988048 11.476 100 95 180 0 1160607536 79431312 19188176
11:19:12 1222 8192000000 10053745168 10433925120 1073720352 11.588 100 93 180 0 1173170448 81900912 17549184
11:20:14 1858 8192000000 10052276944 10440712192 1075571280 11.605 100 80 160 1 1178111968 86283360 16257328
11:21:17 953 8192000000 10055073888 10439274496 1084023008 11.686 100 95 182 0 1176599968 74220608 18356352
11:22:19 1393 8192000000 10054257584 10443976704 1087420816 11.718 100 82 151 4 1173207664 68698560 17088288
11:23:21 920 8192000000 10058301216 10448277504 1091826112 11.760 100 93 181 1 1178105888 67952080 18327696
11:24:24 1191 8192000000 10041833392 10436698112 1095714560 11.797 100 83 151 3 1163744752 52455136 15575056
11:25:26 1316 8192000000 10066943104 10457423872 1103325264 11.869 100 96 185 3 1190874576 68468304 19081008
11:26:28 1163 8192000000 10059754224 10450751488 1102217008 11.859 100 94 185 1 1179597520 59568208 17812304
11:27:30 1029 8192000000 10075489456 10468716544 1106113712 11.896 100 85 160 0 1196134704 73087136 16933856
11:28:32 1104 8192000000 10059848432 10448551936 1101383136 11.851 100 97 189 1 1180364816 58950112 20031568
11:29:34 1544 8192000000 10057713040 10446053376 1093979904 11.780 100 80 141 3 1174023376 66909152 13134320
11:30:37 3395 8192000000 10018947248 10402148352 1063854336 11.493 100 73 141 2 1140118032 63015504 13248192
11:31:41 4300 8192000000 10029693712 10412347392 1054904384 11.408 100 69 131 3 1138904832 70511376 13489072
11:32:46 999 8192000000 10004617856 10383482880 1058990816 11.447 100 90 167 3 1127044496 50202800 17850880
11:33:48 2324 8192000000 10006401856 10390597632 1047338656 11.335 99 68 134 0 1123309520 62076800 13894064
11:34:51 5066 8192000000 9988878144 10367619072 1036315536 11.229 100 67 133 0 1122483792 73143536 13024720
11:35:57 1600 8192000000 9973017008 10343616512 1029301552 11.162 99 82 157 1 1095157760 48386144 17470064
11:37:00 1104 8192000000 10000723056 10375069696 1036485472 11.231 100 95 173 2 1118433056 64253840 17693744
11:38:09 2496 8192000000 10010522016 10389184512 1072425104 11.575 100 83 151 0 1130663920 44105472 14133344
11:39:17 4919 8192000000 10044097792 10426527744 1078333136 11.632 100 82 158 1 1164578144 71984896 14260112
11:40:25 6732 8192000000 10077747136 10464935936 1101518080 11.852 100 78 151 2 1189394048 73188944 14687024
11:41:35 6450 8192000000 10061264592 10463039488 1107630480 11.910 100 49 92 1 1188052256 70784896 9636880
11:42:46 4048 8192000000 10116158448 10507636736 1121603424 12.042 100 75 135 0 1232710800 97225408 13881968
11:43:53 1028 8192000000 10166110896 10557050880 1133850224 12.158 100 96 179 3 1276251312 124060208 18340880
11:44:56 1839 8192000000 10186130368 10593886208 1146295360 12.275 100 86 165 1 1296297008 131494720 18506928
11:46:01 2860 8192000000 10207461152 10609831936 1156285984 12.368 100 84 165 1 1320606064 145802336 18517744
11:47:06 1047 8192000000 10226333120 10628800512 1166501072 12.464 100 91 178 1 1339105968 152673232 19931664
11:48:10 2592 8192000000 10220421920 10627432448 1165834784 12.458 100 75 137 2 1336672304 156759552 14077968
11:49:18 1834 8192000000 10276229360 10679681024 1180883184 12.598 100 89 172 0 1385585856 184784832 19917840
11:50:23 5720 8192000000 10295897424 10713649152 1186358224 12.649 100 66 131 2 1406657232 205327824 14971184
11:51:33 1172 8192000000 10347663888 10759729152 1203000544 12.804 100 92 181 0 1455954672 231839760 21114368
11:52:37 1434 8192000000 10392804576 10793394176 1212089184 12.888 100 92 179 3 1501540192 267272496 22178512
11:53:40 1134 8192000000 10451994512 10862157824 1210205904 12.871 100 92 178 2 1561365952 328892752 22267296
11:54:45 938 8192000000 10500863504 10917089280 1206135984 12.833 99 93 186 0 1609189888 379533824 23520080
11:55:50 1611 8192000000 10544112416 10971308032 1215330992 12.918 100 96 190 1 1645921104 407645760 22944352
11:56:54 1779 8192000000 10565102880 10975125504 1209309568 12.863 100 94 185 1 1672952528 441488064 22154896
11:58:00 1611 8192000000 10604730208 11027124224 1217348208 12.937 100 93 180 1 1712261392 472668416 22244768
11:59:04 892 8192000000 10629082736 11080163328 1226490032 13.022 100 99 192 0 1733221888 483116048 23615808
12:00:07 2333 8192000000 10648646320 11076251648 1224072288 12.999 100 96 185 0 1748283152 501906016 22304848
12:01:12 2575 8192000000 10689696608 11121238016 1219522944 12.957 100 64 128 1 1793437440 557667328 16247168
12:02:28 1322 8192000000 10713493680 11157614592 1211380000 12.882 100 73 146 0 1817461056 587183824 18897232
12:03:47 2941 8192000000 10716809936 11181592576 1201924304 12.794 100 61 120 1 1819827712 601872672 16030736
12:04:51 11828 8192000000 10632015920 11142410240 1167847264 12.477 99 41 82 0 1767549328 587925936 11776128
12:06:07 12363 8192000000 10555114256 11031138304 1155408400 12.360 99 46 89 1 1652380864 484708752 12263712
12:07:21 14551 8192000000 10375957984 10960195584 1159818112 12.402 100 43 86 0 1566888752 396191536 10879104
12:08:55 43743 8192000000 10261090896 10753679360 1156282576 12.368 100 33 66 1 1371318832 206687024 8349232
12:10:43 135328 8192000000 10080347024 10546233344 1093211616 11.773 95 14 28 1 1181788736 85919072 2658048
12:14:08 104632 8192000000 10069737280 10523385856 1054334256 11.402 92 16 32 2 1093487344 35485088 3668000
12:16:57 43168 8192000000 10098489008 10539343872 1092424304 11.766 97 28 56 2 1158440064 59309024 6706736
12:18:41 161699 8192000000 10068554560 10516492288 1073158496 11.582 95 18 35 2 1115339360 38894720 3286144
12:22:44 15184 8192000000 10102630080 10538647552 1121133776 12.038 100 55 109 0 1198090032 65952352 11003904
12:24:01 91294 8192000000 10098830608 10536677376 1112080320 11.952 98 35 70 0 1160606128 40810544 7715264
12:26:33 55282 8192000000 10088925712 10539835392 1124131392 12.066 100 44 87 0 1197813392 63846240 9835760
12:28:31 7926 8192000000 10184452176 10617696256 1147569728 12.287 100 58 108 0 1280385616 121814288 11001600
12:29:43 79667 8192000000 10138886512 10596786176 1119574512 12.023 98 21 42 0 1215485120 91024528 4886080
12:32:04 55910 8192000000 10093474288 10579156992 1115205040 11.982 98 16 32 0 1201700208 82850192 3644976
12:34:10 66110 8192000000 10114967360 10588037120 1138288256 12.199 100 17 33 2 1221495136 79135168 4071712
12:36:21 82654 8192000000 10164197136 10624761856 1134956912 12.168 100 19 38 2 1273380528 134160144 4263472
12:38:52 51785 8192000000 10076160544 10504388608 1112498704 11.956 98 34 61 2 1155673392 37206448 5968240
12:40:46 16467 8192000000 10084936592 10542473216 1127586928 12.099 100 26 52 1 1177390768 44179536 5624304
12:42:04 35663 8192000000 10124943744 10560761856 1138566656 12.202 100 57 111 2 1196536720 46129888 11840176
12:43:40 53785 8192000000 10129438128 10567135232 1121584896 12.042 98 27 54 0 1185751056 58830544 5335616
12:45:40 32650 8192000000 10083416960 10542428160 1118892752 12.017 98 31 63 1 1176011248 50664768 6453728
12:47:21 92193 8192000000 10101198000 10584432640 1095402800 11.794 96 25 46 0 1199255568 98942064 4910704
12:50:09 26702 8192000000 10122651088 10570752000 1126832224 12.091 99 38 73 1 1187978656 53503968 7642464
12:51:41 78430 8192000000 10092457920 10588823552 1147231968 12.284 100 38 76 0 1234630720 79289632 8109120
12:54:06 46418 8192000000 10096924848 10536255488 1142088000 12.235 100 34 66 1 1189136032 40797952 6250080
12:55:53 70825 8192000000 10103505536 10557399040 1103560480 11.871 96 31 59 1 1149556576 39868000 6128096
12:58:04 39050 8192000000 10097341824 10545532928 1137825392 12.195 99 23 46 1 1200161568 57057936 5278240
12:59:58 57532 8192000000 10084809520 10553081856 1118032240 12.008 99 9 19 0 1170644368 50733072 1879056
13:02:25 67719 8192000000 10052794816 10551541760 1095400848 11.794 97 21 41 1 1162900064 62479104 5020112
13:04:33 45302 8192000000 10071842656 10510192640 1073928432 11.590 96 28 55 1 1131075056 51099504 6047120
13:06:18 42931 8192000000 10080663232 10526846976 1087599648 11.720 97 38 76 1 1164529184 68594832 8334704
13:08:03 35583 8192000000 10117558048 10549817344 1103270688 11.869 98 36 72 1 1174563136 63847824 7444624
13:10:09 58563 8192000000 10099277200 10546757632 1120623792 12.033 100 26 52 1 1186194272 59957904 5612576
13:12:08 67814 8192000000 10143881632 10618105856 1132411280 12.144 100 39 76 1 1228160432 87938592 7810560
13:14:51 7107 8192000000 10090476096 10513924096 1125401088 12.078 100 62 122 2 1178509792 40795472 12313232
13:15:59 125308 8192000000 10082436176 10525474816 1111075984 11.943 98 38 76 1 1213726816 94780864 7869968
13:19:08 44282 8192000000 10071072608 10550038528 1123310864 12.058 100 35 70 0 1200078864 69825456 6942544
13:20:57 59990 8192000000 10057262352 10536566784 1107208752 11.906 98 10 20 0 1173172096 63839872 2123472
13:23:11 78140 8192000000 10080722448 10556743680 1129306368 12.115 100 8 16 0 1193146016 62129616 1710032
13:25:35 47142 8192000000 10096611904 10546003968 1122678832 12.052 99 25 50 0 1180329728 51970080 5680816
13:27:27 26963 8192000000 10107202224 10545934336 1138315296 12.200 100 45 89 1 1203009232 55472048 9221888
13:29:02 47642 8192000000 10145091088 10592251904 1134220560 12.161 99 26 52 0 1218669968 78887168 5562240
13:30:53 43770 8192000000 10132950960 10574872576 1133154224 12.151 99 33 66 0 1222190768 81581872 7454672
13:32:37 87867 8192000000 10110601296 10566717440 1111495888 11.947 97 21 42 0 1188987712 73210896 4280928
13:35:07 48060 8192000000 10098795312 10543620096 1097147088 11.811 97 23 45 2 1163137824 61261936 4728800
13:36:58 66514 8192000000 8895879536 9071329280 73203680 0.885 7 3 6 0 77819216 4029744 585792

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 24-06-2022 13:39:48 to 24-06-2022 13:40:04.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 103 v_add_invoice_to_stock 335544517
except 14 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 24-06-2022 13:40:05 to 24-06-2022 13:40:07.

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          225465
MON$OLDEST_ACTIVE               225466
MON$OLDEST_SNAPSHOT             225466
MON$NEXT_TRANSACTION            225466
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                       2079648
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             783
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2787 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2787 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2787 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2787 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 ---
--- end of diff output ---

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

24.06.22 13:40:08. 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-06-24 13:40:11 No severe PSQL-related problems occured
24.06.22 13:40:12. End of report.