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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 16480464 kB
MemAvailable 31629412 kB
Buffers 0 kB
Cached 15186920 kB
SwapCached 2544 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-21 22:38:17
DTS_END                         2022-03-21 22:38:17.7070
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/33412
TRN_ID                          240737
ATT_ID                          712
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: 9659.23 24457 1159107
customer order: creation 168.14 357 20177
customer order: refuse 14.43 302 1732
order to supplier: creation 45.18 1333 5421
order to supplier: removal 3.67 107886 440
invoice (draft): creation 46.73 3660 5608
invoice (draft): removal 57.54 779 6905
invoice accept: apply 41.48 17270 4978
invoice accept: cancel 52.54 809 6305
customer reserve: creation 3847.06 169 461647
customer reserve: removal 5077.98 61 609357
realization accept: apply 83.13 183 9975
realization accept: cancel 92.73 101 11128
payment from customer: creation 58.16 109 6979
payment from customer: removal 5.73 78 687
payment to supplier: creation 48.52 132 5822
payment to supplier: removal 3.51 69 421
service: total inventory turnovers 5.03 1137 603
service: total monetary turnovers 6.93 33 831
service: aggregate perf. data 0.73 28895 87
service: refresh index statistics 0.03 325786 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 21-03-2022 22:39:27 to 21-03-2022 22:39:29.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4388
TEST_TIME 2 3931
TEST_TIME 3 4204
TEST_TIME 4 4353
TEST_TIME 5 4859
TEST_TIME 6 5063
TEST_TIME 7 5130
TEST_TIME 8 5239
TEST_TIME 9 5701
TEST_TIME 10 5792
TEST_TIME 11 6546
TEST_TIME 12 6477
TEST_TIME 13 6208
TEST_TIME 14 6251
TEST_TIME 15 6539
TEST_TIME 16 6598
TEST_TIME 17 6622
TEST_TIME 18 6796
TEST_TIME 19 6752
TEST_TIME 20 6826
TEST_TIME 21 7089
TEST_TIME 22 7433
TEST_TIME 23 7799
TEST_TIME 24 8157
TEST_TIME 25 8737
TEST_TIME 26 8696
TEST_TIME 27 8967
TEST_TIME 28 10249
TEST_TIME 29 10711
TEST_TIME 30 10938
TEST_TIME 31 10854
TEST_TIME 32 10935
TEST_TIME 33 10959
TEST_TIME 34 10871
TEST_TIME 35 10745
TEST_TIME 36 10787
TEST_TIME 37 10715
TEST_TIME 38 10553
TEST_TIME 39 10489
TEST_TIME 40 10520
TEST_TIME 41 10384
TEST_TIME 42 10585
TEST_TIME 43 10473
TEST_TIME 44 10316
TEST_TIME 45 10124
TEST_TIME 46 10222
TEST_TIME 47 10296
TEST_TIME 48 10153
TEST_TIME 49 10097
TEST_TIME 50 10053
TEST_TIME 51 10015
TEST_TIME 52 9964
TEST_TIME 53 10051
TEST_TIME 54 9983
TEST_TIME 55 9984
TEST_TIME 56 9969
TEST_TIME 57 9939
TEST_TIME 58 9913
TEST_TIME 59 9784
TEST_TIME 60 9771
TEST_TIME 61 9774
TEST_TIME 62 9780
TEST_TIME 63 9678
TEST_TIME 64 9654
TEST_TIME 65 9673
TEST_TIME 66 9686
TEST_TIME 67 9715
TEST_TIME 68 9713
TEST_TIME 69 9785
TEST_TIME 70 9889
TEST_TIME 71 9856
TEST_TIME 72 9856
TEST_TIME 73 9916
TEST_TIME 74 9942
TEST_TIME 75 9898
TEST_TIME 76 9969
TEST_TIME 77 10019
TEST_TIME 78 10035
TEST_TIME 79 9918
TEST_TIME 80 9902
TEST_TIME 81 9815
TEST_TIME 82 9766
TEST_TIME 83 9726
TEST_TIME 84 9680
TEST_TIME 85 9660
TEST_TIME 86 9619
TEST_TIME 87 9715
TEST_TIME 88 9780
TEST_TIME 89 9787
TEST_TIME 90 9760
TEST_TIME 91 9780
TEST_TIME 92 9773
TEST_TIME 93 9792
TEST_TIME 94 9833
TEST_TIME 95 9838
TEST_TIME 96 9802
TEST_TIME 97 9910
TEST_TIME 98 9902
TEST_TIME 99 9971
TEST_TIME 100 9958
TEST_TIME 101 9934
TEST_TIME 102 9856
TEST_TIME 103 9845
TEST_TIME 104 9797
TEST_TIME 105 9815
TEST_TIME 106 9807
TEST_TIME 107 9760
TEST_TIME 108 9742
TEST_TIME 109 9736
TEST_TIME 110 9705
TEST_TIME 111 9687
TEST_TIME 112 9619
TEST_TIME 113 9641
TEST_TIME 114 9640
TEST_TIME 115 9646
TEST_TIME 116 9705
TEST_TIME 117 9687
TEST_TIME 118 9697
TEST_TIME 119 9727
TEST_TIME 120 9661

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 21-03-2022 22:39:31 to 21-03-2022 22:39:34.

