Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 18.06.2022 10:38
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 16035592 kB
MemAvailable 31283396 kB
Buffers 0 kB
Cached 15700620 kB
SwapCached 2460 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-18 10:37:12
DTS_END                         2022-06-18 10:37:12.5750
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/40104
TRN_ID                          224546
ATT_ID                          632
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: 8967.53 23187 1076104
customer order: creation 176.23 483 21148
customer order: refuse 15.14 372 1817
order to supplier: creation 47.64 1462 5717
order to supplier: removal 3.16 173879 379
invoice (draft): creation 47.30 3187 5676
invoice (draft): removal 48.38 1047 5806
invoice accept: apply 42.66 25469 5119
invoice accept: cancel 44.04 1332 5285
customer reserve: creation 3924.81 245 470977
customer reserve: removal 4314.49 101 517739
realization accept: apply 86.95 271 10434
realization accept: cancel 82.68 170 9921
payment from customer: creation 60.82 181 7298
payment from customer: removal 5.82 130 698
payment to supplier: creation 50.92 183 6110
payment to supplier: removal 3.73 165 448
service: total inventory turnovers 4.03 4445 484
service: total monetary turnovers 7.77 367 932
service: aggregate perf. data 0.93 16083 111
service: refresh index statistics 0.04 234167 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 18-06-2022 10:38:41 to 18-06-2022 10:38:43.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 9587
TEST_TIME 2 8050
TEST_TIME 3 7262
TEST_TIME 4 6743
TEST_TIME 5 6836
TEST_TIME 6 6472
TEST_TIME 7 6371
TEST_TIME 8 6773
TEST_TIME 9 6606
TEST_TIME 10 6889
TEST_TIME 11 7223
TEST_TIME 12 7427
TEST_TIME 13 7640
TEST_TIME 14 7679
TEST_TIME 15 7698
TEST_TIME 16 7912
TEST_TIME 17 8076
TEST_TIME 18 7970
TEST_TIME 19 8123
TEST_TIME 20 8138
TEST_TIME 21 8046
TEST_TIME 22 8046
TEST_TIME 23 8249
TEST_TIME 24 8363
TEST_TIME 25 8482
TEST_TIME 26 8708
TEST_TIME 27 9179
TEST_TIME 28 9226
TEST_TIME 29 9693
TEST_TIME 30 9897
TEST_TIME 31 9915
TEST_TIME 32 10366
TEST_TIME 33 10457
TEST_TIME 34 10810
TEST_TIME 35 10822
TEST_TIME 36 10772
TEST_TIME 37 10895
TEST_TIME 38 10711
TEST_TIME 39 10540
TEST_TIME 40 10422
TEST_TIME 41 10483
TEST_TIME 42 10490
TEST_TIME 43 10413
TEST_TIME 44 10474
TEST_TIME 45 10264
TEST_TIME 46 10080
TEST_TIME 47 10006
TEST_TIME 48 9979
TEST_TIME 49 9851
TEST_TIME 50 9855
TEST_TIME 51 9830
TEST_TIME 52 9776
TEST_TIME 53 9673
TEST_TIME 54 9613
TEST_TIME 55 9511
TEST_TIME 56 9465
TEST_TIME 57 9466
TEST_TIME 58 9631
TEST_TIME 59 9664
TEST_TIME 60 9691
TEST_TIME 61 9710
TEST_TIME 62 9708
TEST_TIME 63 9678
TEST_TIME 64 9639
TEST_TIME 65 9788
TEST_TIME 66 9722
TEST_TIME 67 9831
TEST_TIME 68 9838
TEST_TIME 69 9760
TEST_TIME 70 9738
TEST_TIME 71 9812
TEST_TIME 72 9799
TEST_TIME 73 9687
TEST_TIME 74 9600
TEST_TIME 75 9547
TEST_TIME 76 9522
TEST_TIME 77 9438
TEST_TIME 78 9372
TEST_TIME 79 9365
TEST_TIME 80 9329
TEST_TIME 81 9244
TEST_TIME 82 9238
TEST_TIME 83 9250
TEST_TIME 84 9342
TEST_TIME 85 9318
TEST_TIME 86 9295
TEST_TIME 87 9281
TEST_TIME 88 9269
TEST_TIME 89 9262
TEST_TIME 90 9267
TEST_TIME 91 9386
TEST_TIME 92 9364
TEST_TIME 93 9361
TEST_TIME 94 9365
TEST_TIME 95 9346
TEST_TIME 96 9298
TEST_TIME 97 9256
TEST_TIME 98 9230
TEST_TIME 99 9185
TEST_TIME 100 9143
TEST_TIME 101 9111
TEST_TIME 102 9039
TEST_TIME 103 9045
TEST_TIME 104 9047
TEST_TIME 105 9038
TEST_TIME 106 9040
TEST_TIME 107 9025
TEST_TIME 108 9003
TEST_TIME 109 8991
TEST_TIME 110 8954
TEST_TIME 111 8988
TEST_TIME 112 9034
TEST_TIME 113 9079
TEST_TIME 114 9149
TEST_TIME 115 9119
TEST_TIME 116 9087
TEST_TIME 117 9072
TEST_TIME 118 9112
TEST_TIME 119 9065
TEST_TIME 120 8993

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 18-06-2022 10:38:44 to 18-06-2022 10:38:48.

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 1511134 1511134 0 0.00 0 21574 13 0 0
doc_list_biud 1511122 1511122 0 0.00 0 61944 41 0 0
sp_add_invoice_to_stock 5240 5119 121 2.30 66 196683 25470 0 121
sp_cancel_adding_invoice 5285 5285 0 0.00 6 79637 1332 0 0
sp_cancel_client_order 1817 1817 0 0.00 6 9195 373 0 0
sp_cancel_customer_reserve 517739 517739 0 0.00 1 61948 102 0 0
sp_cancel_pay_from_customer 698 698 0 0.00 4 5737 131 0 0
sp_cancel_pay_to_supplier 448 448 0 0.00 4 15066 165 0 0
sp_cancel_supplier_invoice 5815 5806 9 0.15 3 14957 1048 0 9
sp_cancel_supplier_order 379 379 0 0.00 47 1324051 173879 0 0
sp_cancel_write_off 9921 9921 0 0.00 2 15349 171 0 0
sp_client_order 21148 21148 0 0.00 5 27313 484 0 0
sp_customer_reserve 470977 470977 0 0.00 1 136987 245 0 0
sp_fill_shopping_cart 32525 32525 0 0.00 1 19078 86 0 0
sp_fill_shopping_cart_clo_res 470944 470944 0 0.00 0 16345 19 0 0
sp_get_clo_for_invoice 5078 5078 0 0.00 0 40528 302 0 0
sp_kill_cost_storno 16352 16352 0 0.00 0 10052 72 0 0
sp_kill_qstorno_ret_qs2qd 1051584 1051584 0 0.00 0 61932 45 0 0
sp_kill_qty_storno 556459 556459 0 0.00 0 61944 102 0 0
sp_lock_selected_doc 21598 21598 0 0.00 0 9716 7 0 0
sp_make_cost_storno 28920 28920 0 0.00 0 12044 76 0 0
sp_multiply_rows_for_pdistr 28920 28920 0 0.00 0 8616 37 0 0
sp_multiply_rows_for_qdistr 21146 21146 0 0.00 0 20856 170 0 0
sp_pay_from_customer 7298 7298 0 0.00 5 19208 182 0 0
sp_pay_to_supplier 6110 6110 0 0.00 6 9286 184 0 0
sp_payment_common 13407 13407 0 0.00 2 9124 46 0 0
sp_qd_handle_on_cancel_clo 1817 1817 0 0.00 0 9185 299 0 0
sp_qd_handle_on_invoice_upd_sts 10363 10363 0 0.00 1 12503 492 0 0
sp_qd_handle_on_reserve_upd_sts 10434 10434 0 0.00 0 24684 65 0 0
sp_reserve_write_off 10434 10434 0 0.00 8 24736 271 0 0
sp_supplier_invoice 5676 5676 0 0.00 10 79278 3188 0 0
sp_supplier_order 5717 5717 0 0.00 7 36927 1463 0 0
srv_aggregate_perf_data 112 111 1 0.89 2682 163268 16083 0 1
srv_fill_mon_cache_memory 70 70 0 0.00 650 136349 37227 0 0
srv_find_qd_qs_mism 1026534 1026534 0 0.00 0 21572 11 0 0
srv_make_invnt_saldo 484 484 0 0.00 42 79942 4445 0 0
srv_make_money_saldo 932 932 0 0.00 1 9928 367 0 0
srv_recalc_idx_stat 5 5 0 0.00 56496 389237 234168 0 0
t$perf-abend:sp_add_invoice_to_stock 121 121 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 9 9 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 5127 5127 0 0.00 1 10275 924 0 0
t$perf-norm:sp_cancel_adding_invoice 465 465 0 0.00 1 6440 479 0 0
t$perf-norm:sp_cancel_client_order 1817 1817 0 0.00 0 1211 24 0 0
t$perf-norm:sp_cancel_customer_reserve 779 779 0 0.00 0 2554 28 0 0
t$perf-norm:sp_cancel_pay_from_customer 698 698 0 0.00 0 333 12 0 0
t$perf-norm:sp_cancel_pay_to_supplier 448 448 0 0.00 0 923 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 391 391 0 0.00 0 1925 44 0 0
t$perf-norm:sp_cancel_supplier_order 379 379 0 0.00 1 87090 6772 0 0
t$perf-norm:sp_cancel_write_off 1112 1112 0 0.00 0 770 17 0 0
t$perf-norm:sp_client_order 21148 21148 0 0.00 0 4849 36 0 0
t$perf-norm:sp_customer_reserve 1064 1064 0 0.00 0 6408 21 0 0
t$perf-norm:sp_pay_from_customer 7298 7298 0 0.00 0 5817 21 0 0
t$perf-norm:sp_pay_to_supplier 6110 6110 0 0.00 0 5191 19 0 0
t$perf-norm:sp_reserve_write_off 10434 10434 0 0.00 0 5654 24 0 0
t$perf-norm:sp_supplier_invoice 5676 5676 0 0.00 0 6375 34 0 0
t$perf-norm:sp_supplier_order 5717 5717 0 0.00 0 6466 35 0 0
t$perf-norm:srv_aggregate_perf_data 111 111 0 0.00 0 683 32 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 649 15 0 0
t$perf-norm:srv_make_invnt_saldo 484 484 0 0.00 0 3473 22 0 0
t$perf-norm:srv_make_money_saldo 932 932 0 0.00 0 2286 7 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 5 203 87 0 0
v_add_invoice_to_stock 10392 10150 242 2.32 0 5782 25 0 242
v_all_customers 38584 38584 0 0.00 0 99 4 0 0
v_all_suppliers 31890 31890 0 0.00 0 108 4 0 0
v_all_wares 42286 42286 0 0.00 0 151 4 0 0
v_cancel_adding_invoice 930 930 0 0.00 0 5280 20 0 0
v_cancel_client_order 3634 3634 0 0.00 0 7932 14 0 0
v_cancel_customer_prepayment 1396 1396 0 0.00 0 5713 19 0 0
v_cancel_customer_reserve 1558 1558 0 0.00 0 1266 12 0 0
v_cancel_payment_to_supplier 896 896 0 0.00 0 4635 18 0 0
v_cancel_supplier_invoice 800 782 18 2.25 0 359 21 0 18
v_cancel_supplier_order 758 758 0 0.00 0 530 11 0 0
v_cancel_write_off 2224 2224 0 0.00 0 2791 23 0 0
v_max_id_clo_ord 5712 5712 0 0.00 0 803 5 0 0
v_max_id_clo_res 1064 1064 0 0.00 0 2302 15 0 0
v_max_id_ord_sup 5668 5668 0 0.00 0 5416 9 0 0
v_max_non_paid_invoice 1545 1545 0 0.00 0 185 7 0 0
v_max_non_paid_realizn 3871 3871 0 0.00 0 4887 8 0 0
v_min_id_clo_ord 5712 5712 0 0.00 0 7331 15 0 0
v_min_id_clo_res 1064 1064 0 0.00 0 6556 18 0 0
v_min_id_ord_sup 5668 5668 0 0.00 0 4757 10 0 0
v_min_non_paid_invoice 6110 6110 0 0.00 0 4850 14 0 0
v_min_non_paid_realizn 7297 7297 0 0.00 0 8601 19 0 0
v_our_firm 10554 10554 0 0.00 0 105 5 0 0
v_reserve_write_off 20868 20868 0 0.00 0 5166 10 0 0
x_lock_depdocs_on_canc_invoice 10700 10700 0 0.00 0 15017 135 0 0
x_lock_depdocs_on_canc_sup_ord 379 379 0 0.00 0 2931 352 0 0
x_make_qstorno_1000_1200 5717 5717 0 0.00 2 36915 1282 0 0
x_make_qstorno_1200_2000 5676 5676 0 0.00 4 68577 2959 0 0
x_make_qstorno_2100_3300 470976 470976 0 0.00 0 136976 214 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 18-06-2022 10:38:49 to 18-06-2022 10:38:53.

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
08:07:16 2 8192000000 8796669024 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
08:08:17 35991 8192000000 9724532112 10023211008 797928000 8.875 100 83 165 0 826424080 7464000 21032080
08:09:58 27483 8192000000 9770789696 10077052928 835636576 9.256 100 87 174 1 869730192 13274688 20818928
08:11:31 18822 8192000000 9825704880 10146783232 871953152 9.620 100 79 157 1 922381536 32232224 18196160
08:12:56 9312 8192000000 9861413088 10195136512 917493520 10.071 100 80 161 1 971019536 36501056 17024960
08:14:12 3384 8192000000 9931796496 10272624640 964398224 10.532 100 95 187 0 1048584528 64640800 19545504
08:15:19 1809 8192000000 9959827440 10315087872 996909760 10.849 100 88 172 0 1074997728 60237440 17850528
08:16:23 2341 8192000000 10001140336 10361892864 1018698672 11.059 100 92 182 1 1121408320 84085328 18624320
08:17:28 1170 8192000000 10020696688 10387128320 1038998320 11.255 100 98 193 1 1142476752 83243680 20234752
08:18:31 840 8192000000 10041404368 10413543424 1051153520 11.372 100 93 170 1 1153907952 86005648 16748784
08:19:33 1576 8192000000 10054857856 10437341184 1063564032 11.491 100 93 180 0 1172397952 90042496 18791424
08:20:36 935 8192000000 10043886112 10425081856 1066211664 11.516 100 93 173 1 1165453392 80945616 18296112
08:21:38 1084 8192000000 10042964992 10421874688 1079250976 11.640 100 94 188 2 1162002464 63170320 19581168
08:22:41 1120 8192000000 10053553552 10435858432 1085978336 11.704 100 96 188 1 1173317520 68902000 18437184
08:23:43 983 8192000000 10062070912 10449190912 1083569088 11.681 100 89 171 0 1183904784 83171056 17164640
08:24:45 1500 8192000000 10049099840 10438529024 1090850032 11.751 100 85 164 1 1172265200 64672720 16742448
08:25:47 1213 8192000000 10048003696 10437046272 1091394368 11.756 100 96 183 3 1171073792 61702576 17976848
08:26:50 1189 8192000000 10059349776 10447704064 1098092272 11.820 100 97 183 2 1185575488 67915856 19567360
08:27:52 1270 8192000000 10092255216 10481926144 1094409536 11.785 100 94 182 0 1209155984 97294176 17452272
08:28:54 1108 8192000000 10017558480 10400186368 1076998896 11.619 100 92 173 4 1138259520 43559184 17701440
08:29:55 859 8192000000 10041054976 10428289024 1093345376 11.774 100 85 166 0 1163477296 52199744 17932176
08:30:57 4425 8192000000 10012653968 10398617600 1078849984 11.637 100 68 125 2 1133360176 42647936 11862256
08:32:02 4409 8192000000 9991792384 10383818752 1045365584 11.316 98 57 113 0 1120106720 62097088 12644048
08:33:07 1310 8192000000 9974887712 10354745344 1040755328 11.272 100 71 132 0 1097902768 42865152 14282288
08:34:09 1606 8192000000 10011355728 10391601152 1057174192 11.429 100 83 162 1 1135668432 63653152 14841088
08:35:12 1728 8192000000 9960618784 10333020160 1019781104 11.070 99 76 140 1 1082135664 46354832 15999728
08:36:14 1521 8192000000 9976082448 10352611328 1035236160 11.219 100 80 156 1 1094854688 44046304 15572224
08:37:16 8930 8192000000 9976340608 10352951296 1044441088 11.307 100 75 125 2 1101106848 44955840 11709920
08:38:33 12192 8192000000 10021096656 10405171200 1062662416 11.482 100 73 143 0 1145394320 69188368 13543536
08:39:56 2984 8192000000 10048263408 10427187200 1071708224 11.568 100 85 153 0 1160824128 73723456 15392448
08:41:15 887 8192000000 10059379632 10438418432 1087767696 11.721 100 94 179 2 1174140544 67678432 18694416
08:42:21 8727 8192000000 10111055328 10514292736 1105836352 11.893 100 72 138 0 1233594016 113171904 14585760
08:43:35 2199 8192000000 10138734864 10528665600 1121540528 12.042 100 87 169 0 1256796960 117759776 17496656
08:44:40 9822 8192000000 10167249664 10561290240 1121901264 12.045 100 72 140 1 1280939920 143642576 15396080
08:45:56 6457 8192000000 10201281776 10592391168 1137210848 12.189 100 81 150 2 1308502928 155689472 15602608
08:47:10 1732 8192000000 10236141232 10645897216 1154881936 12.355 100 84 164 1 1352703200 179570864 18250400
08:48:13 1405 8192000000 10255512592 10660179968 1162742208 12.429 100 96 188 0 1366815232 182116080 21956944
08:49:17 1424 8192000000 10265044784 10687156224 1173276864 12.527 100 96 189 0 1378561168 185062400 20221904
08:50:20 1006 8192000000 10288459344 10691153920 1172829952 12.523 100 94 182 0 1398882016 204753904 21298160
08:51:23 851 8192000000 10334143984 10735423488 1177450624 12.566 100 97 190 1 1439910688 241610032 20850032
08:52:28 638 8192000000 10375643840 10790780928 1183497216 12.623 100 99 190 1 1482037808 277276576 21264016
08:53:33 1490 8192000000 10355587584 10770886656 1172203024 12.517 99 92 180 3 1461089872 267619216 21267632
08:54:37 880 8192000000 10375225264 10782838784 1189778032 12.681 100 94 183 3 1485161728 274241968 21141728
08:55:46 2353 8192000000 10396980000 10807042048 1171627248 12.512 99 79 151 1 1497581952 308635664 17319040
08:56:53 2567 8192000000 10397970432 10821197824 1173435104 12.529 99 71 139 0 1507848256 317396192 17016960
08:58:06 2303 8192000000 10421945312 10841763840 1193875600 12.719 100 64 124 0 1526839008 318252800 14710608
08:59:15 1192 8192000000 10498173296 10903392256 1182028208 12.609 100 97 193 1 1604594848 400258688 22307952
09:00:18 1710 8192000000 10447695760 10899435520 1176972528 12.562 100 76 149 0 1552069952 357114960 17982464
09:01:24 1940 8192000000 10472269744 10907090944 1173171840 12.526 100 74 145 0 1577209040 386459856 17577344
09:02:29 942 8192000000 10515854960 10926428160 1177153152 12.564 100 95 190 1 1617660000 418031568 22475280
09:03:33 7743 8192000000 10471839840 10932408320 1170683856 12.503 100 50 100 0 1569602976 386015648 12903472
09:04:53 2387 8192000000 10395630880 10916118528 1167031920 12.469 100 54 106 1 1503631584 323314448 13285216
09:05:58 3426 8192000000 10384836944 10848477184 1155441504 12.361 100 47 94 0 1487174096 319144944 12587648
09:07:06 27101 8192000000 10325947552 10785914880 1160832192 12.411 99 28 56 1 1429004448 261216352 6955904
09:08:46 18997 8192000000 10300035872 10816077824 1165654064 12.456 100 33 66 0 1399196832 224847152 8695616
09:10:31 48072 8192000000 10160188352 10644377600 1138889360 12.205 99 16 30 1 1298891552 156534256 3467936
09:12:20 109927 8192000000 10111031856 10587545600 1100873136 11.846 95 15 29 0 1165475264 61458688 3143440
09:15:16 66249 8192000000 10082943120 10525171712 1101865632 11.855 96 14 26 0 1138218624 33739760 2613232
09:17:23 58696 8192000000 10134102544 10556592128 1122131024 12.047 98 53 104 1 1218666976 85080736 11455216
09:19:30 42270 8192000000 10078702384 10504245248 1090847456 11.751 97 22 44 0 1146813760 51635184 4331120
09:21:40 136347 8192000000 10095617280 10528632832 1125124608 12.075 100 26 52 0 1152852320 21725088 6002624
09:24:59 134689 8192000000 10096842672 10520145920 1103757344 11.873 98 49 92 3 1166867456 53058160 10051952
09:28:16 43886 8192000000 10120718032 10552594432 1135633120 12.174 100 38 76 1 1220794208 76665504 8495584
09:30:03 25063 8192000000 10166260672 10596536320 1129184432 12.114 98 50 88 3 1243308080 103065824 11057824
09:31:29 78373 8192000000 10223454768 10679279616 1146455072 12.276 100 20 40 0 1309109680 157682784 4971824
09:34:24 40064 8192000000 10201012320 10658217984 1132827904 12.148 100 19 38 0 1306681008 168672896 5180208
09:36:32 69245 8192000000 10073338288 10520305664 1105123040 11.886 97 16 32 0 1197544768 89077424 3344304
09:38:52 67200 8192000000 10107932016 10566000640 1130995600 12.131 99 24 46 1 1210094448 74579888 4518960
09:41:05 59025 8192000000 10150403968 10596544512 1107771360 11.911 98 18 36 0 1211345152 99581824 3991968
09:43:05 18441 8192000000 10096199680 10517983232 1123553904 12.061 100 63 123 1 1184058016 47017248 13486864
09:44:25 108919 8192000000 10073594384 10495614976 1093439280 11.775 97 20 37 1 1140186096 43067184 3679632
09:47:18 48395 8192000000 10168156896 10603737088 1136928576 12.187 100 29 58 1 1255162544 112167904 6066064
09:49:07 110791 8192000000 10081000896 10536415232 1125498416 12.079 99 39 76 0 1161408112 28149280 7760416
09:52:11 5030 8192000000 10086972480 10521407488 1138250208 12.199 100 42 82 0 1179908048 33450560 8207280
09:53:18 55880 8192000000 10091763392 10559672320 1141252992 12.227 100 17 34 0 1198819840 54118144 3448704
09:55:27 54810 8192000000 10128124128 10589470720 1128807040 12.110 98 21 42 0 1221168592 87409296 4952256
09:57:32 79560 8192000000 10140641136 10594230272 1137713168 12.194 99 14 28 1 1232664256 91866208 3084880
09:59:53 104113 8192000000 10105854304 10634092544 1127249504 12.095 98 18 36 0 1237863952 106684432 3930016
10:02:39 36306 8192000000 10079576384 10534223872 1116133056 11.990 98 28 56 0 1158286832 36220672 5933104
10:04:21 31694 8192000000 10100772816 10543939584 1115192048 11.982 98 23 46 0 1164013408 44062496 4758864
10:05:53 40714 8192000000 10098277568 10533060608 1078926960 11.637 95 40 80 2 1144239952 56840304 8472688
10:07:38 60727 8192000000 10114052640 10604277760 1119822832 12.025 99 16 33 0 1244701424 121453200 3425392
10:09:40 23419 8192000000 10085332704 10540843008 1138272304 12.199 100 35 70 0 1198983520 54085312 6625904
10:11:05 28977 8192000000 10065360496 10510737408 1089473696 11.738 97 27 52 0 1135549728 41033264 5042768
10:12:34 75590 8192000000 10072764768 10524258304 1103483424 11.871 98 44 83 2 1166660048 54482576 8694048
10:15:11 50876 8192000000 10034116816 10496094208 1102166384 11.858 98 11 22 0 1136717712 31854832 2696496
10:17:02 66835 8192000000 10055152768 10514333696 1131566800 12.136 100 8 16 0 1166833392 33756080 1510512
10:19:10 30182 8192000000 10084810128 10554122240 1128757296 12.110 99 12 25 0 1190617344 59393376 2466672
10:20:53 50980 8192000000 10037656880 10523693056 1098910944 11.827 97 14 25 1 1142696800 41261984 2523872
10:22:47 51529 8192000000 10101796352 10558345216 1135674992 12.175 100 23 46 0 1192988416 52465344 4848080
10:24:44 28224 8192000000 10151844288 10595495936 1139331504 12.209 100 45 88 2 1239861744 90845872 9684368
10:26:27 28005 8192000000 10173130944 10619301888 1139313424 12.209 99 32 63 1 1266744192 120733856 6696912
10:27:56 58035 8192000000 10212323424 10681004032 1144049152 12.254 99 51 101 4 1332346544 176871408 11425984
10:29:58 73472 8192000000 10114948976 10557571072 1080967440 11.657 95 17 34 0 1159975552 75327728 3680384
10:32:13 20714 8192000000 10072926512 10495496192 1089925568 11.742 97 48 94 0 1124156448 24031040 10199840
10:33:37 119982 8192000000 10065407856 10587811840 1096440304 11.804 97 18 36 0 1214064560 113481600 4142656
10:36:49 30005 8192000000 9136378240 9398231040 278598544 3.289 26 8 12 0 289031952 9349664 1083744

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 18-06-2022 10:38:55 to 18-06-2022 10:39:10.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 121 v_add_invoice_to_stock 335544517
except 9 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 18-06-2022 10:39:11 to 18-06-2022 10:39:13.

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          225143
MON$OLDEST_ACTIVE               225144
MON$OLDEST_SNAPSHOT             225144
MON$NEXT_TRANSACTION            225144
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                       2068384
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             785
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

18.06.22 10:39:14. 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-18 10:39:17 No severe PSQL-related problems occured
18.06.22 10:39:18. End of report.