Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 18.11.2021 16:38
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 16875620 kB
MemAvailable 31559396 kB
Buffers 0 kB
Cached 14770784 kB
SwapCached 0 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.8
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 2021-11-18 16:38:16
DTS_END                         2021-11-18 16:37:58.1160
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/35128
TRN_ID                          245259
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: 9418.83 23582 1130260
customer order: creation 174.33 331 20920
customer order: refuse 14.69 329 1763
order to supplier: creation 49.05 1177 5886
order to supplier: removal 3.26 100056 391
invoice (draft): creation 46.93 3328 5631
invoice (draft): removal 53.18 756 6382
invoice accept: apply 42.93 16615 5151
invoice accept: cancel 48.08 711 5769
customer reserve: creation 3935.33 167 472240
customer reserve: removal 4737.02 54 568443
realization accept: apply 85.31 156 10237
realization accept: cancel 95.08 100 11410
payment from customer: creation 60.74 99 7289
payment from customer: removal 5.89 75 707
payment to supplier: creation 50.48 112 6058
payment to supplier: removal 3.53 60 424
service: total inventory turnovers 5.14 998 617
service: total monetary turnovers 6.84 34 821
service: aggregate perf. data 0.98 16242 117
service: refresh index statistics 0.03 330248 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 18-11-2021 16:39:16 to 18-11-2021 16:39:18.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 1806
TEST_TIME 2 1786
TEST_TIME 3 2202
TEST_TIME 4 2451
TEST_TIME 5 2847
TEST_TIME 6 3097
TEST_TIME 7 3395
TEST_TIME 8 3872
TEST_TIME 9 4206
TEST_TIME 10 4422
TEST_TIME 11 4667
TEST_TIME 12 5484
TEST_TIME 13 5807
TEST_TIME 14 6097
TEST_TIME 15 6641
TEST_TIME 16 6770
TEST_TIME 17 8023
TEST_TIME 18 8117
TEST_TIME 19 8680
TEST_TIME 20 8699
TEST_TIME 21 8982
TEST_TIME 22 9023
TEST_TIME 23 9898
TEST_TIME 24 10847
TEST_TIME 25 10890
TEST_TIME 26 10877
TEST_TIME 27 10777
TEST_TIME 28 10787
TEST_TIME 29 10547
TEST_TIME 30 10468
TEST_TIME 31 10366
TEST_TIME 32 10169
TEST_TIME 33 10021
TEST_TIME 34 10093
TEST_TIME 35 10081
TEST_TIME 36 10059
TEST_TIME 37 9930
TEST_TIME 38 9773
TEST_TIME 39 9729
TEST_TIME 40 9759
TEST_TIME 41 9740
TEST_TIME 42 9754
TEST_TIME 43 9764
TEST_TIME 44 9652
TEST_TIME 45 9660
TEST_TIME 46 9628
TEST_TIME 47 9594
TEST_TIME 48 9518
TEST_TIME 49 9590
TEST_TIME 50 9591
TEST_TIME 51 9667
TEST_TIME 52 9709
TEST_TIME 53 9673
TEST_TIME 54 9800
TEST_TIME 55 9754
TEST_TIME 56 9743
TEST_TIME 57 9918
TEST_TIME 58 9813
TEST_TIME 59 9864
TEST_TIME 60 10024
TEST_TIME 61 10008
TEST_TIME 62 9876
TEST_TIME 63 9860
TEST_TIME 64 9788
TEST_TIME 65 9764
TEST_TIME 66 9802
TEST_TIME 67 9703
TEST_TIME 68 9707
TEST_TIME 69 9643
TEST_TIME 70 9564
TEST_TIME 71 9502
TEST_TIME 72 9528
TEST_TIME 73 9556
TEST_TIME 74 9527
TEST_TIME 75 9487
TEST_TIME 76 9539
TEST_TIME 77 9542
TEST_TIME 78 9586
TEST_TIME 79 9620
TEST_TIME 80 9576
TEST_TIME 81 9573
TEST_TIME 82 9551
TEST_TIME 83 9720
TEST_TIME 84 9723
TEST_TIME 85 9808
TEST_TIME 86 9786
TEST_TIME 87 9754
TEST_TIME 88 9661
TEST_TIME 89 9667
TEST_TIME 90 9636
TEST_TIME 91 9656
TEST_TIME 92 9592
TEST_TIME 93 9579
TEST_TIME 94 9522
TEST_TIME 95 9496
TEST_TIME 96 9504
TEST_TIME 97 9532
TEST_TIME 98 9468
TEST_TIME 99 9538
TEST_TIME 100 9606
TEST_TIME 101 9602
TEST_TIME 102 9579
TEST_TIME 103 9553
TEST_TIME 104 9621
TEST_TIME 105 9595
TEST_TIME 106 9574
TEST_TIME 107 9637
TEST_TIME 108 9629
TEST_TIME 109 9579
TEST_TIME 110 9616
TEST_TIME 111 9543
TEST_TIME 112 9507
TEST_TIME 113 9468
TEST_TIME 114 9485
TEST_TIME 115 9421
TEST_TIME 116 9401
TEST_TIME 117 9461
TEST_TIME 118 9415
TEST_TIME 119 9429
TEST_TIME 120 9421
TEST_TIME 121 9343

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 18-11-2021 16:39:20 to 18-11-2021 16:39:23.

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 1568061 1568061 0 0.00 0 15413 6 0 0
doc_list_biud 1568061 1568061 0 0.00 0 31344 25 0 0
sp_add_invoice_to_stock 5257 5151 106 2.01 25 210110 16616 0 106
sp_cancel_adding_invoice 5769 5769 0 0.00 5 65776 712 0 0
sp_cancel_client_order 1763 1763 0 0.00 4 15193 330 0 0
sp_cancel_customer_reserve 568443 568443 0 0.00 1 22092 55 0 0
sp_cancel_pay_from_customer 707 707 0 0.00 2 5592 75 0 0
sp_cancel_pay_to_supplier 424 424 0 0.00 2 2326 60 0 0
sp_cancel_supplier_invoice 6387 6382 5 0.07 2 31440 757 0 5
sp_cancel_supplier_order 391 391 0 0.00 8 899724 100057 0 0
sp_cancel_write_off 11410 11410 0 0.00 1 14297 101 0 0
sp_client_order 20920 20920 0 0.00 3 14297 331 0 0
sp_customer_reserve 472240 472240 0 0.00 0 72522 167 0 0
sp_fill_shopping_cart 32424 32424 0 0.00 1 9893 37 0 0
sp_fill_shopping_cart_clo_res 472235 472235 0 0.00 0 41849 14 0 0
sp_get_clo_for_invoice 5146 5146 0 0.00 0 40307 308 0 0
sp_kill_cost_storno 18310 18310 0 0.00 0 9658 50 0 0
sp_kill_qstorno_ret_qs2qd 1155069 1155069 0 0.00 0 31344 30 0 0
sp_kill_qty_storno 609539 609539 0 0.00 0 31344 64 0 0
sp_lock_selected_doc 21260 21260 0 0.00 0 9763 6 0 0
sp_make_cost_storno 28728 28728 0 0.00 0 11983 46 0 0
sp_multiply_rows_for_pdistr 28728 28728 0 0.00 0 9541 24 0 0
sp_multiply_rows_for_qdistr 20920 20920 0 0.00 0 8925 162 0 0
sp_pay_from_customer 7289 7289 0 0.00 4 11534 100 0 0
sp_pay_to_supplier 6058 6058 0 0.00 5 12002 112 0 0
sp_payment_common 13347 13347 0 0.00 1 11024 24 0 0
sp_qd_handle_on_cancel_clo 1763 1763 0 0.00 0 15186 298 0 0
sp_qd_handle_on_invoice_upd_sts 10913 10913 0 0.00 0 14384 280 0 0
sp_qd_handle_on_reserve_upd_sts 10237 10237 0 0.00 0 17517 56 0 0
sp_reserve_write_off 10237 10237 0 0.00 6 17570 156 0 0
sp_supplier_invoice 5631 5631 0 0.00 7 95762 3328 0 0
sp_supplier_order 5886 5886 0 0.00 5 29312 1178 0 0
srv_aggregate_perf_data 117 117 0 0.00 2654 205519 16243 0 0
srv_fill_mon_cache_memory 60 60 0 0.00 2360 129325 53713 0 0
srv_find_qd_qs_mism 1081567 1081567 0 0.00 0 15412 5 0 0
srv_make_invnt_saldo 617 617 0 0.00 43 48066 998 0 0
srv_make_money_saldo 821 821 0 0.00 1 7253 35 0 0
srv_recalc_idx_stat 4 4 0 0.00 254243 375320 330248 0 0
t$perf-abend:sp_add_invoice_to_stock 106 106 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 5151 5151 0 0.00 0 17082 170 0 0
t$perf-norm:sp_cancel_adding_invoice 410 410 0 0.00 0 11058 103 0 0
t$perf-norm:sp_cancel_client_order 1763 1763 0 0.00 0 5079 13 0 0
t$perf-norm:sp_cancel_customer_reserve 708 708 0 0.00 0 264 4 0 0
t$perf-norm:sp_cancel_pay_from_customer 707 707 0 0.00 0 5217 10 0 0
t$perf-norm:sp_cancel_pay_to_supplier 424 424 0 0.00 0 385 2 0 0
t$perf-norm:sp_cancel_supplier_invoice 443 443 0 0.00 0 420 12 0 0
t$perf-norm:sp_cancel_supplier_order 391 391 0 0.00 0 19910 1580 0 0
t$perf-norm:sp_cancel_write_off 1033 1033 0 0.00 0 2633 8 0 0
t$perf-norm:sp_client_order 20920 20920 0 0.00 0 12288 14 0 0
t$perf-norm:sp_customer_reserve 1065 1065 0 0.00 0 1179 3 0 0
t$perf-norm:sp_pay_from_customer 7289 7289 0 0.00 0 9283 15 0 0
t$perf-norm:sp_pay_to_supplier 6058 6058 0 0.00 0 17022 19 0 0
t$perf-norm:sp_reserve_write_off 10237 10237 0 0.00 0 17024 12 0 0
t$perf-norm:sp_supplier_invoice 5631 5631 0 0.00 0 8744 16 0 0
t$perf-norm:sp_supplier_order 5886 5886 0 0.00 0 6481 15 0 0
t$perf-norm:srv_aggregate_perf_data 117 117 0 0.00 0 852 13 0 0
t$perf-norm:srv_fill_mon_cache_memory 60 60 0 0.00 0 2170 41 0 0
t$perf-norm:srv_make_invnt_saldo 617 617 0 0.00 0 1455 12 0 0
t$perf-norm:srv_make_money_saldo 821 821 0 0.00 0 2604 12 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 92 25 0 0
v_add_invoice_to_stock 10500 10288 212 2.01 0 4852 19 0 212
v_all_customers 38350 38350 0 0.00 0 17 0 0 0
v_all_suppliers 31728 31728 0 0.00 0 22 1 0 0
v_all_wares 41838 41838 0 0.00 0 80 1 0 0
v_cancel_adding_invoice 820 820 0 0.00 0 4000 11 0 0
v_cancel_client_order 3526 3526 0 0.00 0 4857 6 0 0
v_cancel_customer_prepayment 1414 1414 0 0.00 0 4857 6 0 0
v_cancel_customer_reserve 1416 1416 0 0.00 0 1936 4 0 0
v_cancel_payment_to_supplier 848 848 0 0.00 0 1476 6 0 0
v_cancel_supplier_invoice 896 886 10 1.11 0 4143 22 0 10
v_cancel_supplier_order 782 782 0 0.00 0 1600 5 0 0
v_cancel_write_off 2066 2066 0 0.00 0 4879 16 0 0
v_max_id_clo_ord 5884 5884 0 0.00 0 215 1 0 0
v_max_id_clo_res 1065 1065 0 0.00 0 5100 36 0 0
v_max_id_ord_sup 5619 5619 0 0.00 0 3647 4 0 0
v_max_non_paid_invoice 1697 1697 0 0.00 0 1406 3 0 0
v_max_non_paid_realizn 3843 3843 0 0.00 0 1501 4 0 0
v_min_id_clo_ord 5884 5884 0 0.00 0 3184 7 0 0
v_min_id_clo_res 1065 1065 0 0.00 0 8160 24 0 0
v_min_id_ord_sup 5619 5619 0 0.00 0 5550 9 0 0
v_min_non_paid_invoice 6058 6058 0 0.00 0 11020 18 0 0
v_min_non_paid_realizn 7289 7289 0 0.00 0 8002 18 0 0
v_our_firm 10380 10380 0 0.00 0 15 1 0 0
v_reserve_write_off 20474 20474 0 0.00 0 4859 6 0 0
x_lock_depdocs_on_canc_invoice 11708 11708 0 0.00 0 20042 102 0 0
x_lock_depdocs_on_canc_sup_ord 391 391 0 0.00 0 8023 302 0 0
x_make_qstorno_1000_1200 5886 5886 0 0.00 1 29280 1103 0 0
x_make_qstorno_1200_2000 5631 5631 0 0.00 3 95741 3201 0 0
x_make_qstorno_2100_3300 472240 472240 0 0.00 0 72520 151 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 18-11-2021 16:39:24 to 18-11-2021 16:39:28.

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:01 6 8192000000 8799918544 8811413504 6309952 0.076 2 1 2 0 6409584 56848 42784
14:09:03 42616 8192000000 9918881472 10235359232 984583088 10.729 100 88 174 1 1013489200 6037584 22868528
14:10:51 20412 8192000000 9973146576 10299793408 1049759120 11.358 100 87 174 0 1080663104 8989248 21914736
14:12:18 13443 8192000000 10000472304 10341924864 1087451808 11.718 100 80 160 0 1117104224 10389952 19262464
14:13:35 10749 8192000000 10052750640 10407833600 1143070576 12.244 100 82 164 0 1173414752 10967584 19376592
14:14:49 9051 8192000000 10098140336 10460372992 1179018256 12.581 100 77 154 2 1208830960 11597760 18214944
14:16:01 4306 8192000000 10133482736 10506997760 1227490528 13.031 100 81 161 0 1257045616 11423984 18131104
14:17:07 6191 8192000000 10168107088 10547929088 1254736816 13.282 100 80 158 1 1286933952 14257472 17939664
14:18:15 2279 8192000000 10201211456 10587377664 1289649936 13.601 100 87 174 1 1322147712 12773632 19724144
14:19:18 4899 8192000000 10193524624 10594562048 1299885120 13.694 100 44 86 2 1319853808 10160880 9807808
14:20:25 2034 8192000000 10196919392 10605084672 1306245872 13.752 100 40 80 2 1322994448 7970096 8778480
14:21:30 18458 8192000000 10237618512 10631340032 1310955792 13.795 100 80 158 3 1335556064 6524400 18075872
14:22:50 2860 8192000000 10220950960 10633437184 1322914656 13.903 100 40 80 0 1340445984 8492336 9038992
14:23:53 5434 8192000000 10222076832 10639781888 1330397616 13.971 100 29 58 1 1345155904 7646432 7111856
14:25:03 28193 8192000000 10243794576 10643697664 1332975088 13.994 100 70 142 1 1355657984 5804624 16878272
14:26:31 5089 8192000000 10235089248 10651082752 1337654976 14.036 100 42 85 1 1354654496 7717840 9281680
14:27:38 5564 8192000000 10207525888 10621739008 1301477120 13.709 98 23 46 0 1312741456 5955072 5309264
14:28:47 43419 8192000000 10161370976 10570489856 1194755904 12.728 91 35 69 3 1208347376 5286576 8304896
14:30:33 4623 8192000000 10153617072 10553778176 1250799600 13.246 99 32 63 0 1264886816 7030064 7057152
14:31:38 5712 8192000000 10145431744 10540253184 1227861408 13.034 98 30 61 4 1241147392 6191632 7094352
14:32:45 42341 8192000000 10154276032 10560630784 1244084080 13.184 98 22 44 2 1254950192 5365232 5500880
14:34:41 6806 8192000000 10176066528 10580512768 1281378384 13.526 100 35 70 2 1295905568 6388176 8139008
14:35:50 8418 8192000000 10194825312 10604515328 1299244144 13.688 100 23 45 0 1309799888 5383760 5171984
14:36:59 8462 8192000000 10203373248 10617114624 1311088448 13.796 100 21 42 0 1321662176 5573680 5000048
14:38:07 117224 8192000000 10245822368 10659397632 1337349824 14.034 100 35 69 2 1354868000 8135984 9382192
14:41:08 23054 8192000000 10280038592 10695770112 1366756608 14.298 100 42 82 2 1391151136 14927504 9467024
14:42:43 17407 8192000000 10294899984 10713362432 1386196928 14.472 100 39 77 2 1411592256 16279824 9115504
14:44:36 18081 8192000000 10322149296 10745307136 1406296400 14.651 100 45 90 1 1440138576 22414992 11427184
14:45:59 9640 8192000000 10327955904 10752036864 1406721072 14.655 100 43 86 3 1440999104 23276752 11001280
14:47:15 2824 8192000000 10347004960 10761138176 1402321936 14.616 99 62 123 3 1443018480 25607552 15088992
14:48:25 11763 8192000000 10361072112 10782777344 1422834368 14.798 100 54 105 2 1468706320 32207408 13664544
14:49:46 3925 8192000000 10362266240 10784575488 1414616848 14.725 99 66 132 1 1465901136 34964544 16319744
14:51:04 3239 8192000000 10365757152 10776100864 1405719696 14.646 100 79 159 1 1466855808 39976576 21159536
14:52:12 5744 8192000000 10338869552 10754600960 1376033152 14.381 99 61 121 0 1440338576 48801232 15504192
14:53:25 2389 8192000000 10374459296 10781646848 1399682928 14.592 100 87 175 2 1476656400 55359184 21614288
14:54:33 2360 8192000000 10376201024 10797019136 1407324864 14.660 100 66 132 1 1476391120 53177120 15889136
14:55:45 17601 8192000000 10324445488 10759860224 1361927312 14.255 98 36 71 0 1417725856 45750368 10048176
14:57:29 2860 8192000000 10301985696 10716073984 1331364064 13.979 97 64 126 1 1386063472 37887888 16811520
14:58:33 28219 8192000000 10313326176 10749837312 1370402032 14.331 100 22 43 4 1421236480 44928496 5905952
15:00:09 75549 8192000000 10256233136 10699730944 1300100464 13.696 96 19 38 1 1370791520 64683392 6007664
15:02:25 116608 8192000000 10275563664 10709757952 1330581264 13.972 98 15 30 1 1352232096 18295776 3355056
15:05:23 129323 8192000000 10250827472 10696450048 1319580416 13.873 97 23 46 1 1335018720 10333168 5105136
15:08:43 97847 8192000000 10252226384 10671599616 1256942496 13.302 93 11 22 2 1274854448 16018960 1892992
15:11:21 27165 8192000000 10258766688 10699186176 1339878784 14.056 99 34 68 0 1357276432 9516304 7881344
15:12:51 62647 8192000000 10242449664 10685579264 1334458368 14.007 98 26 52 1 1350080608 9727360 5894880
15:15:05 82562 8192000000 10291112704 10736627712 1383544128 14.448 100 17 33 2 1398072320 10566752 3961440
15:17:28 79927 8192000000 10290605392 10740453376 1384614064 14.458 100 30 60 0 1404286736 12611920 7060752
15:20:35 69020 8192000000 10292525968 10748289024 1387286912 14.482 100 21 42 0 1404742352 12711296 4744144
15:22:46 70196 8192000000 10286762656 10761859072 1390958800 14.514 100 6 12 0 1408987088 16654832 1373456
15:25:02 43004 8192000000 10295151216 10753257472 1386320640 14.473 99 25 50 0 1401723120 9930656 5471824
15:26:47 92289 8192000000 10312006912 10773680128 1399102160 14.587 100 15 30 1 1416356256 13826496 3427600
15:29:21 66796 8192000000 10311825744 10764476416 1380012512 14.417 98 17 34 0 1396615968 13042608 3560848
15:31:35 80137 8192000000 10298805536 10739249152 1331447552 13.980 95 10 20 0 1343477216 10035184 1994480
15:34:00 50608 8192000000 10291158320 10746454016 1366015024 14.291 99 17 34 1 1388815664 19252768 3547872
15:35:51 50391 8192000000 10299514624 10756063232 1369931104 14.326 99 29 58 1 1396305904 20038896 6335904
15:37:42 84713 8192000000 10289193392 10742562816 1356205360 14.203 98 15 30 0 1372723760 13512176 3006224
15:40:14 24667 8192000000 10287488832 10732912640 1361570016 14.251 98 38 74 2 1379002752 9269424 8163312
15:41:39 34590 8192000000 10264064144 10702520320 1333378960 13.998 96 34 68 0 1352811616 11884496 7548160
15:43:15 80120 8192000000 10253210688 10717712384 1329365600 13.961 97 6 12 0 1341809744 11182784 1261360
15:45:35 46618 8192000000 10238461280 10691379200 1325048048 13.922 98 13 26 1 1337182000 8596192 3537760
15:47:23 93584 8192000000 10260696688 10708549632 1327172512 13.942 97 22 43 0 1344456960 12433232 4851216
15:50:10 38219 8192000000 10248595728 10706731008 1336450368 14.025 99 23 44 1 1355124048 13875328 4798352
15:51:49 57598 8192000000 10265996784 10710011904 1311512672 13.800 96 23 46 0 1331552736 14671728 5368336
15:53:57 102260 8192000000 10277499088 10724036608 1353500496 14.179 99 23 46 1 1376114320 17445104 5168720
15:56:50 35615 8192000000 10284465536 10728271872 1358294960 14.222 99 27 52 0 1376768096 12065344 6407792
15:58:35 55386 8192000000 10296965360 10734342144 1334137360 14.005 97 20 40 0 1363168384 24306816 4724208
16:00:34 99180 8192000000 10282455904 10739290112 1330766144 13.974 97 16 32 0 1349601824 15200560 3635120
16:03:13 54059 8192000000 10277429248 10720813056 1302920704 13.722 95 14 28 1 1318919504 13031856 2966944
16:05:11 92903 8192000000 10286481424 10730823680 1369703008 14.324 100 27 54 1 1387665904 11912960 6049936
16:07:48 54787 8192000000 10272660976 10733895680 1362820576 14.263 99 20 40 0 1381597664 14352576 4424512
16:09:45 60612 8192000000 10267148592 10734624768 1366750160 14.298 99 10 21 0 1381817552 12702672 2364720
16:11:49 57390 8192000000 10302328736 10758213632 1384033248 14.453 99 18 36 0 1400665776 12795776 3836752
16:13:47 49822 8192000000 10303234256 10756694016 1380834464 14.424 99 16 32 0 1396572304 12491408 3246432
16:15:40 36302 8192000000 10292814368 10740772864 1367300304 14.303 98 24 48 1 1385607984 12692944 5614736
16:17:19 92933 8192000000 10293409456 10753228800 1367064224 14.301 98 9 18 0 1385685248 16285488 2335536
16:20:16 17541 8192000000 10311639552 10752323584 1393994448 14.541 100 45 90 0 1415123408 10937456 10191504
16:21:47 64851 8192000000 10291354752 10733551616 1353349488 14.178 97 30 59 2 1371416752 11399888 6667376
16:23:57 30336 8192000000 10302348480 10744512512 1365540128 14.287 99 38 76 1 1387040816 13264928 8235760
16:25:30 47466 8192000000 10306306320 10748080128 1367258112 14.302 99 12 24 0 1381157824 10922624 2977088
16:27:26 115466 8192000000 10275193648 10705973248 1313597424 13.819 96 22 44 0 1327004016 8682688 4723904
16:30:21 59061 8192000000 10272971472 10727084032 1359043152 14.229 99 17 34 0 1374666064 11181728 4441184
16:32:30 53054 8192000000 10290706704 10748231680 1388694352 14.494 100 12 24 0 1406398144 14428784 3275008
16:34:24 54788 8192000000 10264484160 10719555584 1345386576 14.106 98 9 17 1 1362450832 14610512 2453744
16:36:29 68405 8192000000 10273884576 10725470208 1332116576 13.986 97 13 26 1 1347126256 11995392 3014288

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 18-11-2021 16:39:30 to 18-11-2021 16:39:45.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 106 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 18-11-2021 16:39:46 to 18-11-2021 16:39:48.

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          258308
MON$OLDEST_ACTIVE               258309
MON$OLDEST_SNAPSHOT             258309
MON$NEXT_TRANSACTION            258309
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                       2019328
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


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

18.11.21 16:39:49. 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
2021-11-18 16:39:51 No severe PSQL-related problems occured
18.11.21 16:39:52. End of report.