Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 26.10.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 15330304 kB
MemAvailable 30471168 kB
Buffers 0 kB
Cached 16409464 kB
SwapCached 1976 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.3
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-10-26 10:37:24
DTS_END                         2022-10-26 10:37:24.0570
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_AGGREGATE_PERF_DATA(83:5) ==> TMP_AGGREGATE_PERF_DATA_AUTOGEN(495:9) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/36106
TRN_ID                          213902
ATT_ID                          625
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: 8883.61 30188 1066033
customer order: creation 162.58 497 19510
customer order: refuse 14.31 454 1717
order to supplier: creation 43.72 1349 5246
order to supplier: removal 3.43 176546 412
invoice (draft): creation 43.19 3179 5183
invoice (draft): removal 50.41 979 6049
invoice accept: apply 39.76 29512 4771
invoice accept: cancel 45.49 1385 5459
customer reserve: creation 3680.61 283 441673
customer reserve: removal 4519.02 106 542283
realization accept: apply 79.67 297 9560
realization accept: cancel 73.89 188 8867
payment from customer: creation 58.33 191 6999
payment from customer: removal 5.73 147 688
payment to supplier: creation 47.79 199 5735
payment to supplier: removal 3.16 144 379
service: total inventory turnovers 3.92 4562 470
service: total monetary turnovers 7.64 430 917
service: aggregate perf. data 0.93 15575 111
service: refresh index statistics 0.03 367731 4

