Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 18.06.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 16176308 kB
MemAvailable 31238140 kB
Buffers 0 kB
Cached 15520236 kB
SwapCached 2460 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.10
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-06-18 22:38:19
DTS_END                         2022-06-18 22:38:19.2090
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(57:17)
IP                              ::1/33140
TRN_ID                          246694
ATT_ID                          702
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: 9073.88 20162 1088866
customer order: creation 173.23 341 20788
customer order: refuse 14.04 337 1685
order to supplier: creation 45.91 1265 5509
order to supplier: removal 3.31 94992 397
invoice (draft): creation 46.05 3815 5526
invoice (draft): removal 50.45 791 6054
invoice accept: apply 42.43 17634 5091
invoice accept: cancel 45.63 865 5475
customer reserve: creation 3846.10 177 461532
customer reserve: removal 4513.67 54 541640
realization accept: apply 85.53 180 10264
realization accept: cancel 78.72 107 9446
payment from customer: creation 58.84 122 7061
payment from customer: removal 5.28 83 634
payment to supplier: creation 49.38 123 5926
payment to supplier: removal 3.50 71 420
service: total inventory turnovers 4.59 1280 551
service: total monetary turnovers 6.41 96 769
service: aggregate perf. data 0.78 24970 94
service: refresh index statistics 0.03 255930 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 18-06-2022 22:39:10 to 18-06-2022 22:39:12.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4273
TEST_TIME 2 4197
TEST_TIME 3 4261
TEST_TIME 4 4775
TEST_TIME 5 4935
TEST_TIME 6 4988
TEST_TIME 7 5005
TEST_TIME 8 4975
TEST_TIME 9 5373
TEST_TIME 10 6267
TEST_TIME 11 6890
TEST_TIME 12 6974
TEST_TIME 13 7716
TEST_TIME 14 7840
TEST_TIME 15 8049
TEST_TIME 16 8351
TEST_TIME 17 8939
TEST_TIME 18 8888
TEST_TIME 19 8985
TEST_TIME 20 9012
TEST_TIME 21 9738
TEST_TIME 22 9791
TEST_TIME 23 9883
TEST_TIME 24 9843
TEST_TIME 25 9756
TEST_TIME 26 9860
TEST_TIME 27 10021
TEST_TIME 28 10167
TEST_TIME 29 10276
TEST_TIME 30 10578
TEST_TIME 31 10761
TEST_TIME 32 10988
TEST_TIME 33 10767
TEST_TIME 34 10496
TEST_TIME 35 10449
TEST_TIME 36 10419
TEST_TIME 37 10339
TEST_TIME 38 10183
TEST_TIME 39 10254
TEST_TIME 40 10148
TEST_TIME 41 10082
TEST_TIME 42 9938
TEST_TIME 43 9904
TEST_TIME 44 9848
TEST_TIME 45 9822
TEST_TIME 46 9720
TEST_TIME 47 9718
TEST_TIME 48 9591
TEST_TIME 49 9500
TEST_TIME 50 9501
TEST_TIME 51 9403
TEST_TIME 52 9392
TEST_TIME 53 9328
TEST_TIME 54 9284
TEST_TIME 55 9284
TEST_TIME 56 9312
TEST_TIME 57 9305
TEST_TIME 58 9200
TEST_TIME 59 9203
TEST_TIME 60 9161
TEST_TIME 61 9142
TEST_TIME 62 9118
TEST_TIME 63 9187
TEST_TIME 64 9188
TEST_TIME 65 9205
TEST_TIME 66 9146
TEST_TIME 67 9223
TEST_TIME 68 9222
TEST_TIME 69 9279
TEST_TIME 70 9202
TEST_TIME 71 9257
TEST_TIME 72 9277
TEST_TIME 73 9279
TEST_TIME 74 9330
TEST_TIME 75 9348
TEST_TIME 76 9417
TEST_TIME 77 9299
TEST_TIME 78 9283
TEST_TIME 79 9207
TEST_TIME 80 9188
TEST_TIME 81 9183
TEST_TIME 82 9138
TEST_TIME 83 9158
TEST_TIME 84 9098
TEST_TIME 85 9044
TEST_TIME 86 8979
TEST_TIME 87 9039
TEST_TIME 88 9021
TEST_TIME 89 9045
TEST_TIME 90 9051
TEST_TIME 91 9021
TEST_TIME 92 9098
TEST_TIME 93 9079
TEST_TIME 94 9136
TEST_TIME 95 9146
TEST_TIME 96 9165
TEST_TIME 97 9188
TEST_TIME 98 9199
TEST_TIME 99 9240
TEST_TIME 100 9206
TEST_TIME 101 9284
TEST_TIME 102 9309
TEST_TIME 103 9345
TEST_TIME 104 9257
TEST_TIME 105 9194
TEST_TIME 106 9199
TEST_TIME 107 9151
TEST_TIME 108 9099
TEST_TIME 109 9066
TEST_TIME 110 9100
TEST_TIME 111 9045
TEST_TIME 112 9023
TEST_TIME 113 8985
TEST_TIME 114 9051
TEST_TIME 115 9041
TEST_TIME 116 9013
TEST_TIME 117 9084
TEST_TIME 118 9077
TEST_TIME 119 9116
TEST_TIME 120 9083

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 18-06-2022 22:39:14 to 18-06-2022 22:39:17.

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 1516207 1516207 0 0.00 0 24280 6 0 0
doc_list_biud 1516207 1516207 0 0.00 0 72265 25 0 0
sp_add_invoice_to_stock 5256 5091 165 3.13 36 144250 17634 0 165
sp_cancel_adding_invoice 5475 5475 0 0.00 4 44918 866 0 0
sp_cancel_client_order 1685 1685 0 0.00 4 12339 338 0 0
sp_cancel_customer_reserve 541640 541640 0 0.00 1 26277 55 0 0
sp_cancel_pay_from_customer 634 634 0 0.00 2 5614 83 0 0
sp_cancel_pay_to_supplier 420 420 0 0.00 3 2497 72 0 0
sp_cancel_supplier_invoice 6068 6054 14 0.23 1 72273 792 0 14
sp_cancel_supplier_order 397 397 0 0.00 7 1006395 94993 0 0
sp_cancel_write_off 9446 9446 0 0.00 1 10699 108 0 0
sp_client_order 20788 20788 0 0.00 3 24943 341 0 0
sp_customer_reserve 461532 461532 0 0.00 0 46653 177 0 0
sp_fill_shopping_cart 31816 31816 0 0.00 1 17201 44 0 0
sp_fill_shopping_cart_clo_res 461524 461524 0 0.00 0 12353 14 0 0
sp_get_clo_for_invoice 5083 5083 0 0.00 0 20207 339 0 0
sp_kill_cost_storno 15975 15975 0 0.00 0 10685 59 0 0
sp_kill_qstorno_ret_qs2qd 1099177 1099177 0 0.00 0 72262 30 0 0
sp_kill_qty_storno 580044 580044 0 0.00 0 72264 66 0 0
sp_lock_selected_doc 21020 21020 0 0.00 0 7863 5 0 0
sp_make_cost_storno 28334 28334 0 0.00 0 19637 55 0 0
sp_multiply_rows_for_pdistr 28334 28334 0 0.00 0 7542 27 0 0
sp_multiply_rows_for_qdistr 20788 20788 0 0.00 0 15238 154 0 0
sp_pay_from_customer 7061 7061 0 0.00 4 49020 123 0 0
sp_pay_to_supplier 5926 5926 0 0.00 4 19649 124 0 0
sp_payment_common 12987 12987 0 0.00 1 49004 39 0 0
sp_qd_handle_on_cancel_clo 1685 1685 0 0.00 0 12332 307 0 0
sp_qd_handle_on_invoice_upd_sts 10558 10558 0 0.00 0 31343 361 0 0
sp_qd_handle_on_reserve_upd_sts 10264 10264 0 0.00 0 19775 67 0 0
sp_reserve_write_off 10264 10264 0 0.00 6 19844 181 0 0
sp_supplier_invoice 5526 5526 0 0.00 6 80269 3815 0 0
sp_supplier_order 5509 5509 0 0.00 5 33767 1266 0 0
srv_aggregate_perf_data 95 94 1 1.05 2493 347801 24970 0 1
srv_fill_mon_cache_memory 63 63 0 0.00 1848 146442 45426 0 0
srv_find_qd_qs_mism 1041108 1041108 0 0.00 0 24279 5 0 0
srv_make_invnt_saldo 551 551 0 0.00 51 109290 1281 0 0
srv_make_money_saldo 769 769 0 0.00 1 49774 96 0 0
srv_recalc_idx_stat 4 4 0 0.00 185252 427320 255930 0 0
t$perf-abend:sp_add_invoice_to_stock 165 165 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 14 14 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 5093 5093 0 0.00 0 15897 187 0 0
t$perf-norm:sp_cancel_adding_invoice 400 400 0 0.00 0 4550 101 0 0
t$perf-norm:sp_cancel_client_order 1685 1685 0 0.00 0 6782 17 0 0
t$perf-norm:sp_cancel_customer_reserve 707 707 0 0.00 0 1204 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 634 634 0 0.00 0 2110 9 0 0
t$perf-norm:sp_cancel_pay_to_supplier 420 420 0 0.00 0 1840 10 0 0
t$perf-norm:sp_cancel_supplier_invoice 400 400 0 0.00 0 487 11 0 0
t$perf-norm:sp_cancel_supplier_order 397 397 0 0.00 0 27521 1517 0 0
t$perf-norm:sp_cancel_write_off 1030 1030 0 0.00 0 6815 23 0 0
t$perf-norm:sp_client_order 20788 20788 0 0.00 0 6981 20 0 0
t$perf-norm:sp_customer_reserve 1045 1045 0 0.00 0 1184 5 0 0
t$perf-norm:sp_pay_from_customer 7061 7061 0 0.00 0 8798 15 0 0
t$perf-norm:sp_pay_to_supplier 5926 5926 0 0.00 0 5782 10 0 0
t$perf-norm:sp_reserve_write_off 10264 10264 0 0.00 0 6654 14 0 0
t$perf-norm:sp_supplier_invoice 5526 5526 0 0.00 0 5500 26 0 0
t$perf-norm:sp_supplier_order 5509 5509 0 0.00 0 4989 19 0 0
t$perf-norm:srv_aggregate_perf_data 94 94 0 0.00 0 217 6 0 0
t$perf-norm:srv_fill_mon_cache_memory 63 63 0 0.00 0 104 2 0 0
t$perf-norm:srv_make_invnt_saldo 551 551 0 0.00 0 1129 25 0 0
t$perf-norm:srv_make_money_saldo 769 769 0 0.00 0 4097 26 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 19 6 0 0
v_add_invoice_to_stock 10496 10166 330 3.14 0 6750 18 0 330
v_all_customers 37642 37642 0 0.00 0 16 1 0 0
v_all_suppliers 30342 30342 0 0.00 0 13 1 0 0
v_all_wares 41576 41576 0 0.00 0 19 1 0 0
v_cancel_adding_invoice 800 800 0 0.00 0 903 8 0 0
v_cancel_client_order 3370 3370 0 0.00 0 5336 6 0 0
v_cancel_customer_prepayment 1268 1268 0 0.00 0 2855 5 0 0
v_cancel_customer_reserve 1414 1414 0 0.00 0 4836 11 0 0
v_cancel_payment_to_supplier 840 840 0 0.00 0 2491 8 0 0
v_cancel_supplier_invoice 828 800 28 3.38 0 2438 19 0 28
v_cancel_supplier_order 794 794 0 0.00 0 676 4 0 0
v_cancel_write_off 2060 2060 0 0.00 0 1771 12 0 0
v_max_id_clo_ord 5508 5508 0 0.00 0 705 1 0 0
v_max_id_clo_res 1045 1045 0 0.00 0 3912 16 0 0
v_max_id_ord_sup 5520 5520 0 0.00 0 6961 6 0 0
v_max_non_paid_invoice 1783 1783 0 0.00 0 256 2 0 0
v_max_non_paid_realizn 3946 3946 0 0.00 0 3044 5 0 0
v_min_id_clo_ord 5508 5508 0 0.00 0 8794 10 0 0
v_min_id_clo_res 1045 1045 0 0.00 0 6807 23 0 0
v_min_id_ord_sup 5520 5520 0 0.00 0 6823 4 0 0
v_min_non_paid_invoice 5926 5926 0 0.00 0 8468 25 0 0
v_min_non_paid_realizn 7061 7061 0 0.00 0 48987 36 0 0
v_our_firm 10164 10164 0 0.00 0 25 1 0 0
v_reserve_write_off 20528 20528 0 0.00 0 5595 6 0 0
x_lock_depdocs_on_canc_invoice 11129 11129 0 0.00 0 11234 105 0 0
x_lock_depdocs_on_canc_sup_ord 397 397 0 0.00 0 4449 339 0 0
x_make_qstorno_1000_1200 5509 5509 0 0.00 2 33710 1173 0 0
x_make_qstorno_1200_2000 5526 5526 0 0.00 3 80260 3658 0 0
x_make_qstorno_2100_3300 461532 461532 0 0.00 0 46652 160 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 18-06-2022 22:39:18 to 18-06-2022 22:39:22.

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:22 10 8192000000 8798897392 8810233856 5315664 0.064 2 1 2 0 5415264 56816 42784
20:09:24 13979 8192000000 9873463392 10180984832 961591184 10.505 100 87 171 1 990327008 5703632 23032192
20:10:42 32971 8192000000 9944607696 10265747456 1019205280 11.064 100 90 181 0 1050667936 7991808 23470848
20:12:19 16487 8192000000 9974476448 10304299008 1056754880 11.425 100 85 170 1 1088177056 9579008 21843168
20:13:39 9737 8192000000 10029312880 10375897088 1121139168 12.038 100 77 155 0 1148756656 9432096 18185392
20:15:02 7746 8192000000 10089173072 10448830464 1175700304 12.550 100 80 160 1 1206112112 11762720 18649088
20:16:11 5496 8192000000 10133777232 10503520256 1222294688 12.983 100 79 157 1 1252542528 12858880 17388960
20:17:18 2117 8192000000 10160504272 10533613568 1248331872 13.223 100 89 179 1 1282673360 14135920 20205568
20:18:22 1617 8192000000 10200220208 10580922368 1280148416 13.514 100 88 177 0 1313631280 13398192 20084672
20:19:24 1244 8192000000 10224166256 10610356224 1304557264 13.737 100 93 185 0 1337837248 12491712 20788272
20:20:26 25954 8192000000 10217828448 10615939072 1310474256 13.790 100 67 136 2 1332627920 5116336 17037328
20:21:52 15395 8192000000 10206474256 10620358656 1314601072 13.828 100 26 53 1 1327237296 6990784 5645440
20:23:11 16927 8192000000 10219405456 10636910592 1325968160 13.931 100 13 26 0 1334309168 5764592 2576416
20:24:30 8553 8192000000 10225303008 10643836928 1336420208 14.025 100 27 53 0 1348628272 6297392 5910672
20:25:43 52711 8192000000 10227289024 10652819456 1343687328 14.091 100 52 104 2 1361873296 5960224 12225744
20:27:38 9894 8192000000 10220608368 10639855616 1317634976 13.855 99 20 38 1 1327837360 5362576 4839808
20:28:49 8069 8192000000 10154445552 10560413696 1243735168 13.181 98 31 62 1 1256518192 5435056 7347968
20:30:03 11162 8192000000 10143883760 10544762880 1232551728 13.078 98 23 46 2 1243503696 5278368 5673600
20:31:18 32056 8192000000 10116231584 10518269952 1168079056 12.479 93 22 44 0 1178224656 4294032 5851568
20:32:53 4357 8192000000 10160711584 10558390272 1259062672 13.321 100 35 69 0 1273191360 6047200 8081488
20:33:57 6080 8192000000 10180260608 10587619328 1288056976 13.587 100 25 50 0 1299486208 5871808 5557424
20:35:05 9663 8192000000 10189375296 10605195264 1298172928 13.679 100 22 44 0 1312479584 8805024 5501632
20:36:15 28549 8192000000 10190340864 10605858816 1301754576 13.711 100 24 48 3 1313043264 6348448 4940240
20:37:46 8655 8192000000 10205294976 10619990016 1311109312 13.796 100 31 62 1 1324735792 5990256 7636224
20:38:59 13832 8192000000 10243956528 10650398720 1326898016 13.939 99 47 92 0 1344404000 6497360 11008624
20:40:32 33313 8192000000 10261270112 10683301888 1360137584 14.239 100 33 65 0 1381484080 13491232 7855264
20:42:08 1847 8192000000 10290367024 10702897152 1371254544 14.338 100 60 118 1 1402511536 16734352 14522640
20:43:15 24154 8192000000 10282028528 10706931712 1370713296 14.333 100 34 68 0 1397522656 18234256 8575104
20:44:42 11820 8192000000 10287529856 10716684288 1380664880 14.422 100 42 82 1 1405944176 16097152 9182144
20:45:58 2862 8192000000 10300436272 10723274752 1382735632 14.441 100 48 97 0 1412981888 18806016 11440240
20:47:15 3084 8192000000 10309966672 10720976896 1371830752 14.343 99 74 146 1 1412593904 23523312 17239840
20:48:27 3731 8192000000 10270118256 10674884608 1327669344 13.946 97 71 142 1 1372551424 27324496 17557584
20:49:36 2152 8192000000 10310881152 10714238976 1357100000 14.211 99 90 178 3 1405041200 26439232 21501968
20:50:41 2822 8192000000 10294467632 10696556544 1338207728 14.041 99 80 160 0 1390721152 32891216 19622208
20:51:52 4822 8192000000 10291959152 10699112448 1347393184 14.124 99 72 144 1 1390755808 25635216 17727408
20:53:02 3253 8192000000 10289783232 10689667072 1340055280 14.058 98 71 142 0 1385623808 28800944 16767584
20:54:09 4900 8192000000 10296864784 10703863808 1346601648 14.117 99 70 138 2 1393066464 29907856 16556960
20:55:18 5599 8192000000 10304234048 10715099136 1359443360 14.232 100 58 112 0 1407512160 33162576 14906224
20:56:27 15242 8192000000 10289833040 10713612288 1362691104 14.262 100 30 60 0 1397961696 27283632 7986960
20:57:48 10299 8192000000 10309228032 10718851072 1361709904 14.253 100 61 122 0 1410026096 32966096 15350096
20:59:03 6290 8192000000 10317009040 10728390656 1365667840 14.288 100 71 142 0 1420160880 36006000 18487040
21:00:12 10819 8192000000 10294549488 10720145408 1363373856 14.268 100 38 75 1 1401698320 28356144 9968320
21:01:28 9227 8192000000 10309474224 10739531776 1363892048 14.272 99 30 61 2 1404711664 32627888 8191728
21:02:42 9697 8192000000 10329695200 10760503296 1381166848 14.427 99 31 62 2 1426422512 37010032 8245632
21:04:11 23372 8192000000 10336547792 10769018880 1390863280 14.514 100 24 48 1 1444451232 47205792 6382160
21:05:39 41603 8192000000 10337636128 10772619264 1365085952 14.283 98 26 52 1 1422354720 49452800 7815968
21:07:22 22986 8192000000 10333801296 10782801920 1380878400 14.424 100 26 52 1 1437505568 49140336 7486832
21:08:51 19671 8192000000 10335972368 10771976192 1384812368 14.460 99 43 83 1 1428143280 33943888 9387024
21:10:12 33075 8192000000 10301281600 10754068480 1396138016 14.561 100 19 38 2 1412519584 12190336 4191232
21:12:10 87934 8192000000 10318203568 10766700544 1394193184 14.543 99 30 60 0 1416073328 14658656 7221488
21:14:40 33195 8192000000 10322478544 10763632640 1406020736 14.649 100 31 63 1 1424231840 10686592 7524512
21:16:14 75967 8192000000 10326552160 10793943040 1423024608 14.800 100 13 26 0 1441648944 15570224 3054112
21:18:31 85315 8192000000 10319527136 10771722240 1402228256 14.615 99 13 26 1 1420408880 15055824 3124800
21:21:02 68932 8192000000 10313787168 10778501120 1409847872 14.683 100 21 42 1 1431032400 16363408 4821120
21:23:13 65306 8192000000 10314161760 10773983232 1386576272 14.475 98 16 32 1 1401782176 11108944 4096960
21:26:41 121682 8192000000 10285274688 10750214144 1361052224 14.247 97 14 27 0 1377263520 13009184 3202112
21:30:29 58311 8192000000 10288121792 10752311296 1359816160 14.236 97 9 18 0 1378984560 17069968 2098432
21:32:45 51956 8192000000 10283481456 10750164992 1375720544 14.378 99 21 42 2 1394010512 13321520 4968448
21:35:07 52430 8192000000 10238610288 10693701632 1291749216 13.620 94 16 31 1 1312332528 16386080 4197232
21:37:14 42478 8192000000 10256165840 10718916608 1348643152 14.135 99 11 22 0 1360464128 9546928 2274048
21:39:16 40027 8192000000 10225532448 10675118080 1279246704 13.506 95 24 48 1 1290812640 6621600 4944336
21:41:25 32255 8192000000 10241167664 10683686912 1318093408 13.859 99 41 82 0 1338874944 11258480 9523056
21:42:59 8563 8192000000 10274345248 10710380544 1359633520 14.234 100 48 95 2 1379486320 7633808 12218992
21:44:11 34199 8192000000 10288677680 10725740544 1358477376 14.224 99 35 68 2 1378388112 12588272 7322464
21:45:47 84243 8192000000 10257856144 10701414400 1299451856 13.690 94 16 31 1 1315197360 12230624 3514880
21:48:11 39144 8192000000 10286975056 10721812480 1343210384 14.086 98 24 48 1 1356433856 8093600 5129872
21:49:54 110425 8192000000 10279423056 10734673920 1322752992 13.902 96 12 24 0 1338525648 13081056 2691600
21:52:50 57231 8192000000 10296312816 10745298944 1339410688 14.052 97 13 24 0 1362343680 20204848 2728144
21:54:50 146442 8192000000 10277463536 10725208064 1360180624 14.239 99 10 20 0 1379356912 16617872 2558416
21:58:24 88930 8192000000 10287587728 10752311296 1372741936 14.352 99 10 20 1 1387738256 12942256 2054064
22:01:19 83621 8192000000 10281807920 10748309504 1371570416 14.341 99 10 21 1 1389868000 15826448 2471136
22:03:43 65276 8192000000 10289638656 10743529472 1388511248 14.493 100 18 36 2 1403847664 10996560 4339856
22:05:52 51193 8192000000 10291515472 10749399040 1392262752 14.526 100 7 14 0 1400029024 6524960 1241312
22:07:48 77037 8192000000 10296750272 10758160384 1360350576 14.241 97 15 30 0 1373821312 9634368 3836368
22:10:05 70463 8192000000 10295790304 10752290816 1364447216 14.277 97 17 34 0 1379356064 11394224 3514624
22:12:21 41552 8192000000 10317266672 10771185664 1389668736 14.503 99 11 22 1 1399626336 7943808 2013792
22:14:14 95112 8192000000 10298084688 10751242240 1331181136 13.978 95 20 40 0 1353970752 18056624 4732992
22:16:50 83138 8192000000 10302362576 10751078400 1346291136 14.114 97 19 38 1 1364476496 14236576 3948784
22:19:18 92642 8192000000 10299053888 10747756544 1303666912 13.729 94 8 16 0 1318290912 13016704 1607296
22:22:03 95101 8192000000 10279912832 10729259008 1364531760 14.278 99 29 57 0 1382285024 11468288 6284976
22:24:44 35334 8192000000 10263202656 10715668480 1326698944 13.937 96 3 6 0 1333162544 5843488 620112
22:26:20 48692 8192000000 10253646864 10702344192 1328534320 13.954 97 10 20 0 1340982288 10121904 2326064
22:28:46 47305 8192000000 10243243872 10700746752 1337385584 14.034 99 11 22 0 1348052960 8392496 2274880
22:30:39 87300 8192000000 10258222784 10710532096 1313606960 13.819 96 10 20 0 1327382112 11234912 2540240
22:33:12 34055 8192000000 10256832768 10700480512 1309421472 13.781 97 25 50 1 1327900608 12839296 5639840
22:34:59 72546 8192000000 10252763424 10711498752 1335002240 14.012 99 11 22 1 1352254992 14721296 2531456
22:37:12 75857 8192000000 9255870048 9536536576 399910272 4.654 30 7 14 0 410651744 9351280 1390192

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 18-06-2022 22:39:24 to 18-06-2022 22:39:39.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 165 v_add_invoice_to_stock 335544517
except 14 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 18-06-2022 22:39:40 to 18-06-2022 22:39:42.

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          247012
MON$OLDEST_ACTIVE               247013
MON$OLDEST_SNAPSHOT             247013
MON$NEXT_TRANSACTION            247013
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                       2047328
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


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

18.06.22 22:39:43. 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-06-18 22:39:45 No severe PSQL-related problems occured
18.06.22 22:39:47. End of report.