Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 10.08.2022 01: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 16161688 kB
MemAvailable 30921068 kB
Buffers 0 kB
Cached 15543336 kB
SwapCached 2512 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-08-10 01:38:47
DTS_END                         2022-08-10 01:38:30.6290
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_FILL_MON_CACHE_MEMORY(20:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/49196
TRN_ID                          247647
ATT_ID                          274
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: 9233.63 23199 1108036
customer order: creation 178.20 334 21384
customer order: refuse 15.54 337 1865
order to supplier: creation 48.01 1172 5761
order to supplier: removal 3.39 79001 407
invoice (draft): creation 47.65 3088 5718
invoice (draft): removal 50.01 647 6001
invoice accept: apply 44.03 18110 5283
invoice accept: cancel 45.51 715 5461
customer reserve: creation 4076.56 179 489187
customer reserve: removal 4420.74 47 530489
realization accept: apply 85.67 179 10280
realization accept: cancel 82.87 111 9944
payment from customer: creation 61.83 116 7419
payment from customer: removal 6.43 98 771
payment to supplier: creation 50.54 130 6065
payment to supplier: removal 3.72 115 446
service: total inventory turnovers 5.20 1102 624
service: total monetary turnovers 6.95 27 834
service: aggregate perf. data 0.78 23215 93
service: refresh index statistics 0.03 335266 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-08-2022 01:39:27 to 10-08-2022 01:39:29.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4671
TEST_TIME 2 6766
TEST_TIME 3 6418
TEST_TIME 4 5747
TEST_TIME 5 5406
TEST_TIME 6 5630
TEST_TIME 7 5681
TEST_TIME 8 5538
TEST_TIME 9 5348
TEST_TIME 10 5593
TEST_TIME 11 5743
TEST_TIME 12 6012
TEST_TIME 13 6246
TEST_TIME 14 6358
TEST_TIME 15 6536
TEST_TIME 16 6576
TEST_TIME 17 6954
TEST_TIME 18 7790
TEST_TIME 19 7910
TEST_TIME 20 8507
TEST_TIME 21 8691
TEST_TIME 22 9080
TEST_TIME 23 9630
TEST_TIME 24 9812
TEST_TIME 25 10359
TEST_TIME 26 10481
TEST_TIME 27 10236
TEST_TIME 28 9985
TEST_TIME 29 9724
TEST_TIME 30 9663
TEST_TIME 31 9639
TEST_TIME 32 9554
TEST_TIME 33 9586
TEST_TIME 34 9498
TEST_TIME 35 9574
TEST_TIME 36 9458
TEST_TIME 37 9273
TEST_TIME 38 9252
TEST_TIME 39 9256
TEST_TIME 40 9377
TEST_TIME 41 9381
TEST_TIME 42 9282
TEST_TIME 43 9451
TEST_TIME 44 9465
TEST_TIME 45 9400
TEST_TIME 46 9410
TEST_TIME 47 9384
TEST_TIME 48 9525
TEST_TIME 49 9616
TEST_TIME 50 9777
TEST_TIME 51 9716
TEST_TIME 52 9748
TEST_TIME 53 9594
TEST_TIME 54 9537
TEST_TIME 55 9421
TEST_TIME 56 9473
TEST_TIME 57 9461
TEST_TIME 58 9352
TEST_TIME 59 9379
TEST_TIME 60 9333
TEST_TIME 61 9230
TEST_TIME 62 9100
TEST_TIME 63 9154
TEST_TIME 64 9275
TEST_TIME 65 9257
TEST_TIME 66 9275
TEST_TIME 67 9397
TEST_TIME 68 9374
TEST_TIME 69 9365
TEST_TIME 70 9473
TEST_TIME 71 9454
TEST_TIME 72 9513
TEST_TIME 73 9509
TEST_TIME 74 9485
TEST_TIME 75 9575
TEST_TIME 76 9535
TEST_TIME 77 9505
TEST_TIME 78 9420
TEST_TIME 79 9424
TEST_TIME 80 9394
TEST_TIME 81 9354
TEST_TIME 82 9332
TEST_TIME 83 9308
TEST_TIME 84 9260
TEST_TIME 85 9234
TEST_TIME 86 9175
TEST_TIME 87 9168
TEST_TIME 88 9132
TEST_TIME 89 9228
TEST_TIME 90 9211
TEST_TIME 91 9225
TEST_TIME 92 9281
TEST_TIME 93 9263
TEST_TIME 94 9270
TEST_TIME 95 9269
TEST_TIME 96 9310
TEST_TIME 97 9324
TEST_TIME 98 9344
TEST_TIME 99 9386
TEST_TIME 100 9435
TEST_TIME 101 9427
TEST_TIME 102 9462
TEST_TIME 103 9399
TEST_TIME 104 9364
TEST_TIME 105 9318
TEST_TIME 106 9311
TEST_TIME 107 9279
TEST_TIME 108 9279
TEST_TIME 109 9268
TEST_TIME 110 9234
TEST_TIME 111 9229
TEST_TIME 112 9196
TEST_TIME 113 9237
TEST_TIME 114 9224
TEST_TIME 115 9242
TEST_TIME 116 9249
TEST_TIME 117 9235
TEST_TIME 118 9216
TEST_TIME 119 9283
TEST_TIME 120 9236

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 10-08-2022 01:39:30 to 10-08-2022 01: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 1559425 1559425 0 0.00 0 30629 6 0 0
doc_list_biud 1559425 1559425 0 0.00 0 26481 21 0 0
sp_add_invoice_to_stock 5427 5283 144 2.65 27 172454 18110 0 144
sp_cancel_adding_invoice 5461 5461 0 0.00 4 47190 716 0 0
sp_cancel_client_order 1865 1865 0 0.00 5 19232 338 0 0
sp_cancel_customer_reserve 530489 530489 0 0.00 0 26483 47 0 0
sp_cancel_pay_from_customer 771 771 0 0.00 2 11813 99 0 0
sp_cancel_pay_to_supplier 446 446 0 0.00 3 10888 115 0 0
sp_cancel_supplier_invoice 6014 6001 13 0.21 1 14137 648 0 13
sp_cancel_supplier_order 407 407 0 0.00 5 1173217 79002 0 0
sp_cancel_write_off 9944 9944 0 0.00 1 13262 111 0 0
sp_client_order 21384 21384 0 0.00 3 48719 334 0 0
sp_customer_reserve 489187 489187 0 0.00 0 61351 180 0 0
sp_fill_shopping_cart 32859 32859 0 0.00 1 12190 40 0 0
sp_fill_shopping_cart_clo_res 489184 489184 0 0.00 0 14864 14 0 0
sp_get_clo_for_invoice 5280 5280 0 0.00 0 21018 291 0 0
sp_kill_cost_storno 16622 16622 0 0.00 0 16650 47 0 0
sp_kill_qstorno_ret_qs2qd 1077330 1077330 0 0.00 0 26477 26 0 0
sp_kill_qty_storno 569727 569727 0 0.00 0 26480 57 0 0
sp_lock_selected_doc 21593 21593 0 0.00 0 9772 7 0 0
sp_make_cost_storno 29044 29044 0 0.00 0 28421 50 0 0
sp_multiply_rows_for_pdistr 29044 29044 0 0.00 0 24796 28 0 0
sp_multiply_rows_for_qdistr 21384 21384 0 0.00 0 16301 148 0 0
sp_pay_from_customer 7419 7419 0 0.00 4 30157 117 0 0
sp_pay_to_supplier 6065 6065 0 0.00 4 20148 131 0 0
sp_payment_common 13484 13484 0 0.00 1 29937 36 0 0
sp_qd_handle_on_cancel_clo 1865 1865 0 0.00 0 19225 309 0 0
sp_qd_handle_on_invoice_upd_sts 10741 10741 0 0.00 0 18002 290 0 0
sp_qd_handle_on_reserve_upd_sts 10280 10280 0 0.00 0 22613 59 0 0
sp_reserve_write_off 10280 10280 0 0.00 6 30985 179 0 0
sp_supplier_invoice 5718 5718 0 0.00 5 74533 3089 0 0
sp_supplier_order 5761 5761 0 0.00 4 32821 1172 0 0
srv_aggregate_perf_data 94 93 1 1.06 2404 410509 23215 0 1
srv_fill_mon_cache_memory 63 63 0 0.00 1446 139831 47647 0 0
srv_find_qd_qs_mism 1057229 1057229 0 0.00 0 23731 6 0 0
srv_make_invnt_saldo 624 624 0 0.00 27 99098 1103 0 0
srv_make_money_saldo 834 834 0 0.00 1 2078 27 0 0
srv_recalc_idx_stat 4 4 0 0.00 143535 505812 335267 0 0
t$perf-abend:sp_add_invoice_to_stock 144 144 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 13 13 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 5283 5283 0 0.00 0 11384 142 0 0
t$perf-norm:sp_cancel_adding_invoice 424 424 0 0.00 0 4031 93 0 0
t$perf-norm:sp_cancel_client_order 1865 1865 0 0.00 0 1887 13 0 0
t$perf-norm:sp_cancel_customer_reserve 690 690 0 0.00 0 5997 26 0 0
t$perf-norm:sp_cancel_pay_from_customer 771 771 0 0.00 0 1636 7 0 0
t$perf-norm:sp_cancel_pay_to_supplier 446 446 0 0.00 0 1085 8 0 0
t$perf-norm:sp_cancel_supplier_invoice 419 419 0 0.00 0 1300 12 0 0
t$perf-norm:sp_cancel_supplier_order 407 407 0 0.00 0 28292 1261 0 0
t$perf-norm:sp_cancel_write_off 1012 1012 0 0.00 0 3054 11 0 0
t$perf-norm:sp_client_order 21384 21384 0 0.00 0 5333 14 0 0
t$perf-norm:sp_customer_reserve 1038 1038 0 0.00 0 5680 10 0 0
t$perf-norm:sp_pay_from_customer 7419 7419 0 0.00 0 4580 7 0 0
t$perf-norm:sp_pay_to_supplier 6065 6065 0 0.00 0 4044 9 0 0
t$perf-norm:sp_reserve_write_off 10280 10280 0 0.00 0 5212 10 0 0
t$perf-norm:sp_supplier_invoice 5718 5718 0 0.00 0 6956 21 0 0
t$perf-norm:sp_supplier_order 5761 5761 0 0.00 0 4848 12 0 0
t$perf-norm:srv_aggregate_perf_data 93 93 0 0.00 0 3140 38 0 0
t$perf-norm:srv_fill_mon_cache_memory 63 63 0 0.00 0 37 1 0 0
t$perf-norm:srv_make_invnt_saldo 624 624 0 0.00 0 1059 13 0 0
t$perf-norm:srv_make_money_saldo 834 834 0 0.00 0 1314 15 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 3 2 0 0
v_add_invoice_to_stock 10844 10556 288 2.65 0 6615 22 0 288
v_all_customers 38606 38606 0 0.00 0 22 0 0 0
v_all_suppliers 31450 31450 0 0.00 0 29 1 0 0
v_all_wares 42766 42766 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 848 848 0 0.00 0 2531 12 0 0
v_cancel_client_order 3730 3730 0 0.00 0 4747 6 0 0
v_cancel_customer_prepayment 1542 1542 0 0.00 0 3989 8 0 0
v_cancel_customer_reserve 1380 1380 0 0.00 0 6270 21 0 0
v_cancel_payment_to_supplier 892 892 0 0.00 0 2133 6 0 0
v_cancel_supplier_invoice 864 838 26 3.00 0 795 15 0 26
v_cancel_supplier_order 814 814 0 0.00 0 142 2 0 0
v_cancel_write_off 2024 2024 0 0.00 0 4797 16 0 0
v_max_id_clo_ord 5759 5759 0 0.00 0 12185 5 0 0
v_max_id_clo_res 1038 1038 0 0.00 0 4135 16 0 0
v_max_id_ord_sup 5716 5716 0 0.00 0 2842 3 0 0
v_max_non_paid_invoice 1815 1815 0 0.00 0 395 2 0 0
v_max_non_paid_realizn 4089 4089 0 0.00 0 3439 5 0 0
v_min_id_clo_ord 5759 5759 0 0.00 0 4483 6 0 0
v_min_id_clo_res 1038 1038 0 0.00 0 1584 6 0 0
v_min_id_ord_sup 5716 5716 0 0.00 0 6715 14 0 0
v_min_non_paid_invoice 6065 6065 0 0.00 0 19642 26 0 0
v_min_non_paid_realizn 7419 7419 0 0.00 0 29931 32 0 0
v_our_firm 10820 10820 0 0.00 0 179 1 0 0
v_reserve_write_off 20558 20558 0 0.00 0 5982 6 0 0
x_lock_depdocs_on_canc_invoice 11043 11043 0 0.00 0 23758 100 0 0
x_lock_depdocs_on_canc_sup_ord 407 407 0 0.00 0 31254 404 0 0
x_make_qstorno_1000_1200 5761 5761 0 0.00 1 32791 1102 0 0
x_make_qstorno_1200_2000 5718 5718 0 0.00 2 74521 2933 0 0
x_make_qstorno_2100_3300 489187 489187 0 0.00 0 61346 164 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-08-2022 01:39:35 to 10-08-2022 01: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
23:08:34 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
23:09:34 30529 8192000000 9912323008 10224713728 992459920 10.805 100 87 174 0 1020376288 5808032 22108336
23:11:10 20953 8192000000 9955194256 10277195776 1037461424 11.240 100 89 178 0 1068655184 8337920 22855840
23:12:36 16883 8192000000 9990251632 10321670144 1072109584 11.572 100 85 170 0 1103057696 9478880 21469232
23:14:02 7857 8192000000 10038991712 10385080320 1124993408 12.074 100 81 162 0 1154363200 10377472 18992320
23:15:20 6414 8192000000 10090966976 10447429632 1176226656 12.555 100 83 166 0 1207888128 12767520 18893952
23:16:28 3512 8192000000 10131326512 10497556480 1216755248 12.932 100 84 167 0 1248600800 13741568 18103984
23:17:35 3012 8192000000 10154092592 10534891520 1248525328 13.225 100 65 130 1 1274187472 11408336 14253808
23:18:43 2679 8192000000 10183541936 10572468224 1281738528 13.529 100 67 133 0 1307518864 11253008 14527328
23:19:47 1989 8192000000 10204250528 10592055296 1299495792 13.691 100 75 149 2 1329456256 13546736 16413728
23:20:50 8000 8192000000 10191292768 10602131456 1304559760 13.737 100 25 50 0 1317303216 7599344 5144112
23:22:01 8612 8192000000 10192433216 10609971200 1314548224 13.827 100 33 66 0 1330945296 7361456 9035616
23:23:12 15573 8192000000 10219907344 10632314880 1320714032 13.883 100 30 61 0 1333947648 5419632 7813984
23:24:29 7769 8192000000 10209273280 10631573504 1325218112 13.924 100 20 40 0 1335250048 5168272 4863664
23:25:43 10593 8192000000 10220789584 10640633856 1332801712 13.992 100 21 40 0 1341922800 4859168 4261920
23:26:55 65219 8192000000 10225652320 10635526144 1325861408 13.930 100 45 88 2 1342282176 6418080 10002688
23:29:01 5230 8192000000 10204038448 10617180160 1292850080 13.630 98 22 45 0 1304042480 6064400 5128000
23:30:07 7420 8192000000 10159451360 10565902336 1239355360 13.140 97 19 38 0 1249110608 5134688 4620560
23:31:15 55198 8192000000 10135559552 10532753408 1211596912 12.884 97 31 61 2 1224207120 5027584 7582624
23:33:14 7468 8192000000 10141096944 10547380224 1237359360 13.122 98 23 47 1 1247818128 5030256 5428512
23:34:22 8236 8192000000 10172513600 10584563712 1282793744 13.539 100 20 40 0 1296978688 9769984 4414960
23:35:31 21383 8192000000 10190773264 10603241472 1300628800 13.701 100 21 43 0 1310258128 5100352 4528976
23:36:53 23845 8192000000 10196658768 10608988160 1302194688 13.715 100 19 37 1 1311666128 5273072 4198368
23:38:20 7894 8192000000 10210938432 10631397376 1324491104 13.917 100 16 30 0 1332575184 5308384 2775696
23:39:33 28446 8192000000 10260187904 10674683904 1349214656 14.140 100 52 104 0 1375023520 14090976 11717888
23:41:22 20741 8192000000 10276622560 10698616832 1370802320 14.334 100 38 76 2 1389517136 9927888 8786928
23:42:49 21051 8192000000 10283440704 10708860928 1377810592 14.397 100 42 84 1 1400006384 12857120 9338672
23:44:14 19391 8192000000 10294062080 10721234944 1372219568 14.347 99 26 50 0 1395450464 17348336 5882560
23:46:00 23825 8192000000 10311673744 10736095232 1392243408 14.526 100 51 102 0 1425439456 21359552 11836496
23:47:37 8091 8192000000 10327262768 10752516096 1400670272 14.601 100 49 98 0 1440243504 27499552 12073680
23:48:51 11458 8192000000 10330640128 10761191424 1402614064 14.618 100 39 78 0 1442944304 30665264 9664976
23:50:08 2147 8192000000 10333416592 10751283200 1393725232 14.539 99 69 133 5 1439985312 30329952 15930128
23:51:15 4362 8192000000 10342854416 10763694080 1406297200 14.651 100 64 129 2 1451443824 29960208 15186416
23:52:24 2196 8192000000 10361317472 10775805952 1413061728 14.711 100 81 160 1 1466751056 33723600 19965728
23:53:29 1446 8192000000 10376552144 10791419904 1421511984 14.786 100 81 162 2 1479079616 37987984 19579648
23:54:39 10023 8192000000 10344465104 10759946240 1393427872 14.536 100 64 128 2 1452760496 43459168 15873456
23:55:58 4628 8192000000 10339001856 10747346944 1381737168 14.432 100 80 160 0 1451279568 49608016 19934384
23:57:07 15089 8192000000 10295227600 10725699584 1351064912 14.157 99 30 58 0 1401554656 42578960 7910784
23:58:36 5852 8192000000 10308228480 10732105728 1359958912 14.237 100 40 78 1 1415420096 45301904 10159280
00:00:00 13733 8192000000 10302619440 10727051264 1356113168 14.202 100 29 57 0 1406443120 42611008 7718944
00:01:17 13683 8192000000 10259568752 10694127616 1308428736 13.772 97 37 74 1 1348058224 30546064 9083424
00:02:38 23091 8192000000 10265776784 10699767808 1319000128 13.868 98 14 28 0 1347167712 24762048 3405536
00:04:02 52524 8192000000 10245151248 10685845504 1321142992 13.887 98 8 16 0 1345056032 21929104 1983936
00:05:55 103467 8192000000 10253978144 10694590464 1351960144 14.165 100 39 78 0 1367441040 6683808 8797088
00:08:41 79435 8192000000 10271227616 10715201536 1345476240 14.107 98 31 62 0 1367345680 14235984 7633456
00:11:02 54215 8192000000 10258136976 10713546752 1351513584 14.161 99 9 18 1 1362690080 9459648 1716848
00:13:00 20515 8192000000 10264930832 10710347776 1364936768 14.282 100 16 30 1 1376353472 8132640 3284064
00:14:30 34012 8192000000 10273890848 10717716480 1371946320 14.344 100 28 55 0 1386109200 7720624 6442256
00:16:06 54890 8192000000 10277560912 10736361472 1378836480 14.406 100 11 22 0 1391452896 10019040 2597376
00:18:09 50222 8192000000 10295200240 10753523712 1372677424 14.351 99 12 24 0 1390361744 15009872 2674448
00:20:01 71854 8192000000 10272747440 10729693184 1335269632 14.015 96 29 58 0 1363808496 22100704 6438160
00:22:21 82571 8192000000 10306873424 10752303104 1387961168 14.488 100 21 42 0 1407117136 14477552 4678416
00:24:44 71860 8192000000 10314740336 10766045184 1383034784 14.444 99 13 26 1 1406432832 20239696 3158352
00:27:06 54147 8192000000 10309946192 10759094272 1367058240 14.301 98 11 22 0 1386792128 16747232 2986656
00:29:04 50863 8192000000 10304372640 10746400768 1358242352 14.222 97 26 52 0 1372187472 8530400 5414720
00:31:02 109100 8192000000 10305648576 10769465344 1382323408 14.437 99 36 72 1 1405940288 15485744 8131136
00:33:53 71146 8192000000 10274121328 10738470912 1349920368 14.147 97 19 36 0 1372708448 18058768 4729312
00:36:06 67708 8192000000 10261195376 10716512256 1345304368 14.105 97 6 12 1 1358375728 11717328 1354032
00:38:39 66424 8192000000 10279438544 10731606016 1353705520 14.181 98 14 28 0 1374954432 17839856 3409056
00:41:11 60527 8192000000 10290010304 10750717952 1371198512 14.338 99 19 38 0 1391227072 15700048 4328512
00:43:12 53221 8192000000 10268033312 10719375360 1319287776 13.870 95 16 31 0 1334620304 11709664 3622864
00:45:06 60729 8192000000 10230127152 10670370816 1281167680 13.524 94 18 36 0 1293270992 8494784 3608528
00:47:12 71453 8192000000 10254120976 10706784256 1322360048 13.898 98 20 40 0 1339935136 12982672 4592416
00:49:26 28459 8192000000 10258088384 10691387392 1309406896 13.781 97 55 108 2 1333040976 10044576 13589504
00:51:06 73753 8192000000 10247217744 10693042176 1248308048 13.223 93 10 20 0 1261300800 11009280 1983472
00:53:21 88725 8192000000 10260475280 10687381504 1291744928 13.620 96 21 42 0 1307795888 11097248 4953712
00:55:59 51322 8192000000 10272323456 10701602816 1336409984 14.025 99 61 122 1 1362946656 13140032 13396640
00:57:53 56296 8192000000 10255592432 10710114304 1355790240 14.200 100 15 30 0 1371096288 11305664 4000384
00:59:50 59482 8192000000 10254521216 10710802432 1344687232 14.100 99 6 12 0 1357254864 10845536 1722096
01:01:49 40206 8192000000 10263460336 10724749312 1371219376 14.338 100 9 18 0 1386280480 13104384 1956720
01:03:31 9188 8192000000 10281344832 10717442048 1369894704 14.326 100 57 113 3 1389540512 6774608 12871200
01:04:40 75861 8192000000 10282339296 10749341696 1388586752 14.493 100 13 26 0 1400379808 8866064 2926992
01:06:57 55180 8192000000 10278006496 10753617920 1368636880 14.315 99 21 42 0 1390207168 16470736 5099552
01:09:03 71108 8192000000 10284102368 10738958336 1377443040 14.394 99 9 18 0 1386713872 7608896 1661936
01:11:15 81640 8192000000 10289740320 10746200064 1343398720 14.088 96 11 22 0 1353271632 7915008 1957904
01:13:37 97132 8192000000 10300176992 10754084864 1368548016 14.314 98 15 30 1 1382888560 11305984 3034560
01:16:18 39216 8192000000 10301103168 10759024640 1374603488 14.368 98 28 57 1 1395141968 13536336 7002144
01:18:07 93767 8192000000 10304699696 10751524864 1350563584 14.153 97 9 18 0 1365007232 12660880 1782768
01:20:42 139830 8192000000 10293314368 10750025728 1362233920 14.257 97 24 48 0 1383574816 15876816 5464080
01:24:10 55959 8192000000 10284008656 10742505472 1354455024 14.188 97 11 22 0 1365226704 8372144 2399536
01:26:15 56158 8192000000 10271521408 10736984064 1369140256 14.319 99 9 18 0 1383770368 12992704 1637408
01:28:12 65300 8192000000 10278877536 10742710272 1386734000 14.477 100 21 42 0 1401469984 10103552 4632432
01:30:28 57484 8192000000 10252534016 10706092032 1335513696 14.017 97 22 44 0 1349909472 9383232 5012544
01:32:28 24600 8192000000 10251488144 10695143424 1330118256 13.968 98 24 46 2 1342248496 7225904 4904336
01:33:58 42489 8192000000 10263576064 10714902528 1339687360 14.055 98 31 62 0 1356811680 10583584 6540736
01:35:41 25604 8192000000 10259475552 10686324736 1295911248 13.658 95 41 82 0 1314725680 9948080 8866352
01:37:08 42775 8192000000 10248451360 10694696960 1311611840 13.801 97 26 52 0 1329587616 11798992 6176784

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:14, from 10-08-2022 01:39:41 to 10-08-2022 01:39:55.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 144 v_add_invoice_to_stock 335544517
except 13 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 10-08-2022 01:39:56 to 10-08-2022 01:39:58.

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

10.08.22 01:39:59. 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-08-10 01:40:02 No severe PSQL-related problems occured
10.08.22 01:40:03. End of report.