Performance in TOTAL, chart


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

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7427
TEST_TIME 2 7213
TEST_TIME 3 6559
TEST_TIME 4 5857
TEST_TIME 5 5696
TEST_TIME 6 6041
TEST_TIME 7 5864
TEST_TIME 8 5831
TEST_TIME 9 5778
TEST_TIME 10 5675
TEST_TIME 11 5900
TEST_TIME 12 6546
TEST_TIME 13 6618
TEST_TIME 14 6569
TEST_TIME 15 6506
TEST_TIME 16 6772
TEST_TIME 17 6826
TEST_TIME 18 6898
TEST_TIME 19 6923
TEST_TIME 20 7101
TEST_TIME 21 7174
TEST_TIME 22 7264
TEST_TIME 23 7215
TEST_TIME 24 7453
TEST_TIME 25 7619
TEST_TIME 26 8283
TEST_TIME 27 8519
TEST_TIME 28 8502
TEST_TIME 29 8886
TEST_TIME 30 9217
TEST_TIME 31 9326
TEST_TIME 32 9435
TEST_TIME 33 9953
TEST_TIME 34 10150
TEST_TIME 35 10495
TEST_TIME 36 10260
TEST_TIME 37 10274
TEST_TIME 38 10128
TEST_TIME 39 10017
TEST_TIME 40 9779
TEST_TIME 41 9615
TEST_TIME 42 9691
TEST_TIME 43 9537
TEST_TIME 44 9724
TEST_TIME 45 9598
TEST_TIME 46 9600
TEST_TIME 47 9489
TEST_TIME 48 9494
TEST_TIME 49 9457
TEST_TIME 50 9437
TEST_TIME 51 9356
TEST_TIME 52 9328
TEST_TIME 53 9215
TEST_TIME 54 9260
TEST_TIME 55 9251
TEST_TIME 56 9207
TEST_TIME 57 9077
TEST_TIME 58 9108
TEST_TIME 59 9053
TEST_TIME 60 8995
TEST_TIME 61 8939
TEST_TIME 62 8904
TEST_TIME 63 8985
TEST_TIME 64 8956
TEST_TIME 65 8953
TEST_TIME 66 9000
TEST_TIME 67 8999
TEST_TIME 68 9112
TEST_TIME 69 9056
TEST_TIME 70 9119
TEST_TIME 71 9073
TEST_TIME 72 9189
TEST_TIME 73 9255
TEST_TIME 74 9245
TEST_TIME 75 9240
TEST_TIME 76 9160
TEST_TIME 77 9111
TEST_TIME 78 9063
TEST_TIME 79 9053
TEST_TIME 80 9021
TEST_TIME 81 8936
TEST_TIME 82 8897
TEST_TIME 83 8850
TEST_TIME 84 8894
TEST_TIME 85 8928
TEST_TIME 86 8902
TEST_TIME 87 8860
TEST_TIME 88 8892
TEST_TIME 89 8857
TEST_TIME 90 8871
TEST_TIME 91 8886
TEST_TIME 92 8994
TEST_TIME 93 9068
TEST_TIME 94 9075
TEST_TIME 95 9088
TEST_TIME 96 9144
TEST_TIME 97 9087
TEST_TIME 98 9021
TEST_TIME 99 9023
TEST_TIME 100 9018
TEST_TIME 101 8999
TEST_TIME 102 8941
TEST_TIME 103 8920
TEST_TIME 104 8911
TEST_TIME 105 8882
TEST_TIME 106 8870
TEST_TIME 107 8839
TEST_TIME 108 8856
TEST_TIME 109 8857
TEST_TIME 110 8897
TEST_TIME 111 8882
TEST_TIME 112 8892
TEST_TIME 113 8879
TEST_TIME 114 8912
TEST_TIME 115 8889
TEST_TIME 116 8890
TEST_TIME 117 8886
TEST_TIME 118 9061
TEST_TIME 119 8987
TEST_TIME 120 8915

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 26-10-2022 10:39:11 to 26-10-2022 10:39:15.

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 1473907 1473907 0 0.00 0 34378 15 0 0
doc_list_biud 1473885 1473885 0 0.00 0 48400 45 0 0
sp_add_invoice_to_stock 4950 4771 179 3.61 72 212763 29513 0 179
sp_cancel_adding_invoice 5459 5459 0 0.00 6 89709 1386 0 0
sp_cancel_client_order 1717 1717 0 0.00 7 8526 455 0 0
sp_cancel_customer_reserve 542283 542283 0 0.00 1 48443 107 0 0
sp_cancel_pay_from_customer 688 688 0 0.00 4 5545 147 0 0
sp_cancel_pay_to_supplier 379 379 0 0.00 4 3985 145 0 0
sp_cancel_supplier_invoice 6074 6049 25 0.41 2 33025 979 0 25
sp_cancel_supplier_order 412 412 0 0.00 9 1351014 176547 0 0
sp_cancel_write_off 8867 8867 0 0.00 2 11088 189 0 0
sp_client_order 19510 19510 0 0.00 6 33132 498 0 0
sp_customer_reserve 441673 441673 0 0.00 0 115722 284 0 0
sp_fill_shopping_cart 29927 29927 0 0.00 1 19311 82 0 0
sp_fill_shopping_cart_clo_res 441637 441637 0 0.00 0 16918 20 0 0
sp_get_clo_for_invoice 4727 4727 0 0.00 0 25378 280 0 0
sp_kill_cost_storno 15393 15393 0 0.00 0 11086 81 0 0
sp_kill_qstorno_ret_qs2qd 1099894 1099894 0 0.00 0 48320 46 0 0
sp_kill_qty_storno 579070 579070 0 0.00 0 48396 106 0 0
sp_lock_selected_doc 19928 19928 0 0.00 0 8860 7 0 0
sp_make_cost_storno 27021 27021 0 0.00 0 20704 89 0 0
sp_multiply_rows_for_pdistr 27020 27020 0 0.00 0 10980 41 0 0
sp_multiply_rows_for_qdistr 19508 19508 0 0.00 0 9986 208 0 0
sp_pay_from_customer 6999 6999 0 0.00 5 19537 191 0 0
sp_pay_to_supplier 5735 5735 0 0.00 6 22624 199 0 0
sp_payment_common 12733 12733 0 0.00 2 9380 48 0 0
sp_qd_handle_on_cancel_clo 1717 1717 0 0.00 1 8515 369 0 0
sp_qd_handle_on_invoice_upd_sts 10185 10185 0 0.00 0 35604 556 0 0
sp_qd_handle_on_reserve_upd_sts 9557 9557 0 0.00 0 20593 64 0 0
sp_reserve_write_off 9560 9560 0 0.00 9 20660 298 0 0
sp_supplier_invoice 5183 5183 0 0.00 6 86553 3180 0 0
sp_supplier_order 5246 5246 0 0.00 7 54603 1350 0 0
srv_aggregate_perf_data 112 111 1 0.89 2028 117686 15576 0 1
srv_fill_mon_cache_memory 70 70 0 0.00 855 183513 34101 0 0
srv_find_qd_qs_mism 1019598 1019598 0 0.00 0 34370 11 0 0
srv_make_invnt_saldo 470 470 0 0.00 87 66037 4562 0 0
srv_make_money_saldo 917 917 0 0.00 1 17768 430 0 0
srv_recalc_idx_stat 4 4 0 0.00 214732 486883 367731 0 0
t$perf-abend:sp_add_invoice_to_stock 179 179 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 25 25 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 4781 4781 0 0.00 1 13503 980 0 0
t$perf-norm:sp_cancel_adding_invoice 401 401 0 0.00 1 6445 536 0 0
t$perf-norm:sp_cancel_client_order 1717 1717 0 0.00 0 4790 39 0 0
t$perf-norm:sp_cancel_customer_reserve 689 689 0 0.00 0 1578 28 0 0
t$perf-norm:sp_cancel_pay_from_customer 688 688 0 0.00 0 2133 16 0 0
t$perf-norm:sp_cancel_pay_to_supplier 379 379 0 0.00 0 622 14 0 0
t$perf-norm:sp_cancel_supplier_invoice 393 393 0 0.00 0 1196 44 0 0
t$perf-norm:sp_cancel_supplier_order 412 412 0 0.00 0 105190 7252 0 0
t$perf-norm:sp_cancel_write_off 973 973 0 0.00 0 2451 25 0 0
t$perf-norm:sp_client_order 19511 19511 0 0.00 0 4528 40 0 0
t$perf-norm:sp_customer_reserve 993 993 0 0.00 0 2420 26 0 0
t$perf-norm:sp_pay_from_customer 6999 6999 0 0.00 0 8655 20 0 0
t$perf-norm:sp_pay_to_supplier 5735 5735 0 0.00 0 5911 21 0 0
t$perf-norm:sp_reserve_write_off 9561 9561 0 0.00 0 4530 23 0 0
t$perf-norm:sp_supplier_invoice 5183 5183 0 0.00 0 3487 32 0 0
t$perf-norm:sp_supplier_order 5246 5246 0 0.00 0 3473 35 0 0
t$perf-norm:srv_aggregate_perf_data 111 111 0 0.00 0 1336 32 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 927 17 0 0
t$perf-norm:srv_make_invnt_saldo 470 470 0 0.00 0 4030 26 0 0
t$perf-norm:srv_make_money_saldo 917 917 0 0.00 0 3532 9 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 5 198 59 0 0
v_add_invoice_to_stock 9794 9436 358 3.65 0 5318 26 0 358
v_all_customers 36322 36322 0 0.00 0 135 4 0 0
v_all_suppliers 29608 29608 0 0.00 0 73 4 0 0
v_all_wares 39006 39006 0 0.00 0 60 4 0 0
v_cancel_adding_invoice 802 802 0 0.00 0 889 16 0 0
v_cancel_client_order 3434 3434 0 0.00 0 2892 15 0 0
v_cancel_customer_prepayment 1376 1376 0 0.00 0 2183 12 0 0
v_cancel_customer_reserve 1378 1378 0 0.00 1 2338 16 0 0
v_cancel_payment_to_supplier 758 758 0 0.00 0 2108 24 0 0
v_cancel_supplier_invoice 836 786 50 5.98 0 4316 35 0 50
v_cancel_supplier_order 824 824 0 0.00 0 4410 23 0 0
v_cancel_write_off 1946 1946 0 0.00 0 1738 24 0 0
v_max_id_clo_ord 5242 5242 0 0.00 0 691 5 0 0
v_max_id_clo_res 993 993 0 0.00 0 3361 22 0 0
v_max_id_ord_sup 5181 5181 0 0.00 0 5422 10 0 0
v_max_non_paid_invoice 1354 1354 0 0.00 0 144 8 0 0
v_max_non_paid_realizn 3440 3440 0 0.00 0 3284 9 0 0
v_min_id_clo_ord 5242 5242 0 0.00 0 1807 8 0 0
v_min_id_clo_res 993 993 0 0.00 0 4233 16 0 0
v_min_id_ord_sup 5181 5181 0 0.00 0 6042 10 0 0
v_min_non_paid_invoice 5734 5734 0 0.00 0 5139 14 0 0
v_min_non_paid_realizn 6998 6998 0 0.00 0 9363 20 0 0
v_our_firm 9800 9800 0 0.00 0 79 5 0 0
v_reserve_write_off 19114 19114 0 0.00 0 5119 14 0 0
x_lock_depdocs_on_canc_invoice 11115 11115 0 0.00 0 15203 123 0 0
x_lock_depdocs_on_canc_sup_ord 412 412 0 0.00 0 9242 406 0 0
x_make_qstorno_1000_1200 5246 5246 0 0.00 3 54568 1176 0 0
x_make_qstorno_1200_2000 5183 5183 0 0.00 3 86432 2957 0 0
x_make_qstorno_2100_3300 441670 441670 0 0.00 0 115720 250 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 26-10-2022 10:39:16 to 26-10-2022 10:39:20.

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:27 15 8192000000 8811811568 8828022784 13919600 0.169 7 1 2 0 14037440 82064 35776
08:08:28 15535 8192000000 9708256528 10007244800 794162768 8.837 100 87 174 0 823001920 7531760 21307392
08:09:51 18841 8192000000 9763776144 10078748672 842308592 9.323 100 88 176 0 874963088 11356640 21297856
08:11:17 16741 8192000000 9803772192 10125737984 879340144 9.693 100 85 170 0 916147584 16858672 19948768
08:12:39 9663 8192000000 9857941168 10187153408 911313312 10.010 100 83 166 0 967333104 37674880 18344912
08:13:51 6101 8192000000 9917922592 10260406272 950081264 10.392 100 87 172 0 1025220720 56872048 18267408
08:15:03 2957 8192000000 9959769712 10312122368 982741632 10.711 100 83 166 0 1076201072 76511760 16947680
08:16:12 1324 8192000000 9999034016 10359668736 1013691680 11.011 100 90 170 0 1116467472 85785888 16989904
08:17:16 1046 8192000000 10012007088 10381246464 1033159328 11.199 100 92 173 0 1127003824 75819296 18025200
08:18:18 1268 8192000000 10017594768 10388729856 1047889120 11.340 100 89 171 2 1137298192 71190416 18218656
08:19:21 7416 8192000000 10043232736 10415951872 1059417792 11.451 100 92 175 1 1162035376 85094800 17522784
08:20:31 978 8192000000 10029622048 10415267840 1063706288 11.492 100 98 188 2 1153891424 71935328 18249808
08:21:35 1102 8192000000 10051058944 10433585152 1068194624 11.535 100 97 189 4 1171993952 85221408 18577920
08:22:38 1183 8192000000 10064062736 10448584704 1080688960 11.654 100 97 188 2 1183637168 82877952 20070256
08:23:40 1281 8192000000 10060978288 10447257600 1080274640 11.650 100 97 188 1 1184069328 84914016 18880672
08:24:43 1373 8192000000 10063425536 10448113664 1088005520 11.724 100 97 187 0 1184556368 78424848 18126000
08:25:46 1009 8192000000 10068447312 10453557248 1089294720 11.736 100 95 187 0 1190687568 83039440 18353408
08:26:49 1136 8192000000 10065140624 10455011328 1094727936 11.788 100 96 179 0 1187379984 74250320 18401728
08:27:53 1233 8192000000 10071870256 10460696576 1102698064 11.863 100 96 184 1 1191752928 71542048 17512816
08:28:56 1244 8192000000 10054894912 10440409088 1099868592 11.836 100 95 182 0 1181004352 62163936 18971824
08:29:58 2927 8192000000 10055792512 10448650240 1099309440 11.831 100 78 150 0 1176998224 62693088 14995696
08:31:02 1558 8192000000 10046665136 10436096000 1074918560 11.599 100 85 164 1 1171727456 80254432 16554464
08:32:04 1029 8192000000 10041336720 10426290176 1086767136 11.712 100 95 175 2 1167807792 63405136 17635520
08:33:07 1204 8192000000 10028035936 10408374272 1069326176 11.546 100 90 180 0 1150592720 62919104 18347440
08:34:10 1136 8192000000 10010113440 10388160512 1056288800 11.421 100 95 169 3 1133502912 60193680 17020432
08:35:12 1119 8192000000 10029370896 10405900288 1049400096 11.355 100 100 193 2 1150927136 82673680 18853360
08:36:14 900 8192000000 9995884336 10371289088 1051854368 11.378 100 86 166 3 1125912800 56800016 17258416
08:37:16 1216 8192000000 10016770624 10396762112 1048637680 11.348 100 84 163 1 1140636048 76538256 15460112
08:38:30 2790 8192000000 10008113888 10383167488 1044298480 11.306 99 89 172 1 1118913200 57574208 17040512
08:39:37 5284 8192000000 10030071136 10418765824 1061848336 11.474 100 67 125 2 1152374064 78197904 12327824
08:40:51 4010 8192000000 10022626192 10418835456 1062338672 11.479 99 56 111 0 1135595424 61950944 11305808
08:41:58 4960 8192000000 10052665504 10437435392 1079749104 11.645 100 69 136 2 1172767568 78895744 14122720
08:43:07 14011 8192000000 10081558128 10472656896 1080407968 11.651 99 71 139 0 1200161344 105413312 14340064
08:44:25 5239 8192000000 10111352688 10503188480 1101963872 11.856 100 77 150 3 1226833232 109585344 15284016
08:45:34 1272 8192000000 10158192176 10549563392 1106867360 11.903 100 93 184 1 1279515024 150327648 22320016
08:46:40 2383 8192000000 10170544784 10558644224 1109591968 11.929 99 81 155 1 1290710784 164462800 16656016
08:47:49 1517 8192000000 10237215968 10629107712 1135234416 12.171 100 85 160 2 1352011968 199510304 17267248
08:48:56 923 8192000000 10252662544 10675904512 1146134880 12.273 100 96 177 2 1363623744 198308224 19180640
08:50:00 1424 8192000000 10252753248 10658320384 1156904432 12.374 100 83 158 1 1363484816 189031536 17548848
08:51:08 3951 8192000000 10276130672 10685267968 1163572592 12.437 100 82 163 1 1391939648 211037504 17329552
08:52:15 2759 8192000000 10329596464 10738098176 1178633040 12.577 100 67 133 0 1440057472 246394448 15029984
08:53:21 946 8192000000 10371297392 10791673856 1189533904 12.679 100 96 182 2 1482706192 272839056 20333232
08:54:24 842 8192000000 10405688672 10811482112 1189136288 12.675 100 98 190 2 1512884864 302222880 21525696
08:55:30 1284 8192000000 10433172288 10839724032 1200756448 12.783 100 97 188 0 1540544368 318393696 21394224
08:56:36 1816 8192000000 10492513920 10911141888 1207222720 12.843 100 96 183 1 1600787872 372594448 20970704
08:57:43 882 8192000000 10484366560 10916499456 1195149808 12.731 99 95 184 0 1590419088 372810784 22458496
08:58:48 932 8192000000 10516198048 10937462784 1202637952 12.801 100 94 180 0 1620593968 396638096 21317920
08:59:51 1108 8192000000 10544582032 10967089152 1198441456 12.762 100 97 190 0 1651455664 429794160 23220048
09:00:55 948 8192000000 10575727456 11026862080 1197161984 12.750 100 97 192 0 1681359072 460377440 23819648
09:01:59 1727 8192000000 10578468176 11046199296 1199336064 12.770 100 92 178 1 1680585712 460015456 21234192
09:03:04 909 8192000000 10569344736 11038646272 1185767920 12.644 100 98 192 1 1673804896 464071440 23965536
09:04:07 5546 8192000000 10452626720 10912423936 1155699792 12.363 99 50 96 1 1559379808 391098688 12581328
09:05:15 20032 8192000000 10479550512 10922622976 1174657408 12.540 100 44 88 1 1574665680 389055312 10952960
09:06:52 29222 8192000000 10383189888 10841763840 1146670736 12.278 100 23 46 0 1480223792 327453792 6099264
09:08:25 43553 8192000000 10326636832 10815856640 1141448496 12.229 99 21 42 0 1463244656 316403168 5392992
09:10:18 10487 8192000000 10225894672 10734702592 1137613648 12.193 99 28 56 1 1360491616 216147216 6730752
09:11:33 56247 8192000000 10081052208 10627977216 1114489248 11.975 98 17 32 1 1212256960 93862688 3905024
09:13:31 866 8192000000 10093225008 10505474048 1134265600 12.162 100 71 135 2 1188701856 39082112 15354144
09:14:33 4304 8192000000 10142349808 10569723904 1144477936 12.258 100 58 104 1 1248032992 91222288 12332768
09:15:42 39683 8192000000 10170637808 10600325120 1134032608 12.159 98 35 63 1 1240689200 99685328 6971264
09:17:40 140565 8192000000 10160027648 10678190080 1134249760 12.161 99 22 42 0 1252191984 113655536 4286688
09:21:42 40895 8192000000 10126225680 10580443136 1145567648 12.268 100 37 72 0 1219460288 66334448 7558192
09:23:31 27869 8192000000 10129380320 10595020800 1151378144 12.322 100 34 66 0 1231906704 73220928 7307632
09:25:23 183490 8192000000 10099541920 10576490496 1107127904 11.905 96 18 35 0 1177925840 67420976 3376960
09:29:36 76665 8192000000 10101369776 10544300032 1118420144 12.012 98 24 48 0 1183783648 60520320 4843184
09:31:55 33932 8192000000 10083677632 10526892032 1124878608 12.073 99 38 72 0 1179762304 46342944 8540752
09:33:29 110279 8192000000 10117419920 10571968512 1139021712 12.206 99 29 56 0 1229857264 85142576 5692976
09:37:17 72337 8192000000 10094528448 10567872512 1132281888 12.143 98 22 44 0 1199584224 62579792 4722544
09:39:36 65793 8192000000 10085917840 10543820800 1131637040 12.137 98 16 31 2 1188157488 53053104 3467344
09:41:43 24934 8192000000 10107635600 10559414272 1143810992 12.251 100 44 86 0 1200472336 47943936 8717408
09:43:08 29673 8192000000 10141056256 10573320192 1136243328 12.180 99 46 90 1 1222254496 76212064 9799104
09:45:06 111264 8192000000 10160298192 10603810816 1076300416 11.612 94 22 44 0 1151250672 70508368 4441888
09:47:58 46492 8192000000 10143472672 10582011904 1104798112 11.883 97 30 60 0 1204926256 93800496 6327648
09:49:45 24689 8192000000 10091544224 10563088384 1116046928 11.990 99 43 80 0 1191778784 67645888 8085968
09:51:12 36756 8192000000 10106060704 10542682112 1123625744 12.061 99 47 93 0 1178337824 45608400 9103680
09:53:19 57620 8192000000 10072133248 10503860224 1110052688 11.933 98 36 70 0 1150854512 33579200 7222624
09:55:21 15792 8192000000 10063350352 10501505024 1108854256 11.922 99 46 88 1 1158059952 40227856 8977840
09:56:38 64059 8192000000 10073488928 10547716096 1117965056 12.008 99 26 52 0 1205247296 81991888 5290352
09:58:43 49302 8192000000 10115628800 10567815168 1110653536 11.939 98 19 36 0 1185277328 70057920 4565872
10:00:58 70103 8192000000 10107796016 10609827840 1116104016 11.990 99 25 50 0 1250924448 128986496 5833936
10:03:19 28146 8192000000 10133397424 10577727488 1142309056 12.237 100 27 53 0 1221597120 73261040 6027024
10:04:52 23247 8192000000 10153913280 10614538240 1114601776 11.976 98 39 73 0 1223735360 101307728 7825856
10:06:19 31528 8192000000 10180119328 10629316608 1145519088 12.267 100 34 67 0 1266818576 113585104 7714384
10:07:53 50127 8192000000 10203573952 10684178432 1136496448 12.183 99 31 62 0 1328175504 184505696 7173360
10:11:33 34629 8192000000 10127588752 10576814080 1128855744 12.111 99 39 78 0 1221214048 84778176 7580128
10:13:09 35586 8192000000 10110014368 10563067904 1141069856 12.226 100 32 64 0 1226197360 78775136 6352368
10:14:48 143976 8192000000 10080217120 10587627520 1114287536 11.973 98 23 46 0 1191380704 72318768 4774400
10:18:29 44721 8192000000 10066202768 10535280640 1117802016 12.006 98 8 16 0 1167750048 48446864 1501168
10:20:14 44297 8192000000 10034022464 10506616832 1098366272 11.822 98 7 14 0 1131810176 32253200 1190704
10:22:20 39617 8192000000 10058153648 10507350016 1097138144 11.810 97 23 46 0 1126749392 24933872 4677376
10:24:02 32802 8192000000 10108346320 10553520128 1140609936 12.221 100 29 58 0 1188675760 42188496 5877328
10:25:45 67817 8192000000 10132781168 10603556864 1134662512 12.165 99 20 40 0 1221676864 82427056 4587296
10:27:53 55747 8192000000 10122768832 10571280384 1113903776 11.969 97 29 53 1 1183994528 63996560 6094192
10:29:59 37324 8192000000 10139718720 10587164672 1110689968 11.939 97 31 60 0 1201471168 84061616 6719584
10:31:43 17852 8192000000 10125076320 10562301952 1128043856 12.103 99 48 89 1 1207465408 70682080 8739472
10:33:03 8701 8192000000 10170028080 10611539968 1137722400 12.194 100 58 110 1 1260539584 110466960 12350224
10:34:13 43048 8192000000 10231204992 10677383168 1137760624 12.194 99 35 70 0 1322275184 176913808 7600752
10:35:57 93231 8192000000 9192920736 9482895360 334187648 3.919 31 10 20 0 344312032 8304096 1820288

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 26-10-2022 10:39:22 to 26-10-2022 10:39:38.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 179 v_add_invoice_to_stock 335544517
except 25 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 26-10-2022 10:39:39 to 26-10-2022 10:39:41.

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          214292
MON$OLDEST_ACTIVE               214293
MON$OLDEST_SNAPSHOT             214293
MON$NEXT_TRANSACTION            214293
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                       2044704
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             767
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2863 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2863 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2863 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2863 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 ---
:19: 
:20: mscs-test-161.budzdorov.ru    Wed Oct 26 10:37:32 2022
:21:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:22: 
:23: 
:24: mscs-test-161.budzdorov.ru    Wed Oct 26 10:37:32 2022
:25:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:26: 
--- end of diff output ---

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

26.10.22 10:39:42. 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-10-26 10:39:45 No severe PSQL-related problems occured
26.10.22 10:39:46. End of report.