Performance in DETAILS

UNIT CNT_ALL CNT_OK CNT_ERR ERR_PRC OK_MIN_MS OK_MAX_MS OK_AVG_MS CNT_LK_CONFL CNT_USER_EXC
doc_list_aiud 1588196 1588196 0 0.00 0 12063 6 0 0
doc_list_biud 1588196 1588196 0 0.00 0 102763 29 0 0
sp_add_invoice_to_stock 5089 4978 111 2.18 21 153903 17271 0 111
sp_cancel_adding_invoice 6305 6305 0 0.00 4 76346 809 0 0
sp_cancel_client_order 1732 1732 0 0.00 3 6812 302 0 0
sp_cancel_customer_reserve 609357 609357 0 0.00 1 43054 61 0 0
sp_cancel_pay_from_customer 687 687 0 0.00 2 5458 78 0 0
sp_cancel_pay_to_supplier 421 421 0 0.00 3 2149 70 0 0
sp_cancel_supplier_invoice 6914 6905 9 0.13 2 102787 780 0 9
sp_cancel_supplier_order 440 440 0 0.00 4 1133572 107887 0 0
sp_cancel_write_off 11128 11128 0 0.00 1 9939 102 0 0
sp_client_order 20177 20177 0 0.00 3 26256 357 0 0
sp_customer_reserve 461647 461647 0 0.00 0 132709 169 0 0
sp_fill_shopping_cart 31201 31201 0 0.00 1 30425 40 0 0
sp_fill_shopping_cart_clo_res 461646 461646 0 0.00 0 13052 12 0 0
sp_get_clo_for_invoice 4971 4971 0 0.00 0 17331 282 0 0
sp_kill_cost_storno 18541 18541 0 0.00 0 11978 53 0 0
sp_kill_qstorno_ret_qs2qd 1237187 1237187 0 0.00 0 102757 33 0 0
sp_kill_qty_storno 650811 650811 0 0.00 0 102761 71 0 0
sp_lock_selected_doc 20801 20801 0 0.00 0 8898 6 0 0
sp_make_cost_storno 27745 27745 0 0.00 0 10784 53 0 0
sp_multiply_rows_for_pdistr 27745 27745 0 0.00 0 9577 29 0 0
sp_multiply_rows_for_qdistr 20177 20177 0 0.00 0 15450 153 0 0
sp_pay_from_customer 6979 6979 0 0.00 4 14562 109 0 0
sp_pay_to_supplier 5822 5822 0 0.00 4 14120 132 0 0
sp_payment_common 12801 12801 0 0.00 1 14559 27 0 0
sp_qd_handle_on_cancel_clo 1732 1732 0 0.00 0 6797 278 0 0
sp_qd_handle_on_invoice_upd_sts 11274 11274 0 0.00 0 32546 354 0 0
sp_qd_handle_on_reserve_upd_sts 9975 9975 0 0.00 0 26192 67 0 0
sp_reserve_write_off 9975 9975 0 0.00 6 26249 183 0 0
sp_supplier_invoice 5608 5608 0 0.00 7 128944 3660 0 0
sp_supplier_order 5421 5421 0 0.00 5 36045 1333 0 0
srv_aggregate_perf_data 88 87 1 1.13 2525 567486 28895 0 1
srv_fill_mon_cache_memory 63 63 0 0.00 1533 144043 48430 0 0
srv_find_qd_qs_mism 1112551 1112551 0 0.00 0 9156 5 0 0
srv_make_invnt_saldo 603 603 0 0.00 23 60565 1138 0 0
srv_make_money_saldo 831 831 0 0.00 1 9362 34 0 0
srv_recalc_idx_stat 4 4 0 0.00 245219 478305 325786 0 0
t$perf-abend:sp_add_invoice_to_stock 111 111 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 9 9 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 4978 4978 0 0.00 0 11831 166 0 0
t$perf-norm:sp_cancel_adding_invoice 440 440 0 0.00 0 8851 93 0 0
t$perf-norm:sp_cancel_client_order 1732 1732 0 0.00 0 1193 10 0 0
t$perf-norm:sp_cancel_customer_reserve 711 711 0 0.00 0 2250 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 687 687 0 0.00 0 6183 11 0 0
t$perf-norm:sp_cancel_pay_to_supplier 421 421 0 0.00 0 2444 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 390 390 0 0.00 0 2156 25 0 0
t$perf-norm:sp_cancel_supplier_order 440 440 0 0.00 0 28794 1600 0 0
t$perf-norm:sp_cancel_write_off 1036 1036 0 0.00 0 2773 6 0 0
t$perf-norm:sp_client_order 20177 20177 0 0.00 0 8455 18 0 0
t$perf-norm:sp_customer_reserve 918 918 0 0.00 0 7644 14 0 0
t$perf-norm:sp_pay_from_customer 6979 6979 0 0.00 0 16764 12 0 0
t$perf-norm:sp_pay_to_supplier 5822 5822 0 0.00 0 13239 12 0 0
t$perf-norm:sp_reserve_write_off 9975 9975 0 0.00 0 19889 12 0 0
t$perf-norm:sp_supplier_invoice 5608 5608 0 0.00 0 4098 18 0 0
t$perf-norm:sp_supplier_order 5421 5421 0 0.00 0 8337 17 0 0
t$perf-norm:srv_aggregate_perf_data 87 87 0 0.00 0 589 8 0 0
t$perf-norm:srv_fill_mon_cache_memory 63 63 0 0.00 0 7456 121 0 0
t$perf-norm:srv_make_invnt_saldo 603 603 0 0.00 0 2246 24 0 0
t$perf-norm:srv_make_money_saldo 831 831 0 0.00 0 1557 19 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 14 6 0 0
v_add_invoice_to_stock 10160 9938 222 2.18 0 6467 19 0 222
v_all_customers 37110 37110 0 0.00 0 48 1 0 0
v_all_suppliers 30766 30766 0 0.00 0 67 1 0 0
v_all_wares 40354 40354 0 0.00 0 122 1 0 0
v_cancel_adding_invoice 880 880 0 0.00 0 3949 9 0 0
v_cancel_client_order 3464 3464 0 0.00 0 3621 7 0 0
v_cancel_customer_prepayment 1374 1374 0 0.00 0 2954 6 0 0
v_cancel_customer_reserve 1422 1422 0 0.00 0 2526 6 0 0
v_cancel_payment_to_supplier 842 842 0 0.00 0 2116 10 0 0
v_cancel_supplier_invoice 798 780 18 2.25 0 642 13 0 18
v_cancel_supplier_order 880 880 0 0.00 0 1258 7 0 0
v_cancel_write_off 2072 2072 0 0.00 0 5054 17 0 0
v_max_id_clo_ord 5418 5418 0 0.00 0 1608 2 0 0
v_max_id_clo_res 918 918 0 0.00 0 5085 28 0 0
v_max_id_ord_sup 5603 5603 0 0.00 0 4390 6 0 0
v_max_non_paid_invoice 1459 1459 0 0.00 0 228 2 0 0
v_max_non_paid_realizn 3529 3529 0 0.00 0 2554 4 0 0
v_min_id_clo_ord 5418 5418 0 0.00 0 4175 9 0 0
v_min_id_clo_res 918 918 0 0.00 0 10691 24 0 0
v_min_id_ord_sup 5603 5603 0 0.00 0 8240 13 0 0
v_min_non_paid_invoice 5822 5822 0 0.00 0 14110 21 0 0
v_min_non_paid_realizn 6979 6979 0 0.00 0 14555 19 0 0
v_our_firm 10144 10144 0 0.00 0 22 1 0 0
v_reserve_write_off 19950 19950 0 0.00 0 3628 5 0 0
x_lock_depdocs_on_canc_invoice 12820 12820 0 0.00 0 23658 120 0 0
x_lock_depdocs_on_canc_sup_ord 440 440 0 0.00 0 31001 480 0 0
x_make_qstorno_1000_1200 5421 5421 0 0.00 1 35998 1254 0 0
x_make_qstorno_1200_2000 5608 5608 0 0.00 3 128936 3516 0 0
x_make_qstorno_2100_3300 461647 461647 0 0.00 0 132708 155 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 21-03-2022 22:39:35 to 21-03-2022 22:39:39.

