Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 23.03.2022 01:39
Common Performance Final Results
  1. Hardware and OS info
  2. Test configuration
  3. Test Finish details
  4. Test workload details
  5. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score:    as table     as chart
  2. Performance per MINUTE, during test_time phase:    as table     as chart
  3. Performance, DETAILS per units
  4. Memory consumption, metadata cache, attachments activity    as table    as chart
  5. Monitoring data: STATEMENTS activity, as chart
  6. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database statistics was not gathered. Change config parameter 'run_db_statistics' to 1.
  3. Database validation was not performed. Change config parameter 'run_db_validation' to 1.
  4. New in firebird.log while test was run
  5. Final processing of ISQL logs

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 17012168 kB
MemAvailable 31695000 kB
Buffers 0 kB
Cached 14742892 kB
SwapCached 2992 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-03-23 01:38:11
DTS_END                         2022-03-23 01:38:11.5410
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/47428
TRN_ID                          238552
ATT_ID                          651
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: 8897.58 23145 1067710
customer order: creation 170.35 319 20442
customer order: refuse 14.66 341 1759
order to supplier: creation 45.08 1222 5410
order to supplier: removal 3.21 93925 385
invoice (draft): creation 44.89 3316 5387
invoice (draft): removal 49.28 710 5914
invoice accept: apply 41.38 16856 4966
invoice accept: cancel 44.54 786 5345
customer reserve: creation 3814.57 166 457748
customer reserve: removal 4380.69 54 525683
realization accept: apply 81.70 174 9804
realization accept: cancel 79.92 102 9590
payment from customer: creation 58.91 113 7069
payment from customer: removal 5.48 68 658
payment to supplier: creation 47.39 137 5687
payment to supplier: removal 3.76 67 451
service: total inventory turnovers 4.75 1102 570
service: total monetary turnovers 6.07 25 728
service: aggregate perf. data 0.92 17778 110
service: refresh index statistics 0.03 325642 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 23-03-2022 01:39:49 to 23-03-2022 01:39:52.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6139
TEST_TIME 2 4376
TEST_TIME 3 5328
TEST_TIME 4 4727
TEST_TIME 5 4538
TEST_TIME 6 4658
TEST_TIME 7 5021
TEST_TIME 8 5488
TEST_TIME 9 5324
TEST_TIME 10 5786
TEST_TIME 11 6360
TEST_TIME 12 6401
TEST_TIME 13 6439
TEST_TIME 14 6736
TEST_TIME 15 6859
TEST_TIME 16 7272
TEST_TIME 17 7379
TEST_TIME 18 7832
TEST_TIME 19 8243
TEST_TIME 20 8335
TEST_TIME 21 8471
TEST_TIME 22 8604
TEST_TIME 23 9312
TEST_TIME 24 9298
TEST_TIME 25 9874
TEST_TIME 26 10167
TEST_TIME 27 10949
TEST_TIME 28 10899
TEST_TIME 29 10629
TEST_TIME 30 10405
TEST_TIME 31 10370
TEST_TIME 32 10271
TEST_TIME 33 10073
TEST_TIME 34 9874
TEST_TIME 35 9867
TEST_TIME 36 9678
TEST_TIME 37 9629
TEST_TIME 38 9683
TEST_TIME 39 9624
TEST_TIME 40 9587
TEST_TIME 41 9532
TEST_TIME 42 9337
TEST_TIME 43 9319
TEST_TIME 44 9277
TEST_TIME 45 9144
TEST_TIME 46 9079
TEST_TIME 47 9095
TEST_TIME 48 9111
TEST_TIME 49 9013
TEST_TIME 50 8939
TEST_TIME 51 8877
TEST_TIME 52 8857
TEST_TIME 53 8941
TEST_TIME 54 8884
TEST_TIME 55 9026
TEST_TIME 56 8960
TEST_TIME 57 9020
TEST_TIME 58 8981
TEST_TIME 59 8982
TEST_TIME 60 9067
TEST_TIME 61 9092
TEST_TIME 62 9087
TEST_TIME 63 9181
TEST_TIME 64 9119
TEST_TIME 65 9220
TEST_TIME 66 9340
TEST_TIME 67 9274
TEST_TIME 68 9180
TEST_TIME 69 9181
TEST_TIME 70 9105
TEST_TIME 71 9115
TEST_TIME 72 9146
TEST_TIME 73 9086
TEST_TIME 74 9055
TEST_TIME 75 9023
TEST_TIME 76 8964
TEST_TIME 77 8999
TEST_TIME 78 8980
TEST_TIME 79 9050
TEST_TIME 80 9082
TEST_TIME 81 9088
TEST_TIME 82 9112
TEST_TIME 83 9252
TEST_TIME 84 9204
TEST_TIME 85 9233
TEST_TIME 86 9221
TEST_TIME 87 9220
TEST_TIME 88 9253
TEST_TIME 89 9232
TEST_TIME 90 9232
TEST_TIME 91 9202
TEST_TIME 92 9175
TEST_TIME 93 9132
TEST_TIME 94 9087
TEST_TIME 95 9052
TEST_TIME 96 9015
TEST_TIME 97 9044
TEST_TIME 98 9074
TEST_TIME 99 9068
TEST_TIME 100 9056
TEST_TIME 101 9069
TEST_TIME 102 9047
TEST_TIME 103 9062
TEST_TIME 104 9085
TEST_TIME 105 9069
TEST_TIME 106 9063
TEST_TIME 107 9118
TEST_TIME 108 9092
TEST_TIME 109 9122
TEST_TIME 110 9140
TEST_TIME 111 9132
TEST_TIME 112 9082
TEST_TIME 113 9074
TEST_TIME 114 9032
TEST_TIME 115 9061
TEST_TIME 116 9036
TEST_TIME 117 9004
TEST_TIME 118 8972
TEST_TIME 119 8967
TEST_TIME 120 8903

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 23-03-2022 01:39:53 to 23-03-2022 01:39:56.

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 1491052 1491052 0 0.00 0 19716 6 0 0
doc_list_biud 1491052 1491052 0 0.00 0 26187 24 0 0
sp_add_invoice_to_stock 5140 4966 174 3.38 41 195889 16856 0 174
sp_cancel_adding_invoice 5345 5345 0 0.00 4 87890 787 0 0
sp_cancel_client_order 1759 1759 0 0.00 4 18558 341 0 0
sp_cancel_customer_reserve 525683 525683 0 0.00 1 22172 54 0 0
sp_cancel_pay_from_customer 658 658 0 0.00 3 6595 68 0 0
sp_cancel_pay_to_supplier 451 451 0 0.00 2 3886 67 0 0
sp_cancel_supplier_invoice 5932 5914 18 0.30 2 14017 711 0 18
sp_cancel_supplier_order 385 385 0 0.00 18 919956 93926 0 0
sp_cancel_write_off 9590 9590 0 0.00 1 11709 102 0 0
sp_client_order 20442 20442 0 0.00 3 27669 319 0 0
sp_customer_reserve 457748 457748 0 0.00 0 42786 167 0 0
sp_fill_shopping_cart 31238 31238 0 0.00 1 17048 40 0 0
sp_fill_shopping_cart_clo_res 457744 457744 0 0.00 0 24359 14 0 0
sp_get_clo_for_invoice 4962 4962 0 0.00 0 43276 337 0 0
sp_kill_cost_storno 16044 16044 0 0.00 0 8296 51 0 0
sp_kill_qstorno_ret_qs2qd 1067255 1067255 0 0.00 0 22166 29 0 0
sp_kill_qty_storno 563442 563442 0 0.00 0 26181 64 0 0
sp_lock_selected_doc 20453 20453 0 0.00 0 6917 6 0 0
sp_make_cost_storno 27522 27522 0 0.00 0 19702 53 0 0
sp_multiply_rows_for_pdistr 27522 27522 0 0.00 0 7785 30 0 0
sp_multiply_rows_for_qdistr 20442 20442 0 0.00 0 24637 131 0 0
sp_pay_from_customer 7069 7069 0 0.00 4 9792 113 0 0
sp_pay_to_supplier 5687 5687 0 0.00 4 20262 138 0 0
sp_payment_common 12756 12756 0 0.00 2 20245 33 0 0
sp_qd_handle_on_cancel_clo 1759 1759 0 0.00 0 18551 310 0 0
sp_qd_handle_on_invoice_upd_sts 10307 10307 0 0.00 0 26177 305 0 0
sp_qd_handle_on_reserve_upd_sts 9804 9804 0 0.00 0 22767 60 0 0
sp_reserve_write_off 9804 9804 0 0.00 6 22787 174 0 0
sp_supplier_invoice 5387 5387 0 0.00 7 82853 3317 0 0
sp_supplier_order 5410 5410 0 0.00 5 39633 1223 0 0
srv_aggregate_perf_data 110 110 0 0.00 2827 237220 17778 0 0
srv_fill_mon_cache_memory 59 59 0 0.00 1162 149589 54026 0 0
srv_find_qd_qs_mism 1020315 1020315 0 0.00 0 18149 5 0 0
srv_make_invnt_saldo 570 570 0 0.00 32 101304 1103 0 0
srv_make_money_saldo 728 728 0 0.00 1 2597 25 0 0
srv_recalc_idx_stat 4 4 0 0.00 139703 504637 325642 0 0
t$perf-abend:sp_add_invoice_to_stock 174 174 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 18 18 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4968 4968 0 0.00 0 20373 144 0 0
t$perf-norm:sp_cancel_adding_invoice 391 391 0 0.00 0 20679 150 0 0
t$perf-norm:sp_cancel_client_order 1759 1759 0 0.00 0 3403 13 0 0
t$perf-norm:sp_cancel_customer_reserve 663 663 0 0.00 0 1453 14 0 0
t$perf-norm:sp_cancel_pay_from_customer 658 658 0 0.00 0 3067 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 451 451 0 0.00 0 744 5 0 0
t$perf-norm:sp_cancel_supplier_invoice 411 411 0 0.00 0 1102 11 0 0
t$perf-norm:sp_cancel_supplier_order 385 385 0 0.00 0 25259 1355 0 0
t$perf-norm:sp_cancel_write_off 969 969 0 0.00 0 1546 8 0 0
t$perf-norm:sp_client_order 20442 20442 0 0.00 0 8404 17 0 0
t$perf-norm:sp_customer_reserve 986 986 0 0.00 0 6030 9 0 0
t$perf-norm:sp_pay_from_customer 7069 7069 0 0.00 0 5106 8 0 0
t$perf-norm:sp_pay_to_supplier 5687 5687 0 0.00 0 5812 9 0 0
t$perf-norm:sp_reserve_write_off 9804 9804 0 0.00 0 4609 8 0 0
t$perf-norm:sp_supplier_invoice 5387 5387 0 0.00 0 7873 15 0 0
t$perf-norm:sp_supplier_order 5410 5410 0 0.00 0 3134 15 0 0
t$perf-norm:srv_aggregate_perf_data 110 110 0 0.00 0 285 9 0 0
t$perf-norm:srv_fill_mon_cache_memory 59 59 0 0.00 0 3 0 0 0
t$perf-norm:srv_make_invnt_saldo 570 570 0 0.00 0 3573 22 0 0
t$perf-norm:srv_make_money_saldo 728 728 0 0.00 0 5549 25 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 193 50 0 0
v_add_invoice_to_stock 10272 9924 348 3.38 0 11093 21 0 348
v_all_customers 37212 37212 0 0.00 0 14 0 0 0
v_all_suppliers 29764 29764 0 0.00 0 37 1 0 0
v_all_wares 40884 40884 0 0.00 0 16 1 0 0
v_cancel_adding_invoice 782 782 0 0.00 0 1426 7 0 0
v_cancel_client_order 3518 3518 0 0.00 0 7237 5 0 0
v_cancel_customer_prepayment 1316 1316 0 0.00 0 452 3 0 0
v_cancel_customer_reserve 1326 1326 0 0.00 0 10122 16 0 0
v_cancel_payment_to_supplier 902 902 0 0.00 0 818 6 0 0
v_cancel_supplier_invoice 858 822 36 4.19 0 476 14 0 36
v_cancel_supplier_order 770 770 0 0.00 0 1918 9 0 0
v_cancel_write_off 1938 1938 0 0.00 0 2945 15 0 0
v_max_id_clo_ord 5410 5410 0 0.00 0 2330 2 0 0
v_max_id_clo_res 986 986 0 0.00 0 1666 12 0 0
v_max_id_ord_sup 5386 5386 0 0.00 0 5543 5 0 0
v_max_non_paid_invoice 1601 1601 0 0.00 0 2784 4 0 0
v_max_non_paid_realizn 3713 3713 0 0.00 0 1242 4 0 0
v_min_id_clo_ord 5410 5410 0 0.00 0 5864 6 0 0
v_min_id_clo_res 986 986 0 0.00 0 6596 19 0 0
v_min_id_ord_sup 5386 5386 0 0.00 0 2957 5 0 0
v_min_non_paid_invoice 5687 5687 0 0.00 0 20239 30 0 0
v_min_non_paid_realizn 7069 7069 0 0.00 0 8617 24 0 0
v_our_firm 10384 10384 0 0.00 0 51 1 0 0
v_reserve_write_off 19608 19608 0 0.00 0 11175 6 0 0
x_lock_depdocs_on_canc_invoice 10848 10848 0 0.00 0 25610 123 0 0
x_lock_depdocs_on_canc_sup_ord 385 385 0 0.00 0 8182 354 0 0
x_make_qstorno_1000_1200 5410 5410 0 0.00 1 39617 1136 0 0
x_make_qstorno_1200_2000 5387 5387 0 0.00 3 82798 3176 0 0
x_make_qstorno_2100_3300 457748 457748 0 0.00 0 40998 150 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 23-03-2022 01:39:57 to 23-03-2022 01:40:01.

