Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 22.05.2022 04: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 16220932 kB
MemAvailable 31412048 kB
Buffers 20 kB
Cached 15459036 kB
SwapCached 2588 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-05-22 04:37:17
DTS_END                         2022-05-22 04:37:16.9220
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/44984
TRN_ID                          216158
ATT_ID                          619
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: 8623.95 20618 1034874
customer order: creation 165.49 479 19859
customer order: refuse 14.17 385 1700
order to supplier: creation 43.83 1414 5260
order to supplier: removal 3.24 165692 389
invoice (draft): creation 43.56 3391 5227
invoice (draft): removal 46.64 1101 5597
invoice accept: apply 40.21 26831 4825
invoice accept: cancel 41.68 1416 5001
customer reserve: creation 3799.78 252 455974
customer reserve: removal 4149.05 100 497886
realization accept: apply 79.93 264 9592
realization accept: cancel 72.56 155 8707
payment from customer: creation 55.73 180 6687
payment from customer: removal 5.66 117 679
payment to supplier: creation 47.12 203 5654
payment to supplier: removal 3.28 146 393
service: total inventory turnovers 4.03 3612 483
service: total monetary turnovers 7.01 311 841
service: aggregate perf. data 0.96 16321 115
service: refresh index statistics 0.04 189991 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 22-05-2022 04:39:16 to 22-05-2022 04:39:18.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6821
TEST_TIME 2 5712
TEST_TIME 3 5277
TEST_TIME 4 5576
TEST_TIME 5 5808
TEST_TIME 6 6551
TEST_TIME 7 6554
TEST_TIME 8 6563
TEST_TIME 9 6748
TEST_TIME 10 6729
TEST_TIME 11 6681
TEST_TIME 12 6728
TEST_TIME 13 6777
TEST_TIME 14 6705
TEST_TIME 15 6768
TEST_TIME 16 7012
TEST_TIME 17 7323
TEST_TIME 18 7405
TEST_TIME 19 7581
TEST_TIME 20 7691
TEST_TIME 21 7885
TEST_TIME 22 8016
TEST_TIME 23 7900
TEST_TIME 24 8215
TEST_TIME 25 8349
TEST_TIME 26 8352
TEST_TIME 27 8828
TEST_TIME 28 9138
TEST_TIME 29 9627
TEST_TIME 30 10314
TEST_TIME 31 11246
TEST_TIME 32 11206
TEST_TIME 33 11127
TEST_TIME 34 11359
TEST_TIME 35 11266
TEST_TIME 36 11167
TEST_TIME 37 10892
TEST_TIME 38 10817
TEST_TIME 39 10658
TEST_TIME 40 10545
TEST_TIME 41 10390
TEST_TIME 42 10192
TEST_TIME 43 10131
TEST_TIME 44 10134
TEST_TIME 45 10010
TEST_TIME 46 9865
TEST_TIME 47 9741
TEST_TIME 48 9678
TEST_TIME 49 9534
TEST_TIME 50 9498
TEST_TIME 51 9423
TEST_TIME 52 9411
TEST_TIME 53 9328
TEST_TIME 54 9339
TEST_TIME 55 9236
TEST_TIME 56 9164
TEST_TIME 57 9256
TEST_TIME 58 9317
TEST_TIME 59 9295
TEST_TIME 60 9267
TEST_TIME 61 9285
TEST_TIME 62 9344
TEST_TIME 63 9279
TEST_TIME 64 9357
TEST_TIME 65 9370
TEST_TIME 66 9370
TEST_TIME 67 9367
TEST_TIME 68 9334
TEST_TIME 69 9273
TEST_TIME 70 9321
TEST_TIME 71 9335
TEST_TIME 72 9309
TEST_TIME 73 9272
TEST_TIME 74 9157
TEST_TIME 75 9171
TEST_TIME 76 9182
TEST_TIME 77 9179
TEST_TIME 78 9131
TEST_TIME 79 9107
TEST_TIME 80 9070
TEST_TIME 81 9008
TEST_TIME 82 8923
TEST_TIME 83 8926
TEST_TIME 84 8916
TEST_TIME 85 8983
TEST_TIME 86 8962
TEST_TIME 87 8949
TEST_TIME 88 8942
TEST_TIME 89 9020
TEST_TIME 90 9011
TEST_TIME 91 9065
TEST_TIME 92 9077
TEST_TIME 93 9043
TEST_TIME 94 9068
TEST_TIME 95 9117
TEST_TIME 96 9084
TEST_TIME 97 9010
TEST_TIME 98 8952
TEST_TIME 99 8967
TEST_TIME 100 8924
TEST_TIME 101 8891
TEST_TIME 102 8882
TEST_TIME 103 8891
TEST_TIME 104 8870
TEST_TIME 105 8858
TEST_TIME 106 8865
TEST_TIME 107 8862
TEST_TIME 108 8831
TEST_TIME 109 8852
TEST_TIME 110 8857
TEST_TIME 111 8855
TEST_TIME 112 8858
TEST_TIME 113 8890
TEST_TIME 114 8831
TEST_TIME 115 8837
TEST_TIME 116 8789
TEST_TIME 117 8774
TEST_TIME 118 8740
TEST_TIME 119 8720
TEST_TIME 120 8648

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 22-05-2022 04:39:20 to 22-05-2022 04:39:23.

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 1453921 1453921 0 0.00 0 33853 14 0 0
doc_list_biud 1453915 1453915 0 0.00 0 37318 40 0 0
sp_add_invoice_to_stock 4930 4825 105 2.12 38 232371 26831 0 105
sp_cancel_adding_invoice 5001 5001 0 0.00 7 101155 1417 0 0
sp_cancel_client_order 1700 1700 0 0.00 5 12898 386 0 0
sp_cancel_customer_reserve 497886 497886 0 0.00 1 37342 101 0 0
sp_cancel_pay_from_customer 679 679 0 0.00 4 6524 117 0 0
sp_cancel_pay_to_supplier 393 393 0 0.00 4 6550 146 0 0
sp_cancel_supplier_invoice 5603 5597 6 0.10 3 16750 1101 0 6
sp_cancel_supplier_order 389 389 0 0.00 9 1625180 165693 0 0
sp_cancel_write_off 8707 8707 0 0.00 2 7530 156 0 0
sp_client_order 19859 19859 0 0.00 6 24972 480 0 0
sp_customer_reserve 455974 455974 0 0.00 1 91448 252 0 0
sp_fill_shopping_cart 30346 30346 0 0.00 1 16813 87 0 0
sp_fill_shopping_cart_clo_res 455945 455945 0 0.00 0 13601 20 0 0
sp_get_clo_for_invoice 4792 4792 0 0.00 0 40182 365 0 0
sp_kill_cost_storno 14780 14780 0 0.00 0 33834 87 0 0
sp_kill_qstorno_ret_qs2qd 1010465 1010465 0 0.00 0 37268 44 0 0
sp_kill_qty_storno 533664 533664 0 0.00 0 37311 101 0 0
sp_lock_selected_doc 19774 19774 0 0.00 0 12635 8 0 0
sp_make_cost_storno 26725 26725 0 0.00 0 22228 83 0 0
sp_multiply_rows_for_pdistr 26725 26725 0 0.00 0 12901 40 0 0
sp_multiply_rows_for_qdistr 19859 19859 0 0.00 0 14208 186 0 0
sp_pay_from_customer 6687 6687 0 0.00 6 13100 181 0 0
sp_pay_to_supplier 5654 5654 0 0.00 6 22247 204 0 0
sp_payment_common 12339 12339 0 0.00 2 11918 53 0 0
sp_qd_handle_on_cancel_clo 1700 1700 0 0.00 0 5655 304 0 0
sp_qd_handle_on_invoice_upd_sts 9793 9793 0 0.00 0 33320 541 0 0
sp_qd_handle_on_reserve_upd_sts 9592 9592 0 0.00 0 14989 57 0 0
sp_reserve_write_off 9592 9592 0 0.00 8 16173 265 0 0
sp_supplier_invoice 5227 5227 0 0.00 10 82115 3392 0 0
sp_supplier_order 5260 5260 0 0.00 7 45088 1414 0 0
srv_aggregate_perf_data 115 115 0 0.00 2505 224047 16321 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 756 150352 39401 0 0
srv_find_qd_qs_mism 987090 987090 0 0.00 0 15127 11 0 0
srv_make_invnt_saldo 483 483 0 0.00 54 109649 3612 0 0
srv_make_money_saldo 841 841 0 0.00 1 10975 312 0 0
srv_recalc_idx_stat 5 5 0 0.00 98937 326972 189992 0 0
t$perf-abend:sp_add_invoice_to_stock 105 105 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 6 6 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4826 4826 0 0.00 1 40042 880 0 0
t$perf-norm:sp_cancel_adding_invoice 386 386 0 0.00 1 6213 515 0 0
t$perf-norm:sp_cancel_client_order 1700 1700 0 0.00 0 16227 41 0 0
t$perf-norm:sp_cancel_customer_reserve 619 619 0 0.00 0 2873 31 0 0
t$perf-norm:sp_cancel_pay_from_customer 679 679 0 0.00 0 1650 15 0 0
t$perf-norm:sp_cancel_pay_to_supplier 393 393 0 0.00 0 1952 20 0 0
t$perf-norm:sp_cancel_supplier_invoice 347 347 0 0.00 0 1285 32 0 0
t$perf-norm:sp_cancel_supplier_order 389 389 0 0.00 0 56038 6376 0 0
t$perf-norm:sp_cancel_write_off 880 880 0 0.00 0 497 15 0 0
t$perf-norm:sp_client_order 19859 19859 0 0.00 0 11037 37 0 0
t$perf-norm:sp_customer_reserve 948 948 0 0.00 0 2379 17 0 0
t$perf-norm:sp_pay_from_customer 6687 6687 0 0.00 0 5682 19 0 0
t$perf-norm:sp_pay_to_supplier 5654 5654 0 0.00 0 8860 19 0 0
t$perf-norm:sp_reserve_write_off 9592 9592 0 0.00 0 10023 21 0 0
t$perf-norm:sp_supplier_invoice 5227 5227 0 0.00 0 4154 28 0 0
t$perf-norm:sp_supplier_order 5260 5260 0 0.00 0 6461 32 0 0
t$perf-norm:srv_aggregate_perf_data 115 115 0 0.00 0 539 24 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 1563 40 0 0
t$perf-norm:srv_make_invnt_saldo 483 483 0 0.00 0 5966 29 0 0
t$perf-norm:srv_make_money_saldo 841 841 0 0.00 0 546 5 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 7 184 93 0 0
v_add_invoice_to_stock 9786 9576 210 2.14 0 8077 21 0 210
v_all_customers 35729 35729 0 0.00 0 64 3 0 0
v_all_suppliers 29672 29672 0 0.00 0 194 4 0 0
v_all_wares 39716 39716 0 0.00 0 63 3 0 0
v_cancel_adding_invoice 772 772 0 0.00 0 536 14 0 0
v_cancel_client_order 3400 3400 0 0.00 0 7923 11 0 0
v_cancel_customer_prepayment 1358 1358 0 0.00 0 1790 11 0 0
v_cancel_customer_reserve 1238 1238 0 0.00 0 2056 12 0 0
v_cancel_payment_to_supplier 786 786 0 0.00 0 4013 21 0 0
v_cancel_supplier_invoice 706 694 12 1.69 0 2787 23 0 12
v_cancel_supplier_order 778 778 0 0.00 0 634 11 0 0
v_cancel_write_off 1760 1760 0 0.00 0 723 20 0 0
v_max_id_clo_ord 5260 5260 0 0.00 0 141 4 0 0
v_max_id_clo_res 948 948 0 0.00 0 2582 13 0 0
v_max_id_ord_sup 5227 5227 0 0.00 0 4664 9 0 0
v_max_non_paid_invoice 1303 1303 0 0.00 0 526 7 0 0
v_max_non_paid_realizn 3675 3675 0 0.00 0 2733 7 0 0
v_min_id_clo_ord 5259 5259 0 0.00 0 4207 10 0 0
v_min_id_clo_res 948 948 0 0.00 0 6860 25 0 0
v_min_id_ord_sup 5227 5227 0 0.00 0 9728 13 0 0
v_min_non_paid_invoice 5653 5653 0 0.00 0 7273 26 0 0
v_min_non_paid_realizn 6686 6686 0 0.00 0 11889 26 0 0
v_our_firm 10004 10004 0 0.00 0 76 4 0 0
v_reserve_write_off 19184 19184 0 0.00 0 4069 10 0 0
x_lock_depdocs_on_canc_invoice 10251 10251 0 0.00 0 15283 141 0 0
x_lock_depdocs_on_canc_sup_ord 389 389 0 0.00 0 17361 381 0 0
x_make_qstorno_1000_1200 5260 5260 0 0.00 3 45074 1257 0 0
x_make_qstorno_1200_2000 5227 5227 0 0.00 4 82096 3125 0 0
x_make_qstorno_2100_3300 455974 455974 0 0.00 0 91420 221 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 22-05-2022 04:39:24 to 22-05-2022 04:39:28.

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
02:07:20 1 8192000000 8796669024 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
02:08:20 27973 8192000000 9712681744 10008190976 790347056 8.798 100 89 178 0 820338144 7876400 22114688
02:09:58 17309 8192000000 9758687824 10065203200 835196352 9.252 100 89 179 0 869097568 12613616 21287600
02:11:22 5792 8192000000 9799575056 10117279744 866939392 9.569 100 84 168 0 908300288 21923488 19437408
02:12:35 10472 8192000000 9860303312 10194948096 914205264 10.039 100 82 164 2 973073104 40829088 18038752
02:13:49 2443 8192000000 9926561536 10269204480 963219872 10.520 100 94 182 0 1042449248 60092944 19136432
02:14:54 3049 8192000000 9968811088 10328023040 999812288 10.877 100 88 174 0 1087981680 70542064 17627328
02:16:01 1532 8192000000 10019789904 10385199104 1031881520 11.187 100 87 168 1 1142824560 94319440 16623600
02:17:04 1214 8192000000 10004746144 10377535488 1053444112 11.394 100 94 185 2 1134440384 61729328 19266944
02:18:07 1464 8192000000 10016902640 10393767936 1062880384 11.484 100 82 157 1 1137332768 60176096 14276288
02:19:11 1018 8192000000 10059066592 10440081408 1080157712 11.649 100 91 178 1 1184510624 86582944 17769968
02:20:15 699 8192000000 10042758080 10426912768 1076746304 11.616 100 93 180 1 1164051584 69053216 18252064
02:21:17 1106 8192000000 10045676656 10430636032 1080343504 11.651 100 99 193 0 1168617696 67647216 20626976
02:22:19 1147 8192000000 10035301040 10425577472 1084527312 11.691 100 93 174 2 1157326384 54893632 17905440
02:23:21 1536 8192000000 10050697488 10442924032 1085533280 11.700 100 90 176 1 1173494560 69517920 18443360
02:24:24 1268 8192000000 10064527440 10450628608 1092379968 11.765 100 94 171 1 1187457840 76028464 19049408
02:25:26 1147 8192000000 10080788256 10471460864 1093209648 11.773 100 94 187 2 1202699200 90959712 18529840
02:26:29 2363 8192000000 10056276272 10444558336 1094078976 11.781 100 84 159 0 1178529024 70173632 14276416
02:27:32 3166 8192000000 10044633072 10441822208 1099823520 11.836 100 65 121 1 1162677392 50887872 11966000
02:28:37 1069 8192000000 10065773248 10460016640 1097076592 11.810 100 91 179 2 1186198368 70792272 18329504
02:29:38 1385 8192000000 10028632032 10410848256 1070973136 11.561 100 94 171 3 1150718464 62594192 17151136
02:30:41 1095 8192000000 10044651104 10427109376 1073767424 11.588 100 86 169 0 1167053200 76119136 17166640
02:31:43 1055 8192000000 10003531552 10382696448 1059003328 11.447 100 88 161 1 1129796320 55376544 15416448
02:32:46 1296 8192000000 10018667472 10395779072 1056578176 11.424 100 88 173 4 1136748432 63915328 16254928
02:33:48 1132 8192000000 9968806416 10337509376 1026251840 11.132 99 82 155 1 1095591856 52497600 16842416
02:34:49 4056 8192000000 9981419488 10357366784 1040105424 11.266 100 80 141 5 1109172800 54234432 14832944
02:35:54 1788 8192000000 9995520848 10382462976 1041455344 11.279 100 77 149 1 1115634160 58927776 15251040
02:36:57 1124 8192000000 9993994224 10371678208 1040151232 11.266 100 86 159 1 1120091008 62488880 17450896
02:38:03 24477 8192000000 10016981536 10406694912 1070228112 11.554 100 62 119 1 1144338832 62327136 11783584
02:39:33 3178 8192000000 10042782352 10430246912 1089050944 11.734 100 75 144 1 1164775152 60870448 14853760
02:40:39 14612 8192000000 10087732944 10488225792 1099755664 11.835 100 52 101 1 1202108672 92129344 10223664
02:41:57 11860 8192000000 10145645968 10532950016 1114032928 11.971 100 77 148 0 1256877136 127701504 15142704
02:43:11 14127 8192000000 10182339904 10584379392 1130519056 12.126 100 78 147 0 1299548464 152774512 16254896
02:44:32 1023 8192000000 10190259936 10579959808 1145838144 12.270 100 95 178 1 1302473424 136716704 19918576
02:45:34 1708 8192000000 10231667808 10636034048 1155217536 12.358 100 95 178 2 1350306848 174341808 20747504
02:46:39 822 8192000000 10263452576 10659401728 1171636416 12.512 100 85 166 0 1371681824 182535392 17510016
02:47:43 4557 8192000000 10306818416 10711207936 1174739952 12.541 100 78 152 1 1419594768 227916832 16937984
02:48:53 2968 8192000000 10339106160 10736631808 1187747472 12.662 100 89 170 1 1445709968 239091696 18870800
02:50:00 1745 8192000000 10376747040 10784727040 1190723776 12.690 100 89 172 1 1487117200 276891600 19501824
02:51:06 1255 8192000000 10414626352 10817208320 1195148768 12.731 100 96 190 1 1520340480 303483392 21708320
02:52:10 794 8192000000 10460370992 10866794496 1192628464 12.708 100 93 187 1 1573391920 358580480 22182976
02:53:14 1292 8192000000 10488217840 10912722944 1197751248 12.755 100 95 185 2 1595159520 375508944 21899328
02:54:19 1773 8192000000 10496659968 10918227968 1208271616 12.853 100 95 177 3 1600004848 371740896 19992336
02:55:23 978 8192000000 10539197088 10952097792 1211424384 12.882 100 95 184 2 1646595088 412867184 22303520
02:56:26 994 8192000000 10534503696 10960412672 1206522304 12.837 100 86 168 1 1644077872 417706880 19848688
02:57:29 749 8192000000 10572167696 11009925120 1209830144 12.868 100 95 187 1 1680470880 447190720 23450016
02:58:33 3050 8192000000 10588469360 11009961984 1201039088 12.786 100 68 132 2 1691069840 473084528 16946224
02:59:40 1123 8192000000 10617451696 11044876288 1213324640 12.900 100 94 178 2 1718762944 483927184 21511120
03:00:44 10657 8192000000 10619774560 11099246592 1201408096 12.789 99 57 114 0 1713136384 496533824 15194464
03:01:57 4308 8192000000 10638437600 11072004096 1189513744 12.679 100 56 110 3 1746232976 542154656 14564576
03:03:06 6883 8192000000 10649256032 11089432576 1192760176 12.709 100 60 116 0 1759730784 552527552 14443056
03:04:15 7164 8192000000 10608928096 11108802560 1194104176 12.722 100 56 110 1 1712114816 503602992 14407648
03:06:00 23154 8192000000 10434511536 10958110720 1142347664 12.238 100 39 76 1 1529959808 376882032 10730112
03:07:43 44383 8192000000 10164590480 10657718272 1162450272 12.426 100 21 40 1 1414758400 247288448 5019680
03:09:28 75509 8192000000 10110078688 10581458944 1085525328 11.700 95 20 39 1 1175077136 84987776 4564032
03:11:52 25545 8192000000 10066102912 10509549568 1123562448 12.061 99 14 28 0 1155115776 28807136 2746192
03:13:19 74887 8192000000 10093911072 10531389440 1125430512 12.078 99 44 77 2 1180576624 46830960 8315152
03:16:00 29388 8192000000 10079710832 10564218880 1125785408 12.082 99 14 28 0 1178921856 50593120 2543328
03:17:49 91346 8192000000 10086705712 10532249600 1103375904 11.870 97 16 33 0 1133330896 26536688 3418304
03:20:21 106993 8192000000 10050152512 10493624320 1073490608 11.585 95 17 34 0 1125088416 47918960 3678848
03:23:20 83505 8192000000 10061009232 10526429184 1099056384 11.829 99 21 42 1 1162073904 58079376 4938144
03:25:47 83690 8192000000 10058965584 10496696320 1113347296 11.964 99 31 60 0 1140572944 20624288 6601360
03:28:12 67419 8192000000 10100600096 10567544832 1132847888 12.148 100 33 66 1 1204231008 64078304 7304816
03:30:35 67739 8192000000 10097145040 10580729856 1114672720 11.977 98 20 40 1 1178983280 59951504 4359056
03:32:43 49041 8192000000 10129490016 10616557568 1137793792 12.195 100 27 52 1 1252768480 108838288 6136400
03:34:45 89905 8192000000 10055544064 10555781120 1114172304 11.972 98 14 28 0 1177356272 59970944 3213024
03:37:15 40904 8192000000 10112325664 10564321280 1130971904 12.131 99 23 46 0 1200763664 65019280 4772480
03:38:57 45018 8192000000 10075965600 10540142592 1114309888 11.973 98 24 48 0 1185806688 66524240 4972560
03:40:49 35784 8192000000 10159316240 10610753536 1143109952 12.245 100 35 70 1 1236236384 85973264 7153168
03:42:25 150351 8192000000 10095769616 10587426816 1137582976 12.193 99 15 30 0 1210753056 70073776 3096304
03:46:25 27439 8192000000 10136127008 10564255744 1155922928 12.365 100 41 82 1 1222498720 57778064 8797728
03:47:55 81994 8192000000 10097874160 10582118400 1145562528 12.268 100 17 34 0 1214867600 66131248 3173824
03:50:18 103153 8192000000 10142513008 10591526912 1139707440 12.213 99 34 67 2 1265233216 118153296 7372480
03:53:09 66392 8192000000 10093762992 10552918016 1121931152 12.045 98 32 62 3 1177567232 49702256 5933824
03:55:16 25685 8192000000 10056446736 10497740800 1092403872 11.766 96 31 63 0 1126056080 27479264 6172944
03:56:47 43771 8192000000 10089769088 10534866944 1098406304 11.823 97 18 36 1 1154456528 52096864 3953360
03:58:31 97397 8192000000 10110707056 10567708672 1106703600 11.901 98 17 34 1 1192557120 81925408 3928112
04:01:09 8064 8192000000 10094229744 10534584320 1122703440 12.053 100 39 68 1 1213956512 83199008 8054064
04:02:17 66871 8192000000 10062828432 10506162176 1083803888 11.684 96 12 23 1 1126448912 40178528 2466496
04:04:29 65193 8192000000 10114311952 10561601536 1108777744 11.921 98 19 38 0 1190762784 77906480 4078560
04:06:34 65841 8192000000 10081706560 10543312896 1091311728 11.755 97 26 50 1 1162365152 65712400 5341024
04:08:45 46640 8192000000 10075656016 10512076800 1112165424 11.953 99 37 72 0 1162960448 43272848 7522176
04:10:32 32997 8192000000 10141224256 10578628608 1132209600 12.142 99 40 80 0 1233109472 92972992 7926880
04:12:08 30432 8192000000 10077028272 10516271104 1113526096 11.966 98 35 69 0 1180323792 60125712 6671984
04:13:40 78305 8192000000 10103113504 10533347328 1087661424 11.720 96 47 92 1 1175136640 78343056 9132160
04:16:04 56341 8192000000 10056753488 10540732416 1121853664 12.044 100 15 30 1 1175344352 50874208 2616480
04:18:00 117724 8192000000 10084555104 10566221824 1121931488 12.045 99 9 18 0 1188089248 63654864 2502896
04:21:00 48995 8192000000 10070996544 10521890816 1129132816 12.113 99 16 31 0 1160687856 28115328 3439712
04:22:51 44984 8192000000 10074360512 10550312960 1122629328 12.052 99 35 69 4 1175566080 45148224 7788528
04:24:51 19156 8192000000 10089929632 10515066880 1134896400 12.167 100 51 101 3 1184775472 38379712 11499360
04:26:12 19025 8192000000 10089722384 10526982144 1109867424 11.931 98 35 70 1 1176881328 59443952 7569952
04:27:35 20422 8192000000 10111925520 10546888704 1122683488 12.052 99 49 96 0 1196956096 64891152 9381456
04:28:57 6082 8192000000 10105846992 10533404672 1126521120 12.089 100 50 98 0 1196049264 59648048 9880096
04:30:06 36280 8192000000 10069673856 10528198656 1116018480 11.989 99 36 71 5 1187106736 63861184 7227072
04:31:46 89831 8192000000 10052676688 10533928960 1119258448 12.020 99 33 65 1 1174336000 48073104 7004448
04:34:33 86326 8192000000 10099984976 10576842752 1131169696 12.132 99 12 24 0 1200212992 66397024 2646272
04:37:04 26515 8192000000 8950880768 9180672000 116087184 1.397 11 5 9 0 134097696 16967792 1042720

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 22-05-2022 04:39:30 to 22-05-2022 04:39:46.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 105 v_add_invoice_to_stock 335544517
except 6 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 22-05-2022 04:39:47 to 22-05-2022 04:39:49.

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          216304
MON$OLDEST_ACTIVE               216707
MON$OLDEST_SNAPSHOT             216707
MON$NEXT_TRANSACTION            216707
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                       2061600
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.2.2767 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2767 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2767 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2767 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'

22.05.22 04:39:50. 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-05-22 04:39:52 No severe PSQL-related problems occured
22.05.22 04:39:54. End of report.