Memory consumption, metadata cache, attachments activity

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


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

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
20:08:19 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:20 36902 8192000000 9927418640 10239889408 1006176080 10.938 100 91 182 0 1036208272 6607568 23424624
20:11:07 14558 8192000000 9965244256 10291470336 1049351728 11.354 100 89 178 0 1081105120 9458560 22294832
20:12:27 19551 8192000000 10010281440 10348331008 1089312528 11.736 100 85 170 0 1121216976 11320256 20584192
20:13:53 14856 8192000000 10038309440 10386862080 1126750688 12.091 100 83 164 1 1158497152 12640912 19105552
20:15:13 8323 8192000000 10081812400 10442387456 1168560528 12.483 100 78 153 1 1198825232 12918192 17346512
20:16:24 5286 8192000000 10123510240 10498805760 1217395248 12.938 100 68 134 4 1243027088 11080736 14551104
20:17:31 2232 8192000000 10163991616 10541367296 1251212608 13.249 100 77 155 0 1281846464 13436688 17197168
20:18:36 1475 8192000000 10196971728 10580246528 1289049232 13.596 100 93 186 0 1325382976 14880800 21452944
20:19:38 6098 8192000000 10209707824 10601705472 1298220800 13.679 100 67 133 1 1323419664 10542192 14656672
20:20:45 5389 8192000000 10199959232 10603536384 1302380624 13.717 100 33 66 1 1317730784 7007808 8342352
20:21:55 14606 8192000000 10198991120 10616291328 1312593888 13.810 100 11 22 0 1320266080 5314960 2357232
20:23:10 74685 8192000000 10213237632 10638942208 1326584208 13.936 100 33 65 3 1339952064 5368688 7999168
20:25:25 6124 8192000000 10223387312 10646814720 1333939856 14.003 100 20 40 1 1343417232 5274096 4203280
20:26:34 6847 8192000000 10232020496 10654060544 1336865856 14.029 100 21 42 1 1347429792 5823712 4740224
20:27:41 12971 8192000000 10215804320 10639773696 1310198592 13.788 98 20 40 1 1321454016 6248656 5006768
20:28:54 42202 8192000000 10161262416 10576900096 1211564032 12.884 92 23 46 1 1222270048 5305344 5400672
20:30:38 4602 8192000000 10163434704 10564673536 1268022128 13.404 100 34 68 0 1282088304 6682464 7383712
20:31:43 7762 8192000000 10125553232 10522165248 1203145632 12.806 97 20 40 0 1213257456 5456464 4655360
20:32:51 5730 8192000000 10136858656 10536361984 1247014528 13.211 99 27 53 1 1258769408 5163504 6591376
20:33:59 23505 8192000000 10156221840 10563362816 1255365568 13.287 99 15 29 1 1264280000 5493264 3421168
20:35:23 6301 8192000000 10173384944 10586710016 1282695616 13.538 100 19 39 1 1293920768 6822608 4402544
20:36:29 7559 8192000000 10198698048 10605453312 1301391680 13.708 100 31 63 1 1313405040 5350352 6663008
20:37:38 13953 8192000000 10201613168 10613030912 1308801216 13.775 100 24 48 0 1320243952 6310368 5132368
20:38:56 41173 8192000000 10233363920 10649763840 1328435776 13.953 100 28 56 1 1340254320 4942464 6876080
20:40:44 3725 8192000000 10261188992 10670747648 1350433184 14.151 100 62 121 2 1373490368 9568528 13488656
20:41:54 31151 8192000000 10266600880 10692096000 1363873824 14.272 100 40 80 0 1382730480 9494624 9362032
20:43:30 3210 8192000000 10295027008 10710921216 1377122272 14.391 100 67 135 2 1405223664 11794896 16306496
20:44:40 31676 8192000000 10305780976 10719916032 1387579872 14.484 100 59 118 1 1416362160 15468384 13313904
20:46:16 6736 8192000000 10317266160 10730463232 1375272624 14.374 99 68 133 2 1416101632 25797888 15031120
20:47:27 4886 8192000000 10326244624 10748395520 1386750736 14.477 99 60 120 1 1427344992 26384480 14209776
20:48:38 6432 8192000000 10339628240 10753732608 1397273024 14.571 100 70 139 1 1445484192 31565376 16645792
20:49:47 3183 8192000000 10333939776 10750156800 1389376432 14.500 99 70 138 0 1441365888 35324336 16665120
20:50:53 12688 8192000000 10324165312 10746363904 1363398992 14.268 98 41 81 1 1406767456 33326912 10041552
20:52:30 2904 8192000000 10342357520 10753306624 1386307760 14.473 100 71 143 0 1447033968 42819184 17907024
20:53:37 6088 8192000000 10328233568 10742272000 1379480656 14.412 100 66 134 0 1437922448 41049936 17391856
20:54:51 11431 8192000000 10334195104 10743394304 1366973120 14.300 99 65 130 3 1430545088 46262912 17309056
20:56:08 4354 8192000000 10346602352 10751623168 1379340640 14.411 100 73 146 2 1449266288 51613376 18312272
20:57:16 3776 8192000000 10352323664 10757357568 1374668400 14.369 99 75 148 0 1445174768 51435504 19070864
20:58:26 1532 8192000000 10363079856 10763284480 1380998304 14.425 100 87 174 1 1461615056 58383696 22233056
20:59:35 2648 8192000000 10371832432 10780393472 1396046000 14.560 100 81 162 2 1477951280 61200128 20705152
21:00:43 9190 8192000000 10387025280 10811211776 1412848016 14.709 100 50 100 1 1493156224 66002256 14305952
21:01:59 16110 8192000000 10379663504 10810654720 1414244272 14.722 100 46 92 2 1487345296 60130224 12970800
21:03:19 15217 8192000000 10369140752 10808434688 1407193776 14.659 100 36 72 2 1482149824 64597088 10358960
21:05:12 28423 8192000000 10341937216 10777538560 1355791712 14.200 99 28 56 0 1436286576 71315648 9179216
21:06:43 34930 8192000000 10300577584 10755592192 1356592608 14.207 99 19 38 0 1427341808 65052992 5696208
21:08:22 51414 8192000000 10293690656 10747793408 1363745328 14.271 99 8 16 2 1389182528 23658608 1778592
21:10:45 118911 8192000000 10292058032 10749878272 1340091664 14.058 97 5 10 2 1358664992 17706352 866976
21:13:44 102113 8192000000 10302444192 10757488640 1362197904 14.257 98 14 27 2 1383503520 17789136 3516480
21:16:33 45240 8192000000 10308190064 10754400256 1377710768 14.396 99 22 44 0 1391325680 8826512 4788400
21:18:34 89436 8192000000 10322867344 10771369984 1390947328 14.514 99 10 20 1 1411665488 18324272 2393888
21:21:13 21660 8192000000 10320187008 10760126464 1390440256 14.510 99 36 72 0 1408400608 9760928 8199424
21:22:50 129240 8192000000 10316820912 10767880192 1385778912 14.468 99 32 64 0 1409046144 15394400 7872832
21:26:02 142966 8192000000 10296608544 10752679936 1363494640 14.269 97 28 56 3 1382284768 12721808 6068320
21:29:26 18731 8192000000 10325727168 10766045184 1398990400 14.586 100 38 73 0 1419297792 11720096 8587296
21:30:45 26598 8192000000 10307997424 10763997184 1387591216 14.484 99 19 38 0 1409054400 16719136 4744048
21:32:19 48006 8192000000 10304856640 10772865024 1403531616 14.626 100 7 14 1 1416332576 10901632 1899328
21:34:08 27401 8192000000 10311594096 10775838720 1409069120 14.676 100 10 20 0 1424469184 13046480 2353584
21:35:39 67988 8192000000 10289346672 10766970880 1384472032 14.457 99 10 20 0 1397436112 10580784 2383296
21:37:47 76236 8192000000 10286129392 10758705152 1371271728 14.338 98 24 48 1 1384386336 8159328 4955280
21:40:05 60040 8192000000 10260682512 10728443904 1338691392 14.046 97 22 44 2 1351766864 8213184 4862288
21:42:05 63607 8192000000 10263592864 10724917248 1335289472 14.015 97 7 14 1 1342891456 5833616 1768368
21:44:26 50049 8192000000 10253683520 10708480000 1285050272 13.559 94 16 32 0 1297895232 9243360 3601600
21:46:19 30509 8192000000 10279624816 10730139648 1345898224 14.111 98 19 38 0 1365375360 14848640 4628496
21:47:58 54179 8192000000 10283312304 10746040320 1339826928 14.056 97 9 18 0 1357338560 15506976 2004656
21:49:53 26917 8192000000 10274253200 10712612864 1333939840 14.003 97 46 92 0 1354623200 9692272 10991088
21:51:47 66472 8192000000 10245657376 10697543680 1298499968 13.682 96 15 29 2 1313485024 11594080 3390976
21:53:55 42220 8192000000 10270344464 10717220864 1317340416 13.853 97 29 54 3 1335606016 11930240 6335360
21:55:41 132894 8192000000 10262383760 10711519232 1333129504 13.995 98 13 26 0 1351242064 15008560 3104000
21:59:09 62120 8192000000 10277890832 10726354944 1343927072 14.093 98 26 52 1 1367348288 17479872 5941344
22:01:11 84343 8192000000 10275489632 10735542272 1358227440 14.221 99 12 24 1 1379232592 17976032 3029120
22:03:36 74278 8192000000 10292382528 10753175552 1357139616 14.212 99 12 24 0 1383907472 23727184 3040672
22:06:12 42787 8192000000 10271207488 10732965888 1342880336 14.083 98 15 29 3 1359391312 12886256 3624720
22:07:58 86026 8192000000 10272185440 10729267200 1336168016 14.023 97 27 56 2 1351620784 8726352 6726416
22:10:28 57809 8192000000 10286019088 10741280768 1347328656 14.123 97 17 34 1 1362686000 11603888 3753456
22:12:46 67942 8192000000 10270643456 10720776192 1331257888 13.979 97 19 38 0 1344323632 9149168 3916576
22:14:55 79577 8192000000 10278632224 10742284288 1350716592 14.154 98 15 30 1 1366884656 12629568 3538496
22:17:15 144042 8192000000 10287191856 10740326400 1318775296 13.866 95 12 24 1 1334654784 13225232 2654256
22:20:40 84002 8192000000 10292125648 10753171456 1361333552 14.249 98 18 36 0 1372302128 6935008 4033568
22:23:04 54629 8192000000 10288399584 10753777664 1374803120 14.370 99 17 34 0 1389169520 10011632 4354768
22:24:59 44828 8192000000 10262456848 10723282944 1341536944 14.071 97 9 18 0 1350635184 7187520 1910720
22:26:45 50057 8192000000 10286222368 10749980672 1359803584 14.236 98 24 48 2 1373384816 8034528 5546704
22:28:35 76065 8192000000 10287359744 10752282624 1379723216 14.414 100 12 24 0 1392235216 9807184 2704816
22:30:52 68619 8192000000 10269555712 10735972352 1351841344 14.164 98 25 50 1 1376125472 18176000 6108128
22:33:06 67755 8192000000 10261861824 10728501248 1323765936 13.911 97 13 26 0 1345821392 18953904 3101552
22:35:14 95454 8192000000 10257472448 10710945792 1261477744 13.344 92 9 18 0 1280159392 16595408 2086240
22:37:50 36393 8192000000 9095228272 9326198784 256689104 3.038 19 5 10 0 262507664 4953104 865456

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 21-03-2022 22:39:41 to 21-03-2022 22:39:56.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 111 v_add_invoice_to_stock 335544517
except 9 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 21-03-2022 22:39:57 to 21-03-2022 22:39:59.

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          240536
MON$OLDEST_ACTIVE               241166
MON$OLDEST_SNAPSHOT             241166
MON$NEXT_TRANSACTION            241166
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                       2059168
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'

21.03.22 22:40:00. 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-21 22:40:02 No severe PSQL-related problems occured
21.03.22 22:40:03. End of report.