Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 12.02.2023 16: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 15509656 kB
MemAvailable 30402688 kB
Buffers 0 kB
Cached 16186944 kB
SwapCached 3324 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 2023-02-12 16:38:39
DTS_END                         2023-02-12 16:38:39.9880
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/36614
TRN_ID                          237389
ATT_ID                          615
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: 9084.73 23252 1090167
customer order: creation 163.71 347 19645
customer order: refuse 14.54 363 1745
order to supplier: creation 43.38 1290 5205
order to supplier: removal 3.42 95252 410
invoice (draft): creation 44.46 3448 5335
invoice (draft): removal 52.33 717 6279
invoice accept: apply 40.30 18194 4836
invoice accept: cancel 47.79 684 5735
customer reserve: creation 3723.21 182 446785
customer reserve: removal 4660.92 54 559310
realization accept: apply 81.88 162 9825
realization accept: cancel 85.66 102 10279
payment from customer: creation 56.35 83 6762
payment from customer: removal 5.55 68 666
payment to supplier: creation 47.10 123 5652
payment to supplier: removal 3.18 76 382
service: total inventory turnovers 4.22 1036 506
service: total monetary turnovers 5.91 19 709
service: aggregate perf. data 0.81 21326 97
service: refresh index statistics 0.03 321510 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 12-02-2023 16:39:53 to 12-02-2023 16:39:55.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2525
TEST_TIME 2 4602
TEST_TIME 3 5539
TEST_TIME 4 5408
TEST_TIME 5 5670
TEST_TIME 6 5629
TEST_TIME 7 5491
TEST_TIME 8 5277
TEST_TIME 9 5186
TEST_TIME 10 5181
TEST_TIME 11 5378
TEST_TIME 12 5523
TEST_TIME 13 5827
TEST_TIME 14 5884
TEST_TIME 15 6588
TEST_TIME 16 6563
TEST_TIME 17 6860
TEST_TIME 18 7394
TEST_TIME 19 8048
TEST_TIME 20 8323
TEST_TIME 21 8573
TEST_TIME 22 9299
TEST_TIME 23 9765
TEST_TIME 24 10284
TEST_TIME 25 9928
TEST_TIME 26 9798
TEST_TIME 27 10098
TEST_TIME 28 10089
TEST_TIME 29 9895
TEST_TIME 30 9647
TEST_TIME 31 9712
TEST_TIME 32 9567
TEST_TIME 33 9392
TEST_TIME 34 9391
TEST_TIME 35 9435
TEST_TIME 36 9364
TEST_TIME 37 9228
TEST_TIME 38 9082
TEST_TIME 39 9114
TEST_TIME 40 9065
TEST_TIME 41 9102
TEST_TIME 42 9057
TEST_TIME 43 8937
TEST_TIME 44 8921
TEST_TIME 45 8933
TEST_TIME 46 9160
TEST_TIME 47 9097
TEST_TIME 48 9087
TEST_TIME 49 9078
TEST_TIME 50 9005
TEST_TIME 51 9187
TEST_TIME 52 9162
TEST_TIME 53 9346
TEST_TIME 54 9266
TEST_TIME 55 9331
TEST_TIME 56 9278
TEST_TIME 57 9341
TEST_TIME 58 9227
TEST_TIME 59 9209
TEST_TIME 60 9135
TEST_TIME 61 9050
TEST_TIME 62 9096
TEST_TIME 63 9033
TEST_TIME 64 8959
TEST_TIME 65 8989
TEST_TIME 66 9066
TEST_TIME 67 9055
TEST_TIME 68 9173
TEST_TIME 69 9144
TEST_TIME 70 9138
TEST_TIME 71 9209
TEST_TIME 72 9215
TEST_TIME 73 9196
TEST_TIME 74 9227
TEST_TIME 75 9243
TEST_TIME 76 9279
TEST_TIME 77 9307
TEST_TIME 78 9261
TEST_TIME 79 9234
TEST_TIME 80 9137
TEST_TIME 81 9114
TEST_TIME 82 9152
TEST_TIME 83 9086
TEST_TIME 84 9099
TEST_TIME 85 9092
TEST_TIME 86 9064
TEST_TIME 87 9020
TEST_TIME 88 8950
TEST_TIME 89 8910
TEST_TIME 90 8950
TEST_TIME 91 9009
TEST_TIME 92 9007
TEST_TIME 93 9047
TEST_TIME 94 9052
TEST_TIME 95 9140
TEST_TIME 96 9119
TEST_TIME 97 9139
TEST_TIME 98 9133
TEST_TIME 99 9131
TEST_TIME 100 9131
TEST_TIME 101 9226
TEST_TIME 102 9193
TEST_TIME 103 9267
TEST_TIME 104 9235
TEST_TIME 105 9155
TEST_TIME 106 9139
TEST_TIME 107 9138
TEST_TIME 108 9116
TEST_TIME 109 9076
TEST_TIME 110 9088
TEST_TIME 111 9045
TEST_TIME 112 9031
TEST_TIME 113 9059
TEST_TIME 114 9025
TEST_TIME 115 9020
TEST_TIME 116 9026
TEST_TIME 117 9037
TEST_TIME 118 9041
TEST_TIME 119 9066
TEST_TIME 120 9087

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 12-02-2023 16:39:57 to 12-02-2023 16:40:00.

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 1504842 1504842 0 0.00 0 15977 6 0 0
doc_list_biud 1504842 1504842 0 0.00 0 26077 26 0 0
sp_add_invoice_to_stock 4943 4836 107 2.16 41 213334 18194 0 107
sp_cancel_adding_invoice 5735 5735 0 0.00 3 56578 684 0 0
sp_cancel_client_order 1745 1745 0 0.00 4 8645 363 0 0
sp_cancel_customer_reserve 559310 559310 0 0.00 0 22082 55 0 0
sp_cancel_pay_from_customer 666 666 0 0.00 2 4190 68 0 0
sp_cancel_pay_to_supplier 382 382 0 0.00 2 4254 77 0 0
sp_cancel_supplier_invoice 6284 6279 5 0.07 1 16889 718 0 5
sp_cancel_supplier_order 410 410 0 0.00 9 1064828 95252 0 0
sp_cancel_write_off 10279 10279 0 0.00 1 11654 103 0 0
sp_client_order 19645 19645 0 0.00 3 20520 348 0 0
sp_customer_reserve 446785 446785 0 0.00 0 82816 182 0 0
sp_fill_shopping_cart 30168 30168 0 0.00 1 15589 38 0 0
sp_fill_shopping_cart_clo_res 446772 446772 0 0.00 0 13172 14 0 0
sp_get_clo_for_invoice 4823 4823 0 0.00 0 18146 321 0 0
sp_kill_cost_storno 17062 17062 0 0.00 0 9965 48 0 0
sp_kill_qstorno_ret_qs2qd 1135588 1135588 0 0.00 0 22080 30 0 0
sp_kill_qty_storno 598406 598406 0 0.00 0 26076 65 0 0
sp_lock_selected_doc 20226 20226 0 0.00 0 8036 5 0 0
sp_make_cost_storno 27062 27062 0 0.00 0 12737 43 0 0
sp_multiply_rows_for_pdistr 27062 27062 0 0.00 0 15962 22 0 0
sp_multiply_rows_for_qdistr 19645 19645 0 0.00 0 12275 157 0 0
sp_pay_from_customer 6762 6762 0 0.00 4 8717 83 0 0
sp_pay_to_supplier 5652 5652 0 0.00 4 15985 123 0 0
sp_payment_common 12414 12414 0 0.00 1 8134 22 0 0
sp_qd_handle_on_cancel_clo 1745 1745 0 0.00 0 8622 323 0 0
sp_qd_handle_on_invoice_upd_sts 10558 10558 0 0.00 0 26074 308 0 0
sp_qd_handle_on_reserve_upd_sts 9825 9825 0 0.00 0 21574 64 0 0
sp_reserve_write_off 9825 9825 0 0.00 6 21584 162 0 0
sp_supplier_invoice 5335 5335 0 0.00 6 66595 3448 0 0
sp_supplier_order 5205 5205 0 0.00 5 34367 1291 0 0
srv_aggregate_perf_data 97 97 0 0.00 2272 483009 21327 0 0
srv_fill_mon_cache_memory 65 65 0 0.00 2472 116483 42983 0 0
srv_find_qd_qs_mism 1044905 1044905 0 0.00 0 8041 5 0 0
srv_make_invnt_saldo 506 506 0 0.00 39 21219 1037 0 0
srv_make_money_saldo 709 709 0 0.00 1 332 20 0 0
srv_recalc_idx_stat 4 4 0 0.00 98927 483472 321510 0 0
t$perf-abend:sp_add_invoice_to_stock 107 107 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 5 5 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4836 4836 0 0.00 0 8978 169 0 0
t$perf-norm:sp_cancel_adding_invoice 391 391 0 0.00 0 2759 61 0 0
t$perf-norm:sp_cancel_client_order 1745 1745 0 0.00 0 2406 11 0 0
t$perf-norm:sp_cancel_customer_reserve 671 671 0 0.00 0 3152 14 0 0
t$perf-norm:sp_cancel_pay_from_customer 666 666 0 0.00 0 1353 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 382 382 0 0.00 0 560 8 0 0
t$perf-norm:sp_cancel_supplier_invoice 395 395 0 0.00 0 810 7 0 0
t$perf-norm:sp_cancel_supplier_order 410 410 0 0.00 0 23709 1417 0 0
t$perf-norm:sp_cancel_write_off 918 918 0 0.00 0 1885 5 0 0
t$perf-norm:sp_client_order 19645 19645 0 0.00 0 7494 16 0 0
t$perf-norm:sp_customer_reserve 979 979 0 0.00 0 608 4 0 0
t$perf-norm:sp_pay_from_customer 6762 6762 0 0.00 0 4602 9 0 0
t$perf-norm:sp_pay_to_supplier 5652 5652 0 0.00 0 7788 12 0 0
t$perf-norm:sp_reserve_write_off 9825 9825 0 0.00 0 7858 12 0 0
t$perf-norm:sp_supplier_invoice 5335 5335 0 0.00 0 6211 19 0 0
t$perf-norm:sp_supplier_order 5205 5205 0 0.00 0 6368 12 0 0
t$perf-norm:srv_aggregate_perf_data 97 97 0 0.00 0 691 17 0 0
t$perf-norm:srv_fill_mon_cache_memory 65 65 0 0.00 0 405 7 0 0
t$perf-norm:srv_make_invnt_saldo 506 506 0 0.00 0 1371 15 0 0
t$perf-norm:srv_make_money_saldo 709 709 0 0.00 0 2033 20 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 5 3 0 0
v_add_invoice_to_stock 9860 9646 214 2.17 0 6913 22 0 214
v_all_customers 35590 35590 0 0.00 0 18 0 0 0
v_all_suppliers 29396 29396 0 0.00 0 18 1 0 0
v_all_wares 39290 39290 0 0.00 0 19 1 0 0
v_cancel_adding_invoice 782 782 0 0.00 0 441 6 0 0
v_cancel_client_order 3490 3490 0 0.00 0 8092 10 0 0
v_cancel_customer_prepayment 1332 1332 0 0.00 0 2330 7 0 0
v_cancel_customer_reserve 1342 1342 0 0.00 0 1735 4 0 0
v_cancel_payment_to_supplier 764 764 0 0.00 0 4217 14 0 0
v_cancel_supplier_invoice 800 790 10 1.25 0 2992 27 0 10
v_cancel_supplier_order 820 820 0 0.00 0 152 3 0 0
v_cancel_write_off 1836 1836 0 0.00 0 5131 20 0 0
v_max_id_clo_ord 5202 5202 0 0.00 0 861 1 0 0
v_max_id_clo_res 979 979 0 0.00 0 808 7 0 0
v_max_id_ord_sup 5320 5320 0 0.00 0 7267 9 0 0
v_max_non_paid_invoice 1476 1476 0 0.00 0 468 2 0 0
v_max_non_paid_realizn 3777 3777 0 0.00 0 2785 3 0 0
v_min_id_clo_ord 5202 5202 0 0.00 0 2990 6 0 0
v_min_id_clo_res 979 979 0 0.00 0 4813 24 0 0
v_min_id_ord_sup 5320 5320 0 0.00 0 4056 5 0 0
v_min_non_paid_invoice 5652 5652 0 0.00 0 8130 14 0 0
v_min_non_paid_realizn 6762 6762 0 0.00 0 4065 17 0 0
v_our_firm 9670 9670 0 0.00 0 20 1 0 0
v_reserve_write_off 19650 19650 0 0.00 0 8094 8 0 0
x_lock_depdocs_on_canc_invoice 11619 11619 0 0.00 0 16075 102 0 0
x_lock_depdocs_on_canc_sup_ord 410 410 0 0.00 0 7958 366 0 0
x_make_qstorno_1000_1200 5205 5205 0 0.00 1 34360 1225 0 0
x_make_qstorno_1200_2000 5335 5335 0 0.00 3 66481 3303 0 0
x_make_qstorno_2100_3300 446785 446785 0 0.00 0 82813 166 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 12-02-2023 16:40:01 to 12-02-2023 16:40:05.

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
14:08:43 22 8192000000 8811210848 8826687488 15701744 0.191 4 4 5 0 15929920 88896 139280
14:09:44 27216 8192000000 9891045184 10194653184 969133504 10.578 100 88 176 0 997970400 5466496 23370400
14:11:16 22338 8192000000 9923547776 10239811584 1006502176 10.942 100 87 174 0 1037064448 7622512 22939760
14:12:47 13389 8192000000 9975158336 10304970752 1051897696 11.379 100 86 172 0 1082864704 9530048 21436960
14:14:07 10541 8192000000 10014840784 10359283712 1104753872 11.883 100 73 146 1 1132463520 10161104 17548544
14:15:24 6222 8192000000 10082966032 10437484544 1168361440 12.482 100 80 158 1 1199363200 13064672 17937088
14:16:32 2984 8192000000 10130760864 10496851968 1214603248 12.912 100 83 165 1 1246371808 13523568 18244992
14:17:37 2434 8192000000 10161732624 10535219200 1245801440 13.200 100 84 168 0 1278238544 14125680 18311424
14:18:40 1349 8192000000 10201875776 10583203840 1288334176 13.589 100 82 164 0 1319166912 12746512 18086224
14:19:42 18126 8192000000 10197800208 10598703104 1305195488 13.742 100 48 97 1 1323123360 6113840 11814032
14:21:01 3768 8192000000 10212430352 10616561664 1310865264 13.794 100 37 74 1 1330981088 12340768 7775056
14:22:07 6221 8192000000 10213343600 10622283776 1317961456 13.858 100 28 58 0 1330929232 6822816 6144960
14:23:14 55679 8192000000 10225694864 10640797696 1327817680 13.947 100 40 80 0 1343030448 5003568 10209200
14:25:14 8079 8192000000 10217828160 10641809408 1333948400 14.003 100 16 33 0 1343597840 6216848 3432592
14:26:24 9020 8192000000 10240597536 10652160000 1342788064 14.083 100 23 44 0 1354064704 6111184 5165456
14:27:37 51019 8192000000 10241379328 10660601856 1332056816 13.986 99 36 72 1 1345947584 4920368 8970400
14:29:32 6756 8192000000 10162889376 10567319552 1253490752 13.270 97 26 51 0 1264998848 5702176 5805920
14:30:39 9712 8192000000 10140565728 10539249664 1217518832 12.939 96 19 36 1 1226996480 5803808 3673840
14:31:49 16038 8192000000 10116665312 10505846784 1172249056 12.518 94 30 58 1 1188765824 9348080 7168688
14:33:05 15052 8192000000 10138239888 10537324544 1216530304 12.930 97 26 52 0 1228505280 6275232 5699744
14:34:23 6460 8192000000 10166923808 10576015360 1277429024 13.490 100 27 53 0 1289166272 5723984 6013264
14:35:31 7796 8192000000 10192156720 10599673856 1297336256 13.671 100 17 34 0 1306815936 5809088 3670592
14:36:39 75147 8192000000 10202050352 10613043200 1306358704 13.753 100 22 46 1 1316112080 5214752 4538624
14:38:57 27750 8192000000 10232649968 10644832256 1329859280 13.966 100 39 76 1 1344539536 6027280 8652976
14:40:31 5360 8192000000 10262578624 10674802688 1350168720 14.149 100 53 106 0 1378142720 15735904 12238096
14:41:45 9240 8192000000 10286583664 10700607488 1365646624 14.288 100 64 126 1 1397561168 16924032 14990512
14:43:00 25139 8192000000 10294828240 10718625792 1376223472 14.383 100 39 77 1 1405366352 20015728 9127152
14:44:30 4825 8192000000 10301741904 10726805504 1381965376 14.434 100 39 78 0 1413628224 22345952 9316896
14:45:38 9800 8192000000 10306111632 10732474368 1387191712 14.481 100 42 84 0 1423512464 26314544 10006208
14:46:55 20442 8192000000 10334176352 10757578752 1394235040 14.544 99 51 101 0 1436247392 29909312 12103040
14:48:20 3730 8192000000 10352044704 10768187392 1407670880 14.663 100 61 122 0 1459842768 37320240 14851648
14:49:26 3965 8192000000 10331450432 10748137472 1389030496 14.497 99 62 124 1 1445176960 40307056 15839408
14:50:34 2472 8192000000 10363812624 10776989696 1406895808 14.656 100 74 147 0 1468697168 43683408 18117952
14:51:41 3215 8192000000 10350147744 10765152256 1393760032 14.539 99 68 136 3 1456897024 45536752 17600240
14:52:50 8784 8192000000 10356512720 10770534400 1384165904 14.454 99 64 126 1 1454042240 53778336 16098000
14:54:04 6033 8192000000 10317308240 10738012160 1348474560 14.134 98 55 107 0 1409582544 46969152 14138832
14:55:19 5627 8192000000 10353858016 10764537856 1383841104 14.451 100 61 122 1 1454443040 54650624 15951312
14:56:30 6984 8192000000 10328765200 10748342272 1371418256 14.340 100 34 68 0 1434544336 53248224 9877856
14:57:42 10743 8192000000 10305850528 10740858880 1338933968 14.048 98 33 66 0 1405371824 57087968 9349888
14:59:02 27487 8192000000 10288546224 10725089280 1353933328 14.183 100 23 46 1 1404949184 44464880 6550976
15:00:32 19528 8192000000 10265426752 10705444864 1333682720 14.000 100 28 56 1 1376742000 35462000 7597280
15:02:02 27577 8192000000 10259906064 10694201344 1316252672 13.843 97 29 57 0 1351267440 27795312 7219456
15:03:35 43947 8192000000 10261182000 10699071488 1350664512 14.153 100 37 72 1 1371195344 11468352 9062480
15:05:33 43168 8192000000 10256158768 10689400832 1332960336 13.994 99 39 80 2 1351094880 8687696 9446848
15:07:25 111556 8192000000 10269634432 10708156416 1344508592 14.098 99 14 28 0 1362243536 14369424 3365520
15:10:42 37101 8192000000 10267763696 10712387584 1361964304 14.255 100 17 34 0 1379068368 13323952 3780112
15:12:54 57813 8192000000 10271336624 10716254208 1351513920 14.161 99 15 30 0 1373192512 18437264 3241328
15:15:04 52958 8192000000 10268714096 10719485952 1373294976 14.357 100 21 40 0 1386161568 8422976 4443616
15:16:58 44142 8192000000 10276249152 10728783872 1358092400 14.220 98 24 47 1 1380912128 17402256 5417472
15:18:46 31930 8192000000 10276294416 10723876864 1365445184 14.286 99 19 38 0 1385766848 15710912 4610752
15:20:22 97143 8192000000 10272939232 10723815424 1347540784 14.125 98 19 38 1 1365061584 13276576 4244224
15:23:05 47812 8192000000 10282162912 10742620160 1379203584 14.409 100 9 18 0 1397512576 16002064 2306928
15:24:55 54208 8192000000 10285054736 10740183040 1388540224 14.493 100 11 22 0 1399713280 8985616 2187440
15:26:55 35632 8192000000 10311270384 10755743744 1401477456 14.608 100 23 45 0 1414367168 8120672 4769040
15:28:36 57110 8192000000 10317798416 10768953344 1400607744 14.600 99 40 79 0 1422590496 13165696 8817056
15:30:34 52953 8192000000 10313657712 10780438528 1404919632 14.639 100 15 30 0 1425974480 17728288 3326560
15:32:27 104742 8192000000 10307301648 10757619712 1336712608 14.028 95 16 32 0 1354125712 14143632 3269472
15:35:24 43668 8192000000 10301066432 10750009344 1385556896 14.466 99 34 68 0 1407869424 15203296 7109232
15:37:11 116482 8192000000 10286669872 10742935552 1337959952 14.039 96 14 27 1 1348534240 8118320 2455968
15:40:08 54214 8192000000 10274322192 10738110464 1373324944 14.357 99 14 28 1 1387804896 11263792 3216160
15:42:47 52079 8192000000 10297184368 10749317120 1380188512 14.418 99 16 32 0 1398311728 14364880 3758336
15:45:36 90018 8192000000 10283652544 10737848320 1335135552 14.014 96 15 28 0 1362183856 23561248 3487056
15:48:07 31324 8192000000 10285244880 10724675584 1353453744 14.179 99 39 78 0 1376096384 13700608 8942032
15:49:39 65407 8192000000 10268019744 10711060480 1314163456 13.824 96 20 37 2 1334292912 15929312 4200144
15:51:49 15763 8192000000 10267784032 10697166848 1329203088 13.960 98 26 52 0 1348589120 13617264 5768768
15:53:06 36585 8192000000 10253285232 10698465280 1330237088 13.969 98 22 44 1 1350654688 15173664 5243936
15:54:46 91761 8192000000 10234076496 10677874688 1261759680 13.346 94 18 36 0 1274985392 9604720 3620992
15:57:20 19772 8192000000 10277895568 10703859712 1347034768 14.121 100 45 90 0 1366983216 10481696 9466752
15:58:46 75074 8192000000 10260748864 10705420288 1357407536 14.214 100 37 74 0 1376260256 10446880 8405840
16:01:02 41271 8192000000 10268639120 10697842688 1345814512 14.110 99 39 77 1 1364966656 10198976 8953168
16:02:44 48595 8192000000 10262401408 10714771456 1361522832 14.251 100 18 36 0 1374003936 8641328 3839776
16:04:51 27463 8192000000 10279641376 10725507072 1371119008 14.337 100 30 60 0 1383973968 6210016 6644944
16:06:20 58233 8192000000 10277873840 10730278912 1377856864 14.397 100 13 26 0 1393911696 12238608 3816224
16:08:21 56560 8192000000 10287170144 10737532928 1356092992 14.202 98 14 26 0 1369165776 10302368 2770416
16:10:18 41481 8192000000 10287796480 10738925568 1374373088 14.366 99 10 20 0 1386936624 10593792 1969744
16:12:10 74970 8192000000 10301358592 10763980800 1391896064 14.523 100 17 35 0 1410408096 14221744 4290288
16:14:25 25238 8192000000 10284894016 10730590208 1361042496 14.247 98 33 66 1 1377506368 8795552 7668320
16:16:19 43476 8192000000 10293858672 10731290624 1339674192 14.054 97 36 72 0 1359504928 12145296 7685440
16:18:06 64331 8192000000 10308498608 10754871296 1377130800 14.391 100 28 57 0 1401425744 17745520 6549424
16:20:11 13381 8192000000 10296835296 10735411200 1371353728 14.339 99 43 86 0 1387796496 6564960 9877808
16:21:28 54861 8192000000 10306811328 10755362816 1360546736 14.242 98 20 40 0 1380296448 15196288 4553424
16:25:05 72187 8192000000 10300570720 10769948672 1396141792 14.561 100 25 50 0 1416990464 15371904 5476768
16:27:21 69361 8192000000 10289520400 10749145088 1384315952 14.455 99 5 10 0 1399355904 13773008 1266944
16:29:33 56768 8192000000 10287687968 10744107008 1366718320 14.298 98 15 31 0 1378651680 8200432 3732928
16:31:33 99255 8192000000 10293264480 10748211200 1343245008 14.087 96 13 26 0 1356689040 10699120 2744912
16:34:15 53754 8192000000 10299855568 10758270976 1387181152 14.481 100 20 40 0 1408299376 16628496 4489728
16:36:09 25772 8192000000 10304152672 10755502080 1386563792 14.475 100 27 54 0 1406513104 14108176 5841136
16:37:44 73704 8192000000 9178993232 9438228480 331933728 3.894 24 4 8 0 346851776 13975408 942640

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 12-02-2023 16:40:07 to 12-02-2023 16:40:22.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 107 v_add_invoice_to_stock 335544517
except 5 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 12-02-2023 16:40:23 to 12-02-2023 16:40:25.

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

12.02.23 16:40:26. 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
2023-02-12 16:40:29 No severe PSQL-related problems occured
12.02.23 16:40:30. End of report.