Memory consumption, metadata cache, attachments activity

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


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

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
23:08:15 19 8192000000 8802521456 8815153152 5305344 0.064 2 1 2 0 5404944 56816 42784
23:09:16 26990 8192000000 9884798960 10194841600 971951472 10.606 100 87 174 0 1002540544 6077248 24511824
23:10:45 27240 8192000000 9943367136 10264588288 1023627280 11.107 100 89 177 0 1055064192 7870320 23566592
23:12:15 17431 8192000000 9985246064 10317672448 1071373824 11.565 100 86 172 1 1102117728 9052992 21690912
23:13:43 15740 8192000000 10043291472 10390577152 1126199968 12.086 100 82 163 1 1156102496 10353328 19549200
23:15:07 13871 8192000000 10100144640 10458796032 1180695712 12.597 100 82 164 1 1212123776 12101200 19326864
23:16:23 5303 8192000000 10141941296 10511839232 1227815536 13.034 100 86 171 2 1261724336 14490416 19418384
23:17:30 4669 8192000000 10171032400 10548359168 1258652400 13.318 100 89 173 4 1290257696 13271056 18334240
23:18:38 2657 8192000000 10202402096 10583638016 1290602912 13.610 100 89 178 0 1323438784 13424464 19411408
23:19:43 1728 8192000000 10232485296 10617409536 1306124752 13.751 100 96 190 0 1342289648 14730720 21434176
23:20:46 31114 8192000000 10229925728 10628608000 1318309008 13.861 100 62 123 2 1340455520 6493280 15653232
23:22:18 9093 8192000000 10211222240 10632736768 1329872800 13.966 100 25 50 0 1341774640 6688576 5213264
23:23:30 14930 8192000000 10218648592 10641575936 1336244736 14.024 100 15 30 1 1345406448 5733680 3428032
23:24:49 53888 8192000000 10245334288 10664288256 1346208800 14.113 100 30 60 3 1358299392 4849936 7240656
23:26:43 4292 8192000000 10249659216 10672418816 1351903264 14.165 100 27 54 2 1364926064 6911328 6111472
23:27:49 7743 8192000000 10239004640 10659004416 1342978480 14.084 100 25 51 0 1355045216 5706016 6360720
23:28:58 7329 8192000000 10189976528 10602438656 1277684816 13.492 98 17 34 0 1287307744 6047888 3575040
23:30:07 36910 8192000000 10167435264 10584317952 1239848912 13.145 96 24 47 1 1250716224 5193936 5673376
23:31:44 9486 8192000000 10150259056 10551435264 1236932320 13.118 98 22 44 0 1247935392 5452144 5550928
23:32:57 8764 8192000000 10140641024 10545172480 1233248944 13.084 98 30 60 0 1245606736 5448480 6909312
23:34:07 8477 8192000000 10169335568 10574757888 1276312544 13.479 100 24 47 0 1287686704 5639520 5734640
23:35:16 31458 8192000000 10175026432 10589028352 1285277696 13.561 100 26 52 1 1304755392 13734000 5743696
23:36:48 6830 8192000000 10199254336 10610442240 1301867936 13.712 100 26 52 0 1312777712 4845552 6064224
23:37:57 9193 8192000000 10214219536 10628452352 1314599872 13.828 100 24 48 0 1326169616 5978208 5591536
23:39:15 39958 8192000000 10268507296 10676867072 1354774096 14.190 100 45 86 3 1375152960 10906336 9472528
23:40:55 38482 8192000000 10272774944 10701889536 1370914720 14.335 100 43 86 0 1392133840 11498816 9720304
23:42:42 35148 8192000000 10280094944 10706960384 1377304880 14.392 100 32 63 2 1397831488 13225584 7301024
23:44:20 11510 8192000000 10308292512 10726838272 1392098944 14.525 100 49 99 1 1420671312 16563648 12008720
23:45:37 12932 8192000000 10328051696 10750611456 1396139488 14.561 100 51 101 0 1427858720 18747728 12971504
23:46:56 5780 8192000000 10320312000 10740645888 1390829232 14.513 99 51 102 2 1425888848 21040672 14018944
23:48:07 8118 8192000000 10331853392 10756456448 1391442720 14.519 99 50 98 3 1429868752 25653728 12772304
23:49:21 2453 8192000000 10346761056 10764668928 1408882032 14.674 100 68 135 0 1449578720 25425296 15271392
23:50:27 4297 8192000000 10346888784 10760044544 1396165296 14.561 99 85 172 1 1442475776 26719600 19590880
23:51:36 1296 8192000000 10351053648 10759634944 1402848784 14.620 100 93 184 2 1458864384 32637760 23377840
23:52:43 4007 8192000000 10341457120 10763350016 1388158944 14.489 98 55 109 1 1435621360 33711712 13750704
23:53:49 6390 8192000000 10346897088 10766131200 1389537104 14.502 99 56 110 2 1444860224 41332864 13990256
23:55:12 10415 8192000000 10351350336 10771935232 1403453904 14.626 100 59 116 0 1463326512 44275840 15596768
23:56:26 1161 8192000000 10367777504 10784591872 1406355680 14.652 100 74 149 1 1472009040 47468160 18185200
23:57:34 24379 8192000000 10303332640 10726658048 1332111248 13.986 96 31 62 1 1385518192 44854032 8552912
23:59:00 23712 8192000000 10311785648 10735464448 1350387648 14.151 97 31 62 1 1400122640 41531120 8203872
00:00:32 5448 8192000000 10330237424 10749923328 1368856272 14.317 100 45 90 0 1432972672 52002736 12113664
00:01:55 20459 8192000000 10322397360 10755739648 1362823648 14.263 99 26 52 1 1419283712 49324816 7135248
00:03:21 38448 8192000000 10300092160 10738634752 1347417264 14.124 99 23 46 1 1398298208 44771744 6109200
00:05:04 68408 8192000000 10265546688 10722295808 1323883920 13.912 98 12 24 0 1357922368 30950928 3087520
00:07:13 40077 8192000000 10266370064 10699472896 1341427744 14.070 99 36 72 2 1363188080 13298544 8461792
00:08:59 58664 8192000000 10257210064 10702106624 1343942992 14.093 99 17 34 1 1361514608 13633120 3938496
00:11:16 75363 8192000000 10280217840 10714673152 1352984320 14.174 99 22 41 0 1363390384 6248016 4158048
00:13:47 132149 8192000000 10297348704 10751623168 1370383600 14.330 99 14 28 0 1388379632 14320496 3675536
00:17:56 55315 8192000000 10303817408 10745098240 1387042432 14.479 100 26 53 0 1405240224 11832208 6365584
00:19:55 149588 8192000000 10276757408 10738106368 1364227520 14.275 98 22 46 0 1381863136 12547216 5088400
00:23:28 17861 8192000000 10280607920 10739752960 1376577344 14.386 99 8 16 0 1387869840 9434832 1857664
00:24:48 77083 8192000000 10295411088 10759921664 1382169840 14.436 99 16 32 1 1399537408 13718304 3649264
00:27:10 29617 8192000000 10306631168 10757599232 1404325264 14.633 100 22 42 0 1417407424 8212096 4870064
00:28:41 96491 8192000000 10294597456 10765303808 1404007008 14.631 100 17 35 0 1415413184 7137424 4268752
00:31:28 74592 8192000000 10296507808 10751549440 1372498128 14.349 98 16 32 1 1391879088 15204784 4176176
00:33:44 41816 8192000000 10285092448 10741153792 1364595264 14.279 98 13 26 1 1383067568 15867248 2605056
00:35:32 57397 8192000000 10305326656 10758836224 1382328768 14.437 99 17 34 0 1398590000 12460144 3801088
00:37:29 70647 8192000000 10288869600 10747191296 1328578224 13.954 95 20 40 0 1348353088 15128928 4645936
00:39:41 63703 8192000000 10284472160 10734505984 1323810112 13.911 95 18 34 0 1335365808 7814304 3741392
00:41:49 146027 8192000000 10301389712 10756440064 1317176576 13.851 95 8 16 0 1337496432 18593760 1726096
00:45:19 129861 8192000000 10243736032 10688946176 1264015024 13.367 91 12 24 0 1277053472 10322432 2716016
00:49:23 84192 8192000000 10258802352 10734555136 1339626720 14.054 98 13 26 0 1362322704 19706192 2989792
00:51:48 67553 8192000000 10271237280 10728992768 1325230896 13.924 96 14 28 0 1343242944 15032512 2979536
00:53:56 74147 8192000000 10254784736 10710679552 1297874192 13.676 95 15 30 0 1318281680 16853792 3553696
00:56:11 66049 8192000000 10273216832 10732580864 1345706560 14.109 99 21 43 1 1363532608 13130768 4695280
00:58:17 54121 8192000000 10276971872 10731180032 1351598544 14.162 98 24 48 0 1369677488 12219776 5859168
01:00:12 75317 8192000000 10289726544 10767360000 1379911104 14.416 100 18 36 0 1401083904 17150592 4022208
01:02:27 106519 8192000000 10275878480 10711650304 1290230816 13.606 94 20 40 0 1307042816 12595616 4216384
01:05:15 19649 8192000000 10278859888 10713542656 1340560144 14.062 99 42 84 0 1364323104 14617840 9145120
01:06:45 25582 8192000000 10272273184 10708619264 1344060944 14.094 99 34 68 2 1364889376 13717952 7110480
01:08:17 107291 8192000000 10287612512 10732900352 1375534576 14.377 100 22 44 1 1395714400 15693312 4486512
01:11:05 34337 8192000000 10270543824 10729934848 1369266256 14.320 99 14 28 1 1380126224 7802384 3057584
01:12:42 60682 8192000000 10279749744 10741022720 1376598608 14.386 99 13 26 0 1385505952 6277568 2629776
01:15:27 70397 8192000000 10280039712 10747187200 1353035648 14.175 97 9 18 0 1365010528 10375072 1599808
01:17:37 29391 8192000000 10284026528 10744401920 1389622096 14.502 100 34 67 1 1404292544 7286592 7383856
01:19:19 100108 8192000000 10296645232 10751770624 1359753984 14.235 97 16 32 0 1372618768 9357584 3507200
01:21:59 88964 8192000000 10288452960 10755289088 1354454944 14.188 97 8 16 0 1367429472 11317312 1657216
01:24:38 117519 8192000000 10305672320 10756984832 1344212256 14.095 96 24 48 1 1361612384 12376432 5023696
01:27:36 82392 8192000000 10314511136 10767224832 1367085296 14.301 97 15 30 0 1382047872 11750368 3212208
01:30:00 74899 8192000000 10296123568 10750230528 1380814464 14.424 99 14 28 0 1392698768 8865392 3018912
01:32:16 43558 8192000000 10303972944 10759213056 1390248864 14.508 99 26 51 0 1408154528 12625152 5280512
01:34:00 43205 8192000000 10279957984 10749239296 1378993792 14.408 99 7 14 0 1390816608 10045472 1777344
01:35:43 82515 8192000000 10262441712 10719969280 1335307200 14.015 97 14 28 1 1347669392 8865328 3496864

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 23-03-2022 01:40:03 to 23-03-2022 01:40:18.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 174 v_add_invoice_to_stock 335544517
except 18 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 23-03-2022 01:40:18 to 23-03-2022 01:40:20.

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

23.03.22 01:40:21. 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-03-23 01:40:24 No severe PSQL-related problems occured
23.03.22 01:40:25. End of report.