Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 11.10.2022 01: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 15699228 kB
MemAvailable 30506260 kB
Buffers 0 kB
Cached 16006360 kB
SwapCached 2116 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-10-11 01:38:27
DTS_END                         2022-10-11 01:38:27.0700
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_AGGREGATE_PERF_DATA(83:5) ==> TMP_AGGREGATE_PERF_DATA_AUTOGEN(751:13) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/41922
TRN_ID                          238741
ATT_ID                          666
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: 9057.75 18863 1086930
customer order: creation 172.88 387 20746
customer order: refuse 14.68 343 1761
order to supplier: creation 46.06 1301 5527
order to supplier: removal 3.48 90094 418
invoice (draft): creation 45.93 3324 5512
invoice (draft): removal 50.54 771 6065
invoice accept: apply 41.43 18977 4972
invoice accept: cancel 46.18 819 5542
customer reserve: creation 3782.20 192 453864
customer reserve: removal 4566.73 55 548007
realization accept: apply 83.13 182 9976
realization accept: cancel 76.64 109 9197
payment from customer: creation 57.98 126 6957
payment from customer: removal 5.71 85 685
payment to supplier: creation 48.63 114 5836
payment to supplier: removal 3.23 72 387
service: total inventory turnovers 4.48 1349 538
service: total monetary turnovers 7.00 26 840
service: aggregate perf. data 0.80 20326 96
service: refresh index statistics 0.03 238608 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 11-10-2022 01:39:18 to 11-10-2022 01:39:20.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4991
TEST_TIME 2 4370
TEST_TIME 3 4974
TEST_TIME 4 4334
TEST_TIME 5 4633
TEST_TIME 6 4554
TEST_TIME 7 4683
TEST_TIME 8 4815
TEST_TIME 9 5070
TEST_TIME 10 5017
TEST_TIME 11 6409
TEST_TIME 12 6397
TEST_TIME 13 6744
TEST_TIME 14 6925
TEST_TIME 15 7221
TEST_TIME 16 7161
TEST_TIME 17 7983
TEST_TIME 18 8409
TEST_TIME 19 8460
TEST_TIME 20 8664
TEST_TIME 21 8777
TEST_TIME 22 9191
TEST_TIME 23 10420
TEST_TIME 24 10098
TEST_TIME 25 9996
TEST_TIME 26 9968
TEST_TIME 27 9790
TEST_TIME 28 10015
TEST_TIME 29 10248
TEST_TIME 30 10038
TEST_TIME 31 9956
TEST_TIME 32 9845
TEST_TIME 33 9822
TEST_TIME 34 9676
TEST_TIME 35 9579
TEST_TIME 36 9551
TEST_TIME 37 9526
TEST_TIME 38 9482
TEST_TIME 39 9323
TEST_TIME 40 9154
TEST_TIME 41 9147
TEST_TIME 42 9015
TEST_TIME 43 8992
TEST_TIME 44 8922
TEST_TIME 45 8792
TEST_TIME 46 8694
TEST_TIME 47 8970
TEST_TIME 48 9065
TEST_TIME 49 9003
TEST_TIME 50 9025
TEST_TIME 51 9102
TEST_TIME 52 9177
TEST_TIME 53 9214
TEST_TIME 54 9184
TEST_TIME 55 9253
TEST_TIME 56 9183
TEST_TIME 57 9243
TEST_TIME 58 9278
TEST_TIME 59 9411
TEST_TIME 60 9474
TEST_TIME 61 9327
TEST_TIME 62 9234
TEST_TIME 63 9201
TEST_TIME 64 9222
TEST_TIME 65 9139
TEST_TIME 66 9052
TEST_TIME 67 9095
TEST_TIME 68 9067
TEST_TIME 69 9045
TEST_TIME 70 9027
TEST_TIME 71 9032
TEST_TIME 72 9013
TEST_TIME 73 9070
TEST_TIME 74 9212
TEST_TIME 75 9229
TEST_TIME 76 9170
TEST_TIME 77 9179
TEST_TIME 78 9299
TEST_TIME 79 9263
TEST_TIME 80 9255
TEST_TIME 81 9190
TEST_TIME 82 9090
TEST_TIME 83 9094
TEST_TIME 84 9045
TEST_TIME 85 9005
TEST_TIME 86 8986
TEST_TIME 87 8936
TEST_TIME 88 8977
TEST_TIME 89 8965
TEST_TIME 90 8989
TEST_TIME 91 9017
TEST_TIME 92 9034
TEST_TIME 93 9016
TEST_TIME 94 9030
TEST_TIME 95 9028
TEST_TIME 96 9118
TEST_TIME 97 9108
TEST_TIME 98 9115
TEST_TIME 99 9150
TEST_TIME 100 9114
TEST_TIME 101 9046
TEST_TIME 102 9016
TEST_TIME 103 8985
TEST_TIME 104 8996
TEST_TIME 105 8947
TEST_TIME 106 8911
TEST_TIME 107 8841
TEST_TIME 108 8915
TEST_TIME 109 8929
TEST_TIME 110 8913
TEST_TIME 111 8916
TEST_TIME 112 8962
TEST_TIME 113 8953
TEST_TIME 114 8965
TEST_TIME 115 9002
TEST_TIME 116 8985
TEST_TIME 117 9067
TEST_TIME 118 9082
TEST_TIME 119 9119
TEST_TIME 120 9064

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 11-10-2022 01:39:21 to 11-10-2022 01:39:25.

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 1507013 1507013 0 0.00 0 22856 6 0 0
doc_list_biud 1507012 1507012 0 0.00 0 32076 26 0 0
sp_add_invoice_to_stock 5095 4972 123 2.41 29 214937 18977 0 123
sp_cancel_adding_invoice 5542 5542 0 0.00 4 63189 820 0 0
sp_cancel_client_order 1761 1761 0 0.00 3 13560 343 0 0
sp_cancel_customer_reserve 548007 548007 0 0.00 0 25531 55 0 0
sp_cancel_pay_from_customer 685 685 0 0.00 3 11604 85 0 0
sp_cancel_pay_to_supplier 387 387 0 0.00 3 4285 73 0 0
sp_cancel_supplier_invoice 6077 6065 12 0.19 1 32083 772 0 12
sp_cancel_supplier_order 418 418 0 0.00 7 944109 90095 0 0
sp_cancel_write_off 9197 9197 0 0.00 1 27788 109 0 0
sp_client_order 20746 20746 0 0.00 3 27950 387 0 0
sp_customer_reserve 453864 453864 0 0.00 0 48178 193 0 0
sp_fill_shopping_cart 31768 31768 0 0.00 1 17134 42 0 0
sp_fill_shopping_cart_clo_res 453844 453844 0 0.00 0 17100 16 0 0
sp_get_clo_for_invoice 4952 4952 0 0.00 0 23324 331 0 0
sp_kill_cost_storno 15811 15811 0 0.00 0 22485 49 0 0
sp_kill_qstorno_ret_qs2qd 1111694 1111694 0 0.00 0 32074 30 0 0
sp_kill_qty_storno 585917 585917 0 0.00 0 32075 65 0 0
sp_lock_selected_doc 20730 20730 0 0.00 0 6252 4 0 0
sp_make_cost_storno 27721 27721 0 0.00 0 19866 49 0 0
sp_multiply_rows_for_pdistr 27720 27720 0 0.00 0 22853 28 0 0
sp_multiply_rows_for_qdistr 20746 20746 0 0.00 0 18263 185 0 0
sp_pay_from_customer 6957 6957 0 0.00 4 25888 126 0 0
sp_pay_to_supplier 5836 5836 0 0.00 3 25539 114 0 0
sp_payment_common 12792 12792 0 0.00 1 24727 26 0 0
sp_qd_handle_on_cancel_clo 1761 1761 0 0.00 0 11151 309 0 0
sp_qd_handle_on_invoice_upd_sts 10493 10493 0 0.00 0 22993 294 0 0
sp_qd_handle_on_reserve_upd_sts 9976 9976 0 0.00 0 10849 55 0 0
sp_reserve_write_off 9976 9976 0 0.00 6 25686 182 0 0
sp_supplier_invoice 5512 5512 0 0.00 7 101825 3324 0 0
sp_supplier_order 5527 5527 0 0.00 4 30091 1302 0 0
srv_aggregate_perf_data 97 96 1 1.03 2707 322878 20327 0 1
srv_fill_mon_cache_memory 63 63 0 0.00 1293 147884 45142 0 0
srv_find_qd_qs_mism 1039548 1039548 0 0.00 0 12965 6 0 0
srv_make_invnt_saldo 538 538 0 0.00 56 89346 1350 0 0
srv_make_money_saldo 840 840 0 0.00 1 1167 26 0 0
srv_recalc_idx_stat 4 4 0 0.00 44530 392649 238609 0 0
t$perf-abend:sp_add_invoice_to_stock 123 123 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 12 12 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 4972 4972 0 0.00 0 11861 157 0 0
t$perf-norm:sp_cancel_adding_invoice 469 469 0 0.00 0 12256 157 0 0
t$perf-norm:sp_cancel_client_order 1761 1761 0 0.00 0 3530 14 0 0
t$perf-norm:sp_cancel_customer_reserve 661 661 0 0.00 0 4959 20 0 0
t$perf-norm:sp_cancel_pay_from_customer 685 685 0 0.00 0 3464 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 387 387 0 0.00 0 12702 41 0 0
t$perf-norm:sp_cancel_supplier_invoice 411 411 0 0.00 0 1027 11 0 0
t$perf-norm:sp_cancel_supplier_order 418 418 0 0.00 0 18860 1350 0 0
t$perf-norm:sp_cancel_write_off 1011 1011 0 0.00 0 3654 11 0 0
t$perf-norm:sp_client_order 20746 20746 0 0.00 0 12200 18 0 0
t$perf-norm:sp_customer_reserve 1049 1049 0 0.00 0 3908 14 0 0
t$perf-norm:sp_pay_from_customer 6957 6957 0 0.00 0 8502 14 0 0
t$perf-norm:sp_pay_to_supplier 5836 5836 0 0.00 0 6790 9 0 0
t$perf-norm:sp_reserve_write_off 9976 9976 0 0.00 0 12497 15 0 0
t$perf-norm:sp_supplier_invoice 5512 5512 0 0.00 0 5832 23 0 0
t$perf-norm:sp_supplier_order 5527 5527 0 0.00 0 3976 13 0 0
t$perf-norm:srv_aggregate_perf_data 96 96 0 0.00 0 612 12 0 0
t$perf-norm:srv_fill_mon_cache_memory 63 63 0 0.00 0 139 3 0 0
t$perf-norm:srv_make_invnt_saldo 538 538 0 0.00 0 1015 24 0 0
t$perf-norm:srv_make_money_saldo 840 840 0 0.00 0 1852 14 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 0 6 2 0 0
v_add_invoice_to_stock 10148 9902 246 2.42 0 25841 24 0 246
v_all_customers 37568 37568 0 0.00 0 26 1 0 0
v_all_suppliers 30274 30274 0 0.00 0 23 1 0 0
v_all_wares 41490 41490 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 938 938 0 0.00 0 3219 10 0 0
v_cancel_client_order 3522 3522 0 0.00 0 13496 9 0 0
v_cancel_customer_prepayment 1370 1370 0 0.00 0 11591 16 0 0
v_cancel_customer_reserve 1322 1322 0 0.00 0 25413 34 0 0
v_cancel_payment_to_supplier 774 774 0 0.00 0 3035 9 0 0
v_cancel_supplier_invoice 846 822 24 2.83 0 6720 29 0 24
v_cancel_supplier_order 836 836 0 0.00 0 25344 39 0 0
v_cancel_write_off 2022 2022 0 0.00 0 27727 31 0 0
v_max_id_clo_ord 5521 5521 0 0.00 0 195 1 0 0
v_max_id_clo_res 1049 1049 0 0.00 0 4837 20 0 0
v_max_id_ord_sup 5500 5500 0 0.00 0 4242 5 0 0
v_max_non_paid_invoice 1720 1720 0 0.00 0 491 3 0 0
v_max_non_paid_realizn 3719 3719 0 0.00 0 4367 5 0 0
v_min_id_clo_ord 5521 5521 0 0.00 0 4818 10 0 0
v_min_id_clo_res 1049 1049 0 0.00 0 6343 13 0 0
v_min_id_ord_sup 5500 5500 0 0.00 0 4941 10 0 0
v_min_non_paid_invoice 5836 5836 0 0.00 0 7936 14 0 0
v_min_non_paid_realizn 6956 6956 0 0.00 0 24725 24 0 0
v_our_firm 10396 10396 0 0.00 0 19 1 0 0
v_reserve_write_off 19952 19952 0 0.00 0 25524 13 0 0
x_lock_depdocs_on_canc_invoice 11196 11196 0 0.00 0 8275 107 0 0
x_lock_depdocs_on_canc_sup_ord 418 418 0 0.00 0 6905 327 0 0
x_make_qstorno_1000_1200 5527 5527 0 0.00 1 30080 1224 0 0
x_make_qstorno_1200_2000 5512 5512 0 0.00 3 98650 3169 0 0
x_make_qstorno_2100_3300 453864 453864 0 0.00 0 44747 174 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 11-10-2022 01:39:26 to 11-10-2022 01:39:30.

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
23:08:30 2 8192000000 8797917408 8808923136 3955424 0.048 1 1 2 0 4053696 55488 42784
23:09:31 24277 8192000000 9904654928 10211770368 975254784 10.638 100 85 170 0 1003404752 5759936 22390032
23:11:03 16518 8192000000 9943393104 10265890816 1027472000 11.144 100 84 168 0 1056858416 7781552 21604864
23:12:26 15334 8192000000 9978841568 10311536640 1065811472 11.512 100 82 164 0 1096352928 9719200 20822256
23:13:52 11367 8192000000 10034244688 10385465344 1127201616 12.095 100 80 158 1 1156424400 10651200 18571584
23:15:07 5795 8192000000 10092616736 10455728128 1180591168 12.596 100 65 130 0 1205788736 10705040 14492528
23:16:16 3078 8192000000 10133543056 10502209536 1222945648 12.989 100 79 156 1 1252566464 12405280 17215536
23:17:21 1934 8192000000 10168066992 10545459200 1256008304 13.293 100 82 163 0 1286548704 12796736 17743664
23:18:25 1179 8192000000 10204143872 10585317376 1286206848 13.570 100 87 172 2 1318737712 13577088 18953776
23:19:27 19118 8192000000 10201521216 10603225088 1302734112 13.720 100 54 103 3 1325847760 11656032 11457616
23:20:47 6824 8192000000 10208568688 10617135104 1316355136 13.844 100 33 66 0 1330222880 7275344 6592400
23:21:58 12405 8192000000 10214540704 10629091328 1325662768 13.928 100 9 17 0 1332697392 5164512 1870112
23:23:14 27531 8192000000 10239004288 10646495232 1332931456 13.994 100 61 120 1 1353356192 5996896 14427840
23:24:42 5924 8192000000 10226668944 10651013120 1339562480 14.053 100 27 52 0 1352325328 6311280 6451568
23:25:50 9851 8192000000 10240142048 10656673792 1342653376 14.081 100 19 38 0 1352705712 5741776 4310560
23:27:01 43188 8192000000 10218021280 10634469376 1317686416 13.856 99 29 58 1 1330814896 5591632 7536848
23:28:49 5634 8192000000 10215755904 10630455296 1321163856 13.887 100 33 66 0 1334943392 6269664 7509872
23:29:55 5712 8192000000 10173725920 10579591168 1264095584 13.368 98 19 36 1 1272868432 4786912 3985936
23:31:04 9542 8192000000 10139360704 10538823680 1202711024 12.802 95 19 39 0 1211567600 4637568 4219008
23:32:14 57358 8192000000 10135448592 10536263680 1176188560 12.555 93 35 67 0 1189270320 5088848 7992912
23:34:19 4235 8192000000 10173056816 10579894272 1278710576 13.501 100 27 52 1 1291396880 6924448 5761856
23:35:31 8506 8192000000 10181962432 10597064704 1293880160 13.640 100 18 34 0 1303116128 5290400 3945568
23:36:40 18221 8192000000 10199966688 10605436928 1301046608 13.705 100 28 54 0 1314230224 5461296 7722320
23:37:58 14258 8192000000 10202043408 10618347520 1312599552 13.810 100 28 55 1 1323613984 4357280 6657152
23:39:18 44890 8192000000 10242829024 10657812480 1336765696 14.028 100 50 100 2 1356681024 8924272 10991056
23:41:20 9269 8192000000 10274415856 10688864256 1363201440 14.266 100 49 98 0 1390754624 15915616 11637568
23:42:33 36912 8192000000 10287515248 10707218432 1378464112 14.403 100 38 76 0 1405859344 18706720 8688512
23:44:15 8136 8192000000 10306719248 10725822464 1388389072 14.491 100 50 97 0 1422489104 22591952 11508080
23:45:33 4515 8192000000 10325236752 10746802176 1402901696 14.621 100 53 106 0 1439915712 24181856 12832160
23:46:40 5419 8192000000 10325535840 10743730176 1395091552 14.551 100 58 115 0 1437010544 27606048 14312944
23:47:54 8574 8192000000 10334069472 10757754880 1401816256 14.611 100 55 109 0 1444955056 30200384 12938416
23:49:06 3282 8192000000 10350992048 10771496960 1408722048 14.673 100 73 144 2 1466226304 39454544 18049712
23:50:12 5999 8192000000 10350284016 10759966720 1403853904 14.629 100 81 158 4 1455063568 31071088 20138576
23:51:30 1835 8192000000 10379357872 10794754048 1422766064 14.797 100 84 165 1 1481288016 38162240 20359712
23:52:38 1282 8192000000 10352627360 10764738560 1401416960 14.608 100 76 150 1 1458393376 37560272 19416144
23:53:46 7926 8192000000 10317673728 10734620672 1364901824 14.281 99 60 122 1 1419801872 39593536 15306512
23:54:57 3963 8192000000 10355929584 10765824000 1393485392 14.537 100 78 154 0 1457758784 44822240 19451152
23:56:06 17735 8192000000 10312292704 10734899200 1371750176 14.343 99 47 93 0 1416678752 32882128 12046448
23:57:26 10788 8192000000 10331341712 10754519040 1385438192 14.465 100 41 80 0 1427149120 30929872 10781056
23:58:45 49849 8192000000 10297649424 10732695552 1372530672 14.350 99 25 50 0 1407823824 28570288 6722864
00:00:51 9905 8192000000 10293835376 10724675584 1345953056 14.111 99 28 56 0 1390167392 36812736 7401600
00:02:23 46425 8192000000 10283985376 10706243584 1331073552 13.977 97 45 90 2 1358420880 16553744 10793584
00:04:13 15065 8192000000 10286874528 10721906688 1357197680 14.212 99 30 61 0 1384829088 20327424 7303984
00:05:51 13810 8192000000 10276035520 10713083904 1356106304 14.202 100 22 44 1 1385456448 23099120 6251024
00:07:40 93683 8192000000 10274500288 10714836992 1321656800 13.892 97 28 57 0 1341512128 13922528 5932800
00:10:17 30721 8192000000 10252517456 10686181376 1333375952 13.998 98 24 44 0 1344357904 6460864 4521088
00:11:53 35916 8192000000 10272037760 10703294464 1357442896 14.214 100 32 63 1 1373635712 8881584 7311232
00:14:37 44537 8192000000 10275856688 10718838784 1379496864 14.412 100 16 31 0 1391863728 8911728 3455136
00:16:29 43594 8192000000 10267789088 10704728064 1353441200 14.178 98 13 26 0 1364040400 7310544 3288656
00:18:15 109439 8192000000 10260978928 10716426240 1365222016 14.284 99 27 54 0 1378375376 6602016 6551344
00:21:07 25750 8192000000 10285898240 10731384832 1366943952 14.300 99 41 82 1 1389361808 11961184 10456672
00:22:36 69587 8192000000 10280930352 10733015040 1367134592 14.301 99 19 38 0 1385158848 13560832 4463424
00:25:01 64802 8192000000 10290675904 10767609856 1393194336 14.534 100 19 38 0 1418080544 19644640 5241568
00:27:09 48791 8192000000 10305964416 10751041536 1385884944 14.469 99 26 50 0 1403837024 11324512 6627568
00:28:58 36682 8192000000 10314193440 10753835008 1378111040 14.400 99 39 78 0 1404561680 16867168 9583472
00:30:39 54501 8192000000 10302695376 10759368704 1393213616 14.535 100 14 28 1 1406731952 10350704 3167632
00:32:38 29142 8192000000 10313613584 10764558336 1393594112 14.538 99 40 80 0 1416774832 14735760 8444960
00:34:10 42591 8192000000 10322709888 10767192064 1405020144 14.640 100 38 76 0 1423057168 9770352 8266672
00:36:06 60801 8192000000 10321254512 10789494784 1385575792 14.466 99 18 36 0 1411749008 22275456 3897760
00:38:15 108600 8192000000 10268199664 10703486976 1341904688 14.075 97 27 54 1 1371708944 24040080 5764176
00:41:28 14145 8192000000 10265363440 10699329536 1330237024 13.969 97 26 52 0 1342544624 6040128 6267472
00:42:45 42188 8192000000 10259079904 10714034176 1356424288 14.205 99 11 22 0 1367759664 9031680 2303696
00:44:28 66670 8192000000 10244943296 10706137088 1330964128 13.976 97 13 26 0 1346718960 12554864 3199968
00:46:37 57454 8192000000 10274860528 10701398016 1322071264 13.895 96 27 52 0 1334592320 6419920 6101136
00:48:37 53502 8192000000 10270785680 10722025472 1339664944 14.054 97 21 43 0 1356355264 12378336 4311984
00:50:33 66223 8192000000 10288051824 10740891648 1373148224 14.355 100 23 46 0 1403971744 24833472 5990048
00:52:48 131784 8192000000 10282974464 10724818944 1314669120 13.828 95 9 18 0 1336291856 19545760 2076976
00:56:07 87546 8192000000 10276341664 10739253248 1332483552 13.990 97 8 16 0 1363012160 28493136 2035472
00:58:36 59044 8192000000 10285769488 10730799104 1358969904 14.228 98 27 54 0 1374481920 9526928 5985088
01:02:04 25243 8192000000 10282741040 10739326976 1391199776 14.517 100 15 30 0 1401853072 7087760 3565536
01:03:59 30793 8192000000 10244357152 10694819840 1312518672 13.809 96 8 16 0 1319917680 5922624 1476384
01:05:34 55138 8192000000 10273276112 10729218048 1370128720 14.328 100 19 38 0 1390133344 15290880 4713744
01:07:39 104458 8192000000 10290651616 10742177792 1347997312 14.129 97 15 30 0 1369067008 18043152 3026544
01:10:23 76399 8192000000 10309238224 10751254528 1380109856 14.418 99 23 45 1 1393400096 8677552 4612688
01:12:45 16614 8192000000 10300643840 10740060160 1375616048 14.377 99 41 82 0 1393209696 8240752 9352896
01:14:02 63325 8192000000 10298671744 10750316544 1366629536 14.297 98 11 22 0 1388853264 19697392 2526336
01:16:06 58051 8192000000 10293550816 10736455680 1358724544 14.226 98 22 44 1 1377690240 14071888 4893808
01:18:04 27273 8192000000 10315826656 10744446976 1380074928 14.417 99 36 70 2 1396573632 7701360 8797344
01:19:43 58484 8192000000 10293599744 10749591552 1381358304 14.429 99 28 56 0 1396530176 8617392 6554480
01:21:46 82978 8192000000 10282969920 10746175488 1362783872 14.262 98 16 31 0 1373710928 7710240 3216816
01:24:09 41558 8192000000 10290828288 10750701568 1392338096 14.527 100 7 14 0 1404441824 10407552 1696176
01:25:51 72494 8192000000 10293963888 10770075648 1394030128 14.542 100 10 20 0 1414228240 17562080 2636032
01:28:11 50222 8192000000 10293391040 10743402496 1375374336 14.375 99 28 55 2 1390759328 8607648 6777344
01:30:02 35291 8192000000 10276304352 10729709568 1345034784 14.103 97 17 34 0 1362095264 12715280 4345200
01:31:38 45419 8192000000 10279315568 10718212096 1299828736 13.694 94 17 34 0 1317516400 13992016 3695648
01:33:55 147884 8192000000 10281658368 10737512448 1297096768 13.669 94 16 32 0 1326857376 26092352 3668256
01:37:29 68856 8192000000 9057993952 9278197760 221857120 2.636 17 2 4 0 223701504 1747744 96640

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 11-10-2022 01:39:32 to 11-10-2022 01:39:47.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 123 v_add_invoice_to_stock 335544517
except 12 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 11-10-2022 01:39:48 to 11-10-2022 01:39:50.

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

11.10.22 01:39:51. 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-10-11 01:39:54 No severe PSQL-related problems occured
11.10.22 01:39:55. End of report.