Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 01.02.2023 19: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 15318756 kB
MemAvailable 30409104 kB
Buffers 0 kB
Cached 16371932 kB
SwapCached 3632 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-01 19:38:35
DTS_END                         2023-02-01 19:38:35.2970
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_AGGREGATE_PERF_DATA(83:5) ==> TMP_AGGREGATE_PERF_DATA_AUTOGEN(601:13) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/39506
TRN_ID                          241257
ATT_ID                          717
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: 9533.01 24635 1143961
customer order: creation 169.52 376 20342
customer order: refuse 14.89 343 1787
order to supplier: creation 44.72 1199 5366
order to supplier: removal 3.42 105716 410
invoice (draft): creation 45.29 3089 5435
invoice (draft): removal 55.78 799 6693
invoice accept: apply 41.22 17557 4946
invoice accept: cancel 50.87 691 6104
customer reserve: creation 3796.43 175 455571
customer reserve: removal 5017.99 55 602159
realization accept: apply 83.49 179 10019
realization accept: cancel 80.93 111 9712
payment from customer: creation 57.83 136 6939
payment from customer: removal 5.62 122 674
payment to supplier: creation 49.42 133 5930
payment to supplier: removal 3.69 64 443
service: total inventory turnovers 4.63 1080 555
service: total monetary turnovers 6.48 33 777
service: aggregate perf. data 0.79 22700 95
service: refresh index statistics 0.03 338137 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 01-02-2023 19:39:25 to 01-02-2023 19:39:27.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2042
TEST_TIME 2 2622
TEST_TIME 3 3126
TEST_TIME 4 3221
TEST_TIME 5 3693
TEST_TIME 6 4545
TEST_TIME 7 4753
TEST_TIME 8 4617
TEST_TIME 9 4715
TEST_TIME 10 4869
TEST_TIME 11 5002
TEST_TIME 12 5204
TEST_TIME 13 5206
TEST_TIME 14 5518
TEST_TIME 15 5593
TEST_TIME 16 5864
TEST_TIME 17 6031
TEST_TIME 18 6182
TEST_TIME 19 6629
TEST_TIME 20 6973
TEST_TIME 21 7360
TEST_TIME 22 7980
TEST_TIME 23 7966
TEST_TIME 24 8512
TEST_TIME 25 8771
TEST_TIME 26 9192
TEST_TIME 27 10352
TEST_TIME 28 10385
TEST_TIME 29 10289
TEST_TIME 30 10172
TEST_TIME 31 10250
TEST_TIME 32 10279
TEST_TIME 33 10049
TEST_TIME 34 9799
TEST_TIME 35 9713
TEST_TIME 36 9729
TEST_TIME 37 9681
TEST_TIME 38 9717
TEST_TIME 39 9709
TEST_TIME 40 9675
TEST_TIME 41 9594
TEST_TIME 42 9543
TEST_TIME 43 9455
TEST_TIME 44 9374
TEST_TIME 45 9307
TEST_TIME 46 9387
TEST_TIME 47 9377
TEST_TIME 48 9390
TEST_TIME 49 9422
TEST_TIME 50 9544
TEST_TIME 51 9626
TEST_TIME 52 9561
TEST_TIME 53 9549
TEST_TIME 54 9707
TEST_TIME 55 9748
TEST_TIME 56 9680
TEST_TIME 57 9759
TEST_TIME 58 9815
TEST_TIME 59 9693
TEST_TIME 60 9576
TEST_TIME 61 9610
TEST_TIME 62 9607
TEST_TIME 63 9504
TEST_TIME 64 9481
TEST_TIME 65 9460
TEST_TIME 66 9480
TEST_TIME 67 9492
TEST_TIME 68 9462
TEST_TIME 69 9475
TEST_TIME 70 9642
TEST_TIME 71 9614
TEST_TIME 72 9574
TEST_TIME 73 9696
TEST_TIME 74 9746
TEST_TIME 75 9753
TEST_TIME 76 9729
TEST_TIME 77 9673
TEST_TIME 78 9788
TEST_TIME 79 9702
TEST_TIME 80 9662
TEST_TIME 81 9612
TEST_TIME 82 9556
TEST_TIME 83 9531
TEST_TIME 84 9516
TEST_TIME 85 9520
TEST_TIME 86 9547
TEST_TIME 87 9565
TEST_TIME 88 9546
TEST_TIME 89 9504
TEST_TIME 90 9535
TEST_TIME 91 9589
TEST_TIME 92 9574
TEST_TIME 93 9536
TEST_TIME 94 9664
TEST_TIME 95 9660
TEST_TIME 96 9678
TEST_TIME 97 9694
TEST_TIME 98 9709
TEST_TIME 99 9643
TEST_TIME 100 9605
TEST_TIME 101 9570
TEST_TIME 102 9576
TEST_TIME 103 9540
TEST_TIME 104 9530
TEST_TIME 105 9488
TEST_TIME 106 9475
TEST_TIME 107 9407
TEST_TIME 108 9472
TEST_TIME 109 9435
TEST_TIME 110 9408
TEST_TIME 111 9409
TEST_TIME 112 9455
TEST_TIME 113 9488
TEST_TIME 114 9478
TEST_TIME 115 9485
TEST_TIME 116 9539
TEST_TIME 117 9529
TEST_TIME 118 9492
TEST_TIME 119 9560
TEST_TIME 120 9534

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 01-02-2023 19:39:28 to 01-02-2023 19:39:32.

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 1566826 1566826 0 0.00 0 29296 6 0 0
doc_list_biud 1566825 1566825 0 0.00 0 100927 27 0 0
sp_add_invoice_to_stock 5099 4946 153 3.00 35 219061 17558 0 153
sp_cancel_adding_invoice 6104 6104 0 0.00 3 80714 692 0 0
sp_cancel_client_order 1787 1787 0 0.00 4 18332 343 0 0
sp_cancel_customer_reserve 602159 602159 0 0.00 0 34475 56 0 0
sp_cancel_pay_from_customer 674 674 0 0.00 3 13195 123 0 0
sp_cancel_pay_to_supplier 443 443 0 0.00 3 5135 64 0 0
sp_cancel_supplier_invoice 6706 6693 13 0.19 2 100937 799 0 13
sp_cancel_supplier_order 410 410 0 0.00 5 1069286 105716 0 0
sp_cancel_write_off 9712 9712 0 0.00 1 15832 112 0 0
sp_client_order 20342 20342 0 0.00 3 17486 377 0 0
sp_customer_reserve 455571 455571 0 0.00 0 103588 175 0 0
sp_fill_shopping_cart 31141 31141 0 0.00 1 17155 36 0 0
sp_fill_shopping_cart_clo_res 455567 455567 0 0.00 0 15521 14 0 0
sp_get_clo_for_invoice 4942 4942 0 0.00 0 16241 261 0 0
sp_kill_cost_storno 16933 16933 0 0.00 0 14163 56 0 0
sp_kill_qstorno_ret_qs2qd 1221133 1221133 0 0.00 0 100921 30 0 0
sp_kill_qty_storno 641825 641825 0 0.00 0 100926 65 0 0
sp_lock_selected_doc 20740 20740 0 0.00 0 8824 5 0 0
sp_make_cost_storno 27830 27830 0 0.00 0 29285 59 0 0
sp_multiply_rows_for_pdistr 27830 27830 0 0.00 0 6661 29 0 0
sp_multiply_rows_for_qdistr 20342 20342 0 0.00 0 12696 170 0 0
sp_pay_from_customer 6939 6939 0 0.00 4 14301 136 0 0
sp_pay_to_supplier 5930 5930 0 0.00 4 16693 134 0 0
sp_payment_common 12869 12869 0 0.00 2 14289 36 0 0
sp_qd_handle_on_cancel_clo 1787 1787 0 0.00 0 18325 306 0 0
sp_qd_handle_on_invoice_upd_sts 11045 11045 0 0.00 0 34183 298 0 0
sp_qd_handle_on_reserve_upd_sts 10019 10019 0 0.00 0 16221 52 0 0
sp_reserve_write_off 10019 10019 0 0.00 6 16500 180 0 0
sp_supplier_invoice 5435 5435 0 0.00 6 90984 3089 0 0
sp_supplier_order 5366 5366 0 0.00 5 35332 1200 0 0
srv_aggregate_perf_data 96 95 1 1.04 3028 379291 22701 0 1
srv_fill_mon_cache_memory 61 61 0 0.00 1317 139433 50541 0 0
srv_find_qd_qs_mism 1097336 1097336 0 0.00 0 13747 5 0 0
srv_make_invnt_saldo 555 555 0 0.00 50 52889 1080 0 0
srv_make_money_saldo 777 777 0 0.00 0 8549 34 0 0
srv_recalc_idx_stat 4 4 0 0.00 146906 496797 338138 0 0
t$perf-abend:sp_add_invoice_to_stock 153 153 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 13 13 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 4946 4946 0 0.00 0 15453 187 0 0
t$perf-norm:sp_cancel_adding_invoice 381 381 0 0.00 0 7199 86 0 0
t$perf-norm:sp_cancel_client_order 1787 1787 0 0.00 0 5279 24 0 0
t$perf-norm:sp_cancel_customer_reserve 718 718 0 0.00 0 7754 24 0 0
t$perf-norm:sp_cancel_pay_from_customer 674 674 0 0.00 0 1275 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 443 443 0 0.00 0 14771 41 0 0
t$perf-norm:sp_cancel_supplier_invoice 390 390 0 0.00 0 563 9 0 0
t$perf-norm:sp_cancel_supplier_order 410 410 0 0.00 0 31780 1649 0 0
t$perf-norm:sp_cancel_write_off 977 977 0 0.00 0 7376 23 0 0
t$perf-norm:sp_client_order 20342 20342 0 0.00 0 26663 19 0 0
t$perf-norm:sp_customer_reserve 1016 1016 0 0.00 0 2872 11 0 0
t$perf-norm:sp_pay_from_customer 6939 6939 0 0.00 0 10007 11 0 0
t$perf-norm:sp_pay_to_supplier 5930 5930 0 0.00 0 5653 12 0 0
t$perf-norm:sp_reserve_write_off 10019 10019 0 0.00 0 17215 16 0 0
t$perf-norm:sp_supplier_invoice 5435 5435 0 0.00 0 11301 25 0 0
t$perf-norm:sp_supplier_order 5366 5366 0 0.00 0 14313 19 0 0
t$perf-norm:srv_aggregate_perf_data 95 95 0 0.00 0 84 3 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 9 1 0 0
t$perf-norm:srv_make_invnt_saldo 555 555 0 0.00 0 798 17 0 0
t$perf-norm:srv_make_money_saldo 777 777 0 0.00 0 3395 25 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 13 5 0 0
v_add_invoice_to_stock 10188 9882 306 3.00 0 6229 22 0 306
v_all_customers 36588 36588 0 0.00 0 52 1 0 0
v_all_suppliers 30424 30424 0 0.00 0 17 1 0 0
v_all_wares 40684 40684 0 0.00 0 54 1 0 0
v_cancel_adding_invoice 762 762 0 0.00 0 81 5 0 0
v_cancel_client_order 3574 3574 0 0.00 0 8044 9 0 0
v_cancel_customer_prepayment 1348 1348 0 0.00 0 10699 14 0 0
v_cancel_customer_reserve 1436 1436 0 0.00 0 3091 6 0 0
v_cancel_payment_to_supplier 886 886 0 0.00 0 861 6 0 0
v_cancel_supplier_invoice 806 780 26 3.22 0 1440 17 0 26
v_cancel_supplier_order 820 820 0 0.00 0 2194 8 0 0
v_cancel_write_off 1954 1954 0 0.00 0 513 11 0 0
v_max_id_clo_ord 5365 5365 0 0.00 0 3087 2 0 0
v_max_id_clo_res 1016 1016 0 0.00 0 2994 19 0 0
v_max_id_ord_sup 5434 5434 0 0.00 0 2761 3 0 0
v_max_non_paid_invoice 1517 1517 0 0.00 0 314 3 0 0
v_max_non_paid_realizn 3888 3888 0 0.00 0 1818 4 0 0
v_min_id_clo_ord 5365 5365 0 0.00 0 4203 9 0 0
v_min_id_clo_res 1016 1016 0 0.00 0 2772 10 0 0
v_min_id_ord_sup 5434 5434 0 0.00 0 13006 13 0 0
v_min_non_paid_invoice 5930 5930 0 0.00 0 13200 18 0 0
v_min_non_paid_realizn 6939 6939 0 0.00 0 14208 38 0 0
v_our_firm 10198 10198 0 0.00 0 25 1 0 0
v_reserve_write_off 20038 20038 0 0.00 0 13350 12 0 0
x_lock_depdocs_on_canc_invoice 12407 12407 0 0.00 0 16847 113 0 0
x_lock_depdocs_on_canc_sup_ord 410 410 0 0.00 0 17980 360 0 0
x_make_qstorno_1000_1200 5366 5366 0 0.00 1 35309 1130 0 0
x_make_qstorno_1200_2000 5435 5435 0 0.00 3 86217 2955 0 0
x_make_qstorno_2100_3300 455571 455571 0 0.00 0 103588 159 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 01-02-2023 19:39:33 to 01-02-2023 19:39:37.

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
17:08:39 1 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
17:09:40 13515 8192000000 9897749872 10204360704 981225648 10.696 100 90 180 0 1011268800 6284720 23758432
17:11:06 20434 8192000000 9935711888 10253795328 1015973776 11.033 100 92 184 1 1049003568 8956960 24072832
17:12:30 12121 8192000000 9959424688 10291585024 1048537824 11.347 100 78 156 0 1078066496 9883072 19645600
17:13:45 8830 8192000000 10023631312 10367008768 1105620416 11.891 100 88 172 1 1137915520 11338880 20956224
17:14:56 4803 8192000000 10075969680 10433204224 1165917632 12.459 100 81 161 0 1196926272 13007296 18001344
17:16:04 3095 8192000000 10121933936 10486325248 1205179472 12.824 100 85 170 0 1238567984 14876944 18511568
17:17:11 1937 8192000000 10153616880 10530455552 1246825296 13.209 100 77 153 0 1275033808 10713040 17495472
17:18:15 3112 8192000000 10179544752 10560454656 1269968864 13.421 100 84 168 0 1301531376 13257904 18304608
17:19:20 1240 8192000000 10209121632 10598113280 1300775392 13.702 100 80 160 0 1330746272 11699664 18271216
17:20:24 32471 8192000000 10195364000 10609647616 1312761008 13.811 100 37 74 0 1328052912 6533200 8758704
17:22:05 4975 8192000000 10209638624 10618462208 1317445152 13.854 100 34 66 2 1331994016 6991968 7556896
17:23:11 12448 8192000000 10211821488 10626875392 1323166816 13.905 100 18 34 0 1333094128 6366512 3560800
17:24:23 22802 8192000000 10212036848 10634371072 1329620608 13.964 100 14 28 0 1338894592 6416688 2857296
17:25:50 65015 8192000000 10243100688 10651492352 1336299696 14.024 100 51 99 2 1352859712 5079136 11480880
17:27:55 7584 8192000000 10209720768 10630586368 1324331216 13.916 100 25 50 0 1335813072 5804432 5677424
17:29:04 6173 8192000000 10188762032 10600816640 1283305472 13.543 98 17 34 0 1292526192 5321344 3899376
17:30:12 36604 8192000000 10197253376 10602299392 1290794112 13.611 99 49 97 3 1307913808 5194336 11925360
17:31:49 7240 8192000000 10107966272 10496450560 1185801328 12.644 95 15 28 1 1193865536 4769872 3294336
17:32:57 6665 8192000000 10139460880 10536914944 1220952608 12.970 97 20 40 0 1231335248 5970560 4412080
17:34:07 16627 8192000000 10160795712 10570137600 1254619120 13.281 98 33 63 1 1267311040 5591648 7100272
17:35:24 9303 8192000000 10164787824 10578776064 1280239616 13.515 100 16 32 0 1288984928 5202176 3543136
17:36:34 5506 8192000000 10190554336 10601844736 1299878704 13.694 100 18 36 0 1309472048 4615072 4978272
17:37:39 15842 8192000000 10199493392 10618478592 1314237904 13.825 100 18 36 0 1323614112 4889744 4486464
17:39:06 40701 8192000000 10252930304 10658586624 1343275792 14.087 100 32 64 0 1356600192 5835680 7488720
17:40:55 104993 8192000000 10258605728 10689290240 1364437760 14.277 100 35 68 1 1384211568 11395088 8378720
17:44:08 9130 8192000000 10296936384 10720325632 1383633648 14.449 100 47 94 1 1415763600 20840784 11289168
17:45:26 28224 8192000000 10312735696 10744807424 1399008640 14.586 100 36 72 0 1427810480 20194624 8607216
17:47:05 6282 8192000000 10323075728 10748657664 1404353968 14.634 100 60 119 0 1441540000 22379872 14806160
17:48:18 5080 8192000000 10333918144 10757730304 1408716880 14.673 100 62 122 1 1446903744 24181168 14005696
17:49:26 9697 8192000000 10339585600 10762403840 1412959056 14.710 100 58 116 0 1452380752 25865232 13556464
17:50:42 1316 8192000000 10360322752 10773467136 1418365392 14.758 100 73 144 0 1463623792 27905056 17353344
17:51:46 2233 8192000000 10357068656 10775875584 1416650272 14.743 100 69 136 1 1466747280 33297792 16799216
17:52:52 2247 8192000000 10361301424 10769444864 1407946432 14.666 100 85 165 0 1466020384 38676912 19397040
17:54:00 1471 8192000000 10379527056 10784935936 1411743664 14.699 99 83 162 0 1477485408 45639040 20102704
17:55:06 4204 8192000000 10366299664 10787303424 1413257776 14.713 100 61 123 4 1479465440 49729552 16478112
17:56:18 2923 8192000000 10384950160 10798915584 1419125136 14.765 100 74 145 0 1492788320 55341472 18321712
17:57:29 1528 8192000000 10381334800 10792996864 1409954432 14.684 100 86 172 0 1484736688 52666592 22115664
17:58:34 10440 8192000000 10366952624 10785370112 1403019488 14.622 100 57 112 2 1475833584 58023440 14790656
17:59:48 12949 8192000000 10355369872 10781495296 1396036064 14.560 100 37 74 0 1464128272 57029872 11062336
18:01:08 25349 8192000000 10328831520 10752110592 1357213648 14.212 98 39 80 1 1418677568 50709184 10754736
18:02:35 15021 8192000000 10306233088 10739855360 1361319200 14.249 100 30 60 0 1418150304 48363616 8467488
18:03:55 38651 8192000000 10284456496 10725736448 1307798000 13.766 97 18 36 0 1362130512 48313856 6018656
18:06:13 70895 8192000000 10251462832 10694004736 1306999760 13.759 97 13 24 0 1330859616 21173984 2685872
18:08:24 76514 8192000000 10267683008 10711719936 1324972240 13.922 97 27 54 5 1339319568 9049712 5297616
18:10:48 100086 8192000000 10291477424 10730172416 1376815776 14.388 100 31 62 0 1392646336 8727104 7103456
18:13:29 38873 8192000000 10290411456 10733768704 1367441152 14.304 99 26 52 0 1383434976 9539152 6454672
18:15:10 23073 8192000000 10288113776 10730590208 1362294288 14.258 99 27 54 0 1376793600 7987792 6511520
18:16:39 59947 8192000000 10272638256 10737553408 1374257312 14.365 100 9 18 0 1388949952 12678544 2014096
18:18:42 84879 8192000000 10289026560 10744279040 1359447008 14.232 98 11 22 0 1373294128 11481232 2365888
18:21:08 38026 8192000000 10277824224 10739576832 1382236240 14.437 100 16 32 1 1395719008 9628064 3854704
18:22:46 47575 8192000000 10303994976 10752032768 1394296688 14.544 100 38 71 1 1412164224 9642896 8224640
18:24:34 76508 8192000000 10296995200 10761654272 1381340672 14.429 99 23 46 0 1399363872 12933072 5090128
18:26:51 49320 8192000000 10303451168 10768969728 1396562144 14.564 100 26 51 0 1416732560 14120128 6050288
18:28:41 68316 8192000000 10303177856 10761715712 1372498288 14.349 98 4 9 0 1388189696 14910336 781072
18:30:49 58813 8192000000 10306491152 10755117056 1364578368 14.278 97 21 42 0 1383189216 13462976 5147872
18:32:53 68272 8192000000 10299264832 10755256320 1352371920 14.169 97 5 10 0 1372950512 19189184 1389408
18:35:11 45429 8192000000 10299444976 10752917504 1346183440 14.113 97 31 62 0 1370800112 17649104 6967568
18:37:44 111341 8192000000 10296819904 10746179584 1365221872 14.284 98 32 64 1 1385615296 13273312 7120112
18:41:27 55512 8192000000 10269595856 10726060032 1358616688 14.225 99 14 28 0 1375025024 13253312 3155024
18:43:23 74718 8192000000 10265431824 10719064064 1309503936 13.782 96 16 32 0 1321318288 8565808 3248544
18:45:39 59349 8192000000 10281401776 10725425152 1301537504 13.709 95 21 42 0 1317644928 11171120 4936304
18:47:39 77027 8192000000 10284445408 10742628352 1359440272 14.232 99 23 46 0 1389931840 24827728 5663840
18:50:18 62126 8192000000 10283747024 10742947840 1353108944 14.175 99 26 50 0 1387129504 27674640 6345920
18:52:20 59434 8192000000 10273167904 10719084544 1305200512 13.743 95 28 57 0 1324432544 12450704 6781328
18:54:20 33670 8192000000 10266532512 10702184448 1317578080 13.855 97 31 62 2 1333209408 8739520 6891808
18:55:57 17602 8192000000 10301314096 10722828288 1353017296 14.175 100 55 110 0 1384686928 19328480 12341152
18:57:19 115082 8192000000 10247483120 10699485184 1316614928 13.846 97 28 56 0 1330688128 7654688 6418512
19:00:27 78034 8192000000 10266781904 10732716032 1364930848 14.282 100 13 26 1 1383688400 15838960 2918592
19:02:45 38406 8192000000 10266050112 10727034880 1353648848 14.180 99 11 20 0 1368176128 11894032 2633248
19:04:57 87698 8192000000 10272316144 10733645824 1353531040 14.179 99 10 20 0 1367758880 11791424 2436416
19:07:24 94028 8192000000 10292143376 10757369856 1381617120 14.431 100 23 45 1 1400524992 13256512 5651360
19:09:59 67908 8192000000 10287956672 10739871744 1346271360 14.114 97 16 32 0 1357962656 8394192 3297104
19:12:23 139433 8192000000 10295431408 10753359872 1341474096 14.071 97 9 18 0 1357764912 14569888 1720928
19:15:51 92805 8192000000 10301931616 10763640832 1359796096 14.236 98 14 28 0 1379443280 16465824 3181360
19:18:31 88495 8192000000 10296613920 10752307200 1349719264 14.145 97 22 44 0 1364229072 10005264 4504544
19:21:11 60887 8192000000 10274603792 10742263808 1382430816 14.438 100 17 34 0 1397514496 11339920 3743760
19:23:12 69508 8192000000 10279900928 10736865280 1348538592 14.134 97 15 30 0 1362087728 10168800 3380336
19:25:45 63057 8192000000 10274923856 10739879936 1360788848 14.244 99 18 35 1 1380316736 15271584 4256304
19:28:28 38194 8192000000 10312423664 10766884864 1387306416 14.482 99 39 78 0 1410929552 14502688 9120448
19:30:06 92204 8192000000 10289975952 10751344640 1354381408 14.187 97 13 24 0 1369613968 12593632 2638928
19:32:39 36681 8192000000 10294107664 10744012800 1333011072 13.994 95 28 56 0 1348703808 9398384 6294352
19:34:23 94687 8192000000 10259013136 10716356608 1248779360 13.227 90 19 38 0 1262710976 9709120 4222496
19:36:58 31140 8192000000 10279843168 10715496448 1343121008 14.086 99 45 90 0 1369356640 16510096 9725536
19:38:32 14788 8192000000 9034837824 9237045248 199222928 2.374 15 1 2 0 201285120 2019840 42352

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 01-02-2023 19:39:39 to 01-02-2023 19:39:54.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 153 v_add_invoice_to_stock 335544517
except 13 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 01-02-2023 19:39:55 to 01-02-2023 19:39:57.

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

01.02.23 19:39:58. 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-01 19:40:01 No severe PSQL-related problems occured
01.02.23 19:40:02. End of report.