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

Server and database settinfs

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


Test configuration settings

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

Test finish info

FINISH_STATE                    NORMAL: TEST_TIME EXPIRED AT 2022-06-10 07:46:51
DTS_END                         2022-06-10 07:46:51.4930
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_INVOICE(39:5) ==> X_MAKE_QSTORNO_1200_2000(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/56128
TRN_ID                          218726
ATT_ID                          584
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: 8556.80 30824 1026816
customer order: creation 168.43 459 20211
customer order: refuse 14.34 401 1721
order to supplier: creation 44.13 1434 5296
order to supplier: removal 3.28 155960 393
invoice (draft): creation 44.76 3348 5371
invoice (draft): removal 46.93 981 5631
invoice accept: apply 40.66 26262 4879
invoice accept: cancel 42.25 1223 5070
customer reserve: creation 3748.58 251 449829
customer reserve: removal 4116.03 97 493924
realization accept: apply 80.64 261 9677
realization accept: cancel 79.14 165 9497
payment from customer: creation 57.99 190 6959
payment from customer: removal 5.58 140 669
payment to supplier: creation 47.43 214 5692
payment to supplier: removal 3.51 105 421
service: total inventory turnovers 4.42 3947 530
service: total monetary turnovers 7.79 305 935
service: aggregate perf. data 0.89 17064 107
service: refresh index statistics 0.03 403666 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-06-2022 07:47:47 to 10-06-2022 07:47:49.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 3696
TEST_TIME 2 5562
TEST_TIME 3 5359
TEST_TIME 4 5800
TEST_TIME 5 5561
TEST_TIME 6 5354
TEST_TIME 7 5553
TEST_TIME 8 6210
TEST_TIME 9 6409
TEST_TIME 10 6892
TEST_TIME 11 7031
TEST_TIME 12 7053
TEST_TIME 13 7112
TEST_TIME 14 7161
TEST_TIME 15 7122
TEST_TIME 16 7229
TEST_TIME 17 7450
TEST_TIME 18 7684
TEST_TIME 19 7727
TEST_TIME 20 7840
TEST_TIME 21 7842
TEST_TIME 22 7973
TEST_TIME 23 8322
TEST_TIME 24 8264
TEST_TIME 25 8515
TEST_TIME 26 8535
TEST_TIME 27 8823
TEST_TIME 28 9169
TEST_TIME 29 10020
TEST_TIME 30 9863
TEST_TIME 31 10203
TEST_TIME 32 10892
TEST_TIME 33 11219
TEST_TIME 34 11166
TEST_TIME 35 11017
TEST_TIME 36 10766
TEST_TIME 37 10594
TEST_TIME 38 10492
TEST_TIME 39 10370
TEST_TIME 40 10314
TEST_TIME 41 10131
TEST_TIME 42 10031
TEST_TIME 43 9995
TEST_TIME 44 9900
TEST_TIME 45 9816
TEST_TIME 46 9610
TEST_TIME 47 9489
TEST_TIME 48 9403
TEST_TIME 49 9379
TEST_TIME 50 9348
TEST_TIME 51 9426
TEST_TIME 52 9348
TEST_TIME 53 9466
TEST_TIME 54 9407
TEST_TIME 55 9372
TEST_TIME 56 9297
TEST_TIME 57 9319
TEST_TIME 58 9268
TEST_TIME 59 9319
TEST_TIME 60 9275
TEST_TIME 61 9229
TEST_TIME 62 9253
TEST_TIME 63 9380
TEST_TIME 64 9262
TEST_TIME 65 9171
TEST_TIME 66 9112
TEST_TIME 67 9067
TEST_TIME 68 9042
TEST_TIME 69 8949
TEST_TIME 70 8911
TEST_TIME 71 8865
TEST_TIME 72 8837
TEST_TIME 73 8814
TEST_TIME 74 8883
TEST_TIME 75 8858
TEST_TIME 76 8844
TEST_TIME 77 8794
TEST_TIME 78 8788
TEST_TIME 79 8861
TEST_TIME 80 8823
TEST_TIME 81 8830
TEST_TIME 82 8970
TEST_TIME 83 8914
TEST_TIME 84 8951
TEST_TIME 85 8946
TEST_TIME 86 8872
TEST_TIME 87 8829
TEST_TIME 88 8785
TEST_TIME 89 8743
TEST_TIME 90 8683
TEST_TIME 91 8657
TEST_TIME 92 8768
TEST_TIME 93 8724
TEST_TIME 94 8722
TEST_TIME 95 8701
TEST_TIME 96 8726
TEST_TIME 97 8723
TEST_TIME 98 8711
TEST_TIME 99 8743
TEST_TIME 100 8829
TEST_TIME 101 8799
TEST_TIME 102 8815
TEST_TIME 103 8837
TEST_TIME 104 8823
TEST_TIME 105 8845
TEST_TIME 106 8794
TEST_TIME 107 8760
TEST_TIME 108 8725
TEST_TIME 109 8696
TEST_TIME 110 8639
TEST_TIME 111 8628
TEST_TIME 112 8567
TEST_TIME 113 8534
TEST_TIME 114 8524
TEST_TIME 115 8518
TEST_TIME 116 8539
TEST_TIME 117 8552
TEST_TIME 118 8564
TEST_TIME 119 8568
TEST_TIME 120 8580

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 10-06-2022 07:47:50 to 10-06-2022 07:47:54.

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 1440662 1440662 0 0.00 0 24211 13 0 0
doc_list_biud 1440651 1440651 0 0.00 0 84448 39 0 0
sp_add_invoice_to_stock 4975 4879 96 1.92 34 242147 26263 0 96
sp_cancel_adding_invoice 5070 5070 0 0.00 7 121972 1223 0 0
sp_cancel_client_order 1721 1721 0 0.00 6 12204 401 0 0
sp_cancel_customer_reserve 493924 493924 0 0.00 1 25082 98 0 0
sp_cancel_pay_from_customer 669 669 0 0.00 4 19869 140 0 0
sp_cancel_pay_to_supplier 421 421 0 0.00 4 1475 105 0 0
sp_cancel_supplier_invoice 5636 5631 5 0.08 3 84451 981 0 5
sp_cancel_supplier_order 393 393 0 0.00 12 1592511 155961 0 0
sp_cancel_write_off 9497 9497 0 0.00 1 14514 165 0 0
sp_client_order 20211 20211 0 0.00 6 32621 459 0 0
sp_customer_reserve 449829 449829 0 0.00 1 86151 251 0 0
sp_fill_shopping_cart 30857 30857 0 0.00 1 31277 97 0 0
sp_fill_shopping_cart_clo_res 449801 449801 0 0.00 0 30895 20 0 0
sp_get_clo_for_invoice 4845 4845 0 0.00 0 16097 319 0 0
sp_kill_cost_storno 15657 15657 0 0.00 0 8564 71 0 0
sp_kill_qstorno_ret_qs2qd 1003369 1003369 0 0.00 0 84447 43 0 0
sp_kill_qty_storno 530755 530755 0 0.00 0 84448 98 0 0
sp_lock_selected_doc 20083 20083 0 0.00 0 4628 5 0 0
sp_make_cost_storno 27172 27172 0 0.00 0 22000 81 0 0
sp_multiply_rows_for_pdistr 27170 27170 0 0.00 0 16930 37 0 0
sp_multiply_rows_for_qdistr 20208 20208 0 0.00 0 32566 183 0 0
sp_pay_from_customer 6959 6959 0 0.00 5 24848 191 0 0
sp_pay_to_supplier 5692 5692 0 0.00 6 20128 214 0 0
sp_payment_common 12650 12650 0 0.00 2 9638 48 0 0
sp_qd_handle_on_cancel_clo 1721 1721 0 0.00 0 12192 335 0 0
sp_qd_handle_on_invoice_upd_sts 9915 9915 0 0.00 0 29867 511 0 0
sp_qd_handle_on_reserve_upd_sts 9674 9674 0 0.00 0 11421 53 0 0
sp_reserve_write_off 9677 9677 0 0.00 8 24955 262 0 0
sp_supplier_invoice 5371 5371 0 0.00 10 99350 3348 0 0
sp_supplier_order 5296 5296 0 0.00 7 57964 1435 0 0
srv_aggregate_perf_data 107 107 0 0.00 2589 145800 17064 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 683 176503 39307 0 0
srv_find_qd_qs_mism 978855 978855 0 0.00 0 24211 10 0 0
srv_make_invnt_saldo 530 530 0 0.00 73 203093 3947 0 0
srv_make_money_saldo 935 935 0 0.00 1 15598 306 0 0
srv_recalc_idx_stat 4 4 0 0.00 314445 503818 403666 0 0
t$perf-abend:sp_add_invoice_to_stock 96 96 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 5 5 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4886 4886 0 0.00 0 12984 993 0 0
t$perf-norm:sp_cancel_adding_invoice 370 370 0 0.00 1 6968 489 0 0
t$perf-norm:sp_cancel_client_order 1721 1721 0 0.00 0 4531 28 0 0
t$perf-norm:sp_cancel_customer_reserve 641 641 0 0.00 0 755 22 0 0
t$perf-norm:sp_cancel_pay_from_customer 669 669 0 0.00 0 326 12 0 0
t$perf-norm:sp_cancel_pay_to_supplier 421 421 0 0.00 0 526 14 0 0
t$perf-norm:sp_cancel_supplier_invoice 374 374 0 0.00 0 4920 39 0 0
t$perf-norm:sp_cancel_supplier_order 393 393 0 0.00 0 94376 6047 0 0
t$perf-norm:sp_cancel_write_off 982 982 0 0.00 0 2629 19 0 0
t$perf-norm:sp_client_order 20211 20211 0 0.00 0 6447 35 0 0
t$perf-norm:sp_customer_reserve 1003 1003 0 0.00 0 309 12 0 0
t$perf-norm:sp_pay_from_customer 6959 6959 0 0.00 0 4811 21 0 0
t$perf-norm:sp_pay_to_supplier 5692 5692 0 0.00 0 5631 20 0 0
t$perf-norm:sp_reserve_write_off 9677 9677 0 0.00 0 18470 25 0 0
t$perf-norm:sp_supplier_invoice 5371 5371 0 0.00 0 5696 32 0 0
t$perf-norm:sp_supplier_order 5296 5296 0 0.00 0 6348 32 0 0
t$perf-norm:srv_aggregate_perf_data 107 107 0 0.00 0 474 19 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 232 7 0 0
t$perf-norm:srv_make_invnt_saldo 530 530 0 0.00 0 1517 16 0 0
t$perf-norm:srv_make_money_saldo 935 935 0 0.00 0 1201 7 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 4 119 35 0 0
v_add_invoice_to_stock 9870 9678 192 1.94 0 24493 28 0 192
v_all_customers 36730 36730 0 0.00 0 73 4 0 0
v_all_suppliers 29427 29427 0 0.00 0 81 4 0 0
v_all_wares 40405 40405 0 0.00 0 153 4 0 0
v_cancel_adding_invoice 740 740 0 0.00 0 912 16 0 0
v_cancel_client_order 3442 3442 0 0.00 0 3247 11 0 0
v_cancel_customer_prepayment 1338 1338 0 0.00 0 19838 26 0 0
v_cancel_customer_reserve 1282 1282 0 0.00 1 2381 15 0 0
v_cancel_payment_to_supplier 842 842 0 0.00 0 623 11 0 0
v_cancel_supplier_invoice 758 748 10 1.31 0 3214 26 0 10
v_cancel_supplier_order 786 786 0 0.00 0 10193 25 0 0
v_cancel_write_off 1964 1964 0 0.00 0 3588 23 0 0
v_max_id_clo_ord 5292 5292 0 0.00 0 2320 6 0 0
v_max_id_clo_res 1003 1003 0 0.00 0 1556 13 0 0
v_max_id_ord_sup 5356 5356 0 0.00 0 5824 10 0 0
v_max_non_paid_invoice 1626 1626 0 0.00 0 51 7 0 0
v_max_non_paid_realizn 3609 3609 0 0.00 0 7133 9 0 0
v_min_id_clo_ord 5292 5292 0 0.00 0 6447 12 0 0
v_min_id_clo_res 1003 1003 0 0.00 0 5581 18 0 0
v_min_id_ord_sup 5356 5356 0 0.00 0 5922 11 0 0
v_min_non_paid_invoice 5691 5691 0 0.00 0 9608 18 0 0
v_min_non_paid_realizn 6957 6957 0 0.00 0 8467 21 0 0
v_our_firm 10372 10372 0 0.00 0 65 4 0 0
v_reserve_write_off 19346 19346 0 0.00 0 24797 12 0 0
x_lock_depdocs_on_canc_invoice 10327 10327 0 0.00 0 19020 146 0 0
x_lock_depdocs_on_canc_sup_ord 393 393 0 0.00 0 9062 324 0 0
x_make_qstorno_1000_1200 5296 5296 0 0.00 3 51477 1246 0 0
x_make_qstorno_1200_2000 5371 5371 0 0.00 5 99337 3066 0 0
x_make_qstorno_2100_3300 449827 449827 0 0.00 0 86151 219 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-06-2022 07:47:55 to 10-06-2022 07:47:59.

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
05:16:55 31 8192000000 8808424432 8823238656 7963808 0.097 5 1 2 0 8068528 68944 35776
05:17:56 16567 8192000000 9734437920 10033905664 818025536 9.079 100 91 182 0 847376048 8000880 21349632
05:19:19 9559 8192000000 9761815936 10072051712 840738352 9.307 100 86 172 1 872397504 11621440 20037712
05:20:36 24054 8192000000 9798632880 10117496832 864557488 9.546 100 81 162 0 902948176 19706448 18684240
05:22:06 9548 8192000000 9871104192 10204192768 905031984 9.948 100 74 147 1 971080640 49649136 16399520
05:23:24 3766 8192000000 9916091648 10256330752 948601856 10.377 100 90 180 0 1036817008 68938160 19276992
05:24:31 1763 8192000000 9962148256 10316058624 993587552 10.816 100 87 161 0 1073641488 63735616 16318320
05:25:36 1408 8192000000 9996527520 10359394304 1024035264 11.111 100 94 184 0 1116264512 73939312 18289936
05:26:41 944 8192000000 10012355616 10380992512 1042521968 11.289 100 97 190 1 1130421888 68892544 19007376
05:27:43 1008 8192000000 10044464480 10423017472 1064073360 11.495 100 97 189 3 1164463648 80668416 19721872
05:28:45 809 8192000000 10034698064 10416807936 1080678096 11.654 100 97 192 1 1158950720 59000384 19272240
05:29:47 1012 8192000000 10063732096 10453782528 1084105264 11.687 100 95 180 2 1187596144 84571280 18919600
05:30:50 1068 8192000000 10068206592 10459992064 1088933808 11.733 100 86 170 1 1192563008 84846416 18782784
05:31:52 1572 8192000000 10026973056 10415202304 1089233920 11.735 100 86 166 1 1144935680 39095392 16606368
05:32:54 1114 8192000000 10038406256 10429493248 1093241712 11.773 100 84 159 2 1164564480 54119728 17203040
05:33:56 1121 8192000000 10059750784 10451255296 1099322416 11.831 100 94 180 0 1181777056 64382928 18071712
05:34:58 1201 8192000000 10078563904 10471927808 1101161808 11.849 100 93 184 2 1201136096 81805888 18168400
05:36:01 1152 8192000000 10053334400 10443907072 1100943008 11.847 100 94 175 0 1173357616 54304384 18110224
05:37:03 1206 8192000000 10082294960 10472419328 1102017488 11.857 100 97 183 2 1202398752 81340592 19040672
05:38:05 5766 8192000000 10049651440 10454048768 1092120624 11.763 100 73 146 0 1172600720 65785696 14694400
05:39:11 2406 8192000000 10023006672 10409590784 1073524816 11.586 99 78 145 1 1145134944 56920368 14689760
05:40:15 1155 8192000000 10035334432 10417860608 1064348416 11.498 100 84 162 1 1162199248 80655360 17195472
05:41:16 2945 8192000000 10013802480 10404507648 1052137920 11.381 99 74 145 0 1128304080 61045600 15120560
05:42:20 808 8192000000 9994463952 10369277952 1045085136 11.314 100 91 175 0 1113968432 51307152 17576144
05:43:22 3668 8192000000 10026799888 10418614272 1057547024 11.433 100 60 112 3 1154430336 85592176 11291136
05:44:27 4094 8192000000 10004135248 10393346048 1061309184 11.469 100 61 113 1 1122170496 49294736 11566576
05:45:33 10232 8192000000 10010146384 10401968128 1049109408 11.352 99 79 146 2 1127213808 62400032 15704368
05:46:59 21320 8192000000 9982107760 10366337024 1045874032 11.321 99 67 126 3 1097256160 38349344 13032784
05:48:35 1175 8192000000 10052941904 10433310720 1078973936 11.638 100 84 155 2 1178419088 83301824 16143328
05:49:43 12885 8192000000 10092248992 10477445120 1092954176 11.771 100 79 148 0 1202064528 93887920 15222432
05:50:59 13369 8192000000 10100158448 10494267392 1095519680 11.795 99 66 130 1 1209939024 101173808 13245536
05:52:16 3093 8192000000 10120694064 10516979712 1110940480 11.941 100 64 122 0 1243053472 118595184 13517808
05:53:25 2116 8192000000 10205193968 10596413440 1126243840 12.086 100 84 163 1 1317349520 173069104 18036576
05:54:32 1628 8192000000 10213023616 10608574464 1136894064 12.186 100 89 172 0 1326213024 170655392 18663568
05:55:36 1116 8192000000 10217482496 10624917504 1146572768 12.277 100 93 178 3 1330991088 164299824 20118496
05:56:39 1395 8192000000 10234950608 10638737408 1156685424 12.372 100 91 177 2 1341661600 165326272 19649904
05:57:43 1087 8192000000 10278433552 10679541760 1166495328 12.464 100 87 165 0 1390567184 205276608 18795248
05:58:47 1187 8192000000 10295029440 10695462912 1170489920 12.501 100 95 181 0 1404667328 214061440 20115968
05:59:52 1489 8192000000 10324334096 10728140800 1182871040 12.617 100 86 166 1 1432462000 230605760 18985200
06:00:58 2651 8192000000 10363474576 10773524480 1188560112 12.670 100 79 153 0 1480402656 274061632 17780912
06:02:05 3043 8192000000 10405087520 10819780608 1188459728 12.669 100 83 165 0 1518467760 310295360 19712672
06:03:14 675 8192000000 10433620752 10853240832 1187730944 12.662 100 97 186 0 1540925888 331749920 21445024
06:04:19 2318 8192000000 10446707488 10866589696 1182720576 12.616 100 93 180 1 1550925872 347089968 21115328
06:05:23 1442 8192000000 10448575248 10857951232 1178882784 12.580 100 95 182 2 1554332784 354345760 21104240
06:06:27 977 8192000000 10478282992 10896596992 1182595200 12.614 100 95 188 0 1585334528 381554096 21185232
06:07:31 1136 8192000000 10510686000 10943758336 1179899376 12.589 100 96 190 0 1614986624 411903952 23183296
06:08:36 724 8192000000 10503802016 10949328896 1190467264 12.688 100 99 196 2 1604455408 391312224 22675920
06:09:38 2452 8192000000 10529640528 10997452800 1197909088 12.757 100 67 133 0 1651123152 436182960 17031104
06:10:43 6924 8192000000 10545379360 11004010496 1198493104 12.762 100 58 113 0 1648801184 435918976 14389104
06:11:57 1217 8192000000 10535634464 10976133120 1188802688 12.672 100 79 155 0 1639889136 432031008 19055440
06:13:00 4169 8192000000 10552080176 11021950976 1176726176 12.560 100 55 110 0 1656416080 464809392 14880512
06:14:07 7387 8192000000 10494561072 11013922816 1175124496 12.545 100 41 82 0 1617196080 430926752 11144832
06:15:17 12629 8192000000 10378413264 10890190848 1144394832 12.257 99 35 70 1 1493662560 339941856 9325872
06:16:35 42133 8192000000 10344223248 10860560384 1151767680 12.326 99 27 54 1 1500493920 341369488 7356752
06:18:18 56651 8192000000 10099460944 10615615488 1127036832 12.093 98 13 26 1 1278093552 148054576 3002144
06:20:16 54071 8192000000 10072119760 10536439808 1126628224 12.090 98 22 43 0 1185589744 53472528 5488992
06:22:35 4985 8192000000 10060965056 10486427648 1128720096 12.109 99 65 118 2 1151710288 11933808 11056384
06:23:42 67191 8192000000 10102961968 10550071296 1126202464 12.086 99 30 61 2 1197910608 65685376 6022768
06:26:59 12428 8192000000 10052545296 10524262400 1111534448 11.947 98 6 12 0 1134836240 22318736 983056
06:28:12 76176 8192000000 10111645536 10569515008 1141014080 12.225 100 20 38 1 1221419472 76066352 4339040
06:30:29 64698 8192000000 10114300912 10557140992 1120717904 12.034 98 29 58 1 1186600944 59914960 5968080
06:32:42 176503 8192000000 10148103584 10630213632 1063640432 11.491 93 17 32 2 1157588352 90077968 3869952
06:36:44 41755 8192000000 10073988448 10587549696 1127837232 12.101 100 8 16 0 1234737856 105016544 1884080
06:38:30 82139 8192000000 10079697088 10588823552 1116250864 11.992 98 29 58 0 1185719312 63329216 6139232
06:41:07 49790 8192000000 10091165824 10545233920 1136225936 12.180 100 20 40 1 1193700640 53209552 4265152
06:42:57 11178 8192000000 10088677200 10547560448 1144051200 12.254 100 48 90 0 1180707312 27732704 8923408
06:44:09 22282 8192000000 10115418176 10550845440 1146163168 12.273 100 41 80 1 1208127792 54028160 7936464
06:45:36 36248 8192000000 10087607584 10521468928 1130401616 12.125 99 42 78 1 1172508608 33580592 8526400
06:47:22 40751 8192000000 10158671872 10600886272 1117910096 12.007 98 51 100 0 1196609904 68238704 10461104
06:49:04 107104 8192000000 10069625440 10532151296 1067593520 11.529 95 18 36 0 1113817936 42667968 3556448
06:51:52 36495 8192000000 10047544592 10498314240 1116724432 11.996 100 48 86 2 1160732496 34878512 9129552
06:54:03 52755 8192000000 10028251056 10485522432 1101385024 11.851 98 18 35 1 1140323280 36042352 2895904
06:55:56 49754 8192000000 10070835584 10530222080 1118798464 12.016 99 6 12 0 1161762528 41804768 1159296
06:57:52 70446 8192000000 10115677968 10560974848 1130823536 12.129 99 19 38 1 1199177552 64453824 3900192
07:00:11 92127 8192000000 10111484208 10558201856 1090429696 11.747 95 29 58 1 1144797360 48250512 6117152
07:02:44 21869 8192000000 10118757808 10556264448 1148608720 12.296 100 25 50 2 1215614032 61427792 5577520
07:04:06 45590 8192000000 10180799664 10627117056 1130503104 12.126 98 35 70 1 1253950688 115605568 7842016
07:05:58 37746 8192000000 10126542448 10569703424 1108065648 11.914 97 23 46 1 1209955680 96738384 5151648
07:07:36 58715 8192000000 10116080080 10605105152 1094410736 11.785 96 27 54 0 1215067872 115208528 5448608
07:10:17 30998 8192000000 10111534400 10554613760 1123050448 12.056 100 41 81 0 1186800336 55037904 8711984
07:11:54 86851 8192000000 10084316208 10507788288 1118724768 12.015 99 54 108 0 1168105312 37784480 11596064
07:14:23 97862 8192000000 10107088096 10575536128 1126158736 12.085 99 10 20 0 1195955440 67493232 2303472
07:17:01 80135 8192000000 10088700480 10621894656 1126583312 12.089 99 15 30 1 1242934688 112517696 3833680
07:19:31 71808 8192000000 10079699424 10515181568 1100360512 11.841 97 30 60 1 1141478272 34293424 6824336
07:21:53 75644 8192000000 10100440848 10547257344 1104144144 11.877 97 17 34 0 1133188800 24953552 4091104
07:24:09 103602 8192000000 10118765264 10597531648 1127865248 12.101 99 20 40 1 1211251568 79514992 3871328
07:27:00 62035 8192000000 10092253488 10539581440 1123612688 12.061 98 28 55 0 1156608096 27543440 5451968
07:29:06 51228 8192000000 10099638160 10572812288 1117343568 12.002 98 32 64 0 1201397152 76690448 7363136
07:30:59 46652 8192000000 10088836256 10547986432 1103873024 11.874 98 30 58 0 1152862272 43146512 5842736
07:32:48 109821 8192000000 10018187680 10464051200 1070219696 11.554 95 18 36 0 1111436896 37717488 3499712
07:35:42 64525 8192000000 10051219024 10510643200 1122271440 12.048 100 7 14 0 1168181072 44676592 1233040
07:37:47 63294 8192000000 10082940256 10543783936 1122010624 12.046 99 12 23 1 1166933888 41652816 3270448
07:39:51 69390 8192000000 10067043920 10526818304 1071327376 11.565 95 11 22 2 1137583376 63809776 2446224
07:42:00 69120 8192000000 10094151936 10543251456 1103821184 11.874 98 27 54 1 1166426224 56690112 5914928
07:44:11 98545 8192000000 10099985744 10551508992 1111437376 11.946 98 17 34 0 1181665536 66438368 3789792
07:46:51 9269 8192000000 8936528880 9159172096 96392352 1.162 9 2 2 1 106281984 9572912 316720

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 10-06-2022 07:48:01 to 10-06-2022 07:48:17.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 96 v_add_invoice_to_stock 335544517
except 5 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 10-06-2022 07:48:18 to 10-06-2022 07:48:20.

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          219075
MON$OLDEST_ACTIVE               219076
MON$OLDEST_SNAPSHOT             219076
MON$NEXT_TRANSACTION            219076
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                       2059680
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             774
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

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