Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 25.09.2022 22:38
Common Performance Final Results
  1. Hardware and OS info
  2. Test configuration
  3. Test Finish details
  4. Test workload details
  5. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score:    as table     as chart
  2. Performance per MINUTE, during test_time phase:    as table     as chart
  3. Performance, DETAILS per units
  4. Memory consumption, metadata cache, attachments activity    as table    as chart
  5. Monitoring data: STATEMENTS activity, as chart
  6. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database statistics was not gathered. Change config parameter 'run_db_statistics' to 1.
  3. Database validation was not performed. Change config parameter 'run_db_validation' to 1.
  4. New in firebird.log while test was run
  5. Final processing of ISQL logs

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15256492 kB
MemAvailable 30586136 kB
Buffers 0 kB
Cached 16437672 kB
SwapCached 2132 kB
Command: fdisk -l
WARNING: fdisk GPT support is currently new, and therefore in an experimental phase. Use at your own discretion.
Disk /dev/sda: 599.9 GB, 599932581888 bytes, 1171743324 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk label type: gpt
Disk identifier: 919DACA4-2F35-4CBB-BAA7-2A8CD8F7168C
# Start End Size Type Name
1 2048 411647 200M EFI System EFI System Partition
2 411648 2508799 1G Microsoft basic
3 2508800 1171742719 557.5G Linux LVM
Disk /dev/mapper/centos_mscs--test--161-root: 53.7 GB, 53687091200 bytes, 104857600 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/mapper/centos_mscs--test--161-swap: 16.8 GB, 16844324864 bytes, 32899072 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/sdb: 536 MB, 536870912 bytes, 1048576 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk label type: dos
Disk identifier: 0x00000046
Device Boot Start End Blocks Id System
/dev/sdb1 63 514079 257008+ c W95 FAT32 (LBA)
Disk /dev/mapper/centos_mscs--test--161-home: 528.1 GB, 528109010944 bytes, 1031462912 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes

Server and database settinfs

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


Test configuration settings

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

Test finish info

