Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 17.12.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 15140848 kB
MemAvailable 30039892 kB
Buffers 0 kB
Cached 16541444 kB
SwapCached 3588 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.11
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-12-17 22:38:45
DTS_END                         2022-12-17 22:38:34.1350
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_FILL_MON_CACHE_MEMORY(20:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/42154
TRN_ID                          245502
ATT_ID                          274
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: 9121.42 25718 1094570
customer order: creation 174.79 350 20975
customer order: refuse 15.72 301 1886
order to supplier: creation 47.28 1277 5673
order to supplier: removal 3.43 113005 412
invoice (draft): creation 48.26 3462 5791
invoice (draft): removal 52.74 972 6329
invoice accept: apply 42.23 17098 5067
invoice accept: cancel 47.12 856 5654
customer reserve: creation 3881.75 169 465810
customer reserve: removal 4503.73 66 540448
realization accept: apply 84.40 171 10128
realization accept: cancel 85.19 104 10223
payment from customer: creation 61.88 126 7425
payment from customer: removal 6.10 91 732
payment to supplier: creation 50.50 116 6060
payment to supplier: removal 3.74 77 449
service: total inventory turnovers 5.06 955 607
service: total monetary turnovers 6.69 25 803
service: aggregate perf. data 0.78 26164 94
service: refresh index statistics 0.03 348973 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 17-12-2022 22:39:28 to 17-12-2022 22:39:31.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 1468
TEST_TIME 2 3926
TEST_TIME 3 5215
TEST_TIME 4 4927
TEST_TIME 5 5012
TEST_TIME 6 5035
TEST_TIME 7 5003
TEST_TIME 8 5014
TEST_TIME 9 5109
TEST_TIME 10 5292
TEST_TIME 11 5238
TEST_TIME 12 5122
TEST_TIME 13 5722
TEST_TIME 14 5884
TEST_TIME 15 5847
TEST_TIME 16 5965
TEST_TIME 17 6048
TEST_TIME 18 6103
TEST_TIME 19 6328
TEST_TIME 20 6973
TEST_TIME 21 7244
TEST_TIME 22 7317
TEST_TIME 23 8283
TEST_TIME 24 8876
TEST_TIME 25 8965
TEST_TIME 26 9456
TEST_TIME 27 10876
TEST_TIME 28 10561
TEST_TIME 29 10298
TEST_TIME 30 10119
TEST_TIME 31 10038
TEST_TIME 32 9889
TEST_TIME 33 9757
TEST_TIME 34 9654
TEST_TIME 35 9558
TEST_TIME 36 9501
TEST_TIME 37 9526
TEST_TIME 38 9387
TEST_TIME 39 9399
TEST_TIME 40 9245
TEST_TIME 41 9205
TEST_TIME 42 9060
TEST_TIME 43 9130
TEST_TIME 44 9010
TEST_TIME 45 8942
TEST_TIME 46 8866
TEST_TIME 47 8876
TEST_TIME 48 9010
TEST_TIME 49 9066
TEST_TIME 50 9058
TEST_TIME 51 9061
TEST_TIME 52 9047
TEST_TIME 53 8980
TEST_TIME 54 8974
TEST_TIME 55 8998
TEST_TIME 56 9251
TEST_TIME 57 9265
TEST_TIME 58 9422
TEST_TIME 59 9309
TEST_TIME 60 9196
TEST_TIME 61 9210
TEST_TIME 62 9113
TEST_TIME 63 9125
TEST_TIME 64 9172
TEST_TIME 65 9099
TEST_TIME 66 9038
TEST_TIME 67 9077
TEST_TIME 68 9102
TEST_TIME 69 9083
TEST_TIME 70 9056
TEST_TIME 71 9146
TEST_TIME 72 9093
TEST_TIME 73 9130
TEST_TIME 74 9153
TEST_TIME 75 9171
TEST_TIME 76 9158
TEST_TIME 77 9186
TEST_TIME 78 9366
TEST_TIME 79 9369
TEST_TIME 80 9344
TEST_TIME 81 9251
TEST_TIME 82 9202
TEST_TIME 83 9180
TEST_TIME 84 9160
TEST_TIME 85 9177
TEST_TIME 86 9141
TEST_TIME 87 9108
TEST_TIME 88 9063
TEST_TIME 89 8974
TEST_TIME 90 9074
TEST_TIME 91 9086
TEST_TIME 92 9067
TEST_TIME 93 9056
TEST_TIME 94 9110
TEST_TIME 95 9142
TEST_TIME 96 9117
TEST_TIME 97 9158
TEST_TIME 98 9121
TEST_TIME 99 9141
TEST_TIME 100 9225
TEST_TIME 101 9304
TEST_TIME 102 9315
TEST_TIME 103 9289
TEST_TIME 104 9301
TEST_TIME 105 9353
TEST_TIME 106 9279
TEST_TIME 107 9246
TEST_TIME 108 9206
TEST_TIME 109 9190
TEST_TIME 110 9187
TEST_TIME 111 9149
TEST_TIME 112 9115
TEST_TIME 113 9098
TEST_TIME 114 9067
TEST_TIME 115 9107
TEST_TIME 116 9119
TEST_TIME 117 9130
TEST_TIME 118 9128
TEST_TIME 119 9178
TEST_TIME 120 9124

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 17-12-2022 22:39:32 to 17-12-2022 22:39:35.

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 1526035 1526035 0 0.00 0 22232 6 0 0
doc_list_biud 1526035 1526035 0 0.00 0 65653 30 0 0
sp_add_invoice_to_stock 5154 5067 87 1.68 46 154734 17098 0 87
sp_cancel_adding_invoice 5654 5654 0 0.00 5 81016 856 0 0
sp_cancel_client_order 1886 1886 0 0.00 4 7721 301 0 0
sp_cancel_customer_reserve 540448 540448 0 0.00 0 65654 67 0 0
sp_cancel_pay_from_customer 732 732 0 0.00 3 7277 91 0 0
sp_cancel_pay_to_supplier 449 449 0 0.00 3 3359 77 0 0
sp_cancel_supplier_invoice 6335 6329 6 0.09 2 25631 972 0 6
sp_cancel_supplier_order 412 412 0 0.00 7 1207369 113006 0 0
sp_cancel_write_off 10223 10223 0 0.00 1 19279 104 0 0
sp_client_order 20975 20975 0 0.00 3 23940 351 0 0
sp_customer_reserve 465810 465810 0 0.00 0 67398 170 0 0
sp_fill_shopping_cart 32426 32426 0 0.00 1 40152 40 0 0
sp_fill_shopping_cart_clo_res 465794 465794 0 0.00 0 27293 13 0 0
sp_get_clo_for_invoice 5051 5051 0 0.00 0 22250 320 0 0
sp_kill_cost_storno 17058 17058 0 0.00 0 7273 54 0 0
sp_kill_qstorno_ret_qs2qd 1097860 1097860 0 0.00 0 65650 37 0 0
sp_kill_qty_storno 580131 580131 0 0.00 0 65653 79 0 0
sp_lock_selected_doc 21133 21133 0 0.00 0 7695 6 0 0
sp_make_cost_storno 28664 28664 0 0.00 0 13645 52 0 0
sp_multiply_rows_for_pdistr 28664 28664 0 0.00 0 21474 28 0 0
sp_multiply_rows_for_qdistr 20975 20975 0 0.00 0 23932 158 0 0
sp_pay_from_customer 7425 7425 0 0.00 4 21487 126 0 0
sp_pay_to_supplier 6060 6060 0 0.00 4 11124 117 0 0
sp_payment_common 13485 13485 0 0.00 1 10570 27 0 0
sp_qd_handle_on_cancel_clo 1886 1886 0 0.00 0 7716 275 0 0
sp_qd_handle_on_invoice_upd_sts 10705 10705 0 0.00 0 40130 356 0 0
sp_qd_handle_on_reserve_upd_sts 10128 10128 0 0.00 0 19048 61 0 0
sp_reserve_write_off 10128 10128 0 0.00 6 19075 172 0 0
sp_supplier_invoice 5791 5791 0 0.00 6 90652 3462 0 0
sp_supplier_order 5673 5673 0 0.00 4 31163 1277 0 0
srv_aggregate_perf_data 95 94 1 1.05 2607 510205 26165 0 1
srv_fill_mon_cache_memory 64 64 0 0.00 1930 156171 44683 0 0
srv_find_qd_qs_mism 1045757 1045757 0 0.00 0 18197 5 0 0
srv_make_invnt_saldo 607 607 0 0.00 33 47908 955 0 0
srv_make_money_saldo 803 803 0 0.00 1 2043 25 0 0
srv_recalc_idx_stat 4 4 0 0.00 221635 421637 348974 0 0
t$perf-abend:sp_add_invoice_to_stock 87 87 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 6 6 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 5067 5067 0 0.00 0 17547 153 0 0
t$perf-norm:sp_cancel_adding_invoice 408 408 0 0.00 0 3249 103 0 0
t$perf-norm:sp_cancel_client_order 1886 1886 0 0.00 0 3958 14 0 0
t$perf-norm:sp_cancel_customer_reserve 650 650 0 0.00 0 2425 13 0 0
t$perf-norm:sp_cancel_pay_from_customer 732 732 0 0.00 0 4627 18 0 0
t$perf-norm:sp_cancel_pay_to_supplier 449 449 0 0.00 0 5836 19 0 0
t$perf-norm:sp_cancel_supplier_invoice 403 403 0 0.00 0 3870 22 0 0
t$perf-norm:sp_cancel_supplier_order 412 412 0 0.00 0 23556 1502 0 0
t$perf-norm:sp_cancel_write_off 1014 1014 0 0.00 0 6458 15 0 0
t$perf-norm:sp_client_order 20975 20975 0 0.00 0 16862 18 0 0
t$perf-norm:sp_customer_reserve 1044 1044 0 0.00 0 3545 11 0 0
t$perf-norm:sp_pay_from_customer 7425 7425 0 0.00 0 9098 16 0 0
t$perf-norm:sp_pay_to_supplier 6060 6060 0 0.00 0 5103 12 0 0
t$perf-norm:sp_reserve_write_off 10128 10128 0 0.00 0 13583 14 0 0
t$perf-norm:sp_supplier_invoice 5791 5791 0 0.00 0 17809 22 0 0
t$perf-norm:sp_supplier_order 5673 5673 0 0.00 0 17675 17 0 0
t$perf-norm:srv_aggregate_perf_data 94 94 0 0.00 0 2002 25 0 0
t$perf-norm:srv_fill_mon_cache_memory 64 64 0 0.00 0 569 9 0 0
t$perf-norm:srv_make_invnt_saldo 607 607 0 0.00 0 1932 26 0 0
t$perf-norm:srv_make_money_saldo 803 803 0 0.00 0 1746 17 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 6 3 0 0
v_add_invoice_to_stock 10276 10102 174 1.69 0 5691 16 0 174
v_all_customers 38364 38364 0 0.00 0 30 1 0 0
v_all_suppliers 31682 31682 0 0.00 0 199 1 0 0
v_all_wares 41950 41950 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 816 816 0 0.00 0 1677 8 0 0
v_cancel_client_order 3772 3772 0 0.00 0 2609 5 0 0
v_cancel_customer_prepayment 1464 1464 0 0.00 0 2811 9 0 0
v_cancel_customer_reserve 1300 1300 0 0.00 0 1668 5 0 0
v_cancel_payment_to_supplier 898 898 0 0.00 0 3059 9 0 0
v_cancel_supplier_invoice 818 806 12 1.46 0 529 11 0 12
v_cancel_supplier_order 824 824 0 0.00 0 3793 11 0 0
v_cancel_write_off 2028 2028 0 0.00 0 2577 15 0 0
v_max_id_clo_ord 5673 5673 0 0.00 0 178 1 0 0
v_max_id_clo_res 1044 1044 0 0.00 0 6664 29 0 0
v_max_id_ord_sup 5778 5778 0 0.00 0 3785 3 0 0
v_max_non_paid_invoice 1670 1670 0 0.00 0 491 2 0 0
v_max_non_paid_realizn 4010 4010 0 0.00 0 2236 4 0 0
v_min_id_clo_ord 5673 5673 0 0.00 0 3886 7 0 0
v_min_id_clo_res 1044 1044 0 0.00 0 7430 16 0 0
v_min_id_ord_sup 5778 5778 0 0.00 0 5514 7 0 0
v_min_non_paid_invoice 6060 6060 0 0.00 0 8805 18 0 0
v_min_non_paid_realizn 7425 7425 0 0.00 0 10566 24 0 0
v_our_firm 10416 10416 0 0.00 0 20 1 0 0
v_reserve_write_off 20256 20256 0 0.00 0 3310 6 0 0
x_lock_depdocs_on_canc_invoice 11580 11580 0 0.00 0 28267 130 0 0
x_lock_depdocs_on_canc_sup_ord 412 412 0 0.00 0 12817 358 0 0
x_make_qstorno_1000_1200 5673 5673 0 0.00 1 31139 1213 0 0
x_make_qstorno_1200_2000 5791 5791 0 0.00 2 90630 3304 0 0
x_make_qstorno_2100_3300 465810 465810 0 0.00 0 67396 154 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 17-12-2022 22:39:36 to 17-12-2022 22:39:41.

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:37 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:38 23673 8192000000 9896369216 10204356608 979501696 10.679 100 90 180 0 1009575472 6287072 23786704
20:11:15 23486 8192000000 9945432544 10263166976 1023754560 11.108 100 91 182 0 1056588320 8830288 24003472
20:12:47 13873 8192000000 9965427104 10296344576 1053125856 11.391 100 76 152 0 1082307344 9858096 19323392
20:14:06 8724 8192000000 10024131808 10369564672 1109275312 11.926 100 76 152 0 1137864576 10674992 17914272
20:15:23 4873 8192000000 10085765680 10448420864 1176826992 12.561 100 72 142 0 1203527536 10722656 15977888
20:16:30 4232 8192000000 10128608272 10499362816 1217958688 12.943 100 84 167 1 1249674416 12856192 18859536
20:17:37 2490 8192000000 10175875936 10552569856 1258774144 13.319 100 83 165 0 1291279072 14575200 17929728
20:18:41 1444 8192000000 10204388272 10586853376 1291340032 13.616 100 91 180 2 1323833440 13172096 19321312
20:19:44 13388 8192000000 10213029056 10606227456 1306376576 13.753 100 60 118 0 1330160560 10154128 13629856
20:21:09 7651 8192000000 10203139088 10618642432 1318555664 13.864 100 24 47 0 1334292992 10468736 5268592
20:22:23 6812 8192000000 10210294544 10628063232 1323726304 13.910 100 21 42 1 1334904000 6277312 4900384
20:23:31 10711 8192000000 10218018784 10641653760 1337950064 14.039 100 16 32 1 1347466096 5792416 3723616
20:24:42 41423 8192000000 10252956656 10664181760 1345911168 14.111 100 57 112 0 1365578208 5957744 13709296
20:26:24 5252 8192000000 10242457136 10658443264 1343335088 14.087 100 29 59 0 1355602672 5447072 6820512
20:27:33 8751 8192000000 10227744288 10650951680 1326509232 13.936 99 16 32 0 1335752336 5594896 3648208
20:28:46 57295 8192000000 10162423344 10577682432 1214021552 12.906 93 24 48 0 1225192352 5148896 6021904
20:30:45 5178 8192000000 10160917424 10559672320 1234825712 13.099 97 27 54 0 1246767680 5917152 6024816
20:31:53 13163 8192000000 10132933824 10533625856 1214467808 12.910 97 21 43 0 1224401824 4896064 5037952
20:33:08 64912 8192000000 10145049024 10556973056 1263636592 13.363 100 34 68 1 1277035696 5216752 8182352
20:35:18 7564 8192000000 10188067504 10591399936 1286680016 13.574 100 35 70 0 1301302544 6799648 7822880
20:36:30 9078 8192000000 10195892384 10609569792 1302676880 13.720 100 15 28 0 1310440928 4874032 2890016
20:37:40 12023 8192000000 10196989744 10616098816 1311842240 13.803 100 19 37 0 1321044896 5277424 3925232
20:38:55 64757 8192000000 10241397856 10651422720 1334183008 14.005 100 41 80 0 1354420112 11519072 8718032
20:41:03 26709 8192000000 10282118384 10693619712 1360913888 14.246 100 48 96 1 1385352816 13831584 10607344
20:42:37 19512 8192000000 10296222736 10721591296 1381714112 14.432 100 41 76 1 1405616224 15347024 8555088
20:44:11 13351 8192000000 10323791088 10749206528 1401105312 14.605 100 44 88 2 1433726816 22234256 10387248
20:45:27 13573 8192000000 10323099648 10741239808 1396246384 14.562 100 56 111 0 1434619424 25768432 12604608
20:46:46 16370 8192000000 10336657200 10761969664 1407709840 14.664 100 50 99 0 1444468368 25057824 11700704
20:48:06 5240 8192000000 10342750816 10761277440 1405152896 14.641 100 73 145 0 1456847552 33838208 17856448
20:49:17 9524 8192000000 10360404704 10779852800 1409217504 14.677 99 65 130 0 1464872080 39495440 16159136
20:50:34 12344 8192000000 10376019328 10795356160 1418414480 14.759 100 54 108 0 1473290656 41112848 13763328
20:51:49 4117 8192000000 10384636512 10798653440 1425601664 14.822 100 68 135 1 1484004464 41433408 16969392
20:52:56 4115 8192000000 10378339920 10795868160 1423255136 14.802 100 60 120 1 1486075616 47199920 15620560
20:54:06 3390 8192000000 10407170336 10820235264 1436544720 14.919 100 78 152 0 1510590016 54477584 19567712
20:55:15 3277 8192000000 10410618800 10816716800 1428028496 14.844 100 86 171 0 1511029072 60969488 22031088
20:56:23 2906 8192000000 10386629344 10791391232 1403676544 14.628 99 72 143 1 1486904464 64139744 19088176
20:57:36 5213 8192000000 10396277184 10808426496 1401491168 14.608 99 71 142 3 1488163568 67110992 19561408
20:58:47 1930 8192000000 10394040192 10804375552 1410631072 14.690 100 79 154 1 1495406224 64123712 20651440
20:59:55 7247 8192000000 10376880640 10803671040 1401991456 14.613 100 43 85 1 1483770624 69398304 12380864
21:01:05 23848 8192000000 10356307104 10795655168 1355254272 14.195 97 36 72 0 1443781072 77314032 11212768
21:02:34 30841 8192000000 10312513536 10749812736 1360868560 14.245 99 26 52 0 1425324752 56544448 7911744
21:04:15 24920 8192000000 10315130384 10745167872 1330330576 13.970 98 26 52 0 1404342064 65407184 8604304
21:05:51 74597 8192000000 10282123488 10723536896 1355440512 14.196 99 26 52 1 1370959328 9079136 6439680
21:08:38 45235 8192000000 10250728736 10684792832 1311484448 13.800 96 39 78 0 1327318368 7067120 8766800
21:10:28 66201 8192000000 10261520048 10716393472 1353829328 14.182 99 7 14 0 1363108624 8167184 1112112
21:12:35 38122 8192000000 10285716128 10736869376 1380588976 14.422 100 14 27 0 1391864784 8415152 2860656
21:14:26 24974 8192000000 10282589392 10731794432 1377941008 14.398 100 14 24 0 1393162048 12262704 2958336
21:15:55 127587 8192000000 10284166160 10751864832 1383707232 14.450 100 23 46 0 1408250000 18754704 5788064
21:19:25 59984 8192000000 10286632640 10747764736 1389188128 14.499 100 18 36 0 1402172144 8543472 4440544
21:21:26 43980 8192000000 10268990672 10736615424 1372409776 14.349 99 8 16 0 1382405552 7891648 2104128
21:23:10 44596 8192000000 10286947216 10746408960 1379885568 14.416 100 16 32 0 1393846096 10334656 3625872
21:24:55 92431 8192000000 10300220144 10762403840 1393240720 14.535 100 22 42 0 1415959760 18208512 4510528
21:27:28 72146 8192000000 10287408256 10745344000 1350436320 14.151 97 28 55 0 1367076672 10551200 6089152
21:30:16 49379 8192000000 10318635056 10768130048 1398455344 14.581 100 34 66 1 1419891744 14031360 7405040
21:32:07 32032 8192000000 10327711968 10780868608 1392663360 14.530 99 27 54 0 1419219792 20479312 6077120
21:33:53 61473 8192000000 10296095952 10756362240 1371068640 14.337 98 11 20 1 1397682000 24282048 2331312
21:36:02 94260 8192000000 10293875152 10733158400 1355910080 14.201 97 18 36 0 1372359472 12710784 3738608
21:38:39 82995 8192000000 10280250192 10733105152 1350313728 14.150 97 25 50 1 1365336768 9520608 5502432
21:41:08 6472 8192000000 10286224048 10724323328 1372735600 14.352 100 41 82 0 1396438640 14153840 9549200
21:42:15 49725 8192000000 10245417616 10712743936 1337335376 14.033 98 11 23 0 1349416160 9429408 2651376
21:44:06 63597 8192000000 10258917920 10716082176 1319030464 13.868 96 9 18 0 1327836352 6869824 1936064
21:46:57 61934 8192000000 10264737872 10705809408 1288298720 13.589 94 34 66 0 1305097920 9631472 7167728
21:49:01 76916 8192000000 10263393280 10711195648 1331024352 13.976 98 11 22 0 1343901904 10360256 2517296
21:51:24 17596 8192000000 10265797616 10705719296 1331667632 13.982 98 29 58 0 1346881312 8778224 6435456
21:52:42 25938 8192000000 10271606480 10710986752 1355440864 14.196 100 27 54 0 1370587216 9132080 6014272
21:54:09 9063 8192000000 10245585696 10672295936 1301084528 13.705 97 40 81 0 1319589008 9512000 8992480
21:55:22 46735 8192000000 10271859568 10724712448 1343688016 14.091 99 20 40 0 1371932432 23513520 4730896
21:57:09 156171 8192000000 10260616064 10710691840 1325667984 13.928 97 18 36 0 1341605008 12324976 3612048
22:00:57 31837 8192000000 10273626256 10725167104 1356126224 14.203 99 34 68 0 1373388752 9907776 7354752
22:02:36 26743 8192000000 10287250704 10729578496 1374604496 14.368 100 44 88 0 1393139680 9008432 9526752
22:04:09 66474 8192000000 10251734496 10711846912 1343646592 14.090 98 8 16 0 1352482624 7136416 1699616
22:06:22 54295 8192000000 10283406912 10739531776 1383768624 14.450 100 20 38 0 1397508048 8931648 4807776
22:08:28 66486 8192000000 10278749200 10746900480 1369651360 14.324 99 6 12 0 1379565136 8624208 1289568
22:10:34 106467 8192000000 10276505856 10731913216 1296130272 13.660 93 11 22 0 1308189952 10014016 2045664
22:13:30 50844 8192000000 10305352320 10748178432 1380320096 14.419 100 26 52 0 1394527744 7958832 6248816
22:15:21 69744 8192000000 10293800880 10745667584 1363882624 14.272 98 16 31 1 1382735168 15304592 3547952
22:17:42 18919 8192000000 10307851200 10758594560 1385761248 14.468 100 44 85 0 1410418688 14862816 9794624
22:19:19 45427 8192000000 10300984416 10770784256 1379791792 14.415 100 10 20 0 1407845952 25435232 2618928
22:21:17 74347 8192000000 10290493360 10730094592 1279071600 13.505 92 28 56 0 1295035024 9975808 5987616
22:23:33 144721 8192000000 10266804992 10719453184 1328527360 13.954 97 25 50 0 1345605488 11120752 5957376
22:26:58 35200 8192000000 10278693616 10729365504 1357150448 14.212 99 11 22 0 1372719072 13038752 2529872
22:28:42 56877 8192000000 10250355632 10716499968 1335144368 14.014 98 9 18 0 1348567120 11618480 1804272
22:30:39 48553 8192000000 10265117392 10724265984 1366126144 14.292 100 18 34 3 1379720272 9364992 4229136
22:32:36 54232 8192000000 10241584976 10703003648 1311599584 13.801 97 4 8 0 1327489264 14992496 897184
22:34:34 39310 8192000000 10257516528 10698784768 1315816672 13.839 97 31 60 0 1330550608 7942608 6791328
22:36:35 51819 8192000000 10272747104 10719690752 1345699040 14.109 99 20 40 0 1361408672 11444432 4265200

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 17-12-2022 22:39:43 to 17-12-2022 22:39:58.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 87 v_add_invoice_to_stock 335544517
except 6 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 17-12-2022 22:39:59 to 17-12-2022 22:40:01.

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          259308
MON$OLDEST_ACTIVE               259309
MON$OLDEST_SNAPSHOT             259309
MON$NEXT_TRANSACTION            259309
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                       2010496
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


ISQL Version: LI-V3.0.11.33648 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33648 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33648 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33648 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'

17.12.22 22:40:02. 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-12-17 22:40:04 No severe PSQL-related problems occured
17.12.22 22:40:06. End of report.