Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 02.06.2022 22:39
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 16333360 kB
MemAvailable 31322296 kB
Buffers 0 kB
Cached 15355968 kB
SwapCached 2444 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-02 22:38:17
DTS_END                         2022-06-02 22:38:17.4630
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/40730
TRN_ID                          236293
ATT_ID                          641
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: 9533.33 24335 1144000
customer order: creation 168.90 371 20268
customer order: refuse 13.98 373 1678
order to supplier: creation 44.42 1230 5330
order to supplier: removal 3.45 104841 414
invoice (draft): creation 44.38 3038 5326
invoice (draft): removal 55.83 778 6699
invoice accept: apply 40.67 17232 4880
invoice accept: cancel 50.53 799 6064
customer reserve: creation 3839.52 165 460742
customer reserve: removal 4972.45 56 596694
realization accept: apply 80.72 186 9687
realization accept: cancel 89.86 97 10783
payment from customer: creation 58.28 106 6993
payment from customer: removal 5.24 68 629
payment to supplier: creation 49.68 115 5961
payment to supplier: removal 3.45 84 414
service: total inventory turnovers 4.88 1101 586
service: total monetary turnovers 6.38 23 765
service: aggregate perf. data 0.69 26658 83
service: refresh index statistics 0.03 329372 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 02-06-2022 22:39:27 to 02-06-2022 22:39:29.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5281
TEST_TIME 2 5149
TEST_TIME 3 5254
TEST_TIME 4 4942
TEST_TIME 5 5108
TEST_TIME 6 5477
TEST_TIME 7 5570
TEST_TIME 8 5564
TEST_TIME 9 6004
TEST_TIME 10 6521
TEST_TIME 11 6977
TEST_TIME 12 7096
TEST_TIME 13 7235
TEST_TIME 14 7182
TEST_TIME 15 7498
TEST_TIME 16 7363
TEST_TIME 17 7486
TEST_TIME 18 8335
TEST_TIME 19 8585
TEST_TIME 20 9128
TEST_TIME 21 9775
TEST_TIME 22 9834
TEST_TIME 23 10833
TEST_TIME 24 10760
TEST_TIME 25 11487
TEST_TIME 26 11266
TEST_TIME 27 11057
TEST_TIME 28 11357
TEST_TIME 29 11340
TEST_TIME 30 11129
TEST_TIME 31 11046
TEST_TIME 32 11011
TEST_TIME 33 10698
TEST_TIME 34 10607
TEST_TIME 35 10811
TEST_TIME 36 10615
TEST_TIME 37 10524
TEST_TIME 38 10450
TEST_TIME 39 10349
TEST_TIME 40 10383
TEST_TIME 41 10368
TEST_TIME 42 10269
TEST_TIME 43 10188
TEST_TIME 44 10077
TEST_TIME 45 10019
TEST_TIME 46 9934
TEST_TIME 47 10070
TEST_TIME 48 10282
TEST_TIME 49 10322
TEST_TIME 50 10195
TEST_TIME 51 10167
TEST_TIME 52 10144
TEST_TIME 53 10040
TEST_TIME 54 9936
TEST_TIME 55 9915
TEST_TIME 56 9851
TEST_TIME 57 9776
TEST_TIME 58 9723
TEST_TIME 59 9650
TEST_TIME 60 9664
TEST_TIME 61 9661
TEST_TIME 62 9691
TEST_TIME 63 9659
TEST_TIME 64 9729
TEST_TIME 65 9806
TEST_TIME 66 9901
TEST_TIME 67 9879
TEST_TIME 68 9826
TEST_TIME 69 9982
TEST_TIME 70 10007
TEST_TIME 71 10036
TEST_TIME 72 10056
TEST_TIME 73 10054
TEST_TIME 74 10075
TEST_TIME 75 9993
TEST_TIME 76 9886
TEST_TIME 77 9947
TEST_TIME 78 9908
TEST_TIME 79 9846
TEST_TIME 80 9836
TEST_TIME 81 9845
TEST_TIME 82 9791
TEST_TIME 83 9728
TEST_TIME 84 9695
TEST_TIME 85 9655
TEST_TIME 86 9641
TEST_TIME 87 9639
TEST_TIME 88 9630
TEST_TIME 89 9596
TEST_TIME 90 9578
TEST_TIME 91 9614
TEST_TIME 92 9617
TEST_TIME 93 9703
TEST_TIME 94 9730
TEST_TIME 95 9745
TEST_TIME 96 9758
TEST_TIME 97 9786
TEST_TIME 98 9785
TEST_TIME 99 9802
TEST_TIME 100 9822
TEST_TIME 101 9860
TEST_TIME 102 9919
TEST_TIME 103 9864
TEST_TIME 104 9810
TEST_TIME 105 9783
TEST_TIME 106 9762
TEST_TIME 107 9713
TEST_TIME 108 9743
TEST_TIME 109 9720
TEST_TIME 110 9694
TEST_TIME 111 9680
TEST_TIME 112 9632
TEST_TIME 113 9581
TEST_TIME 114 9567
TEST_TIME 115 9566
TEST_TIME 116 9532
TEST_TIME 117 9553
TEST_TIME 118 9586
TEST_TIME 119 9602
TEST_TIME 120 9537

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 02-06-2022 22:39:30 to 02-06-2022 22:39:34.

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 1571062 1571062 0 0.00 0 21847 6 0 0
doc_list_biud 1571060 1571060 0 0.00 0 52354 27 0 0
sp_add_invoice_to_stock 5025 4880 145 2.88 27 194624 17232 0 145
sp_cancel_adding_invoice 6064 6064 0 0.00 4 51345 800 0 0
sp_cancel_client_order 1678 1678 0 0.00 4 14528 374 0 0
sp_cancel_customer_reserve 596694 596694 0 0.00 1 52357 57 0 0
sp_cancel_pay_from_customer 629 629 0 0.00 2 5316 68 0 0
sp_cancel_pay_to_supplier 414 414 0 0.00 2 5778 85 0 0
sp_cancel_supplier_invoice 6719 6699 20 0.29 2 17123 778 0 20
sp_cancel_supplier_order 414 414 0 0.00 8 1091747 104841 0 0
sp_cancel_write_off 10783 10783 0 0.00 1 9063 98 0 0
sp_client_order 20268 20268 0 0.00 3 20261 371 0 0
sp_customer_reserve 460742 460742 0 0.00 0 124444 166 0 0
sp_fill_shopping_cart 30915 30915 0 0.00 1 13112 34 0 0
sp_fill_shopping_cart_clo_res 460737 460737 0 0.00 0 30115 13 0 0
sp_get_clo_for_invoice 4869 4869 0 0.00 0 19868 305 0 0
sp_kill_cost_storno 17890 17890 0 0.00 0 13850 53 0 0
sp_kill_qstorno_ret_qs2qd 1211284 1211284 0 0.00 0 52337 31 0 0
sp_kill_qty_storno 636881 636881 0 0.00 0 52352 67 0 0
sp_lock_selected_doc 20095 20095 0 0.00 0 9810 6 0 0
sp_make_cost_storno 27505 27505 0 0.00 0 16508 51 0 0
sp_multiply_rows_for_pdistr 27504 27504 0 0.00 0 21844 28 0 0
sp_multiply_rows_for_qdistr 20268 20268 0 0.00 0 11048 167 0 0
sp_pay_from_customer 6993 6993 0 0.00 4 21851 106 0 0
sp_pay_to_supplier 5961 5961 0 0.00 4 17712 116 0 0
sp_payment_common 12954 12954 0 0.00 1 12971 20 0 0
sp_qd_handle_on_cancel_clo 1678 1678 0 0.00 0 14518 353 0 0
sp_qd_handle_on_invoice_upd_sts 10927 10927 0 0.00 0 41903 337 0 0
sp_qd_handle_on_reserve_upd_sts 9686 9686 0 0.00 0 21386 66 0 0
sp_reserve_write_off 9687 9687 0 0.00 6 21402 187 0 0
sp_supplier_invoice 5326 5326 0 0.00 6 93464 3039 0 0
sp_supplier_order 5330 5330 0 0.00 5 26439 1230 0 0
srv_aggregate_perf_data 84 83 1 1.19 2394 463642 26659 0 1
srv_fill_mon_cache_memory 64 64 0 0.00 1505 113201 47224 0 0
srv_find_qd_qs_mism 1096979 1096979 0 0.00 0 16553 5 0 0
srv_make_invnt_saldo 586 586 0 0.00 26 107639 1102 0 0
srv_make_money_saldo 765 765 0 0.00 1 1436 23 0 0
srv_recalc_idx_stat 4 4 0 0.00 132351 451114 329372 0 0
t$perf-abend:sp_add_invoice_to_stock 145 145 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 20 20 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 4880 4880 0 0.00 0 8952 187 0 0
t$perf-norm:sp_cancel_adding_invoice 379 379 0 0.00 0 1722 87 0 0
t$perf-norm:sp_cancel_client_order 1678 1678 0 0.00 0 13534 19 0 0
t$perf-norm:sp_cancel_customer_reserve 591 591 0 0.00 0 2188 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 629 629 0 0.00 0 4361 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 414 414 0 0.00 0 1330 6 0 0
t$perf-norm:sp_cancel_supplier_invoice 414 414 0 0.00 0 1577 25 0 0
t$perf-norm:sp_cancel_supplier_order 414 414 0 0.00 0 16943 1627 0 0
t$perf-norm:sp_cancel_write_off 1027 1027 0 0.00 0 2436 8 0 0
t$perf-norm:sp_client_order 20268 20268 0 0.00 0 5962 18 0 0
t$perf-norm:sp_customer_reserve 990 990 0 0.00 0 3102 10 0 0
t$perf-norm:sp_pay_from_customer 6993 6993 0 0.00 0 4287 9 0 0
t$perf-norm:sp_pay_to_supplier 5961 5961 0 0.00 0 13422 11 0 0
t$perf-norm:sp_reserve_write_off 9687 9687 0 0.00 0 7321 13 0 0
t$perf-norm:sp_supplier_invoice 5326 5326 0 0.00 0 8865 24 0 0
t$perf-norm:sp_supplier_order 5330 5330 0 0.00 0 14998 22 0 0
t$perf-norm:srv_aggregate_perf_data 83 83 0 0.00 0 1225 29 0 0
t$perf-norm:srv_fill_mon_cache_memory 64 64 0 0.00 0 2986 82 0 0
t$perf-norm:srv_make_invnt_saldo 586 586 0 0.00 0 1105 19 0 0
t$perf-norm:srv_make_money_saldo 765 765 0 0.00 0 2508 25 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 16 6 0 0
v_add_invoice_to_stock 10016 9726 290 2.89 0 20842 21 0 290
v_all_customers 37246 37246 0 0.00 0 20 1 0 0
v_all_suppliers 30402 30402 0 0.00 0 131 1 0 0
v_all_wares 40536 40536 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 758 758 0 0.00 0 968 7 0 0
v_cancel_client_order 3356 3356 0 0.00 0 1392 4 0 0
v_cancel_customer_prepayment 1258 1258 0 0.00 0 5304 8 0 0
v_cancel_customer_reserve 1182 1182 0 0.00 0 2688 6 0 0
v_cancel_payment_to_supplier 828 828 0 0.00 0 2518 10 0 0
v_cancel_supplier_invoice 868 828 40 4.60 0 964 15 0 40
v_cancel_supplier_order 828 828 0 0.00 0 1717 7 0 0
v_cancel_write_off 2054 2054 0 0.00 0 6666 16 0 0
v_max_id_clo_ord 5330 5330 0 0.00 0 2206 1 0 0
v_max_id_clo_res 990 990 0 0.00 0 3806 12 0 0
v_max_id_ord_sup 5317 5317 0 0.00 0 4702 4 0 0
v_max_non_paid_invoice 1407 1407 0 0.00 0 850 3 0 0
v_max_non_paid_realizn 3560 3560 0 0.00 0 4107 5 0 0
v_min_id_clo_ord 5330 5330 0 0.00 0 4135 7 0 0
v_min_id_clo_res 990 990 0 0.00 0 1902 7 0 0
v_min_id_ord_sup 5317 5317 0 0.00 0 3864 4 0 0
v_min_non_paid_invoice 5961 5961 0 0.00 0 8253 12 0 0
v_min_non_paid_realizn 6993 6993 0 0.00 0 12966 15 0 0
v_our_firm 10156 10156 0 0.00 0 130 1 0 0
v_reserve_write_off 19372 19372 0 0.00 0 7292 8 0 0
x_lock_depdocs_on_canc_invoice 12349 12349 0 0.00 0 25880 120 0 0
x_lock_depdocs_on_canc_sup_ord 414 414 0 0.00 0 16036 375 0 0
x_make_qstorno_1000_1200 5330 5330 0 0.00 1 26428 1154 0 0
x_make_qstorno_1200_2000 5326 5326 0 0.00 2 93339 2917 0 0
x_make_qstorno_2100_3300 460742 460742 0 0.00 0 124442 150 0 0

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

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:21 1 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:21 42059 8192000000 9910441344 10219659264 988218544 10.764 100 92 184 1 1018112256 5983728 23909984
20:11:06 11017 8192000000 9947328512 10267770880 1032179888 11.189 100 90 180 0 1063837312 8362128 23295296
20:12:25 18110 8192000000 9979504960 10314104832 1065555536 11.510 100 86 173 0 1096673472 9694096 21423840
20:13:57 15198 8192000000 10053364864 10401959936 1138044928 12.197 100 82 164 1 1168185328 10783104 19357296
20:15:16 9507 8192000000 10096286720 10455855104 1183148032 12.620 100 86 172 0 1216267584 13734176 19385376
20:16:27 5642 8192000000 10128722512 10497142784 1217196016 12.936 100 82 163 1 1248984416 13378256 18410144
20:17:34 3479 8192000000 10170515936 10546163712 1252821600 13.264 100 85 170 2 1285241952 13915776 18504576
20:18:39 2101 8192000000 10193786016 10573697024 1281427008 13.526 100 93 186 0 1315439808 13316256 20696544
20:19:43 1472 8192000000 10210896368 10592296960 1291249200 13.616 100 91 182 0 1324822672 12381904 21191568
20:20:46 3261 8192000000 10203535824 10599743488 1301770368 13.711 100 58 114 0 1325552336 10619936 13162032
20:21:51 9546 8192000000 10192886608 10604986368 1311158112 13.797 100 15 30 0 1319579968 5034752 3387104
20:23:03 74951 8192000000 10222883200 10638319616 1325540704 13.927 100 31 62 2 1337411376 5006048 6864624
20:25:18 5700 8192000000 10228632704 10641756160 1330104304 13.968 100 29 58 1 1342914992 5838864 6971824
20:26:24 9515 8192000000 10231742448 10650009600 1336111040 14.022 100 17 34 1 1345132624 5417232 3604352
20:27:35 59384 8192000000 10230187360 10650800128 1339865456 14.056 100 30 60 1 1353568768 5476128 8227184
20:29:37 4957 8192000000 10224231424 10629148672 1320354112 13.880 100 35 70 0 1335348784 7492064 7502608
20:30:42 5929 8192000000 10124039840 10520682496 1203635328 12.810 96 17 32 2 1212691632 5224240 3832064
20:31:48 10752 8192000000 10135172960 10535833600 1234860192 13.099 99 27 54 1 1246464464 5179856 6424416
20:33:00 40306 8192000000 10155982176 10559303680 1253715744 13.272 99 36 72 0 1268298784 5113424 9469616
20:34:40 6344 8192000000 10188216336 10591813632 1287150800 13.578 100 26 52 0 1299321968 6157376 6013792
20:35:49 8699 8192000000 10199755408 10610970624 1300279312 13.698 100 27 54 0 1312174368 5667040 6228016
20:36:59 12123 8192000000 10198422752 10618105856 1310705792 13.792 100 12 23 0 1317955360 4957920 2291648
20:38:11 40051 8192000000 10223240960 10633203712 1321309472 13.889 100 38 76 0 1335302320 5502208 8490640
20:40:01 9023 8192000000 10263970128 10671214592 1349209552 14.140 100 60 118 0 1372415984 10206304 13000128
20:41:13 43375 8192000000 10283052032 10705088512 1366000304 14.291 100 30 60 0 1386715200 13164672 7550224
20:43:08 16193 8192000000 10310481904 10729046016 1383868832 14.451 100 50 99 1 1418028192 22311648 11847712
20:44:30 15537 8192000000 10314403120 10732990464 1389852352 14.505 100 53 106 0 1427748464 25042224 12853888
20:45:50 8895 8192000000 10312092208 10736418816 1383232768 14.445 99 60 116 1 1421963104 24952512 13777824
20:47:07 5029 8192000000 10342558224 10763018240 1404826704 14.638 100 63 123 2 1452289824 32321248 15141872
20:48:16 3994 8192000000 10358713008 10780999680 1419128640 14.765 100 74 148 3 1468866688 31583856 18154192
20:49:24 2200 8192000000 10371924592 10791284736 1427042208 14.835 100 78 155 0 1478851024 33833280 17975536
20:50:29 6580 8192000000 10359607856 10778902528 1415326544 14.731 100 76 152 1 1467593840 33871424 18395872
20:51:44 1502 8192000000 10351707520 10760982528 1394216432 14.543 99 85 169 0 1453875088 39171104 20487552
20:52:49 1997 8192000000 10367311872 10774986752 1407780976 14.664 100 79 157 1 1473119840 44590416 20748448
20:53:58 2942 8192000000 10343608560 10746310656 1360188896 14.239 97 85 170 1 1427762624 45092160 22481568
20:55:10 3000 8192000000 10352298064 10756632576 1376204832 14.383 100 84 169 0 1458002416 59746400 22051184
20:56:19 19418 8192000000 10308607200 10725015552 1328616704 13.955 96 43 87 0 1401830992 60621232 12593056
20:57:43 19432 8192000000 10344311632 10769518592 1386026352 14.470 100 40 79 3 1455933920 58462736 11444832
20:59:31 34339 8192000000 10297549712 10730942464 1347729424 14.127 98 26 52 1 1397560352 42959792 6871136
21:01:09 9672 8192000000 10304279856 10732924928 1353498368 14.179 100 31 62 4 1408429792 45838096 9093328
21:02:20 43044 8192000000 10283648432 10725036032 1325270336 13.924 98 16 32 2 1357589232 28131120 4187776
21:04:04 55876 8192000000 10271871920 10707222528 1353913104 14.183 100 27 54 4 1371876416 10895968 7067344
21:06:02 66730 8192000000 10275174928 10740850688 1337637584 14.036 98 13 26 0 1365178848 24174656 3366608
21:08:09 92003 8192000000 10266271392 10708406272 1299935776 13.695 95 22 44 1 1314001488 9456928 4608784
21:10:43 90912 8192000000 10301733296 10745225216 1368842672 14.317 100 30 59 0 1397694816 21772768 7079376
21:13:21 49330 8192000000 10284394160 10740883456 1376572192 14.386 100 14 28 0 1394303520 14713840 3017488
21:15:12 17301 8192000000 10279166288 10725896192 1348209664 14.131 98 27 53 1 1364083616 10118400 5755552
21:16:31 22940 8192000000 10311201824 10742034432 1369716352 14.325 99 52 101 0 1393476256 11372656 12387248
21:17:57 64695 8192000000 10304380992 10757652480 1377150720 14.391 99 26 52 2 1401725136 17560640 7013776
21:20:03 42339 8192000000 10301238336 10756206592 1383515728 14.448 100 15 30 1 1410211152 22798544 3896880
21:21:49 113201 8192000000 10323136032 10774638592 1391105840 14.516 99 29 58 2 1420619456 22049440 7464176
21:25:17 51777 8192000000 10320941360 10785157120 1400105168 14.596 100 26 52 0 1441578752 34902128 6571456
21:27:37 86135 8192000000 10304856736 10779934720 1386114800 14.471 99 12 24 1 1404386608 15428400 2843408
21:30:06 66581 8192000000 10311349328 10774986752 1401648848 14.610 100 19 39 0 1423306960 17506800 4151312
21:32:16 69469 8192000000 10315981424 10776854528 1393640640 14.538 99 25 50 1 1406832976 7249280 5943056
21:34:29 48048 8192000000 10317003952 10796302336 1415399856 14.732 100 8 16 0 1435561584 19220688 941040
21:36:17 58480 8192000000 10318877440 10783764480 1395151808 14.552 98 14 28 0 1407441536 9443584 2846144
21:38:17 79991 8192000000 10324090848 10807672832 1425534784 14.822 100 9 18 0 1437527056 10169328 1822944
21:40:40 80865 8192000000 10308284384 10775011328 1357328656 14.213 96 12 24 1 1368057712 8578384 2150672
21:43:05 53280 8192000000 10307906016 10761666560 1347313120 14.123 96 23 44 1 1368187536 15997984 4876432
21:45:01 43577 8192000000 10300760064 10754891776 1329377824 13.962 95 13 25 0 1339869824 7874368 2617632
21:46:45 32957 8192000000 10297130640 10738212864 1344916624 14.102 98 44 87 2 1375701344 20496144 10288576
21:48:25 81470 8192000000 10284159232 10742902784 1344468976 14.098 98 8 16 1 1365098368 18655952 1973440
21:50:47 28686 8192000000 10270478400 10710278144 1311886704 13.803 96 29 57 2 1327505648 9434560 6184384
21:52:21 58809 8192000000 10254365824 10696663040 1294230112 13.643 96 31 62 0 1313261376 12380032 6651232
21:54:23 36325 8192000000 10252338256 10688221184 1306705296 13.756 97 44 88 0 1331584400 14176480 10702624
21:56:04 44405 8192000000 10267639680 10722222080 1342829248 14.083 99 26 52 0 1366799472 18319200 5651024
21:57:48 47488 8192000000 10241924560 10685521920 1309789824 13.784 97 29 58 1 1326180912 9734240 6656848
21:59:42 54500 8192000000 10250788672 10695204864 1320092656 13.878 98 19 38 2 1335165728 10994880 4078192
22:01:40 89607 8192000000 10242719472 10700693504 1337280576 14.033 99 13 26 0 1350314464 9742048 3291840
22:04:11 29359 8192000000 10244431168 10691858432 1329109760 13.959 98 25 50 0 1346384816 11723504 5551552
22:05:50 77030 8192000000 10258725440 10710118400 1340071632 14.058 99 5 10 0 1350861456 9605376 1184448
22:08:08 47653 8192000000 10288676048 10737516544 1365430912 14.286 99 39 78 0 1390073088 16153648 8488528
22:10:24 56645 8192000000 10279903504 10741956608 1365945808 14.291 99 25 50 0 1387295584 16081504 5268272
22:12:23 86506 8192000000 10286242304 10746408960 1329870896 13.966 96 14 28 0 1342273744 9501408 2901440
22:14:55 51799 8192000000 10296853872 10755952640 1388557376 14.493 100 24 48 0 1407913040 14195760 5159904
22:16:59 49932 8192000000 10299400448 10754904064 1365633200 14.288 98 28 56 0 1386365824 14608624 6124000
22:19:02 67750 8192000000 10296091456 10747949056 1361168560 14.248 98 10 19 0 1375280752 12269712 1842480
22:21:10 106474 8192000000 10299852176 10754809856 1368129008 14.310 98 16 31 2 1388026992 15461456 4436528
22:24:15 70674 8192000000 10303767456 10767855616 1395529184 14.555 100 15 30 1 1416275504 17434144 3312176
22:26:26 32168 8192000000 10291713360 10759872512 1381792240 14.433 99 9 18 0 1392382320 8794176 1795904
22:28:04 69091 8192000000 10264416128 10728243200 1333416864 13.998 96 17 34 0 1348567232 10913680 4236688
22:30:20 78104 8192000000 10277759424 10741485568 1383719616 14.450 100 17 34 1 1400176528 12531904 3925008
22:33:15 62341 8192000000 10263001168 10721570816 1336664528 14.027 97 9 16 0 1345791680 6854144 2273008
22:35:18 71689 8192000000 10277253664 10734190592 1357398144 14.214 98 9 18 1 1371017280 11857264 1761872
22:37:33 51058 8192000000 9413043888 9721315328 536553072 6.147 40 10 20 0 547342928 8996064 1793792

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 145 v_add_invoice_to_stock 335544517
except 20 v_cancel_supplier_invoice 335544517

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

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          236656
MON$OLDEST_ACTIVE               236657
MON$OLDEST_SNAPSHOT             236657
MON$NEXT_TRANSACTION            236657
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                       2034208
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.33601 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.10.33601 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.10.33601 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.10.33601 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'

02.06.22 22:40:00. 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-02 22:40:02 No severe PSQL-related problems occured
02.06.22 22:40:03. End of report.