Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 02.01.2023 04: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 14956104 kB
MemAvailable 30374824 kB
Buffers 20 kB
Cached 16699804 kB
SwapCached 7720 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 2023-01-02 04:37:23
DTS_END                         2023-01-02 04:37:23.3580
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(68:17)
IP                              ::1/36266
TRN_ID                          228663
ATT_ID                          601
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: 9222.48 21450 1106697
customer order: creation 181.53 442 21784
customer order: refuse 15.66 359 1879
order to supplier: creation 47.51 1372 5701
order to supplier: removal 3.53 170676 424
invoice (draft): creation 46.94 3136 5633
invoice (draft): removal 51.01 1089 6121
invoice accept: apply 42.91 25810 5149
invoice accept: cancel 46.38 1146 5565
customer reserve: creation 3968.55 250 476226
customer reserve: removal 4515.08 104 541809
realization accept: apply 85.93 277 10311
realization accept: cancel 80.47 185 9657
payment from customer: creation 63.28 166 7593
payment from customer: removal 5.90 144 708
payment to supplier: creation 51.15 184 6138
payment to supplier: removal 3.61 110 433
service: total inventory turnovers 4.20 3828 504
service: total monetary turnovers 7.89 353 947
service: aggregate perf. data 0.93 15040 111
service: refresh index statistics 0.03 204334 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 02-01-2023 04:39:10 to 02-01-2023 04:39:12.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5740
TEST_TIME 2 5516
TEST_TIME 3 5473
TEST_TIME 4 5828
TEST_TIME 5 5864
TEST_TIME 6 6246
TEST_TIME 7 6311
TEST_TIME 8 6415
TEST_TIME 9 6788
TEST_TIME 10 6665
TEST_TIME 11 6580
TEST_TIME 12 6806
TEST_TIME 13 6953
TEST_TIME 14 6962
TEST_TIME 15 7158
TEST_TIME 16 7480
TEST_TIME 17 7984
TEST_TIME 18 7770
TEST_TIME 19 7537
TEST_TIME 20 7765
TEST_TIME 21 7797
TEST_TIME 22 7860
TEST_TIME 23 7786
TEST_TIME 24 7657
TEST_TIME 25 8211
TEST_TIME 26 8187
TEST_TIME 27 8767
TEST_TIME 28 9071
TEST_TIME 29 9896
TEST_TIME 30 10091
TEST_TIME 31 9819
TEST_TIME 32 10019
TEST_TIME 33 10984
TEST_TIME 34 10879
TEST_TIME 35 10733
TEST_TIME 36 10623
TEST_TIME 37 10461
TEST_TIME 38 10487
TEST_TIME 39 10604
TEST_TIME 40 10678
TEST_TIME 41 10625
TEST_TIME 42 10462
TEST_TIME 43 10303
TEST_TIME 44 10192
TEST_TIME 45 10040
TEST_TIME 46 10061
TEST_TIME 47 10022
TEST_TIME 48 10012
TEST_TIME 49 9982
TEST_TIME 50 9852
TEST_TIME 51 9882
TEST_TIME 52 9808
TEST_TIME 53 9720
TEST_TIME 54 9610
TEST_TIME 55 9564
TEST_TIME 56 9642
TEST_TIME 57 9718
TEST_TIME 58 9740
TEST_TIME 59 9842
TEST_TIME 60 9837
TEST_TIME 61 9723
TEST_TIME 62 9673
TEST_TIME 63 9679
TEST_TIME 64 9690
TEST_TIME 65 9763
TEST_TIME 66 9765
TEST_TIME 67 9762
TEST_TIME 68 9762
TEST_TIME 69 9768
TEST_TIME 70 9806
TEST_TIME 71 9875
TEST_TIME 72 9856
TEST_TIME 73 9775
TEST_TIME 74 9673
TEST_TIME 75 9724
TEST_TIME 76 9677
TEST_TIME 77 9600
TEST_TIME 78 9580
TEST_TIME 79 9600
TEST_TIME 80 9561
TEST_TIME 81 9537
TEST_TIME 82 9463
TEST_TIME 83 9403
TEST_TIME 84 9378
TEST_TIME 85 9294
TEST_TIME 86 9298
TEST_TIME 87 9250
TEST_TIME 88 9232
TEST_TIME 89 9267
TEST_TIME 90 9280
TEST_TIME 91 9271
TEST_TIME 92 9363
TEST_TIME 93 9355
TEST_TIME 94 9343
TEST_TIME 95 9343
TEST_TIME 96 9389
TEST_TIME 97 9451
TEST_TIME 98 9425
TEST_TIME 99 9434
TEST_TIME 100 9344
TEST_TIME 101 9340
TEST_TIME 102 9319
TEST_TIME 103 9264
TEST_TIME 104 9237
TEST_TIME 105 9197
TEST_TIME 106 9157
TEST_TIME 107 9150
TEST_TIME 108 9117
TEST_TIME 109 9119
TEST_TIME 110 9088
TEST_TIME 111 9074
TEST_TIME 112 9088
TEST_TIME 113 9060
TEST_TIME 114 9027
TEST_TIME 115 9047
TEST_TIME 116 9036
TEST_TIME 117 9087
TEST_TIME 118 9276
TEST_TIME 119 9304
TEST_TIME 120 9242

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 02-01-2023 04:39:14 to 02-01-2023 04: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 1546292 1546292 0 0.00 0 22054 14 0 0
doc_list_biud 1546282 1546282 0 0.00 0 68623 43 0 0
sp_add_invoice_to_stock 5253 5149 104 1.97 40 159884 25811 0 104
sp_cancel_adding_invoice 5565 5565 0 0.00 6 63393 1146 0 0
sp_cancel_client_order 1879 1879 0 0.00 6 10306 360 0 0
sp_cancel_customer_reserve 541809 541809 0 0.00 1 33317 105 0 0
sp_cancel_pay_from_customer 708 708 0 0.00 4 8693 144 0 0
sp_cancel_pay_to_supplier 433 433 0 0.00 3 2700 110 0 0
sp_cancel_supplier_invoice 6125 6121 4 0.06 2 68640 1089 0 4
sp_cancel_supplier_order 424 424 0 0.00 21 1426167 170677 0 0
sp_cancel_write_off 9657 9657 0 0.00 2 11207 185 0 0
sp_client_order 21784 21784 0 0.00 5 11930 442 0 0
sp_customer_reserve 476226 476226 0 0.00 0 50742 250 0 0
sp_fill_shopping_cart 33109 33109 0 0.00 1 17578 78 0 0
sp_fill_shopping_cart_clo_res 476202 476202 0 0.00 0 16467 17 0 0
sp_get_clo_for_invoice 5116 5116 0 0.00 0 20284 216 0 0
sp_kill_cost_storno 16363 16363 0 0.00 0 8102 72 0 0
sp_kill_qstorno_ret_qs2qd 1099820 1099820 0 0.00 0 68619 46 0 0
sp_kill_qty_storno 580881 580881 0 0.00 0 68623 105 0 0
sp_lock_selected_doc 21544 21544 0 0.00 0 10219 9 0 0
sp_make_cost_storno 29158 29158 0 0.00 0 13607 80 0 0
sp_multiply_rows_for_pdistr 29157 29157 0 0.00 0 8600 36 0 0
sp_multiply_rows_for_qdistr 21784 21784 0 0.00 0 11919 168 0 0
sp_pay_from_customer 7593 7593 0 0.00 5 12619 167 0 0
sp_pay_to_supplier 6138 6138 0 0.00 7 13157 184 0 0
sp_payment_common 13727 13727 0 0.00 2 7187 45 0 0
sp_qd_handle_on_cancel_clo 1879 1879 0 0.00 0 10284 287 0 0
sp_qd_handle_on_invoice_upd_sts 10680 10680 0 0.00 0 33013 508 0 0
sp_qd_handle_on_reserve_upd_sts 10311 10311 0 0.00 0 16156 66 0 0
sp_reserve_write_off 10311 10311 0 0.00 9 21942 278 0 0
sp_supplier_invoice 5633 5633 0 0.00 9 90444 3136 0 0
sp_supplier_order 5701 5701 0 0.00 7 36032 1373 0 0
srv_aggregate_perf_data 112 111 1 0.89 2270 147785 15041 0 1
srv_fill_mon_cache_memory 76 76 0 0.00 825 109421 29526 0 0
srv_find_qd_qs_mism 1056156 1056156 0 0.00 0 22052 11 0 0
srv_make_invnt_saldo 504 504 0 0.00 63 79138 3828 0 0
srv_make_money_saldo 947 947 0 0.00 1 14187 353 0 0
srv_recalc_idx_stat 4 4 0 0.00 107191 325618 204335 0 0
t$perf-abend:sp_add_invoice_to_stock 104 104 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 4 4 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 5155 5155 0 0.00 1 25405 793 0 0
t$perf-norm:sp_cancel_adding_invoice 411 411 0 0.00 1 6629 335 0 0
t$perf-norm:sp_cancel_client_order 1879 1879 0 0.00 0 1495 26 0 0
t$perf-norm:sp_cancel_customer_reserve 745 745 0 0.00 0 1021 26 0 0
t$perf-norm:sp_cancel_pay_from_customer 708 708 0 0.00 0 1159 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 433 433 0 0.00 0 992 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 424 424 0 0.00 0 1684 39 0 0
t$perf-norm:sp_cancel_supplier_order 424 424 0 0.00 0 82047 6554 0 0
t$perf-norm:sp_cancel_write_off 1097 1097 0 0.00 0 1557 20 0 0
t$perf-norm:sp_client_order 21786 21786 0 0.00 0 26078 35 0 0
t$perf-norm:sp_customer_reserve 1064 1064 0 0.00 0 3543 20 0 0
t$perf-norm:sp_pay_from_customer 7593 7593 0 0.00 0 5121 17 0 0
t$perf-norm:sp_pay_to_supplier 6138 6138 0 0.00 0 9979 19 0 0
t$perf-norm:sp_reserve_write_off 10313 10313 0 0.00 0 25251 23 0 0
t$perf-norm:sp_supplier_invoice 5633 5633 0 0.00 0 7985 29 0 0
t$perf-norm:sp_supplier_order 5701 5701 0 0.00 0 7194 29 0 0
t$perf-norm:srv_aggregate_perf_data 111 111 0 0.00 0 1605 30 0 0
t$perf-norm:srv_fill_mon_cache_memory 76 76 0 0.00 0 306 11 0 0
t$perf-norm:srv_make_invnt_saldo 504 504 0 0.00 0 444 9 0 0
t$perf-norm:srv_make_money_saldo 947 947 0 0.00 0 405 4 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 118 55 0 0
v_add_invoice_to_stock 10432 10224 208 1.99 0 4801 25 0 208
v_all_customers 40336 40336 0 0.00 0 142 4 0 0
v_all_suppliers 31675 31675 0 0.00 0 63 4 0 0
v_all_wares 43554 43554 0 0.00 0 112 4 0 0
v_cancel_adding_invoice 822 822 0 0.00 0 2483 20 0 0
v_cancel_client_order 3758 3758 0 0.00 0 1360 9 0 0
v_cancel_customer_prepayment 1416 1416 0 0.00 0 2907 12 0 0
v_cancel_customer_reserve 1490 1490 0 0.00 0 2810 14 0 0
v_cancel_payment_to_supplier 866 866 0 0.00 0 2658 13 0 0
v_cancel_supplier_invoice 856 848 8 0.93 0 488 25 0 8
v_cancel_supplier_order 848 848 0 0.00 0 992 13 0 0
v_cancel_write_off 2194 2194 0 0.00 0 3208 23 0 0
v_max_id_clo_ord 5699 5699 0 0.00 0 194 5 0 0
v_max_id_clo_res 1064 1064 0 0.00 0 3649 15 0 0
v_max_id_ord_sup 5626 5626 0 0.00 0 4571 9 0 0
v_max_non_paid_invoice 1622 1622 0 0.00 0 2051 8 0 0
v_max_non_paid_realizn 3744 3744 0 0.00 0 1703 7 0 0
v_min_id_clo_ord 5698 5698 0 0.00 0 2370 8 0 0
v_min_id_clo_res 1064 1064 0 0.00 0 1100 9 0 0
v_min_id_ord_sup 5626 5626 0 0.00 0 10211 13 0 0
v_min_non_paid_invoice 6137 6137 0 0.00 0 5990 17 0 0
v_min_non_paid_realizn 7590 7590 0 0.00 0 7169 19 0 0
v_our_firm 10908 10908 0 0.00 0 117 4 0 0
v_reserve_write_off 20620 20620 0 0.00 0 2900 9 0 0
x_lock_depdocs_on_canc_invoice 11262 11262 0 0.00 0 17705 127 0 0
x_lock_depdocs_on_canc_sup_ord 424 424 0 0.00 0 7604 350 0 0
x_make_qstorno_1000_1200 5701 5701 0 0.00 2 36002 1220 0 0
x_make_qstorno_1200_2000 5633 5633 0 0.00 3 90432 2920 0 0
x_make_qstorno_2100_3300 476225 476225 0 0.00 0 46653 222 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 02-01-2023 04:39:18 to 02-01-2023 04: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
02:07:27 2 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
02:08:28 28232 8192000000 9731497904 10030284800 800817712 8.905 100 87 174 0 829799824 8066848 20915264
02:10:02 19251 8192000000 9765444208 10072731648 838512736 9.285 100 90 178 1 872629360 12703680 21412944
02:11:25 7759 8192000000 9798361184 10116931584 869787360 9.598 100 80 160 0 908409920 20132560 18490000
02:12:35 6370 8192000000 9855842272 10185998336 909001168 9.987 100 79 157 0 962050672 35612864 17436640
02:13:44 4409 8192000000 9922697408 10262323200 945691216 10.349 100 90 176 1 1031244768 67195408 18358144
02:14:52 2254 8192000000 9955783904 10307174400 984490928 10.728 100 82 162 0 1072006896 70625504 16890464
02:15:56 1782 8192000000 9972657200 10335285248 1020864192 11.080 100 83 164 1 1087502592 49727776 16910624
02:17:00 3026 8192000000 10030107136 10397388800 1046959424 11.332 100 85 157 2 1146175488 84399184 14816880
02:18:04 860 8192000000 10041060144 10421792768 1061343152 11.469 100 93 182 0 1157552768 77720704 18488912
02:19:05 1078 8192000000 10033183040 10412490752 1074207024 11.592 100 95 182 1 1155762064 63425808 18129232
02:20:07 3158 8192000000 10002346720 10401779712 1078497056 11.633 100 63 126 1 1142910816 50939728 13474032
02:21:12 886 8192000000 10044787216 10430386176 1086098720 11.706 100 86 156 1 1164454256 63265056 15090480
02:22:13 4209 8192000000 10040719648 10442387456 1092384608 11.765 100 76 151 0 1170522384 63258448 14879328
02:23:18 1103 8192000000 10068301232 10463240192 1096473024 11.804 100 98 191 0 1196300688 80574896 19252768
02:24:20 1423 8192000000 10069957104 10460520448 1097529600 11.814 100 84 166 3 1189954432 75898944 16525888
02:25:23 1070 8192000000 10074057616 10464681984 1101062592 11.848 100 92 178 0 1194538912 75378080 18098240
02:26:25 1289 8192000000 10050651152 10444554240 1103295600 11.869 100 96 175 2 1175352480 53646384 18410496
02:27:27 1226 8192000000 10095505248 10484166656 1100667424 11.844 100 97 182 0 1211612304 92483216 18461664
02:28:29 1426 8192000000 10057203104 10449637376 1089351488 11.736 100 91 174 0 1181983248 73465216 19166544
02:29:31 7655 8192000000 10043198544 10437648384 1089643952 11.739 100 63 118 2 1164019216 62988592 11386672
02:30:40 1064 8192000000 10015552016 10394566656 1061552272 11.471 100 99 188 0 1137001216 55715184 19733760
02:31:42 1129 8192000000 10027549776 10404818944 1060182864 11.458 100 98 191 2 1149988128 69493488 20311776
02:32:44 1155 8192000000 9942719584 10306478080 986675680 10.749 97 91 167 1 1064264400 60451488 17137232
02:33:46 1071 8192000000 9983849072 10356776960 1036553376 11.232 100 97 185 1 1109114896 53338944 19222576
02:34:49 1067 8192000000 9999164896 10375090176 1047125360 11.333 100 92 181 0 1121539360 54805360 19608640
02:35:51 1069 8192000000 10018209808 10394247168 1042798848 11.292 100 91 172 4 1144171856 83059920 18313088
02:36:53 1068 8192000000 9975044848 10345914368 1038254832 11.248 100 89 166 4 1094688160 39445888 16987440
02:37:59 6886 8192000000 9986912384 10370514944 1057342784 11.431 100 62 115 1 1105305472 36810176 11152512
02:39:13 1045 8192000000 10046759760 10426626048 1080335168 11.651 100 94 177 2 1170523664 70488176 19700320
02:40:16 1572 8192000000 10076786736 10460930048 1098461472 11.823 100 91 170 0 1197234768 79768032 19005264
02:41:23 5164 8192000000 10109300704 10505654272 1108627040 11.919 100 81 149 1 1229457232 105512272 15317920
02:42:32 8811 8192000000 10112484944 10524606464 1120494848 12.032 100 63 123 1 1224216704 91259664 12462192
02:43:50 1462 8192000000 10181837776 10577776640 1130521216 12.126 100 89 171 3 1301216272 151194736 19500320
02:44:56 1671 8192000000 10196519728 10597748736 1142839664 12.242 100 77 144 1 1314021136 156018464 15163008
02:46:02 12437 8192000000 10208205120 10622091264 1148292592 12.293 100 61 118 2 1322123872 160731552 13099728
02:47:19 12675 8192000000 10207849504 10626199552 1166847216 12.467 100 58 114 0 1315352688 135780928 12724544
02:48:36 3318 8192000000 10275535376 10680037376 1181457808 12.604 100 84 162 0 1393308752 192574384 19276560
02:49:42 1270 8192000000 10334180176 10743386112 1194523584 12.725 100 89 172 1 1442379824 228508256 19347984
02:50:47 1349 8192000000 10344240320 10752188416 1196578992 12.745 100 95 185 1 1454793056 235891488 22322576
02:51:50 2055 8192000000 10363380352 10804174848 1197603312 12.754 100 83 161 0 1483549264 266650512 19295440
02:52:58 852 8192000000 10405983760 10847399936 1210132544 12.870 100 92 179 3 1513344176 282251936 20959696
02:54:01 1009 8192000000 10401940368 10852102144 1207518048 12.846 100 96 189 1 1511385248 282810192 21057008
02:55:05 12931 8192000000 10409310576 10837250048 1197374256 12.752 99 45 88 1 1516731472 307708176 11649040
02:56:22 1935 8192000000 10470076992 10907828224 1209403056 12.864 100 77 152 0 1575875728 347149008 19323664
02:57:26 1003 8192000000 10528159488 10951073792 1213787520 12.904 100 88 176 0 1633010704 397167088 22056096
02:58:31 1995 8192000000 10533543120 10948419584 1193400416 12.715 99 75 149 2 1634931872 423129984 18401472
02:59:48 3635 8192000000 10544160384 10968948736 1201639248 12.792 100 70 137 1 1646490768 428526064 16325456
03:00:56 1629 8192000000 10609225696 11027320832 1192093968 12.703 100 73 141 2 1715276192 505579600 17602624
03:02:08 2706 8192000000 10606042976 11090345984 1188170848 12.666 100 63 124 0 1720720464 515495728 17053888
03:03:14 814 8192000000 10579649680 11006877696 1168891328 12.486 99 85 161 2 1678585840 489450048 20244464
03:04:17 1407 8192000000 10507700288 10991017984 1150425536 12.313 100 68 130 2 1618785440 452011104 16348800
03:05:30 9614 8192000000 10445554064 10947829760 1122803648 12.053 98 33 66 0 1555930928 423786640 9340640
03:06:44 31223 8192000000 10272213904 10781474816 1129729968 12.119 98 29 58 0 1405872352 268731984 7410400
03:08:16 21604 8192000000 10318251872 10749943808 1155035024 12.357 100 48 95 1 1412179952 246539664 10605264
03:10:32 71830 8192000000 10064258912 10506846208 1088725248 11.731 96 10 20 0 1139776640 49399504 1651888
03:12:44 11410 8192000000 10086151568 10511302656 1136640448 12.184 100 61 113 2 1177868576 29802608 11425520
03:14:03 37645 8192000000 10132974048 10567868416 1123971344 12.064 99 43 78 1 1229145056 96315696 8858016
03:15:44 26953 8192000000 10140959712 10571067392 1124777536 12.072 99 38 66 1 1223377072 91108032 7491504
03:17:11 39923 8192000000 10071421184 10530156544 1132622320 12.146 100 22 38 1 1168795632 32562800 3610512
03:19:05 36082 8192000000 10065834368 10487947264 1119058432 12.018 99 56 98 2 1151048000 22119712 9869856
03:20:49 93805 8192000000 10104730288 10551914496 1111176368 11.944 98 29 59 0 1153655584 36100272 6378944
03:23:23 52042 8192000000 10108451872 10588758016 1138947776 12.206 100 30 60 0 1215658016 70860224 5850016
03:25:18 3087 8192000000 10099807696 10522775552 1134311712 12.162 100 61 119 0 1192410144 45621440 12476992
03:26:23 20013 8192000000 10099190096 10547015680 1143659088 12.250 100 35 65 1 1191612048 41593920 6359040
03:27:47 5694 8192000000 10159227136 10585673728 1156255856 12.368 100 64 123 0 1247076272 78074768 12745648
03:28:54 39774 8192000000 10148638608 10613567488 1148882960 12.299 99 30 56 1 1241161840 85915936 6362944
03:30:34 35185 8192000000 10177629536 10629234688 1121805056 12.044 97 22 44 0 1241457696 114489280 5163360
03:32:12 35854 8192000000 10216548448 10656747520 1113625952 11.967 97 31 63 0 1283735616 162374352 7735312
03:33:49 93958 8192000000 10163862800 10641489920 1116970320 11.998 98 13 26 1 1241998560 121672464 3355776
03:36:31 44734 8192000000 10089118032 10542465024 1137906880 12.196 100 17 30 2 1186023728 44681648 3435200
03:38:22 24489 8192000000 10120470544 10554429440 1147927760 12.290 100 37 70 0 1202256192 46988368 7340064
03:39:49 21014 8192000000 10105703424 10569744384 1122772288 12.053 98 34 65 1 1177803792 48613120 6418384
03:41:15 24124 8192000000 10122839056 10564153344 1112748144 11.958 97 30 59 0 1206254816 87559872 5946800
03:42:41 35682 8192000000 10092916560 10535317504 1112575600 11.957 98 31 62 1 1171502224 52573408 6353216
03:44:18 27676 8192000000 10104735696 10535505920 1119064960 12.018 99 49 92 2 1181121472 52198384 9858128
03:45:46 47811 8192000000 10118345664 10592600064 1113944384 11.970 99 25 50 0 1203494528 84420272 5129872
03:47:50 43419 8192000000 10091090672 10564947968 1094327280 11.784 97 39 78 0 1194338896 92212992 7798624
03:49:34 104831 8192000000 10075060032 10516127744 1099978912 11.837 98 24 48 0 1139668160 34592976 5096272
03:52:24 85916 8192000000 10060070672 10521804800 1106521280 11.899 98 20 41 2 1148988832 38328320 4139232
03:55:08 34488 8192000000 10085181632 10527387648 1109204592 11.925 98 40 80 0 1179846720 63261536 7380592
03:56:50 55814 8192000000 10061744816 10499350528 1097274800 11.812 98 17 34 0 1134333888 33432688 3626400
03:58:47 34571 8192000000 10036398688 10495860736 1093807104 11.779 98 6 12 0 1135564464 40385120 1372240
04:00:22 60202 8192000000 10029600752 10495782912 1113796448 11.968 100 14 28 0 1136539344 20295744 2447152
04:02:23 54142 8192000000 10036526320 10494902272 1093512512 11.776 98 10 20 0 1127727504 32320336 1894656
04:04:24 15091 8192000000 10067312816 10500943872 1109959408 11.932 99 33 64 1 1157802848 41646848 6196592
04:05:42 26815 8192000000 10125807216 10568724480 1123269648 12.058 100 41 81 0 1207652176 76036864 8345664
04:07:18 59749 8192000000 10134987312 10574102528 1115770144 11.987 98 21 42 0 1187353872 67216320 4367408
04:09:21 50228 8192000000 10073944976 10526474240 1116290080 11.992 98 17 34 0 1196135376 76162128 3683168
04:11:11 26690 8192000000 10133327408 10585960448 1131112496 12.132 99 44 88 0 1192175936 52306224 8757216
04:12:40 27367 8192000000 10202563200 10667012096 1159610736 12.400 100 52 101 0 1294467488 124546928 10309824
04:14:09 83429 8192000000 10114674928 10560991232 1133605344 12.155 98 26 52 2 1193584880 54960096 5019440
04:17:28 109418 8192000000 10104219904 10575638528 1141721808 12.232 99 22 44 0 1230640512 84115248 4803456
04:20:23 54715 8192000000 10078394768 10534375424 1114838096 11.978 98 12 24 0 1155005680 37677376 2490208
04:22:28 57208 8192000000 10075307968 10521190400 1116131904 11.990 98 15 30 0 1155356224 34938384 4285936
04:24:31 54779 8192000000 10104812416 10572283904 1131469728 12.135 99 13 26 0 1189466464 55196176 2800560
04:26:27 30429 8192000000 10111753280 10557575168 1111480896 11.946 97 27 52 0 1184409760 67334416 5594448
04:28:01 14235 8192000000 10154325600 10593034240 1132747296 12.147 99 40 80 1 1237351904 95908224 8696384
04:29:17 18538 8192000000 10183905184 10628952064 1143059712 12.244 100 40 80 0 1280929808 128958160 8911936
04:30:36 30912 8192000000 10217408432 10662912000 1145370384 12.266 99 34 67 0 1312233824 159399552 7463888
04:32:13 21424 8192000000 10216845184 10646564864 1150116336 12.311 99 43 86 0 1316557600 156874368 9566896
04:33:38 37935 8192000000 10242199040 10723291136 1131775680 12.138 98 43 84 1 1351668544 210591952 9300912
04:35:32 31714 8192000000 10107892128 10721583104 1112107488 11.952 99 8 16 0 1273641440 159702608 1831344
04:37:04 38810 8192000000 9286246016 9590644736 422758304 4.907 38 8 14 0 441619520 17778848 1082368

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:17, from 02-01-2023 04:39:24 to 02-01-2023 04:39:41.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 104 v_add_invoice_to_stock 335544517
except 4 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 02-01-2023 04:39:42 to 02-01-2023 04:39:44.

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          229714
MON$OLDEST_ACTIVE               229715
MON$OLDEST_SNAPSHOT             229715
MON$NEXT_TRANSACTION            229715
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             792
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'

02.01.23 04:39:45. 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
2023-01-02 04:39:47 No severe PSQL-related problems occured
02.01.23 04:39:49. End of report.