Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 10.07.2022 22: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 16122568 kB
MemAvailable 31088828 kB
Buffers 0 kB
Cached 15565220 kB
SwapCached 2524 kB
Command: fdisk -l
WARNING: fdisk GPT support is currently new, and therefore in an experimental phase. Use at your own discretion.
Disk /dev/sda: 599.9 GB, 599932581888 bytes, 1171743324 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk label type: gpt
Disk identifier: 919DACA4-2F35-4CBB-BAA7-2A8CD8F7168C
# Start End Size Type Name
1 2048 411647 200M EFI System EFI System Partition
2 411648 2508799 1G Microsoft basic
3 2508800 1171742719 557.5G Linux LVM
Disk /dev/mapper/centos_mscs--test--161-root: 53.7 GB, 53687091200 bytes, 104857600 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/mapper/centos_mscs--test--161-swap: 16.8 GB, 16844324864 bytes, 32899072 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/sdb: 536 MB, 536870912 bytes, 1048576 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk label type: dos
Disk identifier: 0x00000046
Device Boot Start End Blocks Id System
/dev/sdb1 63 514079 257008+ c W95 FAT32 (LBA)
Disk /dev/mapper/centos_mscs--test--161-home: 528.1 GB, 528109010944 bytes, 1031462912 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes

Server and database settinfs

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


Test configuration settings

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

Test finish info

