Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 13.04.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 16826088 kB
MemAvailable 31495384 kB
Buffers 0 kB
Cached 14865916 kB
SwapCached 2688 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-04-13 22:38:15
DTS_END                         2022-04-13 22:38:15.1060
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/41494
TRN_ID                          242183
ATT_ID                          653
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: 9092.34 20302 1091081
customer order: creation 172.59 377 20711
customer order: refuse 14.75 354 1770
order to supplier: creation 46.68 1264 5601
order to supplier: removal 3.56 91113 427
invoice (draft): creation 45.18 3215 5422
invoice (draft): removal 51.31 775 6157
invoice accept: apply 41.87 19064 5024
invoice accept: cancel 46.28 824 5554
customer reserve: creation 3884.18 188 466101
customer reserve: removal 4493.66 56 539239
realization accept: apply 85.62 177 10274
realization accept: cancel 76.22 114 9146
payment from customer: creation 59.69 131 7163
payment from customer: removal 5.65 83 678
payment to supplier: creation 49.19 156 5903
payment to supplier: removal 3.69 64 443
service: total inventory turnovers 4.88 1025 586
service: total monetary turnovers 6.50 24 780
service: aggregate perf. data 0.82 19802 98
service: refresh index statistics 0.03 267231 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 13-04-2022 22:39:24 to 13-04-2022 22:39:26.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4758
TEST_TIME 2 4065
TEST_TIME 3 3267
TEST_TIME 4 3219
TEST_TIME 5 3479
TEST_TIME 6 3715
TEST_TIME 7 3671
TEST_TIME 8 3936
TEST_TIME 9 3914
TEST_TIME 10 4109
TEST_TIME 11 4637
TEST_TIME 12 5196
TEST_TIME 13 6086
TEST_TIME 14 6721
TEST_TIME 15 7050
TEST_TIME 16 7058
TEST_TIME 17 7806
TEST_TIME 18 7880
TEST_TIME 19 8825
TEST_TIME 20 9094
TEST_TIME 21 9446
TEST_TIME 22 9503
TEST_TIME 23 10363
TEST_TIME 24 10361
TEST_TIME 25 10326
TEST_TIME 26 10281
TEST_TIME 27 10268
TEST_TIME 28 10081
TEST_TIME 29 9808
TEST_TIME 30 9821
TEST_TIME 31 10032
TEST_TIME 32 9969
TEST_TIME 33 10014
TEST_TIME 34 9931
TEST_TIME 35 9817
TEST_TIME 36 9721
TEST_TIME 37 9611
TEST_TIME 38 9467
TEST_TIME 39 9398
TEST_TIME 40 9229
TEST_TIME 41 9272
TEST_TIME 42 9347
TEST_TIME 43 9312
TEST_TIME 44 9297
TEST_TIME 45 9250
TEST_TIME 46 9196
TEST_TIME 47 9094
TEST_TIME 48 9090
TEST_TIME 49 8983
TEST_TIME 50 8990
TEST_TIME 51 9041
TEST_TIME 52 9067
TEST_TIME 53 9144
TEST_TIME 54 9085
TEST_TIME 55 9161
TEST_TIME 56 9161
TEST_TIME 57 9146
TEST_TIME 58 9199
TEST_TIME 59 9192
TEST_TIME 60 9243
TEST_TIME 61 9189
TEST_TIME 62 9363
TEST_TIME 63 9406
TEST_TIME 64 9383
TEST_TIME 65 9272
TEST_TIME 66 9256
TEST_TIME 67 9295
TEST_TIME 68 9264
TEST_TIME 69 9217
TEST_TIME 70 9177
TEST_TIME 71 9121
TEST_TIME 72 9037
TEST_TIME 73 9071
TEST_TIME 74 9060
TEST_TIME 75 9053
TEST_TIME 76 9065
TEST_TIME 77 9076
TEST_TIME 78 9119
TEST_TIME 79 9215
TEST_TIME 80 9196
TEST_TIME 81 9171
TEST_TIME 82 9168
TEST_TIME 83 9336
TEST_TIME 84 9269
TEST_TIME 85 9318
TEST_TIME 86 9281
TEST_TIME 87 9216
TEST_TIME 88 9216
TEST_TIME 89 9174
TEST_TIME 90 9170
TEST_TIME 91 9121
TEST_TIME 92 9086
TEST_TIME 93 9084
TEST_TIME 94 9074
TEST_TIME 95 9113
TEST_TIME 96 9095
TEST_TIME 97 9132
TEST_TIME 98 9148
TEST_TIME 99 9203
TEST_TIME 100 9224
TEST_TIME 101 9204
TEST_TIME 102 9215
TEST_TIME 103 9202
TEST_TIME 104 9198
TEST_TIME 105 9296
TEST_TIME 106 9277
TEST_TIME 107 9293
TEST_TIME 108 9252
TEST_TIME 109 9214
TEST_TIME 110 9189
TEST_TIME 111 9141
TEST_TIME 112 9150
TEST_TIME 113 9158
TEST_TIME 114 9100
TEST_TIME 115 9080
TEST_TIME 116 9113
TEST_TIME 117 9075
TEST_TIME 118 9128
TEST_TIME 119 9148
TEST_TIME 120 9096

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 13-04-2022 22:39:27 to 13-04-2022 22:39:31.

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 1522052 1522052 0 0.00 0 21176 6 0 0
doc_list_biud 1522050 1522050 0 0.00 0 62589 26 0 0
sp_add_invoice_to_stock 5173 5024 149 2.88 49 237143 19064 0 149
sp_cancel_adding_invoice 5554 5554 0 0.00 5 91662 825 0 0
sp_cancel_client_order 1770 1770 0 0.00 4 26208 354 0 0
sp_cancel_customer_reserve 539239 539239 0 0.00 1 62591 56 0 0
sp_cancel_pay_from_customer 678 678 0 0.00 2 8569 83 0 0
sp_cancel_pay_to_supplier 443 443 0 0.00 3 1373 64 0 0
sp_cancel_supplier_invoice 6167 6157 10 0.16 1 14307 776 0 10
sp_cancel_supplier_order 427 427 0 0.00 6 1101965 91114 0 0
sp_cancel_write_off 9146 9146 0 0.00 1 19702 115 0 0
sp_client_order 20711 20711 0 0.00 3 27839 378 0 0
sp_customer_reserve 466101 466101 0 0.00 0 41670 188 0 0
sp_fill_shopping_cart 31729 31729 0 0.00 1 39486 39 0 0
sp_fill_shopping_cart_clo_res 466088 466088 0 0.00 0 29411 15 0 0
sp_get_clo_for_invoice 5010 5010 0 0.00 0 30168 353 0 0
sp_kill_cost_storno 15821 15821 0 0.00 0 15797 56 0 0
sp_kill_qstorno_ret_qs2qd 1094208 1094208 0 0.00 0 62584 31 0 0
sp_kill_qty_storno 577577 577577 0 0.00 0 62589 67 0 0
sp_lock_selected_doc 21133 21133 0 0.00 0 7001 6 0 0
sp_make_cost_storno 28350 28350 0 0.00 0 17939 62 0 0
sp_multiply_rows_for_pdistr 28350 28350 0 0.00 0 8988 30 0 0
sp_multiply_rows_for_qdistr 20711 20711 0 0.00 0 20904 167 0 0
sp_pay_from_customer 7163 7163 0 0.00 4 12562 131 0 0
sp_pay_to_supplier 5903 5903 0 0.00 4 21375 156 0 0
sp_payment_common 13065 13065 0 0.00 1 21344 35 0 0
sp_qd_handle_on_cancel_clo 1770 1770 0 0.00 0 26201 328 0 0
sp_qd_handle_on_invoice_upd_sts 10564 10564 0 0.00 0 60852 341 0 0
sp_qd_handle_on_reserve_upd_sts 10274 10274 0 0.00 0 20884 57 0 0
sp_reserve_write_off 10274 10274 0 0.00 6 23573 178 0 0
sp_supplier_invoice 5422 5422 0 0.00 6 106558 3215 0 0
sp_supplier_order 5601 5601 0 0.00 5 42192 1265 0 0
srv_aggregate_perf_data 98 98 0 0.00 2728 181841 19803 0 0
srv_fill_mon_cache_memory 61 61 0 0.00 1648 165999 46906 0 0
srv_find_qd_qs_mism 1042727 1042727 0 0.00 0 15041 6 0 0
srv_make_invnt_saldo 586 586 0 0.00 33 37012 1025 0 0
srv_make_money_saldo 780 780 0 0.00 1 1385 25 0 0
srv_recalc_idx_stat 4 4 0 0.00 192195 321051 267231 0 0
t$perf-abend:sp_add_invoice_to_stock 149 149 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 10 10 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5024 5024 0 0.00 0 9530 151 0 0
t$perf-norm:sp_cancel_adding_invoice 408 408 0 0.00 0 1905 74 0 0
t$perf-norm:sp_cancel_client_order 1770 1770 0 0.00 0 6091 16 0 0
t$perf-norm:sp_cancel_customer_reserve 717 717 0 0.00 0 1573 11 0 0
t$perf-norm:sp_cancel_pay_from_customer 678 678 0 0.00 0 2349 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 443 443 0 0.00 0 637 4 0 0
t$perf-norm:sp_cancel_supplier_invoice 412 412 0 0.00 0 4165 20 0 0
t$perf-norm:sp_cancel_supplier_order 427 427 0 0.00 0 60161 1606 0 0
t$perf-norm:sp_cancel_write_off 994 994 0 0.00 0 2757 10 0 0
t$perf-norm:sp_client_order 20711 20711 0 0.00 0 28419 18 0 0
t$perf-norm:sp_customer_reserve 966 966 0 0.00 0 5879 14 0 0
t$perf-norm:sp_pay_from_customer 7163 7163 0 0.00 0 11147 14 0 0
t$perf-norm:sp_pay_to_supplier 5903 5903 0 0.00 0 3957 8 0 0
t$perf-norm:sp_reserve_write_off 10274 10274 0 0.00 0 23449 16 0 0
t$perf-norm:sp_supplier_invoice 5422 5422 0 0.00 0 7878 16 0 0
t$perf-norm:sp_supplier_order 5601 5601 0 0.00 0 6113 14 0 0
t$perf-norm:srv_aggregate_perf_data 98 98 0 0.00 0 144 2 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 64 2 0 0
t$perf-norm:srv_make_invnt_saldo 586 586 0 0.00 0 903 22 0 0
t$perf-norm:srv_make_money_saldo 780 780 0 0.00 0 4586 21 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 7 3 0 0
v_add_invoice_to_stock 10318 10020 298 2.88 0 5178 21 0 298
v_all_customers 37366 37366 0 0.00 0 63 1 0 0
v_all_suppliers 30758 30758 0 0.00 0 47 1 0 0
v_all_wares 41422 41422 0 0.00 0 22 1 0 0
v_cancel_adding_invoice 816 816 0 0.00 0 1508 8 0 0
v_cancel_client_order 3540 3540 0 0.00 0 2491 5 0 0
v_cancel_customer_prepayment 1356 1356 0 0.00 0 1956 8 0 0
v_cancel_customer_reserve 1434 1434 0 0.00 0 3145 10 0 0
v_cancel_payment_to_supplier 886 886 0 0.00 0 1054 8 0 0
v_cancel_supplier_invoice 844 824 20 2.36 0 2231 16 0 20
v_cancel_supplier_order 854 854 0 0.00 0 3218 10 0 0
v_cancel_write_off 1988 1988 0 0.00 0 3975 15 0 0
v_max_id_clo_ord 5600 5600 0 0.00 0 4976 3 0 0
v_max_id_clo_res 966 966 0 0.00 0 6726 20 0 0
v_max_id_ord_sup 5417 5417 0 0.00 0 7908 5 0 0
v_max_non_paid_invoice 1540 1540 0 0.00 0 8336 8 0 0
v_max_non_paid_realizn 4005 4005 0 0.00 0 1028 3 0 0
v_min_id_clo_ord 5600 5600 0 0.00 0 2619 9 0 0
v_min_id_clo_res 966 966 0 0.00 0 4037 10 0 0
v_min_id_ord_sup 5417 5417 0 0.00 0 7864 6 0 0
v_min_non_paid_invoice 5903 5903 0 0.00 0 21337 28 0 0
v_min_non_paid_realizn 7162 7162 0 0.00 0 8751 24 0 0
v_our_firm 10370 10370 0 0.00 0 27 1 0 0
v_reserve_write_off 20548 20548 0 0.00 0 4269 7 0 0
x_lock_depdocs_on_canc_invoice 11299 11299 0 0.00 0 16735 123 0 0
x_lock_depdocs_on_canc_sup_ord 427 427 0 0.00 0 18956 420 0 0
x_make_qstorno_1000_1200 5601 5601 0 0.00 2 42172 1181 0 0
x_make_qstorno_1200_2000 5422 5422 0 0.00 2 106444 3079 0 0
x_make_qstorno_2100_3300 466101 466101 0 0.00 0 34223 171 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 13-04-2022 22:39:32 to 13-04-2022 22:39:36.

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:18 90 8192000000 8831606864 8853757952 25067232 0.305 6 5 6 0 25341408 102736 171440
20:09:20 25460 8192000000 9923386032 10239774720 999987488 10.878 100 87 172 1 1028718784 6414928 22316368
20:10:48 27146 8192000000 9969628080 10295349248 1047765744 11.339 100 91 182 0 1080602704 9682592 23154368
20:12:20 17891 8192000000 10006587520 10345668608 1088297088 11.726 100 81 162 0 1119362528 10452336 20613104
20:13:47 13317 8192000000 10054794576 10406531072 1136889888 12.186 100 84 167 1 1168901840 11278032 20733920
20:15:03 7461 8192000000 10089515968 10448732160 1175696928 12.550 100 78 156 1 1205799136 11493936 18608272
20:16:13 4170 8192000000 10133715264 10503254016 1216205504 12.927 100 83 167 0 1248171536 13821776 18144256
20:17:20 4972 8192000000 10164621184 10540961792 1247900688 13.219 100 83 166 1 1279575616 13137280 18537648
20:18:27 1119 8192000000 10195544880 10574557184 1275660976 13.473 100 95 190 0 1310797520 13538880 21597664
20:19:30 12865 8192000000 10212717184 10599395328 1297426864 13.672 100 83 165 2 1329090592 13015568 18648160
20:20:43 6081 8192000000 10197845104 10597175296 1300030016 13.696 100 40 78 3 1315977104 6865248 9081840
20:21:49 8359 8192000000 10200427744 10613530624 1311180112 13.797 100 18 36 0 1321251824 5822688 4249024
20:22:58 19672 8192000000 10210075744 10629947392 1325065360 13.923 100 14 28 3 1338249872 10340448 2844064
20:24:18 76289 8192000000 10217965888 10643386368 1331125984 13.977 100 24 48 0 1342648048 5974816 5547248
20:26:35 6610 8192000000 10233900704 10655612928 1340763424 14.064 100 20 40 1 1350942256 5286160 4892672
20:27:46 8314 8192000000 10225508080 10639749120 1318619248 13.864 99 24 48 1 1329564784 5484624 5460912
20:28:59 56381 8192000000 10191702496 10592919552 1251917632 13.256 95 43 86 2 1267956288 4911680 11126976
20:30:56 4877 8192000000 10143199728 10535251968 1203134016 12.805 96 29 57 1 1215475120 6239456 6101648
20:32:01 8333 8192000000 10157979328 10561585152 1245579040 13.198 98 25 50 1 1256801008 5707328 5514640
20:33:13 11628 8192000000 10172733488 10580795392 1270610032 13.427 99 23 46 1 1282761184 6117328 6033824
20:34:25 23264 8192000000 10179732496 10593370112 1289803840 13.602 100 23 46 0 1300475760 4958352 5713568
20:35:49 6314 8192000000 10205850048 10614996992 1304924448 13.740 100 34 68 1 1319848720 7376080 7548192
20:36:56 8712 8192000000 10198519760 10616938496 1307681792 13.765 100 28 56 0 1320381920 6265968 6434160
20:38:05 7413 8192000000 10211728304 10631782400 1322378832 13.898 100 15 29 2 1330009440 4830304 2800304
20:39:21 50662 8192000000 10262404880 10679230464 1346436304 14.115 100 38 76 3 1368868432 13670352 8761776
20:41:30 49363 8192000000 10276235216 10699276288 1357862288 14.218 99 42 85 0 1390696992 22666080 10168624
20:43:22 15751 8192000000 10296885360 10717011968 1376334144 14.384 100 43 86 1 1412386064 26191168 9860752
20:44:44 24581 8192000000 10310808320 10734362624 1385951216 14.470 100 36 70 0 1422359808 28233328 8175264
20:46:16 12381 8192000000 10334066112 10751938560 1400154016 14.596 100 63 124 0 1448578960 33286704 15138240
20:47:32 10308 8192000000 10341603744 10758201344 1394573472 14.547 99 61 120 2 1443501312 34997904 13929936
20:49:01 8770 8192000000 10355934752 10775322624 1407607616 14.663 100 62 121 4 1468122496 44177968 16336912
20:50:15 4087 8192000000 10349405968 10771320832 1398078720 14.578 99 62 122 1 1460072944 45705152 16289072
20:51:31 4031 8192000000 10360599040 10779811840 1401666592 14.610 99 79 156 1 1468812768 47870144 19276032
20:52:38 1745 8192000000 10355664592 10760585216 1376394592 14.384 98 91 182 2 1446308224 47392592 22521040
20:53:44 3148 8192000000 10343534944 10752679936 1387540960 14.484 100 81 158 1 1446080528 38109280 20430288
20:54:59 1638 8192000000 10348843488 10754523136 1385416512 14.465 100 82 164 2 1454160880 47023232 21721136
20:56:04 13991 8192000000 10321477248 10743549952 1357057984 14.211 99 50 101 2 1424009664 53373072 13578608
20:57:34 14423 8192000000 10289476576 10727157760 1358351808 14.223 99 32 64 1 1402684704 34966304 9366592
20:58:53 29842 8192000000 10249715840 10672726016 1304068496 13.732 96 24 48 1 1343449936 32625728 6755712
21:00:27 25778 8192000000 10277174464 10711040000 1337424800 14.034 99 20 40 1 1371780560 28779344 5576416
21:01:58 30098 8192000000 10266463216 10705506304 1328247888 13.951 98 15 27 3 1353758176 21374912 4135376
21:03:31 36815 8192000000 10265138112 10707480576 1346558752 14.117 99 19 38 0 1366008384 14566272 4883360
21:05:18 60653 8192000000 10289421168 10725900288 1371313936 14.339 100 29 58 1 1399898992 20949696 7635360
21:07:50 21336 8192000000 10255872528 10692886528 1342878496 14.083 99 16 32 0 1363844352 17400400 3565456
21:09:13 47231 8192000000 10272272400 10721202176 1365637936 14.288 100 9 18 0 1380129168 12822016 1669216
21:11:06 48722 8192000000 10278729200 10733989888 1379234160 14.410 100 22 44 1 1399770240 15541184 4994896
21:12:55 31366 8192000000 10280621744 10739085312 1383711264 14.450 100 9 18 0 1396584560 10810528 2062768
21:14:28 46992 8192000000 10271059344 10713264128 1340175024 14.059 97 25 50 0 1353092720 7329888 5587808
21:16:19 48007 8192000000 10289206656 10739294208 1390227360 14.508 100 25 49 0 1404037904 8363072 5447472
21:19:03 52158 8192000000 10304373088 10753916928 1390408896 14.510 100 36 73 0 1418894480 19646096 8839488
21:20:55 39680 8192000000 10314529104 10759876608 1396887760 14.567 100 35 70 1 1416005408 10407600 8710048
21:22:35 25514 8192000000 10280482688 10735935488 1380997008 14.425 99 29 58 1 1397742576 9947696 6797872
21:24:02 53961 8192000000 10294879344 10755543040 1399239568 14.588 100 24 47 0 1414334992 9457808 5637616
21:26:08 60111 8192000000 10301047824 10762579968 1405099952 14.640 100 16 32 0 1419212944 9985472 4127520
21:28:59 101541 8192000000 10301468928 10767286272 1371152656 14.337 97 11 23 1 1394017776 20490816 2374304
21:31:44 64530 8192000000 10309927504 10761936896 1362882016 14.263 97 16 32 0 1376925664 10100000 3943648
21:34:00 33596 8192000000 10286425344 10731192320 1337533216 14.035 96 23 47 1 1351341712 9080528 4727968
21:35:35 17170 8192000000 10304513360 10744745984 1368968368 14.318 99 45 90 0 1393270496 14463456 9838672
21:36:54 94532 8192000000 10288207232 10753544192 1364768480 14.280 98 19 38 0 1381920400 12876400 4275520
21:39:33 73125 8192000000 10280879456 10748141568 1314834528 13.830 94 22 44 0 1334387648 14982944 4570176
21:42:12 97729 8192000000 10278220320 10720346112 1333502720 13.999 97 17 34 2 1353116064 15146768 4466576
21:44:50 29852 8192000000 10246913408 10695327744 1322911536 13.903 97 25 50 2 1346229920 17289440 6028944
21:46:22 67613 8192000000 10245073792 10703757312 1322452672 13.899 97 14 28 1 1331945984 6231616 3261696
21:48:31 48772 8192000000 10265064864 10717511680 1365238800 14.284 100 8 16 0 1378455904 11353392 1863712
21:50:33 64287 8192000000 10271346384 10729541632 1362173856 14.257 99 10 20 0 1375521376 11213776 2133744
21:53:28 21357 8192000000 10260866032 10707292160 1331560640 13.981 97 38 75 2 1346613792 6272896 8780256
21:55:01 46281 8192000000 10252735776 10695532544 1273269504 13.452 93 26 52 4 1292243312 13108240 5865568
21:56:48 165999 8192000000 10260650336 10711515136 1285309600 13.561 95 15 30 1 1306050592 17292128 3448864
22:00:37 34363 8192000000 10284873264 10736386048 1369712400 14.324 100 28 56 1 1397475568 21450112 6313056
22:02:54 14917 8192000000 10281594688 10718720000 1366244544 14.293 100 44 88 0 1387940128 11673488 10022096
22:04:12 37282 8192000000 10304482608 10735349760 1376363328 14.384 100 29 58 0 1392897344 10231936 6302080
22:06:01 66560 8192000000 10284005184 10728906752 1357903984 14.219 98 33 66 0 1375587680 10190688 7493008
22:08:16 65640 8192000000 10274203760 10733768704 1375195104 14.374 100 7 14 0 1388180480 11729504 1255872
22:10:22 77186 8192000000 10288789856 10756100096 1378920640 14.407 99 14 28 2 1393255184 11279840 3054704
22:13:08 73159 8192000000 10305141952 10755444736 1357231904 14.212 97 13 26 2 1382768800 22477168 3059728
22:15:34 96770 8192000000 10304742848 10768658432 1386834000 14.478 99 25 50 1 1407122240 14412608 5875632
22:19:11 28000 8192000000 10297120368 10726739968 1373177632 14.356 100 21 42 0 1385222032 7131040 4913360
22:20:42 37407 8192000000 10296212752 10742202368 1387497312 14.484 100 16 32 0 1399543152 8897328 3148512
22:22:21 121682 8192000000 10293830592 10757046272 1341810928 14.074 96 29 58 0 1362413904 14332096 6270880
22:25:39 102715 8192000000 10261003632 10706755584 1309374320 13.780 94 15 30 0 1322950336 10606928 2969088
22:28:34 47846 8192000000 10300266512 10737967104 1367974416 14.309 99 44 88 0 1388658048 11089856 9593776
22:30:25 39350 8192000000 10275003936 10734989312 1365876048 14.290 99 23 46 1 1381593248 10275088 5442112
22:32:06 85960 8192000000 10278750704 10732359680 1352041216 14.166 98 12 24 0 1371727520 16361680 3324624
22:34:39 107927 8192000000 10267540544 10724532224 1319526880 13.872 96 10 20 0 1333757248 11693904 2536464
22:37:27 24918 8192000000 10275056656 10722512896 1366927920 14.300 100 30 55 3 1380665936 7194064 6543952

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:14, from 13-04-2022 22:39:38 to 13-04-2022 22:39:52.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 149 v_add_invoice_to_stock 335544517
except 10 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 13-04-2022 22:39:53 to 13-04-2022 22:39:55.

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

13.04.22 22:39:56. 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-04-13 22:39:59 No severe PSQL-related problems occured
13.04.22 22:40:00. End of report.