FINISH_STATE                    NORMAL: TEST_TIME EXPIRED AT 2022-09-25 22:38:25
DTS_END                         2022-09-25 22:38:25.6990
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_AGGREGATE_PERF_DATA(83:5) ==> TMP_AGGREGATE_PERF_DATA_AUTOGEN(451:13) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/35154
TRN_ID                          254071
ATT_ID                          742
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: 9779.54 20344 1173545
customer order: creation 184.15 338 22098
customer order: refuse 15.66 376 1879
order to supplier: creation 49.07 1235 5888
order to supplier: removal 3.50 104187 420
invoice (draft): creation 49.75 3106 5970
invoice (draft): removal 55.91 811 6709
invoice accept: apply 44.09 16412 5291
invoice accept: cancel 50.18 734 6022
customer reserve: creation 4055.35 163 486642
customer reserve: removal 4959.19 57 595103
realization accept: apply 90.21 193 10825
realization accept: cancel 81.07 107 9728
payment from customer: creation 64.38 128 7725
payment from customer: removal 6.48 92 777
payment to supplier: creation 53.58 150 6430
payment to supplier: removal 3.58 120 430
service: total inventory turnovers 5.33 1067 640
service: total monetary turnovers 7.09 24 851
service: aggregate perf. data 0.94 17447 113
service: refresh index statistics 0.03 260123 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 25-09-2022 22:39:12 to 25-09-2022 22:39:14.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 3308
TEST_TIME 2 2837
TEST_TIME 3 2914
TEST_TIME 4 4528
TEST_TIME 5 4485
TEST_TIME 6 4813
TEST_TIME 7 4714
TEST_TIME 8 4828
TEST_TIME 9 4745
TEST_TIME 10 5024
TEST_TIME 11 5297
TEST_TIME 12 5318
TEST_TIME 13 5434
TEST_TIME 14 5528
TEST_TIME 15 5816
TEST_TIME 16 6119
TEST_TIME 17 6039
TEST_TIME 18 6791
TEST_TIME 19 6829
TEST_TIME 20 7197
TEST_TIME 21 7255
TEST_TIME 22 7977
TEST_TIME 23 8521
TEST_TIME 24 8810
TEST_TIME 25 9796
TEST_TIME 26 10386
TEST_TIME 27 10168
TEST_TIME 28 10443
TEST_TIME 29 10227
TEST_TIME 30 10381
TEST_TIME 31 10318
TEST_TIME 32 10298
TEST_TIME 33 10293
TEST_TIME 34 10333
TEST_TIME 35 10250
TEST_TIME 36 10248
TEST_TIME 37 10164
TEST_TIME 38 10240
TEST_TIME 39 10163
TEST_TIME 40 10343
TEST_TIME 41 10242
TEST_TIME 42 10151
TEST_TIME 43 9934
TEST_TIME 44 9832
TEST_TIME 45 10084
TEST_TIME 46 9902
TEST_TIME 47 9975
TEST_TIME 48 9926
TEST_TIME 49 9947
TEST_TIME 50 9972
TEST_TIME 51 9943
TEST_TIME 52 9883
TEST_TIME 53 9898
TEST_TIME 54 9819
TEST_TIME 55 9774
TEST_TIME 56 9692
TEST_TIME 57 9678
TEST_TIME 58 9651
TEST_TIME 59 9641
TEST_TIME 60 9662
TEST_TIME 61 9679
TEST_TIME 62 9678
TEST_TIME 63 9659
TEST_TIME 64 9728
TEST_TIME 65 9829
TEST_TIME 66 9766
TEST_TIME 67 9915
TEST_TIME 68 9943
TEST_TIME 69 9914
TEST_TIME 70 9952
TEST_TIME 71 10024
TEST_TIME 72 10033
TEST_TIME 73 10004
TEST_TIME 74 10016
TEST_TIME 75 9938
TEST_TIME 76 9838
TEST_TIME 77 9798
TEST_TIME 78 9788
TEST_TIME 79 9803
TEST_TIME 80 9783
TEST_TIME 81 9774
TEST_TIME 82 9690
TEST_TIME 83 9731
TEST_TIME 84 9720
TEST_TIME 85 9691
TEST_TIME 86 9727
TEST_TIME 87 9707
TEST_TIME 88 9699
TEST_TIME 89 9769
TEST_TIME 90 9747
TEST_TIME 91 9772
TEST_TIME 92 9772
TEST_TIME 93 9831
TEST_TIME 94 9844
TEST_TIME 95 9931
TEST_TIME 96 9890
TEST_TIME 97 9976
TEST_TIME 98 9886
TEST_TIME 99 9874
TEST_TIME 100 9854
TEST_TIME 101 9826
TEST_TIME 102 9846
TEST_TIME 103 9803
TEST_TIME 104 9763
TEST_TIME 105 9767
TEST_TIME 106 9726
TEST_TIME 107 9700
TEST_TIME 108 9709
TEST_TIME 109 9699
TEST_TIME 110 9738
TEST_TIME 111 9710
TEST_TIME 112 9710
TEST_TIME 113 9790
TEST_TIME 114 9779
TEST_TIME 115 9747
TEST_TIME 116 9747
TEST_TIME 117 9771
TEST_TIME 118 9757
TEST_TIME 119 9795
TEST_TIME 120 9782

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 25-09-2022 22:39:16 to 25-09-2022 22:39:19.

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 1626096 1626096 0 0.00 0 17361 6 0 0
doc_list_biud 1626094 1626094 0 0.00 0 43548 27 0 0
sp_add_invoice_to_stock 5356 5291 65 1.21 48 215505 16412 0 65
sp_cancel_adding_invoice 6022 6022 0 0.00 5 56062 734 0 0
sp_cancel_client_order 1879 1879 0 0.00 5 16185 377 0 0
sp_cancel_customer_reserve 595103 595103 0 0.00 0 43550 57 0 0
sp_cancel_pay_from_customer 777 777 0 0.00 2 6343 93 0 0
sp_cancel_pay_to_supplier 430 430 0 0.00 2 14730 121 0 0
sp_cancel_supplier_invoice 6714 6709 5 0.07 2 20515 811 0 5
sp_cancel_supplier_order 420 420 0 0.00 7 1223509 104188 0 0
sp_cancel_write_off 9728 9728 0 0.00 1 9847 108 0 0
sp_client_order 22098 22098 0 0.00 3 23448 338 0 0
sp_customer_reserve 486642 486642 0 0.00 0 112712 163 0 0
sp_fill_shopping_cart 33955 33955 0 0.00 1 15817 36 0 0
sp_fill_shopping_cart_clo_res 486640 486640 0 0.00 0 20510 13 0 0
sp_get_clo_for_invoice 5289 5289 0 0.00 0 27042 251 0 0
sp_kill_cost_storno 16957 16957 0 0.00 0 7036 53 0 0
sp_kill_qstorno_ret_qs2qd 1207063 1207063 0 0.00 0 43545 31 0 0
sp_kill_qty_storno 635975 635975 0 0.00 0 43548 68 0 0
sp_lock_selected_doc 22374 22374 0 0.00 0 8692 7 0 0
sp_make_cost_storno 30269 30269 0 0.00 0 17270 58 0 0
sp_multiply_rows_for_pdistr 30269 30269 0 0.00 0 8663 27 0 0
sp_multiply_rows_for_qdistr 22098 22098 0 0.00 0 21731 138 0 0
sp_pay_from_customer 7725 7725 0 0.00 4 13981 128 0 0
sp_pay_to_supplier 6430 6430 0 0.00 4 19904 151 0 0
sp_payment_common 14155 14155 0 0.00 1 8433 37 0 0
sp_qd_handle_on_cancel_clo 1879 1879 0 0.00 0 16178 331 0 0
sp_qd_handle_on_invoice_upd_sts 11311 11311 0 0.00 0 16464 333 0 0
sp_qd_handle_on_reserve_upd_sts 10825 10825 0 0.00 0 21770 61 0 0
sp_reserve_write_off 10825 10825 0 0.00 6 22033 194 0 0
sp_supplier_invoice 5970 5970 0 0.00 6 81083 3106 0 0
sp_supplier_order 5888 5888 0 0.00 5 28299 1236 0 0
srv_aggregate_perf_data 114 113 1 0.87 2724 142378 17447 0 1
srv_fill_mon_cache_memory 66 66 0 0.00 2189 156857 41098 0 0
srv_find_qd_qs_mism 1123355 1123355 0 0.00 0 14255 5 0 0
srv_make_invnt_saldo 640 640 0 0.00 56 80914 1067 0 0
srv_make_money_saldo 851 851 0 0.00 0 844 24 0 0
srv_recalc_idx_stat 4 4 0 0.00 115605 364921 260123 0 0
t$perf-abend:sp_add_invoice_to_stock 65 65 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-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5292 5292 0 0.00 0 14286 159 0 0
t$perf-norm:sp_cancel_adding_invoice 424 424 0 0.00 1 4812 88 0 0
t$perf-norm:sp_cancel_client_order 1879 1879 0 0.00 0 5955 20 0 0
t$perf-norm:sp_cancel_customer_reserve 743 743 0 0.00 0 1108 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 777 777 0 0.00 0 2769 9 0 0
t$perf-norm:sp_cancel_pay_to_supplier 430 430 0 0.00 0 153 2 0 0
t$perf-norm:sp_cancel_supplier_invoice 473 473 0 0.00 0 3247 17 0 0
t$perf-norm:sp_cancel_supplier_order 420 420 0 0.00 0 35490 1528 0 0
t$perf-norm:sp_cancel_write_off 1114 1114 0 0.00 0 8746 15 0 0
t$perf-norm:sp_client_order 22098 22098 0 0.00 0 9576 16 0 0
t$perf-norm:sp_customer_reserve 1049 1049 0 0.00 0 1382 6 0 0
t$perf-norm:sp_pay_from_customer 7725 7725 0 0.00 0 17150 10 0 0
t$perf-norm:sp_pay_to_supplier 6430 6430 0 0.00 0 9683 12 0 0
t$perf-norm:sp_reserve_write_off 10825 10825 0 0.00 0 11451 11 0 0
t$perf-norm:sp_supplier_invoice 5970 5970 0 0.00 0 6680 15 0 0
t$perf-norm:sp_supplier_order 5888 5888 0 0.00 0 8775 20 0 0
t$perf-norm:srv_aggregate_perf_data 113 113 0 0.00 0 529 8 0 0
t$perf-norm:srv_fill_mon_cache_memory 66 66 0 0.00 0 127 2 0 0
t$perf-norm:srv_make_invnt_saldo 640 640 0 0.00 0 1390 19 0 0
t$perf-norm:srv_make_money_saldo 851 851 0 0.00 0 1899 18 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 45 13 0 0
v_add_invoice_to_stock 10708 10578 130 1.21 0 13527 22 0 130
v_all_customers 40299 40299 0 0.00 0 23 1 0 0
v_all_suppliers 33244 33244 0 0.00 0 62 1 0 0
v_all_wares 44196 44196 0 0.00 0 109 1 0 0
v_cancel_adding_invoice 848 848 0 0.00 0 1300 9 0 0
v_cancel_client_order 3758 3758 0 0.00 0 12364 12 0 0
v_cancel_customer_prepayment 1554 1554 0 0.00 0 1775 6 0 0
v_cancel_customer_reserve 1486 1486 0 0.00 0 2195 7 0 0
v_cancel_payment_to_supplier 860 860 0 0.00 0 14666 37 0 0
v_cancel_supplier_invoice 956 946 10 1.04 0 15012 38 0 10
v_cancel_supplier_order 840 840 0 0.00 0 1311 8 0 0
v_cancel_write_off 2228 2228 0 0.00 0 9662 20 0 0
v_max_id_clo_ord 5888 5888 0 0.00 0 4534 2 0 0
v_max_id_clo_res 1049 1049 0 0.00 0 9043 19 0 0
v_max_id_ord_sup 5969 5969 0 0.00 0 6683 3 0 0
v_max_non_paid_invoice 1665 1665 0 0.00 0 2866 6 0 0
v_max_non_paid_realizn 4167 4167 0 0.00 0 6569 6 0 0
v_min_id_clo_ord 5888 5888 0 0.00 0 13442 11 0 0
v_min_id_clo_res 1049 1049 0 0.00 0 3628 12 0 0
v_min_id_ord_sup 5969 5969 0 0.00 0 3839 5 0 0
v_min_non_paid_invoice 6430 6430 0 0.00 0 8423 29 0 0
v_min_non_paid_realizn 7725 7725 0 0.00 0 8386 27 0 0
v_our_firm 11012 11012 0 0.00 0 17 1 0 0
v_reserve_write_off 21650 21650 0 0.00 0 13491 8 0 0
x_lock_depdocs_on_canc_invoice 12258 12258 0 0.00 0 18733 107 0 0
x_lock_depdocs_on_canc_sup_ord 420 420 0 0.00 0 28507 436 0 0
x_make_qstorno_1000_1200 5888 5888 0 0.00 1 26994 1158 0 0
x_make_qstorno_1200_2000 5970 5970 0 0.00 3 81061 2984 0 0
x_make_qstorno_2100_3300 486641 486641 0 0.00 0 112711 148 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 25-09-2022 22:39:20 to 25-09-2022 22:39:24.

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
20:08:29 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:30 26557 8192000000 9897221872 10208219136 978065744 10.665 100 82 164 0 1005735808 6384384 21285680
20:11:04 14016 8192000000 9943520736 10263257088 1022252880 11.094 100 88 176 0 1053351472 7988320 23110272
20:12:29 8255 8192000000 9974741776 10304290816 1059697312 11.454 100 90 180 0 1092492800 9456736 23338752
20:13:43 8350 8192000000 10018963424 10363990016 1105742704 11.892 100 80 160 0 1134787376 10148672 18896000
20:14:52 5669 8192000000 10070915984 10426068992 1157816688 12.383 100 79 158 0 1187817584 11333376 18667520
20:16:01 3257 8192000000 10121019792 10484813824 1206903168 12.840 100 82 162 0 1236985440 12286912 17795360
20:17:07 1460 8192000000 10163042032 10534031360 1246071840 13.202 100 90 179 0 1279822912 13436160 20314912
20:18:11 2498 8192000000 10187026912 10566950912 1271118864 13.432 100 82 161 1 1301492320 12582064 17791392
20:19:15 15787 8192000000 10203639328 10595454976 1297066896 13.669 100 58 116 0 1320849312 11506720 12275696
20:20:32 8185 8192000000 10186513952 10597031936 1302020816 13.714 100 20 40 1 1313063120 6795520 4246784
20:21:40 5060 8192000000 10198080192 10609418240 1311765856 13.802 100 34 67 1 1326226224 7443760 7016608
20:22:47 11281 8192000000 10211108080 10626818048 1321745824 13.893 100 23 43 1 1332904320 5604096 5554400
20:24:04 72928 8192000000 10219620640 10643361792 1332050064 13.986 100 30 60 2 1344065920 5224032 6791824
20:26:18 6336 8192000000 10225076544 10641977344 1331967664 13.985 100 18 36 0 1341811136 5841168 4002304
20:27:30 4767 8192000000 10214001328 10632003584 1306164944 13.751 98 25 50 1 1317445392 6247216 5033232
20:28:35 12258 8192000000 10212718464 10623827968 1292184704 13.624 98 32 62 0 1309693056 9500656 8007696
20:29:48 18951 8192000000 10177361120 10595385344 1254340800 13.278 96 22 42 1 1265071664 5719248 5011616
20:31:07 5106 8192000000 10139990592 10539089920 1221527488 12.976 97 20 38 1 1231312880 4953376 4832016
20:32:13 6652 8192000000 10127530736 10522734592 1202641680 12.801 96 26 48 0 1213995584 5119536 6234368
20:33:23 7836 8192000000 10157760704 10570182656 1271648864 13.437 100 17 34 1 1281035888 5649808 3737216
20:34:34 39094 8192000000 10179019520 10591846400 1285081728 13.559 100 20 40 0 1295548512 5980336 4486448
20:36:17 7062 8192000000 10199123440 10611359744 1301772208 13.711 100 30 60 0 1319829712 10858624 7198880
20:37:27 11516 8192000000 10203590800 10617556992 1308139936 13.769 100 18 38 3 1317066416 5375104 3551376
20:38:43 25299 8192000000 10236755664 10644918272 1333012480 13.994 100 43 84 1 1347689632 5268416 9408736
20:40:13 118087 8192000000 10267760416 10683674624 1351358064 14.160 100 43 86 0 1373763296 12194560 10210672
20:43:19 7764 8192000000 10277214112 10701787136 1373426096 14.358 100 39 76 2 1393723712 11242144 9055472
20:44:40 6635 8192000000 10298680336 10726653952 1389578432 14.502 100 49 97 1 1419583232 18879152 11125648
20:45:55 11984 8192000000 10312459008 10737799168 1377861968 14.397 98 49 96 0 1408720304 19334512 11523824
20:47:10 13795 8192000000 10344330096 10765783040 1403852416 14.629 99 42 84 0 1435946992 21427664 10666912
20:48:41 5250 8192000000 10359736512 10783547392 1431963840 14.879 100 59 118 1 1472760976 26286848 14510288
20:49:54 5630 8192000000 10347351520 10773635072 1416056144 14.738 99 56 112 3 1457498304 27959712 13482448
20:51:05 4445 8192000000 10360636128 10776420352 1402506912 14.617 98 65 125 0 1451737664 33632032 15598720
20:52:14 6028 8192000000 10356813264 10773372928 1412796080 14.709 100 68 133 2 1468299024 38566352 16936592
20:53:26 5248 8192000000 10360718896 10769788928 1403302640 14.624 100 72 144 1 1466463152 44807456 18353056
20:54:38 2185 8192000000 10387236096 10797101056 1421035840 14.782 100 76 150 1 1488175664 48418256 18721568
20:55:45 3968 8192000000 10361738464 10768547840 1396885840 14.567 100 63 126 0 1464368256 50570736 16911680
20:56:52 5397 8192000000 10346703984 10755624960 1384414288 14.456 100 70 139 1 1448726192 46496992 17814912
20:58:09 5803 8192000000 10367246288 10793385984 1416408768 14.741 100 45 90 0 1474374768 46026528 11939472
20:59:20 6972 8192000000 10354956144 10781093888 1395519200 14.555 100 41 82 0 1462277984 54657248 12101536
21:00:30 17223 8192000000 10336488912 10765012992 1377179968 14.391 100 38 75 0 1443688784 55825360 10683456
21:01:54 31204 8192000000 10311724976 10749661184 1339136016 14.050 98 21 42 0 1398223104 52399648 6687440
21:03:30 15084 8192000000 10291416912 10731507712 1353059968 14.175 100 33 65 0 1403797536 41452736 9284832
21:04:50 48508 8192000000 10258229856 10692198400 1314755328 13.829 97 20 40 0 1333395440 13591008 5049104
21:06:46 66753 8192000000 10291507440 10717065216 1345145040 14.104 99 11 22 1 1365417888 17622000 2650848
21:09:20 52392 8192000000 10283733664 10722488320 1357961296 14.219 99 15 30 1 1376258880 14951392 3346192
21:11:48 156847 8192000000 10281359328 10722353152 1324578720 13.918 95 9 18 0 1343024352 16400544 2045088
21:15:40 50273 8192000000 10299959968 10748215296 1387131648 14.480 100 25 49 1 1404233680 11630288 5471744
21:17:32 85324 8192000000 10311659456 10762539008 1382672512 14.440 99 9 18 0 1402476336 17299808 2504016
21:19:58 40261 8192000000 10317250160 10765099008 1395152288 14.552 99 34 68 1 1411822912 7876832 8793792
21:21:45 47746 8192000000 10327847184 10777460736 1410574416 14.689 100 29 58 1 1429174176 11479280 7120480
21:23:33 136437 8192000000 10298277088 10755194880 1371232768 14.338 97 26 52 1 1391074512 13473376 6368368
21:26:52 30760 8192000000 10302256640 10754199552 1387304544 14.482 99 35 69 2 1404940976 9149808 8486624
21:28:51 22992 8192000000 10275568560 10731757568 1358423360 14.223 98 40 81 0 1376457936 8721216 9313360
21:30:15 46768 8192000000 10277065264 10739851264 1359762496 14.235 98 15 28 1 1370098640 7315616 3020528
21:32:02 40466 8192000000 10286905936 10747781120 1376067360 14.381 99 20 40 0 1391283056 10461376 4754320
21:33:44 26493 8192000000 10278189456 10742710272 1356288704 14.204 98 10 20 0 1374822240 16549504 1984032
21:35:18 34840 8192000000 10269128336 10722414592 1352023968 14.166 99 33 66 0 1368324192 8395840 7904384
21:36:54 53074 8192000000 10233751504 10689794048 1322416208 13.899 98 6 12 0 1332324320 8245776 1662336
21:38:52 33638 8192000000 10253701232 10716397568 1352243408 14.168 100 19 35 0 1365200192 9627184 3329600
21:41:04 30558 8192000000 10275227184 10721083392 1326704864 13.937 97 19 38 0 1341542992 10835488 4002640
21:42:34 48624 8192000000 10270118976 10724499456 1347975232 14.129 99 17 33 0 1379242560 26974320 4293008
21:44:25 51478 8192000000 10283339312 10738900992 1353573616 14.180 99 17 34 0 1374764848 17230896 3960336
21:46:20 34155 8192000000 10280405248 10734460928 1359297952 14.231 99 26 52 0 1381568928 16366048 5904928
21:48:09 65079 8192000000 10274355696 10722623488 1327901664 13.948 97 10 20 1 1345223600 15040976 2280960
21:50:15 48077 8192000000 10289283136 10732941312 1340749776 14.064 98 20 40 0 1356440928 11538272 4152880
21:52:05 85027 8192000000 10277149408 10728005632 1337954848 14.039 98 26 52 1 1359695904 16266560 5474496
21:54:30 49400 8192000000 10290930912 10736070656 1380925824 14.425 100 43 86 1 1399529040 9463040 9140176
21:56:22 51250 8192000000 10278899888 10746093568 1373906160 14.362 100 12 24 0 1391942928 15359440 2677328
21:58:14 54617 8192000000 10279777184 10743209984 1369839744 14.326 99 12 24 0 1385835296 13347088 2648464
22:00:13 69454 8192000000 10282804288 10743070720 1368743792 14.316 99 17 35 0 1386939184 13520160 4675232
22:03:26 41756 8192000000 10293725504 10748825600 1376447552 14.385 99 22 44 0 1389233600 7873104 4912944
22:05:08 42843 8192000000 10295177584 10751307776 1380740432 14.423 99 33 65 1 1395501872 7573808 7187632
22:07:01 49537 8192000000 10287947264 10755751936 1367534720 14.305 98 16 32 0 1382496336 11047760 3913856
22:08:56 22799 8192000000 10307857968 10758651904 1393826640 14.540 100 43 86 2 1411641344 8284976 9529728
22:10:20 57291 8192000000 10301154640 10755190784 1356652864 14.207 97 12 24 0 1366919360 7540448 2726048
22:12:52 101233 8192000000 10292927280 10734555136 1312919392 13.813 94 22 44 1 1336809664 19000592 4889680
22:15:35 98951 8192000000 10291335056 10740039680 1368380480 14.313 99 22 44 1 1381873072 8606608 4885984
22:18:19 13225 8192000000 10304784240 10736345088 1369596800 14.323 99 61 117 1 1390554192 6584976 14372416
22:19:35 20410 8192000000 10279842640 10737307648 1375782112 14.379 100 23 46 0 1396460224 15365296 5312816
22:21:00 65403 8192000000 10268779360 10718720000 1337285008 14.033 97 6 12 0 1348154288 9459920 1409360
22:23:07 68998 8192000000 10279050432 10731991040 1359792048 14.235 98 19 38 0 1375391584 10853840 4745696
22:26:10 34484 8192000000 10256818176 10714628096 1328981968 13.958 97 24 48 1 1344089168 9805152 5302048
22:27:51 59546 8192000000 10262606176 10718769152 1344146192 14.095 98 20 40 0 1363819936 15443152 4230592
22:29:52 63528 8192000000 10283302384 10737553408 1370092304 14.328 99 19 36 0 1390298224 15607216 4598704
22:32:10 21462 8192000000 10290601008 10738978816 1365653072 14.288 99 41 80 0 1383765776 8151696 9961008
22:33:40 25759 8192000000 10282429008 10725703680 1320308080 13.879 96 38 76 0 1340913856 12259536 8346240
22:35:06 16639 8192000000 10273647792 10706411520 1342853888 14.083 100 54 108 0 1371017264 15951920 12211456
22:36:54 19691 8192000000 10273150496 10713194496 1334810704 14.011 99 41 82 0 1356571616 13263792 8497120
22:38:13 29529 8192000000 8990723984 9265410048 130834768 1.571 10 1 2 0 132103952 1226832 42352

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 65 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 25-09-2022 22:39:43 to 25-09-2022 22:39:45.

Content of mon$database and FB version

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


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

Database statistics

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

Database validation

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

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

--- start of diff output ---
--- end of diff output ---

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

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