Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 15.02.2023 22:40
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 15444120 kB
MemAvailable 30435132 kB
Buffers 0 kB
Cached 16295652 kB
SwapCached 3348 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-15 22:38:42
DTS_END                         2023-02-15 22:38:42.8000
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/59296
TRN_ID                          229307
ATT_ID                          675
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.52 23638 1090142
customer order: creation 157.80 391 18936
customer order: refuse 13.65 353 1638
order to supplier: creation 42.54 1287 5105
order to supplier: removal 3.16 99848 379
invoice (draft): creation 42.44 3392 5093
invoice (draft): removal 52.48 727 6298
invoice accept: apply 39.09 17661 4691
invoice accept: cancel 47.80 724 5736
customer reserve: creation 3631.95 174 435834
customer reserve: removal 4765.58 52 571870
realization accept: apply 77.38 177 9286
realization accept: cancel 91.55 87 10986
payment from customer: creation 53.90 100 6468
payment from customer: removal 5.28 64 633
payment to supplier: creation 45.09 109 5411
payment to supplier: removal 3.28 69 394
service: total inventory turnovers 4.35 1292 522
service: total monetary turnovers 6.32 26 758
service: aggregate perf. data 0.83 16251 100
service: refresh index statistics 0.03 329984 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 15-02-2023 22:40:42 to 15-02-2023 22:40:44.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 1721
TEST_TIME 2 3045
TEST_TIME 3 3451
TEST_TIME 4 4513
TEST_TIME 5 4780
TEST_TIME 6 4819
TEST_TIME 7 4964
TEST_TIME 8 5124
TEST_TIME 9 5217
TEST_TIME 10 5390
TEST_TIME 11 5666
TEST_TIME 12 6031
TEST_TIME 13 6300
TEST_TIME 14 7015
TEST_TIME 15 7181
TEST_TIME 16 7380
TEST_TIME 17 7898
TEST_TIME 18 8099
TEST_TIME 19 8259
TEST_TIME 20 8569
TEST_TIME 21 9005
TEST_TIME 22 9159
TEST_TIME 23 9492
TEST_TIME 24 9469
TEST_TIME 25 9938
TEST_TIME 26 10512
TEST_TIME 27 10595
TEST_TIME 28 10325
TEST_TIME 29 10567
TEST_TIME 30 10423
TEST_TIME 31 10251
TEST_TIME 32 10002
TEST_TIME 33 10081
TEST_TIME 34 9863
TEST_TIME 35 10027
TEST_TIME 36 9992
TEST_TIME 37 9852
TEST_TIME 38 9662
TEST_TIME 39 9622
TEST_TIME 40 9559
TEST_TIME 41 9722
TEST_TIME 42 9729
TEST_TIME 43 9722
TEST_TIME 44 9530
TEST_TIME 45 9469
TEST_TIME 46 9498
TEST_TIME 47 9405
TEST_TIME 48 9319
TEST_TIME 49 9344
TEST_TIME 50 9361
TEST_TIME 51 9350
TEST_TIME 52 9396
TEST_TIME 53 9388
TEST_TIME 54 9472
TEST_TIME 55 9457
TEST_TIME 56 9450
TEST_TIME 57 9496
TEST_TIME 58 9429
TEST_TIME 59 9428
TEST_TIME 60 9348
TEST_TIME 61 9587
TEST_TIME 62 9457
TEST_TIME 63 9396
TEST_TIME 64 9311
TEST_TIME 65 9236
TEST_TIME 66 9251
TEST_TIME 67 9196
TEST_TIME 68 9114
TEST_TIME 69 9146
TEST_TIME 70 9125
TEST_TIME 71 9079
TEST_TIME 72 9119
TEST_TIME 73 9031
TEST_TIME 74 9015
TEST_TIME 75 9043
TEST_TIME 76 8995
TEST_TIME 77 9036
TEST_TIME 78 9022
TEST_TIME 79 9048
TEST_TIME 80 9083
TEST_TIME 81 9134
TEST_TIME 82 9146
TEST_TIME 83 9199
TEST_TIME 84 9182
TEST_TIME 85 9164
TEST_TIME 86 9273
TEST_TIME 87 9273
TEST_TIME 88 9262
TEST_TIME 89 9177
TEST_TIME 90 9148
TEST_TIME 91 9151
TEST_TIME 92 9121
TEST_TIME 93 9074
TEST_TIME 94 9065
TEST_TIME 95 9015
TEST_TIME 96 9057
TEST_TIME 97 9030
TEST_TIME 98 9076
TEST_TIME 99 9054
TEST_TIME 100 9068
TEST_TIME 101 9121
TEST_TIME 102 9227
TEST_TIME 103 9185
TEST_TIME 104 9202
TEST_TIME 105 9323
TEST_TIME 106 9294
TEST_TIME 107 9253
TEST_TIME 108 9394
TEST_TIME 109 9321
TEST_TIME 110 9292
TEST_TIME 111 9249
TEST_TIME 112 9269
TEST_TIME 113 9240
TEST_TIME 114 9192
TEST_TIME 115 9174
TEST_TIME 116 9147
TEST_TIME 117 9119
TEST_TIME 118 9129
TEST_TIME 119 9141
TEST_TIME 120 9086

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 15-02-2023 22:40:46 to 15-02-2023 22:40:49.

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 1493452 1493452 0 0.00 0 33741 6 0 0
doc_list_biud 1493450 1493450 0 0.00 0 37762 26 0 0
sp_add_invoice_to_stock 4849 4691 158 3.25 43 148764 17662 0 158
sp_cancel_adding_invoice 5736 5736 0 0.00 4 79630 724 0 0
sp_cancel_client_order 1638 1638 0 0.00 4 11114 353 0 0
sp_cancel_customer_reserve 571870 571870 0 0.00 0 22526 52 0 0
sp_cancel_pay_from_customer 633 633 0 0.00 3 2812 64 0 0
sp_cancel_pay_to_supplier 394 394 0 0.00 3 3023 70 0 0
sp_cancel_supplier_invoice 6308 6298 10 0.15 2 30260 727 0 10
sp_cancel_supplier_order 379 379 0 0.00 12 1088429 99848 0 0
sp_cancel_write_off 10986 10986 0 0.00 1 7477 87 0 0
sp_client_order 18936 18936 0 0.00 3 25722 392 0 0
sp_customer_reserve 435834 435834 0 0.00 0 51626 174 0 0
sp_fill_shopping_cart 29127 29127 0 0.00 1 23247 40 0 0
sp_fill_shopping_cart_clo_res 435823 435823 0 0.00 0 24205 14 0 0
sp_get_clo_for_invoice 4680 4680 0 0.00 0 27066 366 0 0
sp_kill_cost_storno 17749 17749 0 0.00 0 13428 48 0 0
sp_kill_qstorno_ret_qs2qd 1161403 1161403 0 0.00 0 30217 28 0 0
sp_kill_qty_storno 610873 610873 0 0.00 0 37762 62 0 0
sp_lock_selected_doc 19311 19311 0 0.00 0 5844 4 0 0
sp_make_cost_storno 25845 25845 0 0.00 0 13019 48 0 0
sp_multiply_rows_for_pdistr 25845 25845 0 0.00 0 7400 26 0 0
sp_multiply_rows_for_qdistr 18936 18936 0 0.00 0 20359 170 0 0
sp_pay_from_customer 6468 6468 0 0.00 4 11840 101 0 0
sp_pay_to_supplier 5411 5411 0 0.00 5 6486 110 0 0
sp_payment_common 11879 11879 0 0.00 1 6208 24 0 0
sp_qd_handle_on_cancel_clo 1638 1638 0 0.00 0 11107 325 0 0
sp_qd_handle_on_invoice_upd_sts 10416 10416 0 0.00 0 37760 318 0 0
sp_qd_handle_on_reserve_upd_sts 9286 9286 0 0.00 0 13876 68 0 0
sp_reserve_write_off 9286 9286 0 0.00 6 14121 177 0 0
sp_supplier_invoice 5093 5093 0 0.00 6 81317 3392 0 0
sp_supplier_order 5105 5105 0 0.00 4 45150 1287 0 0
srv_aggregate_perf_data 100 100 0 0.00 2944 104346 16251 0 0
srv_fill_mon_cache_memory 62 62 0 0.00 831 157872 50467 0 0
srv_find_qd_qs_mism 1045714 1045714 0 0.00 0 33740 5 0 0
srv_make_invnt_saldo 522 522 0 0.00 39 92142 1293 0 0
srv_make_money_saldo 758 758 0 0.00 1 2361 26 0 0
srv_recalc_idx_stat 4 4 0 0.00 254675 472951 329984 0 0
t$perf-abend:sp_add_invoice_to_stock 158 158 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 10 10 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4691 4691 0 0.00 0 13127 172 0 0
t$perf-norm:sp_cancel_adding_invoice 362 362 0 0.00 0 11665 134 0 0
t$perf-norm:sp_cancel_client_order 1638 1638 0 0.00 0 7590 31 0 0
t$perf-norm:sp_cancel_customer_reserve 599 599 0 0.00 0 6283 27 0 0
t$perf-norm:sp_cancel_pay_from_customer 633 633 0 0.00 0 2739 8 0 0
t$perf-norm:sp_cancel_pay_to_supplier 394 394 0 0.00 0 510 4 0 0
t$perf-norm:sp_cancel_supplier_invoice 379 379 0 0.00 0 1234 15 0 0
t$perf-norm:sp_cancel_supplier_order 379 379 0 0.00 0 25137 1843 0 0
t$perf-norm:sp_cancel_write_off 961 961 0 0.00 0 2131 9 0 0
t$perf-norm:sp_client_order 18936 18936 0 0.00 0 11940 18 0 0
t$perf-norm:sp_customer_reserve 933 933 0 0.00 0 3427 11 0 0
t$perf-norm:sp_pay_from_customer 6468 6468 0 0.00 0 7415 17 0 0
t$perf-norm:sp_pay_to_supplier 5411 5411 0 0.00 0 6293 13 0 0
t$perf-norm:sp_reserve_write_off 9286 9286 0 0.00 0 11665 17 0 0
t$perf-norm:sp_supplier_invoice 5093 5093 0 0.00 0 8085 17 0 0
t$perf-norm:sp_supplier_order 5105 5105 0 0.00 0 7892 17 0 0
t$perf-norm:srv_aggregate_perf_data 100 100 0 0.00 0 410 10 0 0
t$perf-norm:srv_fill_mon_cache_memory 62 62 0 0.00 0 2331 50 0 0
t$perf-norm:srv_make_invnt_saldo 522 522 0 0.00 0 3336 24 0 0
t$perf-norm:srv_make_money_saldo 758 758 0 0.00 0 1238 13 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 6 4 0 0
v_add_invoice_to_stock 9676 9360 316 3.26 0 3732 18 0 316
v_all_customers 34708 34708 0 0.00 0 24 0 0 0
v_all_suppliers 28242 28242 0 0.00 0 19 1 0 0
v_all_wares 37872 37872 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 724 724 0 0.00 0 2077 8 0 0
v_cancel_client_order 3276 3276 0 0.00 0 6196 7 0 0
v_cancel_customer_prepayment 1266 1266 0 0.00 0 2390 5 0 0
v_cancel_customer_reserve 1198 1198 0 0.00 0 998 4 0 0
v_cancel_payment_to_supplier 788 788 0 0.00 0 2987 8 0 0
v_cancel_supplier_invoice 778 758 20 2.57 0 972 14 0 20
v_cancel_supplier_order 758 758 0 0.00 0 2217 9 0 0
v_cancel_write_off 1922 1922 0 0.00 0 3029 14 0 0
v_max_id_clo_ord 5105 5105 0 0.00 0 294 1 0 0
v_max_id_clo_res 933 933 0 0.00 0 6441 17 0 0
v_max_id_ord_sup 5086 5086 0 0.00 0 5859 7 0 0
v_max_non_paid_invoice 1481 1481 0 0.00 0 1632 6 0 0
v_max_non_paid_realizn 3352 3352 0 0.00 0 3967 5 0 0
v_min_id_clo_ord 5105 5105 0 0.00 0 2770 6 0 0
v_min_id_clo_res 933 933 0 0.00 0 4688 21 0 0
v_min_id_ord_sup 5086 5086 0 0.00 0 4870 4 0 0
v_min_non_paid_invoice 5411 5411 0 0.00 0 6202 18 0 0
v_min_non_paid_realizn 6468 6468 0 0.00 0 5222 17 0 0
v_our_firm 9396 9396 0 0.00 0 25 1 0 0
v_reserve_write_off 18572 18572 0 0.00 0 5611 6 0 0
x_lock_depdocs_on_canc_invoice 11655 11655 0 0.00 0 25468 115 0 0
x_lock_depdocs_on_canc_sup_ord 379 379 0 0.00 0 9448 354 0 0
x_make_qstorno_1000_1200 5105 5105 0 0.00 1 45125 1206 0 0
x_make_qstorno_1200_2000 5093 5093 0 0.00 1 80169 3248 0 0
x_make_qstorno_2100_3300 435834 435834 0 0.00 0 51626 157 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 15-02-2023 22:40:50 to 15-02-2023 22:40:55.

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:46 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:47 26830 8192000000 9895185312 10203111424 976080368 10.646 100 88 176 0 1005565888 6411376 23074144
20:11:18 19722 8192000000 9934760816 10255462400 1015771520 11.031 100 90 179 1 1047793504 8587120 23434864
20:12:42 11429 8192000000 9971397072 10302820352 1055141200 11.410 100 87 174 0 1087525712 10236016 22148496
20:13:57 10120 8192000000 10028297824 10373238784 1108844832 11.921 100 78 154 1 1137994560 9890736 19258992
20:15:12 7099 8192000000 10071088016 10427142144 1153715264 12.344 100 85 168 1 1185220176 11662448 19842464
20:16:21 3073 8192000000 10110154768 10475282432 1194869728 12.729 100 79 158 0 1225990112 14114816 17005568
20:17:26 2628 8192000000 10137723760 10511343616 1226515152 13.022 100 79 158 0 1258350736 14892368 16943216
20:18:30 8908 8192000000 10163933552 10547593216 1261279168 13.342 100 71 138 1 1288487808 12335648 14872992
20:19:41 1158 8192000000 10196158256 10585292800 1289445792 13.599 100 87 172 0 1320692720 12455472 18791456
20:20:44 10895 8192000000 10204671008 10597597184 1297140448 13.669 100 72 144 0 1324575840 10752560 16682832
20:21:58 3707 8192000000 10200893056 10609262592 1309741904 13.784 100 38 76 2 1324238864 6202592 8294368
20:23:02 5868 8192000000 10199983888 10615496704 1314059552 13.823 100 28 56 0 1327568832 7143264 6366016
20:24:09 6086 8192000000 10203182320 10619904000 1318578048 13.864 100 16 32 0 1328412912 6233232 3601632
20:25:16 52532 8192000000 10233346960 10638209024 1323018096 13.904 100 41 81 0 1337698400 4971376 9708928
20:27:09 4248 8192000000 10214007984 10628050944 1320670672 13.883 100 30 62 0 1333806912 5457360 7678880
20:28:18 3944 8192000000 10203509072 10625998848 1315796288 13.839 100 26 52 1 1328612288 7083600 5732400
20:29:26 45463 8192000000 10153701744 10564939776 1186340864 12.649 91 24 47 0 1196944960 5118800 5485296
20:31:12 7275 8192000000 10164101232 10572103680 1231367744 13.067 96 18 36 0 1240239136 4890640 3980752
20:32:20 6739 8192000000 10130903200 10528681984 1222846048 12.988 98 33 66 0 1237014320 6253216 7915056
20:33:27 61076 8192000000 10171319872 10574753792 1261603488 13.345 99 38 76 0 1276543008 6322880 8616640
20:35:32 4171 8192000000 10184530496 10592477184 1288415008 13.590 100 27 54 0 1300654496 6433104 5806384
20:36:37 10360 8192000000 10189546544 10605699072 1297205952 13.670 100 19 35 1 1307116192 6294032 3616208
20:37:52 7334 8192000000 10202587168 10616426496 1305424304 13.745 100 23 47 0 1316461760 5800480 5236976
20:39:04 86303 8192000000 10226018384 10640150528 1315945600 13.840 99 41 83 0 1332351440 7540512 8865328
20:41:36 35247 8192000000 10262904416 10681839616 1353491728 14.179 100 44 88 0 1374981760 11608800 9881232
20:43:15 11613 8192000000 10289225360 10702635008 1368358128 14.312 100 48 96 0 1394404384 15423600 10622656
20:44:34 15213 8192000000 10293961488 10711879680 1377110864 14.391 100 49 97 1 1406049104 17482880 11455360
20:45:54 16681 8192000000 10298972256 10726121472 1389179168 14.499 100 33 66 0 1414559088 17295168 8084752
20:47:27 5327 8192000000 10324041760 10749325312 1405712080 14.646 100 54 107 0 1440838944 21967232 13159632
20:48:38 2441 8192000000 10348392544 10768007168 1414485968 14.724 100 68 134 0 1461862128 31414528 15961632
20:49:47 15408 8192000000 10333380064 10755506176 1383291168 14.446 98 61 122 0 1433083072 34027936 15763968
20:51:05 2334 8192000000 10344421328 10758995968 1400446512 14.599 100 70 137 1 1448355392 31703376 16205504
20:52:11 828 8192000000 10348876672 10761678848 1401934544 14.612 100 86 168 0 1453081680 31436720 19710416
20:53:16 5898 8192000000 10341705712 10756120576 1398342112 14.580 100 68 136 0 1445114512 30134496 16637904
20:54:39 4690 8192000000 10349259696 10768547840 1400455536 14.599 100 68 136 0 1456606480 37426784 18724160
20:55:52 1062 8192000000 10340563744 10746810368 1374609872 14.368 98 94 189 3 1433500352 35325472 23565008
20:56:57 9631 8192000000 10312685280 10735349760 1369930848 14.326 99 41 82 1 1413536384 32950336 10655200
20:58:12 12715 8192000000 10312684656 10743762944 1371542304 14.341 100 27 54 0 1418538528 38956304 8039920
20:59:29 25494 8192000000 10311771520 10749960192 1372272672 14.347 99 23 45 0 1410323664 31740128 6310864
21:01:07 30219 8192000000 10293122848 10723250176 1330107472 13.968 97 20 38 0 1366413216 30241072 6064672
21:02:39 24691 8192000000 10295856672 10728108032 1338364736 14.043 98 27 54 0 1385583968 39605408 7613824
21:04:06 30534 8192000000 10271080544 10706513920 1336438736 14.025 99 18 36 0 1379560432 38341456 4780240
21:05:37 50662 8192000000 10257526432 10700374016 1338395984 14.043 100 13 26 0 1363273984 21410752 3467248
21:07:38 36267 8192000000 10272254032 10711068672 1349063648 14.139 99 21 42 0 1368061680 14429008 4569024
21:09:30 44643 8192000000 10269698288 10716028928 1357457056 14.215 100 15 30 0 1377297888 16830096 3010736
21:11:16 50229 8192000000 10271752064 10731454464 1370682448 14.333 100 17 34 0 1395901184 20774928 4443808
21:13:16 39700 8192000000 10287259568 10722279424 1351911680 14.165 98 37 72 2 1368008608 8069152 8027776
21:15:00 62726 8192000000 10273033408 10723446784 1359316272 14.231 99 17 30 0 1377393216 14517824 3559120
21:17:05 63612 8192000000 10279312240 10718302208 1351342400 14.160 98 40 80 1 1382640672 20666192 10632080
21:19:20 56246 8192000000 10282939808 10749616128 1381570736 14.431 100 18 36 0 1407601008 21625632 4404640
21:21:26 64048 8192000000 10294239712 10744528896 1383580672 14.449 100 8 16 0 1404493696 18888528 2024496
21:23:38 4385 8192000000 10299262944 10748362752 1395388224 14.554 100 43 86 1 1415122352 10018512 9715616
21:24:44 65289 8192000000 10291163440 10759794688 1386435968 14.474 99 14 28 1 1405788192 15927808 3424416
21:26:52 32867 8192000000 10299452496 10758107136 1394709680 14.548 100 47 95 0 1415043760 9092800 11241280
21:28:27 76442 8192000000 10315393488 10768203776 1375515616 14.376 98 28 56 0 1398798192 16942816 6339760
21:30:48 93516 8192000000 10301160112 10764570624 1383623904 14.449 99 7 14 0 1399463392 14360336 1479152
21:33:27 96441 8192000000 10322859920 10774667264 1363386016 14.268 97 23 46 0 1386235264 17798464 5050784
21:36:04 137319 8192000000 10296970048 10740486144 1260431664 13.334 90 11 22 0 1280170096 17574400 2164032
21:39:22 91270 8192000000 10273430640 10729754624 1341820416 14.074 97 8 16 0 1363816368 20642688 1353264
21:42:24 59389 8192000000 10272694128 10714218496 1359304976 14.231 99 29 59 0 1373802912 7820992 6676944
21:44:25 65442 8192000000 10251068176 10698248192 1324678992 13.919 97 9 18 0 1334406176 7872592 1854592
21:46:35 86220 8192000000 10221717872 10674135040 1312800912 13.811 96 13 22 0 1328193696 12612560 2780224
21:49:26 54919 8192000000 10253002272 10708910080 1349479248 14.143 99 21 42 0 1368340880 13965024 4896608
21:51:22 85194 8192000000 10259552864 10718605312 1345356032 14.106 98 20 41 0 1362528608 12844576 4328000
21:53:51 42606 8192000000 10262756752 10712068096 1335930352 14.021 97 11 22 0 1355079376 16258400 2890624
21:55:34 68561 8192000000 10289019840 10739761152 1355401072 14.196 98 17 34 0 1374615472 15456944 3757456
21:58:03 31435 8192000000 10273875568 10722897920 1344258928 14.096 98 20 40 1 1360898480 12355984 4283568
21:59:36 82045 8192000000 10268586384 10725679104 1334803552 14.011 97 11 22 1 1354605952 17260080 2542320
22:02:06 74786 8192000000 10270283712 10716569600 1291453888 13.617 94 23 46 0 1306105120 9777456 4873776
22:04:22 71406 8192000000 10285664400 10720952320 1336720960 14.028 97 29 58 0 1356796624 14006080 6069584
22:06:35 157872 8192000000 10284071280 10732732416 1367368624 14.303 99 30 61 0 1386662320 12127280 7166416
22:10:24 58512 8192000000 10286405984 10745384960 1393044320 14.533 100 17 34 0 1403053792 6407952 3601520
22:12:31 61700 8192000000 10292754208 10746990592 1382905056 14.443 99 6 12 0 1391103744 7015296 1183392
22:14:38 65754 8192000000 10318375504 10775203840 1405984576 14.648 100 10 20 0 1418397680 10221632 2191472
22:16:46 48867 8192000000 10292331104 10741903360 1328578880 13.954 95 18 37 0 1339983168 7459840 3944448
22:18:42 118262 8192000000 10282960800 10755022848 1352187776 14.167 97 14 28 1 1370650800 14986448 3476576
22:21:41 27902 8192000000 10316750576 10756653056 1390298288 14.509 100 29 56 0 1409552000 12761408 6492304
22:23:37 80789 8192000000 10294216064 10741084160 1337164336 14.032 96 5 10 0 1354139792 16169760 805696
22:25:58 97577 8192000000 10295969664 10769686528 1363494320 14.269 98 14 28 0 1386181888 19395440 3292128
22:29:01 57760 8192000000 10283075952 10735173632 1353674016 14.181 98 25 50 0 1372252688 13420208 5158464
22:30:59 57505 8192000000 10261623632 10725539840 1336068032 14.022 97 25 49 1 1351528944 10275552 5185360
22:32:56 32708 8192000000 10270600304 10731257856 1362853696 14.263 99 7 14 0 1374647968 10473696 1320576
22:34:33 63293 8192000000 10274492592 10730659840 1335670576 14.018 96 14 26 0 1351180864 12492144 3018144
22:36:37 42728 8192000000 10274062048 10734477312 1360023728 14.238 99 28 56 0 1376331504 10049216 6258560
22:38:21 33702 8192000000 9163648768 9420939264 329441408 3.866 24 4 8 0 336394976 6105552 848016

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 158 v_add_invoice_to_stock 335544517
except 10 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 15-02-2023 22:41:12 to 15-02-2023 22:41:14.

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

15.02.23 22:41:16. 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-15 22:41:18 No severe PSQL-related problems occured
15.02.23 22:41:19. End of report.