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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15296544 kB
MemAvailable 30413376 kB
Buffers 0 kB
Cached 16390288 kB
SwapCached 3096 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-03-11 22:38:59
DTS_END                         2023-03-11 22:38:41.6520
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/59382
TRN_ID                          235025
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: 9447.10 22485 1133652
customer order: creation 164.93 389 19791
customer order: refuse 13.78 375 1654
order to supplier: creation 44.22 1231 5306
order to supplier: removal 3.62 91549 434
invoice (draft): creation 45.42 3121 5450
invoice (draft): removal 54.99 687 6599
invoice accept: apply 40.52 16864 4862
invoice accept: cancel 49.92 694 5990
customer reserve: creation 3831.68 162 459802
customer reserve: removal 4906.96 53 588835
realization accept: apply 81.25 170 9750
realization accept: cancel 84.37 106 10124
payment from customer: creation 57.27 99 6872
payment from customer: removal 5.38 93 645
payment to supplier: creation 48.21 116 5785
payment to supplier: removal 3.12 86 374
service: total inventory turnovers 4.48 1090 538
service: total monetary turnovers 6.17 23 740
service: aggregate perf. data 0.81 19285 97
service: refresh index statistics 0.03 313512 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 11-03-2023 22:39:54 to 11-03-2023 22:39:56.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 947
TEST_TIME 2 952
TEST_TIME 3 1854
TEST_TIME 4 2641
TEST_TIME 5 3530
TEST_TIME 6 3705
TEST_TIME 7 4343
TEST_TIME 8 4196
TEST_TIME 9 4437
TEST_TIME 10 4486
TEST_TIME 11 4690
TEST_TIME 12 5075
TEST_TIME 13 5300
TEST_TIME 14 6083
TEST_TIME 15 6246
TEST_TIME 16 6862
TEST_TIME 17 7534
TEST_TIME 18 8007
TEST_TIME 19 7902
TEST_TIME 20 8579
TEST_TIME 21 8671
TEST_TIME 22 8904
TEST_TIME 23 8982
TEST_TIME 24 9383
TEST_TIME 25 9413
TEST_TIME 26 9663
TEST_TIME 27 10443
TEST_TIME 28 10331
TEST_TIME 29 10354
TEST_TIME 30 10238
TEST_TIME 31 10118
TEST_TIME 32 10032
TEST_TIME 33 9907
TEST_TIME 34 9904
TEST_TIME 35 9761
TEST_TIME 36 9770
TEST_TIME 37 9686
TEST_TIME 38 9725
TEST_TIME 39 9669
TEST_TIME 40 9717
TEST_TIME 41 9652
TEST_TIME 42 9504
TEST_TIME 43 9323
TEST_TIME 44 9303
TEST_TIME 45 9650
TEST_TIME 46 9567
TEST_TIME 47 9635
TEST_TIME 48 9708
TEST_TIME 49 9746
TEST_TIME 50 9789
TEST_TIME 51 9712
TEST_TIME 52 9760
TEST_TIME 53 9767
TEST_TIME 54 9875
TEST_TIME 55 9932
TEST_TIME 56 9922
TEST_TIME 57 9818
TEST_TIME 58 9785
TEST_TIME 59 9765
TEST_TIME 60 9708
TEST_TIME 61 9720
TEST_TIME 62 9684
TEST_TIME 63 9624
TEST_TIME 64 9549
TEST_TIME 65 9507
TEST_TIME 66 9472
TEST_TIME 67 9573
TEST_TIME 68 9545
TEST_TIME 69 9718
TEST_TIME 70 9650
TEST_TIME 71 9733
TEST_TIME 72 9750
TEST_TIME 73 9811
TEST_TIME 74 9784
TEST_TIME 75 9740
TEST_TIME 76 9803
TEST_TIME 77 9774
TEST_TIME 78 9878
TEST_TIME 79 9898
TEST_TIME 80 9792
TEST_TIME 81 9776
TEST_TIME 82 9697
TEST_TIME 83 9663
TEST_TIME 84 9699
TEST_TIME 85 9680
TEST_TIME 86 9642
TEST_TIME 87 9651
TEST_TIME 88 9637
TEST_TIME 89 9625
TEST_TIME 90 9620
TEST_TIME 91 9537
TEST_TIME 92 9526
TEST_TIME 93 9509
TEST_TIME 94 9477
TEST_TIME 95 9491
TEST_TIME 96 9556
TEST_TIME 97 9593
TEST_TIME 98 9628
TEST_TIME 99 9657
TEST_TIME 100 9624
TEST_TIME 101 9725
TEST_TIME 102 9732
TEST_TIME 103 9791
TEST_TIME 104 9831
TEST_TIME 105 9812
TEST_TIME 106 9749
TEST_TIME 107 9674
TEST_TIME 108 9673
TEST_TIME 109 9633
TEST_TIME 110 9623
TEST_TIME 111 9586
TEST_TIME 112 9557
TEST_TIME 113 9540
TEST_TIME 114 9486
TEST_TIME 115 9460
TEST_TIME 116 9425
TEST_TIME 117 9466
TEST_TIME 118 9513
TEST_TIME 119 9499
TEST_TIME 120 9447

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 11-03-2023 22:39:57 to 11-03-2023 22:40:01.

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 1558289 1558289 0 0.00 0 22095 6 0 0
doc_list_biud 1558289 1558289 0 0.00 0 58701 25 0 0
sp_add_invoice_to_stock 5002 4862 140 2.79 25 233358 16865 0 140
sp_cancel_adding_invoice 5990 5990 0 0.00 4 58832 694 0 0
sp_cancel_client_order 1654 1654 0 0.00 4 20405 375 0 0
sp_cancel_customer_reserve 588835 588835 0 0.00 0 51806 54 0 0
sp_cancel_pay_from_customer 645 645 0 0.00 3 5067 94 0 0
sp_cancel_pay_to_supplier 374 374 0 0.00 3 4270 87 0 0
sp_cancel_supplier_invoice 6611 6599 12 0.18 2 20660 688 0 12
sp_cancel_supplier_order 434 434 0 0.00 9 893003 91550 0 0
sp_cancel_write_off 10124 10124 0 0.00 1 29933 107 0 0
sp_client_order 19791 19791 0 0.00 3 46187 389 0 0
sp_customer_reserve 459802 459802 0 0.00 0 137356 163 0 0
sp_fill_shopping_cart 30521 30521 0 0.00 1 13903 34 0 0
sp_fill_shopping_cart_clo_res 459802 459802 0 0.00 0 25478 15 0 0
sp_get_clo_for_invoice 4862 4862 0 0.00 0 47712 370 0 0
sp_kill_cost_storno 17133 17133 0 0.00 0 6303 45 0 0
sp_kill_qstorno_ret_qs2qd 1194827 1194827 0 0.00 0 51791 29 0 0
sp_kill_qty_storno 628247 628247 0 0.00 0 58699 63 0 0
sp_lock_selected_doc 20148 20148 0 0.00 0 12454 7 0 0
sp_make_cost_storno 27268 27268 0 0.00 0 9907 47 0 0
sp_multiply_rows_for_pdistr 27268 27268 0 0.00 0 6859 25 0 0
sp_multiply_rows_for_qdistr 19791 19791 0 0.00 0 27078 187 0 0
sp_pay_from_customer 6872 6872 0 0.00 4 8111 100 0 0
sp_pay_to_supplier 5785 5785 0 0.00 4 9913 117 0 0
sp_payment_common 12657 12657 0 0.00 1 5791 22 0 0
sp_qd_handle_on_cancel_clo 1654 1654 0 0.00 0 12024 313 0 0
sp_qd_handle_on_invoice_upd_sts 10851 10851 0 0.00 0 58696 303 0 0
sp_qd_handle_on_reserve_upd_sts 9750 9750 0 0.00 0 24292 63 0 0
sp_reserve_write_off 9750 9750 0 0.00 5 24319 171 0 0
sp_supplier_invoice 5450 5450 0 0.00 6 101968 3122 0 0
sp_supplier_order 5306 5306 0 0.00 4 66040 1232 0 0
srv_aggregate_perf_data 98 97 1 1.02 2058 141429 19286 0 1
srv_fill_mon_cache_memory 60 60 0 0.00 2067 159604 50442 0 0
srv_find_qd_qs_mism 1086442 1086442 0 0.00 0 22095 6 0 0
srv_make_invnt_saldo 538 538 0 0.00 30 86573 1091 0 0
srv_make_money_saldo 740 740 0 0.00 1 2873 24 0 0
srv_recalc_idx_stat 4 4 0 0.00 182127 400264 313513 0 0
t$perf-abend:sp_add_invoice_to_stock 140 140 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 12 12 0 0.00 0 0 0 0 0
t$perf-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4862 4862 0 0.00 0 19288 155 0 0
t$perf-norm:sp_cancel_adding_invoice 381 381 0 0.00 0 8295 121 0 0
t$perf-norm:sp_cancel_client_order 1654 1654 0 0.00 0 1847 9 0 0
t$perf-norm:sp_cancel_customer_reserve 685 685 0 0.00 0 2384 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 645 645 0 0.00 0 2200 6 0 0
t$perf-norm:sp_cancel_pay_to_supplier 374 374 0 0.00 0 370 4 0 0
t$perf-norm:sp_cancel_supplier_invoice 372 372 0 0.00 0 801 9 0 0
t$perf-norm:sp_cancel_supplier_order 434 434 0 0.00 0 39171 1585 0 0
t$perf-norm:sp_cancel_write_off 992 992 0 0.00 0 3053 14 0 0
t$perf-norm:sp_client_order 19791 19791 0 0.00 0 10537 15 0 0
t$perf-norm:sp_customer_reserve 978 978 0 0.00 0 1684 4 0 0
t$perf-norm:sp_pay_from_customer 6872 6872 0 0.00 0 8831 9 0 0
t$perf-norm:sp_pay_to_supplier 5785 5785 0 0.00 0 8164 11 0 0
t$perf-norm:sp_reserve_write_off 9750 9750 0 0.00 0 5249 9 0 0
t$perf-norm:sp_supplier_invoice 5450 5450 0 0.00 0 6219 15 0 0
t$perf-norm:sp_supplier_order 5306 5306 0 0.00 0 11477 13 0 0
t$perf-norm:srv_aggregate_perf_data 97 97 0 0.00 0 214 9 0 0
t$perf-norm:srv_fill_mon_cache_memory 60 60 0 0.00 0 3 0 0 0
t$perf-norm:srv_make_invnt_saldo 538 538 0 0.00 0 5989 50 0 0
t$perf-norm:srv_make_money_saldo 740 740 0 0.00 0 1261 13 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 35 12 0 0
v_add_invoice_to_stock 10002 9722 280 2.79 0 10803 20 0 280
v_all_customers 36410 36410 0 0.00 0 15 0 0 0
v_all_suppliers 29892 29892 0 0.00 0 120 0 0 0
v_all_wares 39582 39582 0 0.00 0 62 1 0 0
v_cancel_adding_invoice 762 762 0 0.00 0 12153 27 0 0
v_cancel_client_order 3308 3308 0 0.00 0 8441 8 0 0
v_cancel_customer_prepayment 1290 1290 0 0.00 0 3920 14 0 0
v_cancel_customer_reserve 1370 1370 0 0.00 0 3917 13 0 0
v_cancel_payment_to_supplier 748 748 0 0.00 0 1858 7 0 0
v_cancel_supplier_invoice 768 744 24 3.12 0 5179 30 0 24
v_cancel_supplier_order 868 868 0 0.00 0 1734 9 0 0
v_cancel_write_off 1984 1984 0 0.00 0 2544 15 0 0
v_max_id_clo_ord 5305 5305 0 0.00 0 552 1 0 0
v_max_id_clo_res 978 978 0 0.00 0 3318 23 0 0
v_max_id_ord_sup 5425 5425 0 0.00 0 6753 7 0 0
v_max_non_paid_invoice 1569 1569 0 0.00 0 365 2 0 0
v_max_non_paid_realizn 3495 3495 0 0.00 0 2501 4 0 0
v_min_id_clo_ord 5305 5305 0 0.00 0 2916 6 0 0
v_min_id_clo_res 978 978 0 0.00 0 5209 8 0 0
v_min_id_ord_sup 5425 5425 0 0.00 0 8515 11 0 0
v_min_non_paid_invoice 5785 5785 0 0.00 0 5599 17 0 0
v_min_non_paid_realizn 6872 6872 0 0.00 0 5787 15 0 0
v_our_firm 9926 9926 0 0.00 0 93 1 0 0
v_reserve_write_off 19500 19500 0 0.00 0 6160 7 0 0
x_lock_depdocs_on_canc_invoice 12217 12217 0 0.00 0 25679 118 0 0
x_lock_depdocs_on_canc_sup_ord 434 434 0 0.00 0 12184 374 0 0
x_make_qstorno_1000_1200 5306 5306 0 0.00 1 66028 1166 0 0
x_make_qstorno_1200_2000 5450 5450 0 0.00 3 101128 2991 0 0
x_make_qstorno_2100_3300 459802 459802 0 0.00 0 137328 146 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 11-03-2023 22:40:02 to 11-03-2023 22:40:06.

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:45 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:46 29274 8192000000 9902431024 10212929536 983560560 10.719 100 89 176 0 1013209904 6405456 23243888
20:11:24 12378 8192000000 9932533296 10248392704 1013588416 11.010 100 94 188 0 1046794560 8556400 24649744
20:12:56 11522 8192000000 9963367888 10292101120 1047033040 11.332 100 82 164 0 1077488576 9875360 20580176
20:14:13 8251 8192000000 10026503776 10369748992 1107164000 11.906 100 84 168 0 1137916640 10714400 20038240
20:15:25 4984 8192000000 10072462640 10428567552 1158971920 12.394 100 83 164 1 1190278800 12302336 19004544
20:16:35 1813 8192000000 10128566416 10494382080 1213641488 12.903 100 89 178 0 1247148848 13462624 20044736
20:17:40 2085 8192000000 10153457472 10527412224 1241994896 13.165 100 84 167 0 1275387376 15291024 18101456
20:18:46 1802 8192000000 10195054448 10574331904 1273670224 13.455 100 89 178 2 1306997088 13810560 19516304
20:19:49 1682 8192000000 10207340752 10592550912 1292138096 13.624 100 87 173 0 1324802496 13261904 19402496
20:20:53 10524 8192000000 10203594544 10600476672 1301431120 13.708 100 51 102 0 1321446016 8220896 11794000
20:22:05 6427 8192000000 10199890144 10604785664 1305298032 13.743 100 43 86 1 1324816304 10024656 9493616
20:23:13 3707 8192000000 10203174304 10612748288 1313417200 13.817 100 45 90 2 1331253888 8029568 9807120
20:24:17 6976 8192000000 10205243760 10621165568 1319465648 13.872 100 17 35 0 1328796912 5814736 3516528
20:25:30 61337 8192000000 10239307424 10647089152 1326286784 13.934 100 50 94 2 1348495584 9801536 12407264
20:27:33 6622 8192000000 10218696032 10642079744 1331051680 13.977 100 23 44 0 1341541872 5238400 5251792
20:28:41 11625 8192000000 10223038016 10640519168 1324527184 13.918 100 16 32 1 1342160256 14289312 3343760
20:30:00 15209 8192000000 10216055936 10615300096 1307248704 13.761 99 58 117 0 1327416496 5731952 14435840
20:31:16 3215 8192000000 10196171760 10600763392 1292436896 13.626 100 44 88 0 1315218416 13413056 9368464
20:32:20 4319 8192000000 10154600304 10556956672 1262578928 13.354 100 28 58 0 1275934464 7029952 6325584
20:33:24 1879 8192000000 10136422496 10518888448 1219382208 12.956 97 52 106 1 1236435584 5390320 11663056
20:34:32 14903 8192000000 10156678688 10557255680 1226339312 13.020 97 21 42 0 1241222480 9909920 4973248
20:35:48 8213 8192000000 10177763584 10585702400 1283541264 13.545 100 20 36 1 1293012608 5027856 4443488
20:36:59 11035 8192000000 10190779952 10605522944 1301141216 13.706 100 21 42 0 1311172896 5177680 4854000
20:38:12 15110 8192000000 10210411440 10623148032 1313888864 13.821 100 33 64 0 1325622352 5008416 6725072
20:39:27 105305 8192000000 10243631296 10659987456 1333836512 14.002 100 34 69 0 1351461872 9678352 7947008
20:42:18 29335 8192000000 10260745792 10681352192 1352557104 14.170 100 32 64 0 1375013648 14911232 7545312
20:43:50 9129 8192000000 10279377520 10701615104 1367984208 14.309 100 34 69 0 1391292032 15186672 8121152
20:45:10 5594 8192000000 10315380320 10726154240 1382424496 14.438 100 72 140 1 1420368000 22141472 15802032
20:46:18 14300 8192000000 10308057104 10730266624 1390282960 14.508 100 56 111 0 1424247488 21082752 12881776
20:48:09 8571 8192000000 10314369616 10740092928 1391326576 14.518 100 47 92 1 1430542864 27305040 11911248
20:49:21 4634 8192000000 10330058160 10752098304 1396359040 14.563 100 56 110 1 1439918624 30061776 13497808
20:50:31 6114 8192000000 10344047904 10761617408 1394655840 14.547 99 63 125 0 1446346256 36084032 15606384
20:51:44 2065 8192000000 10363530288 10780471296 1415111200 14.729 100 69 138 2 1470115472 37763280 17240992
20:52:51 6960 8192000000 10337647744 10752929792 1385727744 14.468 100 56 112 0 1443081232 42940752 14412736
20:54:02 4655 8192000000 10360481424 10781761536 1406153072 14.650 100 68 134 0 1470873040 45602016 19117952
20:55:16 21109 8192000000 10331400256 10768982016 1395518640 14.555 100 32 64 0 1452520928 47635104 9367184
20:56:44 7203 8192000000 10315591472 10740932608 1379310112 14.410 100 41 81 2 1422363232 33191440 9861680
20:57:55 18704 8192000000 10310874000 10735992832 1359286336 14.231 99 29 58 0 1405799328 38451616 8061376
20:59:18 7682 8192000000 10288068336 10717917184 1340240368 14.060 98 43 84 2 1383432656 31486384 11705904
21:00:32 29167 8192000000 10298274656 10731036672 1364794848 14.280 100 25 50 0 1404860544 33390816 6674880
21:02:25 29534 8192000000 10275675488 10714853376 1334551632 14.008 98 23 46 0 1378929744 38117200 6260912
21:03:56 32813 8192000000 10271786256 10714689536 1329703072 13.964 99 12 24 0 1370685280 37487424 3494784
21:05:33 29963 8192000000 10248322592 10697785344 1303276112 13.725 97 18 36 1 1327131312 19702352 4152848
21:07:03 44074 8192000000 10276894864 10709954560 1355180192 14.194 100 39 79 0 1378449504 14307808 8961504
21:08:53 159604 8192000000 10266618608 10702295040 1296734624 13.666 94 31 59 2 1309701984 6419152 6548208
21:12:33 101289 8192000000 10281170720 10716667904 1331068672 13.977 97 28 56 0 1347119552 9978384 6072496
21:15:15 41756 8192000000 10303916736 10737508352 1372681600 14.351 99 34 68 0 1392090880 11277296 8131984
21:17:09 140870 8192000000 10284184784 10738503680 1362582896 14.261 99 16 32 0 1381214304 14374400 4257008
21:20:30 84380 8192000000 10309704320 10758094848 1401546416 14.609 100 20 41 0 1421306048 15267504 4492128
21:22:55 72676 8192000000 10294814576 10759954432 1392360848 14.527 100 5 10 0 1415623216 21810976 1451392
21:25:18 51770 8192000000 10306064688 10772406272 1395430400 14.554 99 32 64 0 1416617264 13231120 7955744
21:27:25 68109 8192000000 10303159616 10768084992 1382225584 14.436 98 22 45 0 1397284576 10084848 4974144
21:29:34 67006 8192000000 10298111856 10761175040 1362298352 14.258 97 27 54 0 1384561888 16158080 6105456
21:31:41 64175 8192000000 10303732832 10769051648 1373685792 14.360 98 6 12 0 1387172128 12218928 1267408
21:33:48 43045 8192000000 10298022368 10748706816 1372101392 14.346 98 13 26 0 1385093648 10014704 2977552
21:35:38 42042 8192000000 10317778128 10760908800 1398549328 14.582 100 35 70 0 1422216848 15784640 7882880
21:37:22 58107 8192000000 10308083616 10757779456 1389999968 14.506 99 35 67 1 1407056784 8524848 8531968
21:39:20 23505 8192000000 10300163760 10767441920 1392817568 14.531 99 16 32 0 1408649584 12205104 3626912
21:40:58 48279 8192000000 10295565456 10752012288 1391760416 14.522 100 16 32 0 1407238800 12016240 3462144
21:42:57 66915 8192000000 10295998080 10738114560 1321142960 13.887 94 17 32 0 1341609632 16831328 3635344
21:45:32 45849 8192000000 10271178464 10718302208 1312876352 13.812 95 29 60 0 1334174288 15245792 6052144
21:47:20 56265 8192000000 10270153392 10709561344 1340326944 14.060 98 20 39 0 1358415504 13374064 4714496
21:49:25 48899 8192000000 10270608144 10714673152 1337954480 14.039 98 35 69 1 1354532304 8955664 7622160
21:51:24 109047 8192000000 10271799760 10717667328 1289785408 13.602 94 12 25 0 1303127920 10406208 2936304
21:54:14 38211 8192000000 10274484720 10725879808 1332591328 13.991 98 44 88 0 1363206320 20714032 9900960
21:57:11 88659 8192000000 10260131984 10708774912 1309547280 13.782 96 12 24 0 1327175776 15021920 2606576
21:59:51 43192 8192000000 10268614944 10719936512 1355267552 14.195 99 16 32 0 1371017008 11903040 3846416
22:01:39 51610 8192000000 10274867568 10733469696 1374520128 14.368 100 16 32 0 1391035088 12920016 3594944
22:03:50 75523 8192000000 10269144768 10724167680 1354830848 14.191 98 15 30 0 1371144384 12790960 3522576
22:06:05 69114 8192000000 10277513696 10738188288 1381695232 14.432 100 21 42 0 1397887248 11581152 4610864
22:08:20 68360 8192000000 10280002528 10746777600 1389578928 14.502 100 13 23 0 1398991456 7299216 2113312
22:10:32 65064 8192000000 10271914112 10729926656 1335777872 14.019 96 14 27 0 1349876368 11615920 2482576
22:12:40 54130 8192000000 10303405120 10759987200 1394874080 14.549 100 24 48 0 1415296672 14849024 5573568
22:14:39 25969 8192000000 10304364912 10761158656 1395854880 14.558 100 41 81 0 1425927584 20240816 9831888
22:16:18 29660 8192000000 10294975296 10744954880 1376727792 14.387 99 34 68 0 1396294416 12189504 7377120
22:17:48 61387 8192000000 10318677552 10764918784 1379034848 14.408 99 34 68 0 1398532816 11830848 7667120
22:19:52 73266 8192000000 10306547472 10751950848 1368545056 14.314 98 20 40 0 1385568784 13166608 3857120
22:22:08 78638 8192000000 10307416480 10767679488 1371016368 14.336 98 7 13 0 1388174608 16138336 1019904
22:24:34 85786 8192000000 10299596656 10745839616 1359213584 14.230 97 38 76 0 1377936448 10296320 8426544
22:27:43 78701 8192000000 10271925520 10733961216 1331170400 13.978 95 9 18 0 1340557824 7452352 1935072
22:30:08 44247 8192000000 10268594544 10728542208 1376408672 14.384 100 8 16 0 1388613472 10533712 1671088
22:31:53 81031 8192000000 10285042608 10741006336 1341394016 14.070 97 20 40 0 1360758416 14378768 4985632
22:34:16 55844 8192000000 10253087680 10706374656 1325698928 13.928 97 24 48 0 1356398176 25243536 5455712
22:36:58 47551 8192000000 10261670880 10706100224 1322717472 13.901 97 23 46 0 1336123376 8136960 5268944

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 11-03-2023 22:40:08 to 11-03-2023 22:40:23.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 140 v_add_invoice_to_stock 335544517
except 12 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 11-03-2023 22:40:24 to 11-03-2023 22:40:26.

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

11.03.23 22:40:27. 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-03-11 22:40:29 No severe PSQL-related problems occured
11.03.23 22:40:31. End of report.