Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 09.02.2023 01: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 15139296 kB
MemAvailable 30463248 kB
Buffers 0 kB
Cached 16589212 kB
SwapCached 3660 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-09 01:38:39
DTS_END                         2023-02-09 01:38:39.2740
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_ORDER(38:5) ==> X_MAKE_QSTORNO_1000_1200(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/37768
TRN_ID                          244688
ATT_ID                          651
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: 9594.66 22563 1151359
customer order: creation 176.08 312 21130
customer order: refuse 15.30 313 1836
order to supplier: creation 46.90 1175 5628
order to supplier: removal 3.34 95864 401
invoice (draft): creation 47.18 2967 5661
invoice (draft): removal 54.37 718 6524
invoice accept: apply 43.27 16804 5192
invoice accept: cancel 49.35 794 5922
customer reserve: creation 4042.61 163 485113
customer reserve: removal 4804.43 51 576532
realization accept: apply 85.89 191 10307
realization accept: cancel 92.42 97 11090
payment from customer: creation 61.03 114 7323
payment from customer: removal 5.62 95 674
payment to supplier: creation 50.08 141 6009
payment to supplier: removal 3.81 104 457
service: total inventory turnovers 4.75 1047 570
service: total monetary turnovers 7.32 38 878
service: aggregate perf. data 0.90 18085 108
service: refresh index statistics 0.03 312187 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 09-02-2023 01:40:24 to 09-02-2023 01:40:26.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2270
TEST_TIME 2 2630
TEST_TIME 3 2966
TEST_TIME 4 2559
TEST_TIME 5 2556
TEST_TIME 6 3662
TEST_TIME 7 3978
TEST_TIME 8 5236
TEST_TIME 9 6062
TEST_TIME 10 6313
TEST_TIME 11 6627
TEST_TIME 12 7353
TEST_TIME 13 7315
TEST_TIME 14 7288
TEST_TIME 15 7487
TEST_TIME 16 7822
TEST_TIME 17 7817
TEST_TIME 18 7947
TEST_TIME 19 8108
TEST_TIME 20 8447
TEST_TIME 21 8325
TEST_TIME 22 8431
TEST_TIME 23 9372
TEST_TIME 24 9080
TEST_TIME 25 8999
TEST_TIME 26 9600
TEST_TIME 27 9923
TEST_TIME 28 10438
TEST_TIME 29 10555
TEST_TIME 30 10582
TEST_TIME 31 10472
TEST_TIME 32 10599
TEST_TIME 33 10655
TEST_TIME 34 10465
TEST_TIME 35 10549
TEST_TIME 36 10535
TEST_TIME 37 10461
TEST_TIME 38 10402
TEST_TIME 39 10285
TEST_TIME 40 10072
TEST_TIME 41 10037
TEST_TIME 42 10036
TEST_TIME 43 10052
TEST_TIME 44 9935
TEST_TIME 45 9954
TEST_TIME 46 9916
TEST_TIME 47 9956
TEST_TIME 48 9937
TEST_TIME 49 9861
TEST_TIME 50 9810
TEST_TIME 51 9787
TEST_TIME 52 9675
TEST_TIME 53 9624
TEST_TIME 54 9503
TEST_TIME 55 9606
TEST_TIME 56 9640
TEST_TIME 57 9554
TEST_TIME 58 9725
TEST_TIME 59 9781
TEST_TIME 60 9858
TEST_TIME 61 9834
TEST_TIME 62 9891
TEST_TIME 63 9850
TEST_TIME 64 9869
TEST_TIME 65 9931
TEST_TIME 66 9924
TEST_TIME 67 9930
TEST_TIME 68 10033
TEST_TIME 69 10133
TEST_TIME 70 10055
TEST_TIME 71 9941
TEST_TIME 72 9962
TEST_TIME 73 9865
TEST_TIME 74 9891
TEST_TIME 75 9843
TEST_TIME 76 9774
TEST_TIME 77 9711
TEST_TIME 78 9772
TEST_TIME 79 9692
TEST_TIME 80 9652
TEST_TIME 81 9606
TEST_TIME 82 9680
TEST_TIME 83 9814
TEST_TIME 84 9766
TEST_TIME 85 9874
TEST_TIME 86 9844
TEST_TIME 87 9824
TEST_TIME 88 9847
TEST_TIME 89 9829
TEST_TIME 90 9812
TEST_TIME 91 9936
TEST_TIME 92 9873
TEST_TIME 93 9941
TEST_TIME 94 9904
TEST_TIME 95 9826
TEST_TIME 96 9789
TEST_TIME 97 9742
TEST_TIME 98 9674
TEST_TIME 99 9656
TEST_TIME 100 9674
TEST_TIME 101 9657
TEST_TIME 102 9678
TEST_TIME 103 9629
TEST_TIME 104 9607
TEST_TIME 105 9663
TEST_TIME 106 9676
TEST_TIME 107 9668
TEST_TIME 108 9713
TEST_TIME 109 9707
TEST_TIME 110 9745
TEST_TIME 111 9740
TEST_TIME 112 9750
TEST_TIME 113 9816
TEST_TIME 114 9778
TEST_TIME 115 9711
TEST_TIME 116 9681
TEST_TIME 117 9649
TEST_TIME 118 9621
TEST_TIME 119 9640
TEST_TIME 120 9600

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 09-02-2023 01:40:27 to 09-02-2023 01:40:31.

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 1599040 1599040 0 0.00 0 26043 6 0 0
doc_list_biud 1599039 1599039 0 0.00 0 22416 24 0 0
sp_add_invoice_to_stock 5353 5192 161 3.00 42 168845 16805 0 161
sp_cancel_adding_invoice 5922 5922 0 0.00 3 53380 794 0 0
sp_cancel_client_order 1836 1836 0 0.00 4 7621 313 0 0
sp_cancel_customer_reserve 576532 576532 0 0.00 0 24772 52 0 0
sp_cancel_pay_from_customer 674 674 0 0.00 3 8752 96 0 0
sp_cancel_pay_to_supplier 457 457 0 0.00 3 6483 104 0 0
sp_cancel_supplier_invoice 6536 6524 12 0.18 1 16309 718 0 12
sp_cancel_supplier_order 401 401 0 0.00 5 1018735 95864 0 0
sp_cancel_write_off 11090 11090 0 0.00 1 18182 98 0 0
sp_client_order 21130 21130 0 0.00 3 43930 313 0 0
sp_customer_reserve 485113 485113 0 0.00 0 44279 163 0 0
sp_fill_shopping_cart 32408 32408 0 0.00 1 8368 36 0 0
sp_fill_shopping_cart_clo_res 485102 485102 0 0.00 0 18909 13 0 0
sp_get_clo_for_invoice 5181 5181 0 0.00 0 31556 286 0 0
sp_kill_cost_storno 18143 18143 0 0.00 0 18318 50 0 0
sp_kill_qstorno_ret_qs2qd 1171079 1171079 0 0.00 0 22217 28 0 0
sp_kill_qty_storno 617792 617792 0 0.00 0 22416 62 0 0
sp_lock_selected_doc 21466 21466 0 0.00 0 8529 8 0 0
sp_make_cost_storno 28820 28820 0 0.00 0 17993 58 0 0
sp_multiply_rows_for_pdistr 28819 28819 0 0.00 0 17542 28 0 0
sp_multiply_rows_for_qdistr 21130 21130 0 0.00 0 32864 133 0 0
sp_pay_from_customer 7323 7323 0 0.00 4 17881 114 0 0
sp_pay_to_supplier 6009 6009 0 0.00 4 17521 142 0 0
sp_payment_common 13332 13332 0 0.00 2 17500 33 0 0
sp_qd_handle_on_cancel_clo 1836 1836 0 0.00 0 7617 287 0 0
sp_qd_handle_on_invoice_upd_sts 11103 11103 0 0.00 0 18492 329 0 0
sp_qd_handle_on_reserve_upd_sts 10306 10306 0 0.00 0 21353 64 0 0
sp_reserve_write_off 10307 10307 0 0.00 6 21379 192 0 0
sp_supplier_invoice 5661 5661 0 0.00 6 90187 2968 0 0
sp_supplier_order 5628 5628 0 0.00 5 44049 1175 0 0
srv_aggregate_perf_data 108 108 0 0.00 2898 240411 18086 0 0
srv_fill_mon_cache_memory 61 61 0 0.00 2590 144377 48314 0 0
srv_find_qd_qs_mism 1101190 1101190 0 0.00 0 26043 5 0 0
srv_make_invnt_saldo 570 570 0 0.00 29 53154 1047 0 0
srv_make_money_saldo 878 878 0 0.00 1 2195 38 0 0
srv_recalc_idx_stat 4 4 0 0.00 165637 453838 312187 0 0
t$perf-abend:sp_add_invoice_to_stock 161 161 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-norm:sp_add_invoice_to_stock 5192 5192 0 0.00 0 15147 169 0 0
t$perf-norm:sp_cancel_adding_invoice 440 440 0 0.00 0 3413 108 0 0
t$perf-norm:sp_cancel_client_order 1836 1836 0 0.00 0 2813 10 0 0
t$perf-norm:sp_cancel_customer_reserve 738 738 0 0.00 0 705 9 0 0
t$perf-norm:sp_cancel_pay_from_customer 674 674 0 0.00 0 1409 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 457 457 0 0.00 0 5611 15 0 0
t$perf-norm:sp_cancel_supplier_invoice 441 441 0 0.00 0 3100 25 0 0
t$perf-norm:sp_cancel_supplier_order 401 401 0 0.00 0 18465 1521 0 0
t$perf-norm:sp_cancel_write_off 992 992 0 0.00 0 6810 20 0 0
t$perf-norm:sp_client_order 21130 21130 0 0.00 0 10970 16 0 0
t$perf-norm:sp_customer_reserve 1011 1011 0 0.00 0 3611 8 0 0
t$perf-norm:sp_pay_from_customer 7323 7323 0 0.00 0 9265 9 0 0
t$perf-norm:sp_pay_to_supplier 6009 6009 0 0.00 0 3191 6 0 0
t$perf-norm:sp_reserve_write_off 10307 10307 0 0.00 0 6332 10 0 0
t$perf-norm:sp_supplier_invoice 5661 5661 0 0.00 0 4260 14 0 0
t$perf-norm:sp_supplier_order 5628 5628 0 0.00 0 4449 14 0 0
t$perf-norm:srv_aggregate_perf_data 108 108 0 0.00 0 266 8 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 33 1 0 0
t$perf-norm:srv_make_invnt_saldo 570 570 0 0.00 0 1727 31 0 0
t$perf-norm:srv_make_money_saldo 878 878 0 0.00 0 919 17 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 10 4 0 0
v_add_invoice_to_stock 10684 10362 322 3.01 0 7847 20 0 322
v_all_customers 38352 38352 0 0.00 0 24 1 0 0
v_all_suppliers 30916 30916 0 0.00 0 20 1 0 0
v_all_wares 42260 42260 0 0.00 0 26 1 0 0
v_cancel_adding_invoice 880 880 0 0.00 0 2325 8 0 0
v_cancel_client_order 3672 3672 0 0.00 0 3248 6 0 0
v_cancel_customer_prepayment 1348 1348 0 0.00 0 7802 15 0 0
v_cancel_customer_reserve 1476 1476 0 0.00 0 1110 4 0 0
v_cancel_payment_to_supplier 914 914 0 0.00 0 5117 17 0 0
v_cancel_supplier_invoice 906 882 24 2.64 0 1025 15 0 24
v_cancel_supplier_order 802 802 0 0.00 0 9997 16 0 0
v_cancel_write_off 1984 1984 0 0.00 0 6237 22 0 0
v_max_id_clo_ord 5625 5625 0 0.00 0 910 1 0 0
v_max_id_clo_res 1011 1011 0 0.00 0 2663 14 0 0
v_max_id_ord_sup 5651 5651 0 0.00 0 4784 5 0 0
v_max_non_paid_invoice 1827 1827 0 0.00 0 1510 4 0 0
v_max_non_paid_realizn 3899 3899 0 0.00 0 3168 4 0 0
v_min_id_clo_ord 5625 5625 0 0.00 0 2961 7 0 0
v_min_id_clo_res 1011 1011 0 0.00 0 2823 7 0 0
v_min_id_ord_sup 5651 5651 0 0.00 0 6482 7 0 0
v_min_non_paid_invoice 6009 6009 0 0.00 0 17493 30 0 0
v_min_non_paid_realizn 7323 7323 0 0.00 0 17491 24 0 0
v_our_firm 10756 10756 0 0.00 0 25 1 0 0
v_reserve_write_off 20612 20612 0 0.00 0 7827 7 0 0
x_lock_depdocs_on_canc_invoice 12005 12005 0 0.00 0 17317 121 0 0
x_lock_depdocs_on_canc_sup_ord 401 401 0 0.00 0 5838 351 0 0
x_make_qstorno_1000_1200 5628 5628 0 0.00 1 44035 1096 0 0
x_make_qstorno_1200_2000 5661 5661 0 0.00 3 89208 2845 0 0
x_make_qstorno_2100_3300 485113 485113 0 0.00 0 37541 148 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 09-02-2023 01:40:32 to 09-02-2023 01:40:36.

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
23:08:43 9 8192000000 8815104688 8831668224 19075648 0.232 5 5 6 0 19345200 98112 171440
23:09:44 13780 8192000000 9906822480 10218950656 989047392 10.772 100 91 182 0 1019256880 6083056 24126432
23:11:04 17424 8192000000 9963219264 10288898048 1042748336 11.291 100 84 168 0 1071927120 8126576 21052208
23:12:27 16515 8192000000 9995294928 10329939968 1078906416 11.637 100 90 180 0 1110868272 10144736 21817120
23:13:53 10381 8192000000 10037742544 10382352384 1119856368 12.026 100 86 172 1 1151996464 11601088 20539008
23:15:07 9280 8192000000 10070616992 10429603840 1160523168 12.408 100 75 150 1 1189869808 11902960 17443680
23:16:18 4893 8192000000 10117597248 10484101120 1209587408 12.865 100 80 159 0 1239963248 13363552 17012288
23:17:25 2034 8192000000 10144449984 10513453056 1238834880 13.136 100 86 171 0 1270738192 13659840 18243472
23:18:29 1167 8192000000 10186147008 10564976640 1271949200 13.439 100 87 175 2 1304412928 13328384 19135344
23:19:32 1761 8192000000 10206403248 10590081024 1294552032 13.646 100 86 171 2 1327819552 14444624 18822896
23:20:35 29816 8192000000 10181801488 10596007936 1302869824 13.721 100 30 58 1 1317440304 7691552 6878928
23:22:07 7962 8192000000 10195044016 10607382528 1309653616 13.783 100 24 46 1 1321945856 7000096 5292144
23:23:15 11005 8192000000 10202516576 10620735488 1316523696 13.845 100 16 30 0 1329751520 10269792 2958032
23:24:27 14060 8192000000 10213864880 10630356992 1326595488 13.936 100 31 59 0 1338763760 5891104 6277168
23:25:41 23492 8192000000 10224068800 10649489408 1329762992 13.965 100 24 46 1 1344500544 9582528 5155024
23:27:05 6994 8192000000 10230422896 10652680192 1336801696 14.029 100 27 54 0 1349235904 6642880 5791328
23:28:14 9455 8192000000 10227850784 10647224320 1323460000 13.908 99 7 14 0 1329721312 4651600 1609712
23:29:25 28527 8192000000 10167694816 10581282816 1242235024 13.167 94 21 42 0 1251920448 4828768 4856656
23:31:04 7790 8192000000 10160637824 10564771840 1237257296 13.121 96 24 46 2 1247432448 4919408 5255744
23:32:17 8950 8192000000 10137216784 10538774528 1207030192 12.842 96 19 38 1 1216803536 5166912 4606432
23:33:27 8810 8192000000 10160707632 10563571712 1265822384 13.383 100 17 34 0 1274649008 5003776 3822848
23:34:38 7227 8192000000 10183814960 10584391680 1285567408 13.564 100 35 70 0 1299285632 5461392 8256832
23:35:52 22375 8192000000 10172455664 10588418048 1287757520 13.584 100 18 36 0 1296467184 5136304 3573360
23:37:18 8588 8192000000 10194529408 10613473280 1306688240 13.756 100 24 46 0 1321290512 9673696 4928576
23:38:27 17399 8192000000 10215928000 10637639680 1326470704 13.935 100 16 32 0 1335170208 5169296 3530208
23:40:35 34093 8192000000 10256661968 10671620096 1352619920 14.171 100 42 84 0 1372346720 9672352 10054448
23:42:12 111971 8192000000 10271184448 10706997248 1365597456 14.288 100 32 64 0 1396265824 22899216 7769152
23:45:40 8548 8192000000 10293632832 10712805376 1375034672 14.372 100 46 92 2 1404617568 18864176 10718720
23:46:51 4379 8192000000 10312030288 10729979904 1382164512 14.436 100 66 132 2 1419866112 22790176 14911424
23:48:01 3912 8192000000 10324964592 10743496704 1392344848 14.527 100 78 150 0 1432648832 23170768 17133216
23:49:15 4526 8192000000 10335487216 10754396160 1395663744 14.556 100 76 150 0 1434772064 21706304 17402016
23:50:23 3798 8192000000 10323845248 10737790976 1388790832 14.495 100 67 132 3 1427288864 23604352 14893680
23:51:32 11245 8192000000 10324909216 10754560000 1390255280 14.508 99 43 86 0 1422890112 22667328 9967504
23:52:49 3908 8192000000 10334489328 10756030464 1399638720 14.592 100 68 135 1 1441036944 24044128 17354096
23:54:01 5666 8192000000 10333142432 10751713280 1391377744 14.518 100 69 137 0 1439476608 31219008 16879856
23:55:19 2601 8192000000 10319017872 10731528192 1362229536 14.257 99 66 134 0 1414914400 37148800 15536064
23:56:25 2586 8192000000 10335283632 10739580928 1379226560 14.410 100 86 169 2 1437964848 37952560 20785728
23:57:38 9065 8192000000 10316037664 10737123328 1356292144 14.204 98 38 76 0 1403922096 37329744 10300208
23:58:57 6500 8192000000 10315954608 10723295232 1342892368 14.083 98 69 136 1 1399304848 38626576 17785904
00:00:11 2898 8192000000 10347767600 10752499712 1378670560 14.405 100 78 157 1 1448976240 50634528 19671152
00:01:19 9799 8192000000 10329923840 10761396224 1371979728 14.345 99 34 67 0 1430220592 49100784 9140080
00:02:37 27738 8192000000 10329087568 10754134016 1385150512 14.463 100 41 82 1 1435562608 39647568 10764528
00:04:34 28340 8192000000 10314974048 10758885376 1369144448 14.319 100 24 48 1 1414329984 38181072 7004464
00:06:03 26420 8192000000 10280466800 10728378368 1354742448 14.190 100 15 30 0 1389123712 30698576 3682688
00:07:43 113594 8192000000 10265600416 10710007808 1317279056 13.852 97 8 16 0 1337676288 18624496 1772736
00:10:57 59364 8192000000 10271387424 10720366592 1357465392 14.215 99 8 14 0 1370495888 11726080 1304416
00:12:57 75608 8192000000 10295001664 10734747648 1378724784 14.405 100 19 38 0 1399378560 16492368 4161408
00:15:16 144377 8192000000 10307628848 10747723776 1382624752 14.440 99 24 44 0 1401330048 13908480 4796816
00:18:44 34748 8192000000 10310972672 10747854848 1377552480 14.395 99 50 99 2 1397135168 8695280 10887408
00:20:26 40969 8192000000 10302750528 10753306624 1393624544 14.538 100 40 80 0 1418635792 16311552 8699696
00:22:14 24811 8192000000 10298091536 10759389184 1390059136 14.506 100 9 16 1 1405972448 14188144 1725168
00:23:39 26445 8192000000 10306430288 10755026944 1396344848 14.562 100 27 51 1 1409927264 6351904 7230512
00:25:12 40475 8192000000 10306167120 10773053440 1397399248 14.572 100 18 36 0 1414360112 12815696 4145168
00:26:55 29051 8192000000 10306356560 10766180352 1409012672 14.675 100 16 32 1 1419844752 6700816 4131264
00:28:25 35360 8192000000 10293057360 10752921600 1373775088 14.361 98 14 27 0 1388498624 11792352 2931184
00:30:00 78450 8192000000 10298659152 10762268672 1386664736 14.476 99 19 38 0 1402298544 10409136 5224672
00:32:38 25383 8192000000 10308352224 10764021760 1377101856 14.391 98 24 48 0 1398795008 15760816 5932336
00:34:16 79792 8192000000 10275482048 10742697984 1302026608 13.714 94 12 24 0 1318136032 13649968 2459456
00:37:04 49137 8192000000 10250722896 10708787200 1296883808 13.667 95 11 22 0 1315702528 16363296 2455424
00:38:53 39347 8192000000 10266261536 10716913664 1326818960 13.938 97 19 39 0 1341267024 10474656 3973408
00:40:38 33468 8192000000 10272651264 10714828800 1338710880 14.046 98 21 40 1 1351165616 7863472 4591264
00:42:11 128122 8192000000 10263908576 10715250688 1232291216 13.075 90 15 28 0 1250499040 15286512 2921312
00:45:27 138968 8192000000 10261848400 10718670848 1276509840 13.481 94 13 26 0 1298186320 18555552 3120928
00:48:46 100544 8192000000 10258745760 10702688256 1335701152 14.019 99 20 40 0 1347724320 7764784 4258384
00:51:27 40652 8192000000 10242654672 10703413248 1331552704 13.981 99 13 26 0 1350226544 15858544 2815296
00:53:32 62867 8192000000 10260374896 10717097984 1358246496 14.222 100 11 22 0 1371397408 10847424 2303488
00:55:36 50456 8192000000 10265021328 10722881536 1361291696 14.249 100 15 30 0 1381604576 16085520 4227360
00:57:29 36188 8192000000 10271048768 10724614144 1356959984 14.210 99 21 43 0 1378744768 16017312 5767472
00:59:14 75736 8192000000 10277888496 10740854784 1352204112 14.167 99 21 42 1 1380597824 22929952 5463760
01:01:48 87018 8192000000 10289866496 10750853120 1363899840 14.272 99 26 50 0 1393727696 24025504 5802352
01:04:27 64509 8192000000 10292006576 10743009280 1369093456 14.319 99 26 52 1 1386478688 11663280 5721952
01:06:40 54878 8192000000 10288614160 10740625408 1341387280 14.070 97 25 49 0 1358315776 11692384 5236112
01:08:41 34952 8192000000 10305382688 10761277440 1394799024 14.549 100 31 61 1 1416290464 14314640 7176800
01:11:53 137568 8192000000 10298270368 10759020544 1388268976 14.490 99 24 48 1 1401290944 7938048 5083920
01:15:39 75493 8192000000 10301871152 10768658432 1377363056 14.393 98 7 14 0 1391631248 12462448 1805744
01:17:55 80555 8192000000 10306039744 10777698304 1381551776 14.430 98 15 30 0 1407268256 22455264 3261216
01:20:16 33221 8192000000 10297660176 10756739072 1387104704 14.480 99 36 69 0 1404841888 10343056 7394128
01:21:53 36646 8192000000 10289589536 10741616640 1369862384 14.326 99 41 81 0 1392461744 13072912 9526448
01:23:51 72509 8192000000 10293047920 10758053888 1388303392 14.491 100 10 20 0 1403361424 12908384 2149648
01:26:04 80114 8192000000 10308394160 10753814528 1353242128 14.177 97 22 44 0 1367174816 9614688 4318000
01:28:27 63971 8192000000 10294299136 10736566272 1326814064 13.938 96 24 48 1 1356379776 24024880 5540832
01:30:35 55523 8192000000 10291949968 10739986432 1296277184 13.661 94 13 26 0 1315180064 15638288 3264592
01:32:35 110484 8192000000 10260368128 10711093248 1314838352 13.830 96 20 40 0 1327710336 8400992 4470992
01:35:31 26223 8192000000 10282658064 10730242048 1358445760 14.223 100 29 59 0 1372729808 8032160 6251888
01:36:58 44151 8192000000 10254873712 10720096256 1305399248 13.744 95 12 24 2 1325714688 17378272 2937168

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 09-02-2023 01:40:38 to 09-02-2023 01:40:53.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 161 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 09-02-2023 01:40:54 to 09-02-2023 01:40:56.

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

09.02.23 01:40:57. 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-09 01:41:00 No severe PSQL-related problems occured
09.02.23 01:41:01. End of report.