Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 17.10.2022 13: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 14980276 kB
MemAvailable 30522208 kB
Buffers 0 kB
Cached 16752248 kB
SwapCached 2140 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-17 13:37:23
DTS_END                         2022-10-17 13:37:22.7360
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/43292
TRN_ID                          213120
ATT_ID                          598
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: 8618.04 26001 1034165
customer order: creation 164.11 508 19693
customer order: refuse 14.06 492 1687
order to supplier: creation 44.19 1471 5303
order to supplier: removal 3.23 176472 388
invoice (draft): creation 43.02 3465 5162
invoice (draft): removal 47.85 1067 5742
invoice accept: apply 40.01 26982 4801
invoice accept: cancel 43.10 1323 5172
customer reserve: creation 3739.12 252 448694
customer reserve: removal 4198.72 106 503846
realization accept: apply 80.10 312 9612
realization accept: cancel 76.34 174 9161
payment from customer: creation 57.33 190 6880
payment from customer: removal 5.73 170 687
payment to supplier: creation 46.48 197 5577
payment to supplier: removal 3.23 130 388
service: total inventory turnovers 3.47 5165 416
service: total monetary turnovers 7.02 436 842
service: aggregate perf. data 0.90 17481 108
service: refresh index statistics 0.05 283636 6

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 17-10-2022 13:39:13 to 17-10-2022 13:39:15.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6092
TEST_TIME 2 4810
TEST_TIME 3 5742
TEST_TIME 4 5579
TEST_TIME 5 5869
TEST_TIME 6 5725
TEST_TIME 7 5766
TEST_TIME 8 5856
TEST_TIME 9 6099
TEST_TIME 10 6066
TEST_TIME 11 6290
TEST_TIME 12 6298
TEST_TIME 13 6288
TEST_TIME 14 6402
TEST_TIME 15 6487
TEST_TIME 16 6541
TEST_TIME 17 6798
TEST_TIME 18 6929
TEST_TIME 19 6966
TEST_TIME 20 7215
TEST_TIME 21 7280
TEST_TIME 22 7467
TEST_TIME 23 7589
TEST_TIME 24 7781
TEST_TIME 25 7782
TEST_TIME 26 7751
TEST_TIME 27 7735
TEST_TIME 28 8170
TEST_TIME 29 8303
TEST_TIME 30 8912
TEST_TIME 31 9191
TEST_TIME 32 9340
TEST_TIME 33 9695
TEST_TIME 34 9996
TEST_TIME 35 10015
TEST_TIME 36 10197
TEST_TIME 37 10237
TEST_TIME 38 10294
TEST_TIME 39 10119
TEST_TIME 40 10048
TEST_TIME 41 10185
TEST_TIME 42 10098
TEST_TIME 43 10245
TEST_TIME 44 10083
TEST_TIME 45 9963
TEST_TIME 46 10013
TEST_TIME 47 9953
TEST_TIME 48 9839
TEST_TIME 49 9739
TEST_TIME 50 9710
TEST_TIME 51 9588
TEST_TIME 52 9490
TEST_TIME 53 9514
TEST_TIME 54 9391
TEST_TIME 55 9421
TEST_TIME 56 9337
TEST_TIME 57 9213
TEST_TIME 58 9170
TEST_TIME 59 9095
TEST_TIME 60 9052
TEST_TIME 61 9027
TEST_TIME 62 9000
TEST_TIME 63 8942
TEST_TIME 64 9042
TEST_TIME 65 9090
TEST_TIME 66 8988
TEST_TIME 67 9059
TEST_TIME 68 8986
TEST_TIME 69 9037
TEST_TIME 70 9051
TEST_TIME 71 9045
TEST_TIME 72 9095
TEST_TIME 73 9156
TEST_TIME 74 9128
TEST_TIME 75 9175
TEST_TIME 76 9201
TEST_TIME 77 9180
TEST_TIME 78 9183
TEST_TIME 79 9174
TEST_TIME 80 9217
TEST_TIME 81 9218
TEST_TIME 82 9172
TEST_TIME 83 9133
TEST_TIME 84 9080
TEST_TIME 85 8997
TEST_TIME 86 9034
TEST_TIME 87 9009
TEST_TIME 88 8970
TEST_TIME 89 8936
TEST_TIME 90 8914
TEST_TIME 91 8869
TEST_TIME 92 8849
TEST_TIME 93 8840
TEST_TIME 94 8807
TEST_TIME 95 8823
TEST_TIME 96 8795
TEST_TIME 97 8792
TEST_TIME 98 8786
TEST_TIME 99 8803
TEST_TIME 100 8778
TEST_TIME 101 8774
TEST_TIME 102 8762
TEST_TIME 103 8917
TEST_TIME 104 8938
TEST_TIME 105 8900
TEST_TIME 106 8925
TEST_TIME 107 9042
TEST_TIME 108 9023
TEST_TIME 109 9012
TEST_TIME 110 8975
TEST_TIME 111 8936
TEST_TIME 112 8899
TEST_TIME 113 8889
TEST_TIME 114 8839
TEST_TIME 115 8800
TEST_TIME 116 8762
TEST_TIME 117 8717
TEST_TIME 118 8710
TEST_TIME 119 8680
TEST_TIME 120 8651

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 17-10-2022 13:39:17 to 17-10-2022 13:39:20.

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 1446639 1446639 0 0.00 0 29504 14 0 0
doc_list_biud 1446619 1446619 0 0.00 0 33459 44 0 0
sp_add_invoice_to_stock 4906 4801 105 2.14 61 175123 26982 0 105
sp_cancel_adding_invoice 5172 5172 0 0.00 5 90141 1323 0 0
sp_cancel_client_order 1687 1687 0 0.00 6 14104 493 0 0
sp_cancel_customer_reserve 503846 503846 0 0.00 1 22723 107 0 0
sp_cancel_pay_from_customer 687 687 0 0.00 4 7105 171 0 0
sp_cancel_pay_to_supplier 388 388 0 0.00 4 3441 130 0 0
sp_cancel_supplier_invoice 5750 5742 8 0.13 2 19456 1067 0 8
sp_cancel_supplier_order 388 388 0 0.00 20 1630337 176472 0 0
sp_cancel_write_off 9161 9161 0 0.00 1 10352 174 0 0
sp_client_order 19693 19693 0 0.00 5 33293 508 0 0
sp_customer_reserve 448694 448694 0 0.00 0 138183 252 0 0
sp_fill_shopping_cart 30144 30144 0 0.00 1 55796 95 0 0
sp_fill_shopping_cart_clo_res 448656 448656 0 0.00 0 24902 20 0 0
sp_get_clo_for_invoice 4754 4754 0 0.00 0 41765 358 0 0
sp_kill_cost_storno 15408 15408 0 0.00 0 12727 80 0 0
sp_kill_qstorno_ret_qs2qd 1022983 1022983 0 0.00 0 22387 46 0 0
sp_kill_qty_storno 540361 540361 0 0.00 0 33458 108 0 0
sp_lock_selected_doc 19877 19877 0 0.00 0 5390 7 0 0
sp_make_cost_storno 26823 26823 0 0.00 0 29495 89 0 0
sp_multiply_rows_for_pdistr 26822 26822 0 0.00 0 12521 41 0 0
sp_multiply_rows_for_qdistr 19692 19692 0 0.00 0 21655 178 0 0
sp_pay_from_customer 6880 6880 0 0.00 5 17827 190 0 0
sp_pay_to_supplier 5577 5577 0 0.00 6 15933 198 0 0
sp_payment_common 12457 12457 0 0.00 1 9092 51 0 0
sp_qd_handle_on_cancel_clo 1687 1687 0 0.00 0 14088 415 0 0
sp_qd_handle_on_invoice_upd_sts 9926 9926 0 0.00 0 33451 578 0 0
sp_qd_handle_on_reserve_upd_sts 9611 9611 0 0.00 0 33456 77 0 0
sp_reserve_write_off 9612 9612 0 0.00 9 33485 312 0 0
sp_supplier_invoice 5162 5162 0 0.00 13 114730 3466 0 0
sp_supplier_order 5303 5303 0 0.00 8 91431 1472 0 0
srv_aggregate_perf_data 108 108 0 0.00 2222 145842 17482 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 831 215514 39168 0 0
srv_find_qd_qs_mism 986748 986748 0 0.00 0 9486 10 0 0
srv_make_invnt_saldo 416 416 0 0.00 67 160416 5165 0 0
srv_make_money_saldo 842 842 0 0.00 1 25696 436 0 0
srv_recalc_idx_stat 6 6 0 0.00 85572 569054 283636 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 8 8 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4807 4807 0 0.00 0 10624 1070 0 0
t$perf-norm:sp_cancel_adding_invoice 390 390 0 0.00 2 6622 558 0 0
t$perf-norm:sp_cancel_client_order 1687 1687 0 0.00 0 2752 35 0 0
t$perf-norm:sp_cancel_customer_reserve 671 671 0 0.00 0 2366 37 0 0
t$perf-norm:sp_cancel_pay_from_customer 687 687 0 0.00 0 5709 31 0 0
t$perf-norm:sp_cancel_pay_to_supplier 388 388 0 0.00 0 558 16 0 0
t$perf-norm:sp_cancel_supplier_invoice 384 384 0 0.00 0 4085 45 0 0
t$perf-norm:sp_cancel_supplier_order 388 388 0 0.00 0 111903 8110 0 0
t$perf-norm:sp_cancel_write_off 920 920 0 0.00 0 1860 24 0 0
t$perf-norm:sp_client_order 19694 19694 0 0.00 0 7066 42 0 0
t$perf-norm:sp_customer_reserve 969 969 0 0.00 0 4272 25 0 0
t$perf-norm:sp_pay_from_customer 6880 6880 0 0.00 0 4436 21 0 0
t$perf-norm:sp_pay_to_supplier 5577 5577 0 0.00 0 6685 24 0 0
t$perf-norm:sp_reserve_write_off 9612 9612 0 0.00 0 6715 27 0 0
t$perf-norm:sp_supplier_invoice 5162 5162 0 0.00 0 3308 35 0 0
t$perf-norm:sp_supplier_order 5303 5303 0 0.00 0 8302 38 0 0
t$perf-norm:srv_aggregate_perf_data 108 108 0 0.00 0 571 20 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 5433 87 0 0
t$perf-norm:srv_make_invnt_saldo 416 416 0 0.00 0 428 11 0 0
t$perf-norm:srv_make_money_saldo 842 842 0 0.00 0 3306 10 0 0
t$perf-norm:srv_recalc_idx_stat 6 6 0 0.00 5 217 92 0 0
v_add_invoice_to_stock 9712 9502 210 2.16 0 5856 26 0 210
v_all_customers 36166 36166 0 0.00 0 76 4 0 0
v_all_suppliers 29272 29272 0 0.00 0 231 5 0 0
v_all_wares 39376 39376 0 0.00 0 233 4 0 0
v_cancel_adding_invoice 780 780 0 0.00 0 587 16 0 0
v_cancel_client_order 3374 3374 0 0.00 0 2154 10 0 0
v_cancel_customer_prepayment 1374 1374 0 0.00 0 2583 18 0 0
v_cancel_customer_reserve 1342 1342 0 0.00 0 308 10 0 0
v_cancel_payment_to_supplier 776 776 0 0.00 0 3298 18 0 0
v_cancel_supplier_invoice 784 768 16 2.04 0 2269 31 0 16
v_cancel_supplier_order 776 776 0 0.00 0 2735 17 0 0
v_cancel_write_off 1840 1840 0 0.00 0 1519 23 0 0
v_max_id_clo_ord 5299 5299 0 0.00 0 324 5 0 0
v_max_id_clo_res 969 969 0 0.00 0 1308 12 0 0
v_max_id_ord_sup 5155 5155 0 0.00 0 6374 11 0 0
v_max_non_paid_invoice 1395 1395 0 0.00 0 4859 12 0 0
v_max_non_paid_realizn 3593 3593 0 0.00 0 570 8 0 0
v_min_id_clo_ord 5299 5299 0 0.00 0 1371 9 0 0
v_min_id_clo_res 969 969 0 0.00 0 2456 15 0 0
v_min_id_ord_sup 5155 5155 0 0.00 0 8938 14 0 0
v_min_non_paid_invoice 5577 5577 0 0.00 0 6339 19 0 0
v_min_non_paid_realizn 6880 6880 0 0.00 0 9009 21 0 0
v_our_firm 9780 9780 0 0.00 0 69 5 0 0
v_reserve_write_off 19220 19220 0 0.00 0 3347 10 0 0
x_lock_depdocs_on_canc_invoice 10530 10530 0 0.00 0 20767 129 0 0
x_lock_depdocs_on_canc_sup_ord 388 388 0 0.00 0 3393 384 0 0
x_make_qstorno_1000_1200 5303 5303 0 0.00 3 91392 1281 0 0
x_make_qstorno_1200_2000 5162 5162 0 0.00 7 105685 3191 0 0
x_make_qstorno_2100_3300 448694 448694 0 0.00 0 138181 218 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 17-10-2022 13:39:21 to 17-10-2022 13:39:25.

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
11:07:26 1 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
11:08:27 35157 8192000000 9721373040 10019528704 798199040 8.878 100 93 186 1 829910032 8449488 23261504
11:10:09 24920 8192000000 9767456672 10074198016 839419280 9.294 100 92 184 0 874834560 13483056 21932224
11:11:42 12575 8192000000 9799821808 10117992448 865002720 9.550 100 84 168 0 908063008 23560256 19500032
11:13:03 10938 8192000000 9867689216 10201063424 911925168 10.016 100 79 155 0 970769792 41662128 17182496
11:14:19 4813 8192000000 9921686608 10264563712 961809808 10.507 100 86 169 1 1034064144 54482656 17771680
11:15:27 3036 8192000000 9976862096 10330398720 994901568 10.829 100 91 172 1 1091666288 79525024 17239696
11:16:32 1900 8192000000 10005959984 10371608576 1026483760 11.135 100 87 173 0 1122036176 78166400 17386016
11:17:36 786 8192000000 10031720992 10399604736 1043716560 11.300 100 94 179 2 1153478624 92157840 17604224
11:18:40 1306 8192000000 10040832416 10413023232 1064203504 11.497 100 96 185 3 1159802544 76867456 18731584
11:19:43 1298 8192000000 10036400880 10421325824 1067966176 11.533 100 93 171 1 1159817184 75531840 16319168
11:20:50 968 8192000000 10071996672 10448973824 1074024784 11.590 100 96 183 0 1187438128 94916592 18496752
11:21:55 1152 8192000000 10065059792 10448605184 1082967104 11.676 100 93 179 1 1188969904 87107552 18895248
11:22:58 947 8192000000 10058458320 10442514432 1087509408 11.719 100 92 170 0 1179021568 74108880 17403280
11:24:00 1267 8192000000 10061716080 10449248256 1097980000 11.818 100 95 176 3 1189965600 73395696 18589904
11:25:03 1130 8192000000 10054257168 10443563008 1095836624 11.798 100 97 184 0 1178160320 63107264 19216432
11:26:05 1285 8192000000 10067710192 10459484160 1103880704 11.874 100 94 179 3 1194031280 71458016 18692560
11:27:08 1231 8192000000 10088217472 10490089472 1104124288 11.877 100 97 182 3 1211655248 87897744 19633216
11:28:11 972 8192000000 10057546768 10454282240 1104819408 11.883 100 83 154 4 1178660272 57107040 16733824
11:29:12 948 8192000000 10062747936 10451361792 1100300048 11.840 100 95 183 2 1183431008 64799600 18331360
11:30:14 1256 8192000000 10055530896 10455289856 1092870560 11.770 100 78 143 1 1179283152 71397840 15014752
11:31:17 794 8192000000 10039871312 10423488512 1073494528 11.585 99 95 184 1 1159814352 66869648 19450176
11:32:19 988 8192000000 10012226064 10389061632 1057242992 11.430 100 94 174 6 1135180128 59538544 18398592
11:33:22 874 8192000000 10002861264 10384936960 1044113152 11.304 99 80 152 1 1127495760 68550160 14832448
11:34:23 843 8192000000 9964344528 10339905536 1032560272 11.193 100 86 161 1 1089043424 40466448 16016704
11:35:26 1770 8192000000 9998156576 10376503296 1034437440 11.211 100 89 157 2 1121008272 69378656 17192176
11:36:28 1852 8192000000 9998520112 10375901184 1033573008 11.203 100 76 146 1 1121587312 74091264 13923040
11:37:36 25934 8192000000 10000544320 10379743232 1053001328 11.389 100 60 105 1 1132010640 68895152 10114160
11:39:09 1749 8192000000 10022525184 10397237248 1063966640 11.494 99 88 172 1 1136323136 54493808 17862688
11:40:19 1419 8192000000 10072113376 10455207936 1091163776 11.754 100 89 165 1 1193909152 85522848 17222528
11:41:23 2829 8192000000 10056446688 10450640896 1095112128 11.791 100 72 135 0 1181998480 73212752 13673600
11:42:28 1390 8192000000 10103082848 10485948416 1107116848 11.905 100 98 191 1 1227764496 99789408 20858240
11:43:33 4121 8192000000 10147766640 10546499584 1116180704 11.991 100 62 124 0 1267856208 138567712 13107792
11:44:41 3974 8192000000 10165064368 10557472768 1120413360 12.031 100 82 161 1 1279531488 141459696 17658432
11:45:50 5241 8192000000 10177783296 10576801792 1129062400 12.113 100 86 159 2 1288666720 142980400 16623920
11:47:00 11989 8192000000 10203113840 10609836032 1145113232 12.264 100 69 136 0 1316958128 157513360 14331536
11:48:15 828 8192000000 10246565248 10642591744 1159784752 12.401 100 95 189 2 1359032000 176418048 22829200
11:49:21 6017 8192000000 10277999152 10683596800 1166463952 12.464 100 66 132 0 1389412672 207637360 15311360
11:50:32 1218 8192000000 10314487040 10718691328 1176773488 12.560 100 92 175 1 1426216032 228347216 21095328
11:51:39 2299 8192000000 10340362560 10750705664 1185733040 12.644 100 94 176 0 1444282064 238833200 19715824
11:52:47 1601 8192000000 10379693152 10787995648 1187702544 12.662 100 98 189 1 1491969520 282277264 21989712
11:53:51 3025 8192000000 10416760448 10844028928 1194673280 12.727 100 90 178 1 1528761904 311838160 22250464
11:54:58 806 8192000000 10455496272 10877587456 1202772816 12.802 100 95 180 2 1568145200 343836368 21536016
11:56:02 1025 8192000000 10468640160 10891042816 1190516400 12.688 100 99 197 0 1581328000 368576112 22235488
11:57:07 944 8192000000 10481672880 10898567168 1190861680 12.691 100 95 182 0 1587121360 375924640 20335040
11:58:11 978 8192000000 10470207920 10908561408 1179158576 12.582 100 98 194 0 1577583088 376807552 21616960
11:59:18 2072 8192000000 10510259968 10933800960 1186462288 12.650 100 89 174 1 1616214864 408911648 20840928
12:00:22 1246 8192000000 10523819280 10960547840 1194788208 12.728 100 95 184 0 1630558480 413150544 22619728
12:01:26 849 8192000000 10549131472 10974912512 1195690176 12.736 100 93 181 1 1650404448 433379776 21334496
12:02:29 7608 8192000000 10569576176 10997555200 1175713120 12.550 100 57 112 0 1668138336 477952512 14472704
12:03:55 7053 8192000000 10580336640 11036155904 1170160640 12.498 100 56 107 0 1682336960 498663024 13513296
12:05:07 13605 8192000000 10518451344 11007819776 1159589184 12.399 100 46 91 0 1615579472 443522432 12467856
12:06:31 4130 8192000000 10426385168 10933489664 1150680480 12.316 100 69 135 1 1553271712 385745504 16845728
12:07:40 2386 8192000000 10411358864 10891173888 1158488176 12.389 100 65 127 1 1509904000 336561680 14854144
12:08:48 23952 8192000000 10362433744 10859126784 1146274992 12.275 100 27 54 0 1467829072 314225712 7328368
12:10:34 15759 8192000000 10299116752 10767486976 1149548384 12.305 100 38 71 0 1391055600 233152192 8355024
12:11:56 40495 8192000000 10232031184 10664804352 1132997248 12.150 99 24 47 1 1341797264 203271520 5528496
12:13:58 27394 8192000000 10132477568 10601279488 1130950080 12.130 100 28 57 0 1242360656 105148512 6262064
12:15:27 37464 8192000000 10209691840 10633089024 1154188032 12.349 100 53 104 0 1310855552 144555680 12111840
12:17:58 46250 8192000000 10177502464 10625286144 1157648224 12.381 100 15 30 0 1274571664 113437104 3486336
12:19:44 57114 8192000000 10169644336 10674737152 1152382272 12.332 100 8 16 0 1257419232 103156304 1880656
12:21:47 65285 8192000000 10105497408 10556493824 1119124192 12.019 97 29 57 0 1179754768 54559360 6071216
12:23:55 85566 8192000000 10068580592 10513276928 1110539984 11.938 97 17 30 1 1146806624 33398560 2868080
12:26:38 108435 8192000000 10066214144 10531115008 1118795600 12.016 98 13 26 0 1161667840 40256032 2616208
12:29:28 148662 8192000000 10074015232 10534821888 1085193552 11.697 95 28 56 0 1136088144 45236752 5657840
12:32:57 80248 8192000000 10061329488 10532786176 1129225392 12.114 99 19 36 0 1178773056 45870096 3677568
12:35:19 16932 8192000000 10093460432 10536054784 1150878032 12.318 100 38 75 0 1201002592 42642784 7481776
12:36:51 11689 8192000000 10139643616 10576683008 1160104288 12.404 100 63 124 1 1241881168 68968608 12808272
12:38:04 1792 8192000000 10181196736 10609766400 1156139744 12.367 99 73 140 1 1284409728 113063952 15206032
12:39:07 215298 8192000000 10154890336 10612367360 1139819200 12.214 97 21 42 0 1271796592 127472544 4504848
12:43:43 59609 8192000000 10068690448 10570276864 1113686864 11.967 97 13 26 1 1180426784 64204112 2535808
12:45:51 98802 8192000000 10073932640 10517291008 1112147712 11.953 97 9 18 0 1154973024 41060752 1764560
12:48:31 45338 8192000000 10143653968 10616016896 1140917008 12.224 99 23 46 0 1236213040 90691248 4604784
12:50:16 84371 8192000000 10099896928 10564386816 1124972336 12.074 98 14 29 0 1217571088 89792848 2805904
12:52:42 101904 8192000000 10086317392 10547961856 1127520672 12.098 98 13 26 0 1211809568 81235760 3053136
12:55:27 33303 8192000000 10088086944 10519027712 1106400528 11.898 98 33 66 0 1166491248 53615760 6474960
12:57:06 25175 8192000000 10108709168 10539167744 1111215984 11.944 98 36 72 0 1176965920 58702288 7047648
12:58:33 215513 8192000000 10083601504 10543566848 1106203824 11.896 97 31 60 0 1190092896 77714912 6174160
13:03:23 53425 8192000000 10055682096 10524798976 1114983600 11.980 99 28 53 2 1150382864 29234064 6165200
13:05:18 39225 8192000000 10059455248 10504749056 1110935104 11.941 99 18 35 0 1142292192 27851696 3505392
13:07:07 60166 8192000000 10054022192 10514505728 1096411232 11.804 98 15 28 1 1148280496 48921920 2947344
13:09:31 61288 8192000000 10087989088 10554925056 1112204736 11.953 99 16 29 0 1188130176 73058752 2866688
13:11:35 61834 8192000000 10069269248 10546188288 1125646720 12.080 100 11 22 1 1176060000 48316000 2097280
13:13:45 20920 8192000000 10062807504 10498097152 1105833792 11.893 98 48 87 0 1152357616 36615008 9908816
13:15:09 14842 8192000000 10102937840 10539266048 1130810960 12.129 100 30 60 0 1191615920 54377920 6427040
13:16:33 26059 8192000000 10122682080 10576531456 1126180192 12.085 99 41 82 0 1222435712 87371792 8883728
13:17:59 29739 8192000000 10183725728 10619150336 1137877264 12.196 98 32 64 1 1268576928 123959776 6739888
13:19:29 21557 8192000000 10206207568 10641141760 1142317248 12.237 99 31 59 0 1294063872 145341296 6405328
13:21:02 48278 8192000000 10083284272 10539065344 1113192832 11.963 98 21 39 0 1154968112 37905024 3870256
13:22:54 47667 8192000000 10182698048 10631716864 1137636928 12.193 99 40 80 0 1246208800 100352960 8218912
13:24:45 73407 8192000000 10100713360 10541998080 1092091824 11.763 95 20 38 1 1145359632 49424544 3843264
13:27:07 127033 8192000000 10037015280 10472460288 1111942048 11.951 98 40 78 0 1158469424 38883840 7643536
13:30:17 54162 8192000000 10057089008 10530009088 1123256768 12.058 99 16 32 0 1162123872 35363888 3503216
13:32:11 60274 8192000000 10064826960 10506977280 1099861856 11.836 97 12 21 1 1134218080 32511760 1844464
13:34:14 97324 8192000000 10099029776 10589724672 1139994288 12.215 100 18 30 0 1226194928 82510320 3690320
13:36:55 42350 8192000000 9184354672 9502179328 333519680 3.912 29 4 8 0 362351184 27904624 926880

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:17, from 17-10-2022 13:39:27 to 17-10-2022 13:39:44.

Exceptions occured during test was in run

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

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 17-10-2022 13:39:45 to 17-10-2022 13:39:47.

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          213551
MON$OLDEST_ACTIVE               213552
MON$OLDEST_SNAPSHOT             213552
MON$NEXT_TRANSACTION            213552
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                       2096256
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             760
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

17.10.22 13:39:48. 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-17 13:39:50 No severe PSQL-related problems occured
17.10.22 13:39:52. End of report.