Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 22.12.2022 07: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 14752280 kB
MemAvailable 30120948 kB
Buffers 0 kB
Cached 16972148 kB
SwapCached 3404 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 4.0.3
DB_NAME                         /home/bases/oltp40-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/oltp40-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp40-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb40/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=3400
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/oltp40-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-oltp40
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-12-22 07:37:20
DTS_END                         2022-12-22 07:37:20.8920
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_CANCEL_ADDING_INVOICE(33:5) ==> SP_ADD_INVOICE_TO_STOCK(141:26) ==> SP_CANCEL_CUSTOMER_RESERVE(36:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/39552
TRN_ID                          215835
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: 9035.63 29228 1084275
customer order: creation 159.62 447 19154
customer order: refuse 13.38 398 1606
order to supplier: creation 42.98 1374 5158
order to supplier: removal 3.58 162598 429
invoice (draft): creation 42.63 3069 5116
invoice (draft): removal 51.96 913 6235
invoice accept: apply 38.93 25339 4672
invoice accept: cancel 46.72 1032 5606
customer reserve: creation 3692.12 236 443054
customer reserve: removal 4663.94 99 559673
realization accept: apply 77.05 259 9246
realization accept: cancel 81.68 155 9802
payment from customer: creation 55.55 150 6666
payment from customer: removal 5.21 127 625
payment to supplier: creation 45.47 181 5456
payment to supplier: removal 3.30 125 396
service: total inventory turnovers 3.80 4315 456
service: total monetary turnovers 6.75 374 810
service: aggregate perf. data 0.93 16482 111
service: refresh index statistics 0.03 366881 4

Performance in TOTAL, chart


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

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6368
TEST_TIME 2 5203
TEST_TIME 3 4618
TEST_TIME 4 4661
TEST_TIME 5 4600
TEST_TIME 6 4814
TEST_TIME 7 5082
TEST_TIME 8 5056
TEST_TIME 9 5155
TEST_TIME 10 5731
TEST_TIME 11 6366
TEST_TIME 12 6948
TEST_TIME 13 6986
TEST_TIME 14 7235
TEST_TIME 15 7345
TEST_TIME 16 7630
TEST_TIME 17 7626
TEST_TIME 18 7829
TEST_TIME 19 8196
TEST_TIME 20 8305
TEST_TIME 21 8339
TEST_TIME 22 8383
TEST_TIME 23 8987
TEST_TIME 24 8774
TEST_TIME 25 9010
TEST_TIME 26 9095
TEST_TIME 27 9240
TEST_TIME 28 9664
TEST_TIME 29 10023
TEST_TIME 30 10257
TEST_TIME 31 10541
TEST_TIME 32 10764
TEST_TIME 33 11184
TEST_TIME 34 10999
TEST_TIME 35 10766
TEST_TIME 36 10801
TEST_TIME 37 10719
TEST_TIME 38 10665
TEST_TIME 39 10654
TEST_TIME 40 10724
TEST_TIME 41 10639
TEST_TIME 42 10401
TEST_TIME 43 10260
TEST_TIME 44 10205
TEST_TIME 45 10057
TEST_TIME 46 10114
TEST_TIME 47 10048
TEST_TIME 48 10019
TEST_TIME 49 10027
TEST_TIME 50 10045
TEST_TIME 51 9923
TEST_TIME 52 9976
TEST_TIME 53 9892
TEST_TIME 54 9855
TEST_TIME 55 9855
TEST_TIME 56 9788
TEST_TIME 57 9678
TEST_TIME 58 9559
TEST_TIME 59 9551
TEST_TIME 60 9460
TEST_TIME 61 9478
TEST_TIME 62 9502
TEST_TIME 63 9491
TEST_TIME 64 9503
TEST_TIME 65 9460
TEST_TIME 66 9506
TEST_TIME 67 9483
TEST_TIME 68 9512
TEST_TIME 69 9630
TEST_TIME 70 9640
TEST_TIME 71 9711
TEST_TIME 72 9731
TEST_TIME 73 9620
TEST_TIME 74 9573
TEST_TIME 75 9495
TEST_TIME 76 9472
TEST_TIME 77 9384
TEST_TIME 78 9357
TEST_TIME 79 9268
TEST_TIME 80 9212
TEST_TIME 81 9260
TEST_TIME 82 9207
TEST_TIME 83 9171
TEST_TIME 84 9175
TEST_TIME 85 9238
TEST_TIME 86 9202
TEST_TIME 87 9229
TEST_TIME 88 9182
TEST_TIME 89 9201
TEST_TIME 90 9219
TEST_TIME 91 9374
TEST_TIME 92 9410
TEST_TIME 93 9517
TEST_TIME 94 9481
TEST_TIME 95 9450
TEST_TIME 96 9417
TEST_TIME 97 9331
TEST_TIME 98 9297
TEST_TIME 99 9262
TEST_TIME 100 9240
TEST_TIME 101 9204
TEST_TIME 102 9133
TEST_TIME 103 9138
TEST_TIME 104 9095
TEST_TIME 105 9125
TEST_TIME 106 9087
TEST_TIME 107 9062
TEST_TIME 108 9080
TEST_TIME 109 9087
TEST_TIME 110 9060
TEST_TIME 111 9073
TEST_TIME 112 9098
TEST_TIME 113 9117
TEST_TIME 114 9202
TEST_TIME 115 9186
TEST_TIME 116 9161
TEST_TIME 117 9126
TEST_TIME 118 9099
TEST_TIME 119 9101
TEST_TIME 120 9052

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 22-12-2022 07:39:13 to 22-12-2022 07:39:17.

Performance in DETAILS

UNIT CNT_ALL CNT_OK CNT_ERR ERR_PRC OK_MIN_MS OK_MAX_MS OK_AVG_MS CNT_LK_CONFL CNT_USER_EXC
doc_list_aiud 1492850 1492850 0 0.00 0 13255 12 0 0
doc_list_biud 1492850 1492850 0 0.00 0 23962 43 0 0
sp_add_invoice_to_stock 4771 4672 99 2.07 55 177837 25340 0 99
sp_cancel_adding_invoice 5606 5606 0 0.00 6 91998 1033 0 0
sp_cancel_client_order 1606 1606 0 0.00 5 9253 399 0 0
sp_cancel_customer_reserve 559673 559673 0 0.00 1 24146 100 0 0
sp_cancel_pay_from_customer 625 625 0 0.00 4 6102 127 0 0
sp_cancel_pay_to_supplier 396 396 0 0.00 4 4072 126 0 0
sp_cancel_supplier_invoice 6246 6235 11 0.17 3 16354 914 0 11
sp_cancel_supplier_order 429 429 0 0.00 26 1556293 162598 0 0
sp_cancel_write_off 9802 9802 0 0.00 2 16525 155 0 0
sp_client_order 19154 19154 0 0.00 5 29808 448 0 0
sp_customer_reserve 443054 443054 0 0.00 1 83306 236 0 0
sp_fill_shopping_cart 29423 29423 0 0.00 1 16289 76 0 0
sp_fill_shopping_cart_clo_res 443043 443043 0 0.00 0 21479 20 0 0
sp_get_clo_for_invoice 4633 4633 0 0.00 0 32049 350 0 0
sp_kill_cost_storno 16429 16429 0 0.00 0 11733 66 0 0
sp_kill_qstorno_ret_qs2qd 1135812 1135812 0 0.00 0 23950 44 0 0
sp_kill_qty_storno 597227 597227 0 0.00 0 23960 99 0 0
sp_lock_selected_doc 19206 19206 0 0.00 0 6878 7 0 0
sp_make_cost_storno 25998 25998 0 0.00 0 10194 76 0 0
sp_multiply_rows_for_pdistr 25998 25998 0 0.00 0 5683 33 0 0
sp_multiply_rows_for_qdistr 19154 19154 0 0.00 0 18358 193 0 0
sp_pay_from_customer 6666 6666 0 0.00 5 9153 150 0 0
sp_pay_to_supplier 5456 5456 0 0.00 6 11134 182 0 0
sp_payment_common 12122 12122 0 0.00 2 7380 41 0 0
sp_qd_handle_on_cancel_clo 1606 1606 0 0.00 0 9246 319 0 0
sp_qd_handle_on_invoice_upd_sts 10236 10236 0 0.00 0 13396 482 0 0
sp_qd_handle_on_reserve_upd_sts 9246 9246 0 0.00 0 14278 64 0 0
sp_reserve_write_off 9246 9246 0 0.00 8 14328 259 0 0
sp_supplier_invoice 5116 5116 0 0.00 9 103624 3069 0 0
sp_supplier_order 5158 5158 0 0.00 7 44286 1375 0 0
srv_aggregate_perf_data 111 111 0 0.00 2853 227898 16483 0 0
srv_fill_mon_cache_memory 70 70 0 0.00 719 144099 35324 0 0
srv_find_qd_qs_mism 1038475 1038475 0 0.00 0 12999 9 0 0
srv_make_invnt_saldo 456 456 0 0.00 61 114183 4316 0 0
srv_make_money_saldo 810 810 0 0.00 1 15149 375 0 0
srv_recalc_idx_stat 4 4 0 0.00 196390 564858 366882 0 0
t$perf-abend:sp_add_invoice_to_stock 99 99 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 11 11 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4672 4672 0 0.00 1 8300 858 0 0
t$perf-norm:sp_cancel_adding_invoice 320 320 0 0.00 1 5830 402 0 0
t$perf-norm:sp_cancel_client_order 1606 1606 0 0.00 0 3614 27 0 0
t$perf-norm:sp_cancel_customer_reserve 667 667 0 0.00 0 943 26 0 0
t$perf-norm:sp_cancel_pay_from_customer 625 625 0 0.00 0 802 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 396 396 0 0.00 0 1759 16 0 0
t$perf-norm:sp_cancel_supplier_invoice 364 364 0 0.00 0 3101 47 0 0
t$perf-norm:sp_cancel_supplier_order 429 429 0 0.00 0 63097 6426 0 0
t$perf-norm:sp_cancel_write_off 926 926 0 0.00 0 4257 24 0 0
t$perf-norm:sp_client_order 19154 19154 0 0.00 0 7335 31 0 0
t$perf-norm:sp_customer_reserve 1029 1029 0 0.00 0 1617 14 0 0
t$perf-norm:sp_pay_from_customer 6666 6666 0 0.00 0 3952 18 0 0
t$perf-norm:sp_pay_to_supplier 5456 5456 0 0.00 0 5902 19 0 0
t$perf-norm:sp_reserve_write_off 9246 9246 0 0.00 0 3917 21 0 0
t$perf-norm:sp_supplier_invoice 5116 5116 0 0.00 0 4402 30 0 0
t$perf-norm:sp_supplier_order 5158 5158 0 0.00 0 5235 28 0 0
t$perf-norm:srv_aggregate_perf_data 111 111 0 0.00 0 743 16 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 279 13 0 0
t$perf-norm:srv_make_invnt_saldo 456 456 0 0.00 0 3669 25 0 0
t$perf-norm:srv_make_money_saldo 810 810 0 0.00 0 1045 6 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 180 53 0 0
v_add_invoice_to_stock 9452 9254 198 2.09 0 5579 25 0 198
v_all_customers 35308 35308 0 0.00 0 78 3 0 0
v_all_suppliers 28634 28634 0 0.00 0 155 4 0 0
v_all_wares 38308 38308 0 0.00 0 52 3 0 0
v_cancel_adding_invoice 640 640 0 0.00 0 353 13 0 0
v_cancel_client_order 3212 3212 0 0.00 0 2421 10 0 0
v_cancel_customer_prepayment 1250 1250 0 0.00 0 1871 13 0 0
v_cancel_customer_reserve 1334 1334 0 0.00 0 1231 10 0 0
v_cancel_payment_to_supplier 792 792 0 0.00 0 879 12 0 0
v_cancel_supplier_invoice 750 728 22 2.93 0 938 22 0 22
v_cancel_supplier_order 858 858 0 0.00 0 1982 12 0 0
v_cancel_write_off 1852 1852 0 0.00 0 1475 22 0 0
v_max_id_clo_ord 5158 5158 0 0.00 0 401 4 0 0
v_max_id_clo_res 1029 1029 0 0.00 0 3617 19 0 0
v_max_id_ord_sup 5111 5111 0 0.00 0 3406 7 0 0
v_max_non_paid_invoice 1408 1408 0 0.00 0 142 7 0 0
v_max_non_paid_realizn 3391 3391 0 0.00 0 3337 7 0 0
v_min_id_clo_ord 5158 5158 0 0.00 0 675 7 0 0
v_min_id_clo_res 1029 1029 0 0.00 0 6294 14 0 0
v_min_id_ord_sup 5111 5111 0 0.00 0 4894 9 0 0
v_min_non_paid_invoice 5456 5456 0 0.00 0 5265 17 0 0
v_min_non_paid_realizn 6666 6666 0 0.00 0 5248 13 0 0
v_our_firm 9550 9550 0 0.00 0 77 4 0 0
v_reserve_write_off 18492 18492 0 0.00 0 6160 9 0 0
x_lock_depdocs_on_canc_invoice 11477 11477 0 0.00 0 14571 113 0 0
x_lock_depdocs_on_canc_sup_ord 429 429 0 0.00 0 17732 447 0 0
x_make_qstorno_1000_1200 5158 5158 0 0.00 2 44272 1225 0 0
x_make_qstorno_1200_2000 5116 5116 0 0.00 4 103561 2856 0 0
x_make_qstorno_2100_3300 443054 443054 0 0.00 0 83300 205 0 0

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

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
05:07:24 1 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
05:08:25 16965 8192000000 9721767680 10020388864 802268432 8.919 100 88 176 0 831371888 7956864 21146592
05:09:52 18235 8192000000 9756148160 10061975552 832665200 9.226 100 91 182 0 867118224 13066400 21386624
05:11:20 11014 8192000000 9791367232 10110054400 863615552 9.536 100 85 170 0 904680720 20640016 20425152
05:12:37 6500 8192000000 9860609744 10192257024 911968464 10.017 100 86 170 0 971576848 40442832 19165552
05:13:53 2688 8192000000 9929499264 10273062912 961176672 10.501 100 89 174 0 1045660112 66521520 17961920
05:14:58 2183 8192000000 9969022016 10325164032 993279792 10.813 100 91 180 0 1090779440 78242048 19257600
05:16:02 1316 8192000000 10021688496 10382585856 1023123392 11.102 100 94 182 2 1132923152 91171072 18628688
05:17:07 777 8192000000 10014009200 10385575936 1044478256 11.308 100 95 180 1 1137202864 73851904 18872704
05:18:09 1164 8192000000 10038490448 10416103424 1060388048 11.460 100 95 183 0 1158889728 80823584 17678096
05:19:11 999 8192000000 10055688784 10434936832 1074850992 11.598 100 97 193 0 1179973792 85072496 20050304
05:20:15 1006 8192000000 10049002768 10431311872 1071242240 11.564 100 89 168 1 1172289936 83229072 17818624
05:21:17 1233 8192000000 10068089328 10452545536 1080484160 11.652 100 98 188 1 1189328704 89659168 19185376
05:22:19 992 8192000000 10044137952 10429636608 1090140880 11.744 100 96 182 1 1167819952 58690240 18988832
05:23:21 2839 8192000000 10049161264 10440245248 1087046048 11.715 100 71 137 0 1169288064 69036000 13206016
05:24:25 1160 8192000000 10059276688 10445312000 1094521392 11.786 100 97 179 1 1180847312 67701456 18624464
05:25:28 1380 8192000000 10060815488 10450890752 1097901248 11.818 100 78 146 2 1178735184 66446112 14387824
05:26:30 1148 8192000000 10095696160 10490691584 1105164704 11.887 100 98 185 0 1216416704 92632928 18619072
05:27:32 2144 8192000000 10070804112 10463670272 1106839056 11.902 100 80 151 1 1192547680 71178784 14529840
05:28:35 849 8192000000 10042423952 10437128192 1096875520 11.808 100 84 156 1 1167854944 53239984 17739440
05:29:37 1122 8192000000 10047632416 10435104768 1089390352 11.737 100 94 174 0 1167084656 60259168 17435136
05:30:38 5756 8192000000 10020697760 10415874048 1062398160 11.479 100 58 110 2 1138246576 63377216 12471200
05:31:45 1515 8192000000 10028097280 10406535168 1062119232 11.477 100 87 162 2 1146321680 67005520 17196928
05:32:47 2216 8192000000 9971827184 10348441600 1027461056 11.144 99 70 116 1 1087518336 48071232 11986048
05:33:50 931 8192000000 10002796416 10380128256 1044361008 11.307 100 92 170 2 1125722976 64584176 16777792
05:34:52 1308 8192000000 9925670048 10296823808 1006283680 10.939 100 84 151 0 1049891456 27939136 15668640
05:35:54 1307 8192000000 10003886144 10373894144 1036144784 11.228 100 98 186 2 1126044368 70406848 19492736
05:36:56 1066 8192000000 10007452512 10385719296 1042934432 11.293 100 92 174 1 1131722192 69162128 19625632
05:38:01 1775 8192000000 9977506336 10356953088 1057751168 11.435 100 71 129 2 1098945792 28862112 12332512
05:39:18 1334 8192000000 10047647376 10431430656 1079338704 11.641 100 94 182 3 1174782864 75149328 20294832
05:40:23 6185 8192000000 10061317328 10447523840 1086304144 11.708 100 66 127 1 1183214512 83822592 13087776
05:41:34 2624 8192000000 10086015280 10477068288 1086678176 11.711 100 62 118 0 1202494352 103144752 12671424
05:42:45 4842 8192000000 10119717584 10519343104 1101822128 11.855 100 70 136 0 1235701968 119218320 14661520
05:43:56 9019 8192000000 10179995008 10575421440 1114714640 11.977 100 69 131 1 1291308160 161954880 14638640
05:45:10 1750 8192000000 10192001472 10583330816 1121190128 12.038 100 83 148 0 1303843872 167320048 15333696
05:46:17 2066 8192000000 10244054208 10634854400 1140691792 12.222 100 77 149 0 1356859008 199968448 16198768
05:47:21 860 8192000000 10272487760 10684002304 1158987408 12.394 100 95 178 1 1380774848 200812912 20974528
05:48:26 1194 8192000000 10285773072 10695557120 1162030400 12.422 100 92 178 1 1399762608 217720384 20011824
05:49:29 957 8192000000 10296662896 10723536896 1167424016 12.473 100 98 193 0 1408326480 219434192 21468272
05:50:34 2896 8192000000 10300755280 10729209856 1181629088 12.605 100 79 158 0 1408470624 208958768 17882768
05:51:42 711 8192000000 10346480784 10751406080 1191587824 12.698 100 98 187 1 1454370480 241853808 20928848
05:52:45 1561 8192000000 10379123216 10785267712 1196087680 12.740 100 95 187 1 1486660688 270213360 20359648
05:53:49 1089 8192000000 10394058912 10807025664 1201443824 12.790 100 93 183 1 1503892480 281329216 21119440
05:54:54 1039 8192000000 10418347872 10844696576 1197661296 12.755 100 97 187 3 1521014624 300058688 23294640
05:55:57 850 8192000000 10448377232 10871001088 1199286880 12.770 100 97 189 0 1553586896 331774048 22525968
05:56:59 2948 8192000000 10433067248 10855546880 1198750880 12.765 100 65 126 3 1537952208 322905792 16295536
05:58:09 2653 8192000000 10450057216 10885074944 1185448976 12.641 100 68 136 2 1556706128 354916176 16340976
05:59:15 1080 8192000000 10456671104 10889338880 1189887888 12.682 100 95 191 0 1557437680 344476064 23073728
06:00:18 8429 8192000000 10394445920 10838085632 1177078704 12.563 99 55 111 0 1507563008 316425952 14058352
06:01:32 5979 8192000000 10433336704 10863046656 1177332576 12.565 99 60 110 2 1533508432 342150016 14025840
06:02:40 20555 8192000000 10409839536 10879557632 1141352416 12.228 97 43 85 0 1523156144 370375120 11428608
06:04:06 7942 8192000000 10410027216 10859646976 1155750208 12.363 100 48 90 1 1506991040 339531296 11709536
06:05:15 13592 8192000000 10330855072 10822873088 1159163568 12.395 100 38 74 1 1459110352 290230096 9716688
06:06:45 5689 8192000000 10291336432 10741096448 1156807696 12.373 100 55 97 2 1392711936 225847248 10056992
06:07:55 41627 8192000000 10205567824 10740555776 1144490272 12.258 100 14 28 0 1335386768 187108224 3788272
06:09:46 49600 8192000000 10104495872 10705305600 1144802080 12.261 100 13 26 0 1306075280 158188944 3084256
06:11:36 36057 8192000000 10085779488 10530959360 1128034320 12.103 99 30 56 1 1164824384 30230080 6559984
06:13:13 95403 8192000000 10090817088 10544230400 1133406992 12.153 99 20 41 0 1186460864 49197264 3856608
06:17:12 73786 8192000000 10086343056 10552156160 1073650800 11.587 94 11 20 0 1155371824 79499824 2221200
06:19:46 43306 8192000000 10094924896 10518859776 1109706032 11.930 98 40 71 1 1166336336 48788368 7841936
06:21:30 64010 8192000000 10108762512 10540777472 1127170576 12.095 99 38 72 1 1206941744 71663760 8107408
06:23:35 35486 8192000000 10126633504 10593144832 1129713792 12.119 100 31 62 0 1216420016 79864080 6842144
06:25:21 49537 8192000000 10157789904 10629967872 1143653120 12.250 100 44 88 2 1245459376 92185520 9620736
06:27:19 37014 8192000000 10144807888 10634649600 1148936528 12.300 100 21 42 0 1244080224 90579872 4563824
06:28:57 38012 8192000000 10109318912 10614927360 1143348032 12.247 100 6 12 0 1212202304 67717184 1137088
06:31:10 46607 8192000000 10096321360 10595045376 1148950208 12.300 100 14 28 0 1231499072 79078672 3470192
06:33:03 63116 8192000000 10043376112 10513653760 1128253408 12.105 99 17 34 0 1172034320 40641264 3139648
06:35:06 101479 8192000000 10089210736 10575876096 1104555392 11.881 97 7 14 0 1147013360 41162848 1295120
06:37:48 47223 8192000000 10103827744 10576605184 1130422448 12.125 99 24 48 0 1211138048 74913472 5802128
06:39:41 30868 8192000000 10073337504 10532573184 1105006048 11.885 97 41 78 0 1134272416 20959296 8307072
06:41:15 31598 8192000000 10122668048 10569891840 1131004608 12.131 99 39 78 0 1196518048 57647456 7865984
06:42:50 11728 8192000000 10158649168 10602778624 1145211632 12.265 100 47 94 0 1250935888 95557584 10166672
06:44:03 45698 8192000000 10146023808 10593738752 1153203904 12.340 100 21 42 0 1245665360 88237344 4224112
06:45:52 64466 8192000000 10097720496 10550194176 1125501168 12.079 98 23 46 0 1226364080 95763984 5098928
06:47:57 144098 8192000000 10064552608 10502209536 1089085712 11.734 95 25 50 1 1153380304 59049456 5245136
06:51:21 64126 8192000000 10080023984 10531176448 1111574928 11.947 98 22 42 0 1148278192 32482528 4220736
06:53:27 71838 8192000000 10073028560 10537742336 1130009072 12.121 100 12 22 0 1176652976 43410352 3233552
06:55:52 64754 8192000000 10104218544 10558488576 1109769824 11.930 97 18 36 0 1172805312 58904656 4130832
06:58:20 63054 8192000000 10121557968 10556153856 1097375568 11.813 97 22 45 0 1186245184 83930768 4938848
07:00:25 15995 8192000000 10173205344 10611998720 1152249056 12.331 100 37 73 0 1274871072 114094368 8527648
07:01:49 19886 8192000000 10201151120 10652643328 1148854368 12.299 99 45 89 0 1318649184 159501040 10293776
07:03:16 14928 8192000000 10186991392 10617622528 1143779952 12.251 100 48 83 2 1274755184 122109424 8865808
07:04:38 24605 8192000000 10212951344 10663223296 1157551648 12.380 100 31 60 1 1308100352 143362848 7185856
07:06:19 35913 8192000000 10261923808 10722213888 1157275472 12.378 100 34 67 0 1359790336 194752048 7762816
07:07:55 40689 8192000000 10236081920 10715668480 1131011968 12.131 99 27 52 0 1339254912 202492288 5750656
07:09:46 43357 8192000000 10100422256 10572062720 1120365648 12.030 100 26 52 0 1229699536 103491216 5842672
07:11:39 75167 8192000000 10087656000 10571321344 1108476016 11.918 98 18 36 0 1175394384 63216560 3701808
07:14:10 94140 8192000000 10058407792 10514059264 1105402272 11.889 98 2 4 0 1154016352 48255008 359072
07:17:03 71704 8192000000 10099075840 10576220160 1128492944 12.107 99 22 45 0 1181870112 48870752 4506416
07:19:21 80147 8192000000 10095417472 10579832832 1114298864 11.973 98 20 38 0 1191439296 73370256 3770176
07:21:41 72170 8192000000 10053640624 10540498944 1111534720 11.947 98 20 40 0 1190558416 74815760 4207936
07:24:02 74433 8192000000 10145480256 10592022528 1125771120 12.081 98 24 48 0 1192458640 61563856 5123664
07:26:17 49325 8192000000 10127514912 10574397440 1155403184 12.360 100 34 68 0 1216418160 53370560 7644416
07:28:09 47248 8192000000 10145884352 10628517888 1149395008 12.304 100 35 70 1 1276829648 120235536 7199104
07:30:51 50464 8192000000 10121161872 10624487424 1128409584 12.106 98 27 53 0 1245546640 111646720 5490336
07:32:45 51008 8192000000 10102036752 10547699712 1140922720 12.224 100 29 58 0 1191695360 44744896 6027744
07:34:39 74075 8192000000 10156824992 10622029824 1123650160 12.061 98 55 110 0 1220183712 85530592 11002960
07:37:10 12983 8192000000 9915420128 10378190848 991985232 10.801 87 22 45 0 1036978704 40618960 4374512

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 22-12-2022 07:39:24 to 22-12-2022 07:39:40.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 99 v_add_invoice_to_stock 335544517
except 11 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 22-12-2022 07:39:41 to 22-12-2022 07:39:43.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp40-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   13
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          216344
MON$OLDEST_ACTIVE               216345
MON$OLDEST_SNAPSHOT             216345
MON$NEXT_TRANSACTION            216345
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-30 07:30:08.6030 GMT
MON$PAGES                       2068256
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             766
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2885 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2885 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2885 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2885 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
on disk structure version 13.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-oltp40 according to config parameter 'remove_isql_logs'

22.12.22 07:39:44. There are 3 logs in /var/tmp/logs-oltp40 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-12-22 07:39:47 No severe PSQL-related problems occured
22.12.22 07:39:48. End of report.