FINISH_STATE                    NORMAL: TEST_TIME EXPIRED AT 2022-07-10 22:38:18
DTS_END                         2022-07-10 22:38:18.3050
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_CANCEL_SUPPLIER_ORDER(116:18) ==> SP_CANCEL_CUSTOMER_RESERVE(36:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/54726
TRN_ID                          252993
ATT_ID                          668
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: 9269.43 23736 1112332
customer order: creation 184.87 355 22184
customer order: refuse 15.89 368 1907
order to supplier: creation 49.31 1238 5917
order to supplier: removal 3.49 81506 419
invoice (draft): creation 50.43 3414 6052
invoice (draft): removal 51.52 713 6182
invoice accept: apply 44.18 17751 5301
invoice accept: cancel 45.73 748 5488
customer reserve: creation 4017.81 177 482137
customer reserve: removal 4485.06 49 538207
realization accept: apply 90.98 158 10917
realization accept: cancel 88.12 95 10574
payment from customer: creation 64.53 101 7744
payment from customer: removal 6.23 94 748
payment to supplier: creation 54.35 114 6522
payment to supplier: removal 3.98 63 477
service: total inventory turnovers 5.26 1072 631
service: total monetary turnovers 6.75 47 810
service: aggregate perf. data 0.93 18192 111
service: refresh index statistics 0.03 348471 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-07-2022 22:39:00 to 10-07-2022 22:39:02.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6876
TEST_TIME 2 6151
TEST_TIME 3 6053
TEST_TIME 4 6039
TEST_TIME 5 6150
TEST_TIME 6 6193
TEST_TIME 7 6174
TEST_TIME 8 6180
TEST_TIME 9 6195
TEST_TIME 10 6402
TEST_TIME 11 6657
TEST_TIME 12 6665
TEST_TIME 13 6750
TEST_TIME 14 6872
TEST_TIME 15 7068
TEST_TIME 16 7056
TEST_TIME 17 7819
TEST_TIME 18 8429
TEST_TIME 19 8602
TEST_TIME 20 8920
TEST_TIME 21 8779
TEST_TIME 22 8983
TEST_TIME 23 9494
TEST_TIME 24 9985
TEST_TIME 25 10050
TEST_TIME 26 10305
TEST_TIME 27 10627
TEST_TIME 28 10681
TEST_TIME 29 10524
TEST_TIME 30 10602
TEST_TIME 31 10437
TEST_TIME 32 10268
TEST_TIME 33 10121
TEST_TIME 34 10126
TEST_TIME 35 10004
TEST_TIME 36 9919
TEST_TIME 37 9990
TEST_TIME 38 9956
TEST_TIME 39 9901
TEST_TIME 40 9858
TEST_TIME 41 9795
TEST_TIME 42 9745
TEST_TIME 43 9628
TEST_TIME 44 9611
TEST_TIME 45 9523
TEST_TIME 46 9680
TEST_TIME 47 9615
TEST_TIME 48 9684
TEST_TIME 49 9661
TEST_TIME 50 9736
TEST_TIME 51 9726
TEST_TIME 52 9669
TEST_TIME 53 9707
TEST_TIME 54 9758
TEST_TIME 55 9804
TEST_TIME 56 9798
TEST_TIME 57 9801
TEST_TIME 58 9978
TEST_TIME 59 10048
TEST_TIME 60 9910
TEST_TIME 61 9818
TEST_TIME 62 9778
TEST_TIME 63 9767
TEST_TIME 64 9721
TEST_TIME 65 9664
TEST_TIME 66 9643
TEST_TIME 67 9614
TEST_TIME 68 9622
TEST_TIME 69 9579
TEST_TIME 70 9587
TEST_TIME 71 9771
TEST_TIME 72 9796
TEST_TIME 73 9769
TEST_TIME 74 9762
TEST_TIME 75 9807
TEST_TIME 76 9828
TEST_TIME 77 9801
TEST_TIME 78 9837
TEST_TIME 79 9782
TEST_TIME 80 9672
TEST_TIME 81 9747
TEST_TIME 82 9652
TEST_TIME 83 9649
TEST_TIME 84 9631
TEST_TIME 85 9572
TEST_TIME 86 9559
TEST_TIME 87 9522
TEST_TIME 88 9469
TEST_TIME 89 9455
TEST_TIME 90 9374
TEST_TIME 91 9355
TEST_TIME 92 9340
TEST_TIME 93 9357
TEST_TIME 94 9394
TEST_TIME 95 9404
TEST_TIME 96 9390
TEST_TIME 97 9423
TEST_TIME 98 9409
TEST_TIME 99 9406
TEST_TIME 100 9402
TEST_TIME 101 9497
TEST_TIME 102 9495
TEST_TIME 103 9522
TEST_TIME 104 9535
TEST_TIME 105 9520
TEST_TIME 106 9496
TEST_TIME 107 9433
TEST_TIME 108 9411
TEST_TIME 109 9395
TEST_TIME 110 9348
TEST_TIME 111 9316
TEST_TIME 112 9296
TEST_TIME 113 9308
TEST_TIME 114 9303
TEST_TIME 115 9285
TEST_TIME 116 9340
TEST_TIME 117 9309
TEST_TIME 118 9323
TEST_TIME 119 9338
TEST_TIME 120 9272

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 10-07-2022 22:39:04 to 10-07-2022 22:39: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 1559287 1559287 0 0.00 0 20606 6 0 0
doc_list_biud 1559287 1559287 0 0.00 0 34281 22 0 0
sp_add_invoice_to_stock 5422 5301 121 2.23 53 192157 17751 0 121
sp_cancel_adding_invoice 5488 5488 0 0.00 4 58969 748 0 0
sp_cancel_client_order 1907 1907 0 0.00 4 11836 369 0 0
sp_cancel_customer_reserve 538207 538207 0 0.00 0 23097 50 0 0
sp_cancel_pay_from_customer 748 748 0 0.00 2 7869 94 0 0
sp_cancel_pay_to_supplier 477 477 0 0.00 3 4332 63 0 0
sp_cancel_supplier_invoice 6193 6182 11 0.17 1 20866 713 0 11
sp_cancel_supplier_order 419 419 0 0.00 7 929369 81506 0 0
sp_cancel_write_off 10574 10574 0 0.00 1 8054 96 0 0
sp_client_order 22184 22184 0 0.00 3 16362 355 0 0
sp_customer_reserve 482137 482137 0 0.00 0 48038 178 0 0
sp_fill_shopping_cart 34118 34118 0 0.00 1 18439 38 0 0
sp_fill_shopping_cart_clo_res 482135 482135 0 0.00 0 16308 14 0 0
sp_get_clo_for_invoice 5293 5293 0 0.00 0 31408 304 0 0
sp_kill_cost_storno 17287 17287 0 0.00 0 15631 47 0 0
sp_kill_qstorno_ret_qs2qd 1093589 1093589 0 0.00 0 23094 27 0 0
sp_kill_qty_storno 578984 578984 0 0.00 0 34280 60 0 0
sp_lock_selected_doc 22664 22664 0 0.00 0 9926 8 0 0
sp_make_cost_storno 30473 30473 0 0.00 0 9306 45 0 0
sp_multiply_rows_for_pdistr 30473 30473 0 0.00 0 8943 23 0 0
sp_multiply_rows_for_qdistr 22184 22184 0 0.00 0 12646 160 0 0
sp_pay_from_customer 7744 7744 0 0.00 3 13910 102 0 0
sp_pay_to_supplier 6522 6522 0 0.00 4 22526 115 0 0
sp_payment_common 14266 14266 0 0.00 1 22434 28 0 0
sp_qd_handle_on_cancel_clo 1907 1907 0 0.00 0 11826 329 0 0
sp_qd_handle_on_invoice_upd_sts 10778 10778 0 0.00 0 34279 305 0 0
sp_qd_handle_on_reserve_upd_sts 10917 10917 0 0.00 0 16091 54 0 0
sp_reserve_write_off 10917 10917 0 0.00 6 16100 158 0 0
sp_supplier_invoice 6052 6052 0 0.00 5 86622 3414 0 0
sp_supplier_order 5917 5917 0 0.00 3 25477 1239 0 0
srv_aggregate_perf_data 112 111 1 0.89 2999 439147 18193 0 1
srv_fill_mon_cache_memory 66 66 0 0.00 2099 126499 42526 0 0
srv_find_qd_qs_mism 1061408 1061408 0 0.00 0 20605 6 0 0
srv_make_invnt_saldo 631 631 0 0.00 28 41764 1072 0 0
srv_make_money_saldo 810 810 0 0.00 1 18102 48 0 0
srv_recalc_idx_stat 4 4 0 0.00 195126 487656 348472 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 11 11 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 5301 5301 0 0.00 0 10644 162 0 0
t$perf-norm:sp_cancel_adding_invoice 435 435 0 0.00 0 1940 64 0 0
t$perf-norm:sp_cancel_client_order 1907 1907 0 0.00 0 8604 20 0 0
t$perf-norm:sp_cancel_customer_reserve 808 808 0 0.00 0 2532 15 0 0
t$perf-norm:sp_cancel_pay_from_customer 748 748 0 0.00 0 2240 7 0 0
t$perf-norm:sp_cancel_pay_to_supplier 477 477 0 0.00 0 4746 16 0 0
t$perf-norm:sp_cancel_supplier_invoice 484 484 0 0.00 0 4699 29 0 0
t$perf-norm:sp_cancel_supplier_order 419 419 0 0.00 0 20256 1407 0 0
t$perf-norm:sp_cancel_write_off 1179 1179 0 0.00 0 15709 23 0 0
t$perf-norm:sp_client_order 22184 22184 0 0.00 0 7895 15 0 0
t$perf-norm:sp_customer_reserve 1099 1099 0 0.00 0 2963 8 0 0
t$perf-norm:sp_pay_from_customer 7744 7744 0 0.00 0 5070 10 0 0
t$perf-norm:sp_pay_to_supplier 6522 6522 0 0.00 0 4681 10 0 0
t$perf-norm:sp_reserve_write_off 10917 10917 0 0.00 0 6202 12 0 0
t$perf-norm:sp_supplier_invoice 6052 6052 0 0.00 0 5891 16 0 0
t$perf-norm:sp_supplier_order 5917 5917 0 0.00 0 3522 13 0 0
t$perf-norm:srv_aggregate_perf_data 111 111 0 0.00 0 145 5 0 0
t$perf-norm:srv_fill_mon_cache_memory 66 66 0 0.00 0 254 8 0 0
t$perf-norm:srv_make_invnt_saldo 631 631 0 0.00 0 2189 23 0 0
t$perf-norm:srv_make_money_saldo 810 810 0 0.00 0 764 11 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 4 3 0 0
v_add_invoice_to_stock 10820 10578 242 2.23 0 20128 19 0 242
v_all_customers 40388 40388 0 0.00 0 172 1 0 0
v_all_suppliers 33488 33488 0 0.00 0 18 1 0 0
v_all_wares 44368 44368 0 0.00 0 48 1 0 0
v_cancel_adding_invoice 870 870 0 0.00 0 1553 10 0 0
v_cancel_client_order 3814 3814 0 0.00 0 5127 6 0 0
v_cancel_customer_prepayment 1496 1496 0 0.00 0 569 3 0 0
v_cancel_customer_reserve 1616 1616 0 0.00 0 2656 5 0 0
v_cancel_payment_to_supplier 954 954 0 0.00 0 112 2 0 0
v_cancel_supplier_invoice 990 968 22 2.22 0 2553 17 0 22
v_cancel_supplier_order 838 838 0 0.00 0 344 3 0 0
v_cancel_write_off 2358 2358 0 0.00 0 872 12 0 0
v_max_id_clo_ord 5917 5917 0 0.00 0 1872 2 0 0
v_max_id_clo_res 1099 1099 0 0.00 0 1691 13 0 0
v_max_id_ord_sup 6017 6017 0 0.00 0 6660 5 0 0
v_max_non_paid_invoice 1712 1712 0 0.00 0 128 2 0 0
v_max_non_paid_realizn 4219 4219 0 0.00 0 4776 4 0 0
v_min_id_clo_ord 5917 5917 0 0.00 0 5982 7 0 0
v_min_id_clo_res 1099 1099 0 0.00 0 9105 12 0 0
v_min_id_ord_sup 6017 6017 0 0.00 0 5909 4 0 0
v_min_non_paid_invoice 6522 6522 0 0.00 0 22430 20 0 0
v_min_non_paid_realizn 7744 7744 0 0.00 0 13884 20 0 0
v_our_firm 11030 11030 0 0.00 0 22 1 0 0
v_reserve_write_off 21834 21834 0 0.00 0 3783 4 0 0
x_lock_depdocs_on_canc_invoice 11186 11186 0 0.00 0 27901 111 0 0
x_lock_depdocs_on_canc_sup_ord 419 419 0 0.00 0 9495 325 0 0
x_make_qstorno_1000_1200 5917 5917 0 0.00 1 25457 1163 0 0
x_make_qstorno_1200_2000 6052 6052 0 0.00 2 86338 3267 0 0
x_make_qstorno_2100_3300 482137 482137 0 0.00 0 46182 161 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-07-2022 22:39:08 to 10-07-2022 22:39: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
20:08:22 1 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:23 16084 8192000000 9892589712 10199531520 978914224 10.674 100 87 174 0 1007569952 5626672 23029056
20:10:47 7937 8192000000 9936764176 10255114240 1020139648 11.073 100 86 172 0 1050713424 8041376 22532400
20:12:04 11576 8192000000 9968734288 10296832000 1053878176 11.398 100 85 171 1 1084373184 9469872 21025136
20:13:24 8982 8192000000 10023954560 10368634880 1106083536 11.895 100 82 164 0 1136300992 10721664 19495792
20:14:35 3186 8192000000 10064095968 10418745344 1152408048 12.332 100 80 158 0 1182814320 12503872 17902400
20:15:42 5497 8192000000 10114928288 10481688576 1202294608 12.798 100 81 161 0 1232678880 12744384 17639888
20:16:51 2633 8192000000 10159277712 10529841152 1242124928 13.166 100 81 162 0 1273384736 13548128 17711680
20:17:55 1985 8192000000 10182043632 10561232896 1269063520 13.413 100 87 168 1 1299813904 12586496 18163888
20:19:04 830 8192000000 10217154304 10603319296 1306054224 13.750 100 92 181 1 1339812400 11843168 21915008
20:20:05 2546 8192000000 10212492480 10607861760 1304883568 13.740 100 66 132 1 1331116784 10808128 15425088
20:21:08 5780 8192000000 10215777280 10623561728 1319677392 13.874 100 44 89 0 1336333680 6612960 10043328
20:22:18 8674 8192000000 10217839792 10633900032 1329207968 13.960 100 24 49 0 1341904624 6800864 5895792
20:23:27 10442 8192000000 10222479184 10639458304 1337333200 14.033 100 37 72 1 1351720784 5451264 8936320
20:24:38 16673 8192000000 10228993120 10652205056 1340393616 14.061 100 28 52 0 1352584384 6660896 5529872
20:25:58 6922 8192000000 10239644464 10659397632 1343828944 14.092 100 24 48 0 1355078896 5708976 5540976
20:27:06 5386 8192000000 10218845184 10635640832 1311661520 13.801 98 28 56 0 1324238512 6129680 6447312
20:28:12 63064 8192000000 10187486064 10608037888 1247705440 13.217 94 30 59 1 1259947200 5150048 7091712
20:30:15 6740 8192000000 10177767184 10586812416 1284495280 13.554 99 32 64 1 1297993120 5856896 7640944
20:31:25 4088 8192000000 10117539680 10512920576 1200423968 12.780 97 21 43 0 1210755984 5320496 5011520
20:32:30 74095 8192000000 10145162640 10557808640 1238889536 13.136 98 30 59 1 1251234640 5337008 7008096
20:34:46 4445 8192000000 10180456464 10588151808 1284364704 13.553 100 37 71 1 1298217680 6006064 7846912
20:35:54 9331 8192000000 10193934576 10607538176 1301292592 13.707 100 24 46 0 1311989008 5719408 4977008
20:37:03 19055 8192000000 10201603728 10611122176 1304209600 13.734 100 19 38 0 1314112384 5150112 4752672
20:38:22 28388 8192000000 10228167632 10638835712 1322839696 13.902 100 47 94 1 1340460320 6602640 11017984
20:40:03 39064 8192000000 10256607760 10674446336 1349138896 14.140 100 34 68 0 1365734736 8096480 8499360
20:41:48 6587 8192000000 10283791040 10698162176 1369897408 14.326 100 49 99 1 1396173824 14478448 11797968
20:43:03 17686 8192000000 10285733888 10712174592 1376780672 14.388 100 34 68 0 1398446112 13148496 8516944
20:44:27 20084 8192000000 10295278992 10723119104 1365308992 14.285 98 43 85 0 1395381536 19688080 10384464
20:45:51 13521 8192000000 10303220992 10728251392 1385063696 14.462 100 47 92 0 1414500640 19086480 10350464
20:47:16 8046 8192000000 10328377488 10745208832 1396679184 14.565 100 63 125 1 1434702368 23729264 14293920
20:48:27 6090 8192000000 10315799152 10737258496 1384186080 14.454 99 54 107 1 1426120480 29517120 12417280
20:49:40 2180 8192000000 10303161408 10716012544 1364452384 14.277 100 55 109 1 1409391168 31768304 13170480
20:50:49 2459 8192000000 10318949712 10726248448 1370974016 14.336 100 82 163 1 1425015664 34599232 19442416
20:51:56 5462 8192000000 10332236464 10742366208 1380510624 14.421 100 77 154 1 1439154848 39856640 18787584
20:53:07 6530 8192000000 10325532512 10734465024 1364727760 14.280 99 72 143 0 1424839552 41642096 18469696
20:54:21 3211 8192000000 10315978176 10726105088 1359879488 14.236 100 70 140 0 1420471456 42725568 17866400
20:55:29 2099 8192000000 10337185408 10748866560 1373511728 14.358 100 75 147 1 1442592272 51113568 17966976
20:56:36 2280 8192000000 10325285600 10734399488 1373958720 14.363 100 82 162 0 1430817584 36953888 19904976
20:57:42 6940 8192000000 10299908512 10722095104 1330927568 13.976 97 48 96 0 1376561856 33196960 12437328
20:58:52 10699 8192000000 10300962544 10731679744 1370463376 14.331 100 33 65 0 1406801488 27877168 8460944
21:00:07 18746 8192000000 10302994736 10730512384 1359728512 14.235 99 23 44 1 1401169520 34999056 6441952
21:01:30 17900 8192000000 10283679120 10720186368 1338802160 14.047 98 22 43 0 1380217456 35013824 6401472
21:02:57 19454 8192000000 10273430480 10704293888 1331352416 13.979 98 19 38 1 1353993424 18324416 4316592
21:04:24 19033 8192000000 10281320672 10722967552 1355087664 14.193 100 20 40 0 1390131264 29821424 5222176
21:05:47 34376 8192000000 10278041328 10704056320 1312440512 13.808 97 16 30 0 1330704096 14852288 3411296
21:07:24 73262 8192000000 10268727168 10713448448 1356976224 14.210 100 23 45 1 1376967888 14818112 5173552
21:09:40 97448 8192000000 10278291680 10729889792 1353608208 14.180 98 26 52 1 1369614096 10157216 5848672
21:12:36 77065 8192000000 10288594816 10753945600 1382797264 14.442 100 14 28 0 1402008016 15919888 3290864
21:14:55 28957 8192000000 10303286608 10747015168 1388866240 14.496 100 56 112 1 1411856800 8163584 14826976
21:16:27 13585 8192000000 10283140640 10733191168 1369463696 14.322 99 36 72 0 1385565872 8588832 7513344
21:17:43 35535 8192000000 10298492992 10755313664 1397405936 14.572 100 18 36 0 1410199216 8648304 4144976
21:19:26 33922 8192000000 10294267264 10755817472 1396761664 14.566 100 14 27 0 1408565232 8912128 2891440
21:21:00 77787 8192000000 10292781440 10750083072 1365364672 14.285 97 15 30 0 1381701712 11654224 4682816
21:23:48 47634 8192000000 10282954128 10750857216 1367218096 14.302 98 11 22 0 1388676608 18463648 2994864
21:25:41 70860 8192000000 10306373504 10773520384 1391685952 14.521 99 12 24 0 1405875136 11458032 2731152
21:27:53 59664 8192000000 10305757424 10772979712 1383122112 14.444 98 16 32 0 1402287472 15703936 3461424
21:29:53 33766 8192000000 10292760048 10737676288 1348565968 14.135 97 38 76 0 1365790688 8899184 8325536
21:31:26 23650 8192000000 10292537968 10738298880 1335040032 14.013 96 37 75 0 1356966224 13591344 8334848
21:32:51 46644 8192000000 10294188144 10751852544 1371173120 14.338 99 17 34 0 1389092784 14240368 3679296
21:34:39 31350 8192000000 10326537152 10766594048 1390687888 14.512 100 37 74 0 1417030384 18088640 8253856
21:36:20 70080 8192000000 10297789760 10764619776 1335254480 14.015 96 20 38 1 1366211584 25579920 5377184
21:38:38 114555 8192000000 10273150832 10715734016 1305081216 13.741 94 39 78 0 1323770336 10013760 8675360
21:41:34 87051 8192000000 10252469120 10712969216 1323298752 13.907 97 18 36 0 1337484384 10336064 3849568
21:44:02 38728 8192000000 10268748944 10722205696 1348225824 14.132 99 17 34 0 1365698432 12968192 4504416
21:45:46 26114 8192000000 10291060560 10725580800 1353841216 14.182 99 23 46 1 1375771856 16676912 5253728
21:47:21 53737 8192000000 10292752656 10740486144 1378694368 14.405 100 24 47 0 1404418512 19896352 5827792
21:49:15 40990 8192000000 10285708080 10748125184 1360321152 14.240 99 14 28 0 1382527216 18883184 3322880
21:50:56 13430 8192000000 10286227392 10718855168 1355474416 14.197 99 62 120 3 1375734736 5474464 14785856
21:52:12 69248 8192000000 10274113568 10732003328 1317266224 13.852 96 22 44 0 1336916320 14769424 4880672
21:54:23 44670 8192000000 10298956992 10737807360 1361214288 14.248 99 38 75 0 1382036960 11778592 9044080
21:56:12 126499 8192000000 10282358784 10738016256 1340299136 14.060 97 17 34 0 1355101408 10880944 3921328
21:59:30 78005 8192000000 10258561984 10724155392 1344150480 14.095 98 10 18 0 1361233952 15125376 1958096
22:01:48 39102 8192000000 10283532304 10745790464 1379864928 14.415 100 28 56 0 1397182032 10643664 6673440
22:03:31 46756 8192000000 10287827328 10745098240 1378581600 14.404 99 13 26 0 1388457248 6885024 2990624
22:05:32 61155 8192000000 10255816112 10712842240 1344416912 14.097 97 6 11 0 1352157536 6557216 1183408
22:09:18 71394 8192000000 10286537024 10759262208 1379477360 14.412 99 11 18 0 1389193952 7217152 2499440
22:11:29 59246 8192000000 10300347824 10763464704 1394893440 14.550 100 14 28 0 1407504992 9602368 3009184
22:13:29 56778 8192000000 10272708048 10736562176 1312691408 13.810 94 17 34 1 1327884208 11026352 4166448
22:15:30 37445 8192000000 10293257904 10753916928 1382876144 14.442 100 27 54 0 1400631312 11918896 5836272
22:17:08 40781 8192000000 10298978608 10751848448 1371703232 14.342 99 36 73 0 1397220720 17459616 8057872
22:18:53 101492 8192000000 10287205664 10747355136 1316708736 13.847 95 17 34 0 1342253168 21642080 3902352
22:22:37 79557 8192000000 10277255616 10723164160 1319045728 13.868 96 20 38 1 1331628384 8615680 3966976
22:24:57 86743 8192000000 10265464512 10725613568 1353202560 14.176 99 24 48 0 1370058976 11850144 5006272
22:27:25 65884 8192000000 10230028032 10685267968 1320896416 13.885 97 9 16 0 1329534032 6810384 1827232
22:29:33 68991 8192000000 10237046848 10692173824 1279871360 13.512 94 6 12 0 1291666608 10100560 1694688
22:31:43 32077 8192000000 10247722208 10703495168 1315613792 13.837 97 25 49 0 1328378256 7133376 5631088
22:33:24 68088 8192000000 10263289840 10725728256 1353371920 14.178 99 18 36 0 1368725856 10879456 4474480
22:35:36 72953 8192000000 10253946112 10703859712 1279431104 13.508 94 16 32 1 1296803584 13532800 3839680
22:37:53 13125 8192000000 10272720768 10707451904 1351806592 14.164 100 35 70 0 1367607792 8368720 7432480

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 10-07-2022 22:39:14 to 10-07-2022 22:39:29.

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 11 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 10-07-2022 22:39:30 to 10-07-2022 22:39:32.

Content of mon$database and FB version

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


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

Database statistics

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

Database validation

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

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

--- start of diff output ---
:852: 
:853: mscs-test-161.budzdorov.ru    Sun Jul 10 22:38:21 2022
:854:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3333
:855: 
:856: 
:857: mscs-test-161.budzdorov.ru    Sun Jul 10 22:38:22 2022
:858:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3333
:859: 
--- end of diff output ---

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

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