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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 16652748 kB
MemAvailable 31277828 kB
Buffers 0 kB
Cached 14999900 kB
SwapCached 1220 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.9
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 2022-01-06 16:37:59
DTS_END                         2022-01-06 16:37:59.3330
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_PAY_TO_SUPPLIER(26:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/40666
TRN_ID                          245241
ATT_ID                          681
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: 9412.79 19636 1129535
customer order: creation 180.93 347 21712
customer order: refuse 15.03 345 1803
order to supplier: creation 48.31 1223 5797
order to supplier: removal 3.37 106312 404
invoice (draft): creation 48.35 3487 5802
invoice (draft): removal 51.83 819 6219
invoice accept: apply 44.23 19007 5307
invoice accept: cancel 46.52 834 5582
customer reserve: creation 4090.71 187 490885
customer reserve: removal 4569.81 61 548377
realization accept: apply 89.14 179 10697
realization accept: cancel 86.98 114 10437
payment from customer: creation 62.67 112 7520
payment from customer: removal 6.03 113 724
payment to supplier: creation 51.26 119 6151
payment to supplier: removal 3.50 76 420
service: total inventory turnovers 5.73 908 688
service: total monetary turnovers 7.48 23 898
service: aggregate perf. data 0.90 18459 108
service: refresh index statistics 0.03 240001 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 06-01-2022 16:38:48 to 06-01-2022 16:38:50.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 3248
TEST_TIME 2 3563
TEST_TIME 3 4805
TEST_TIME 4 4556
TEST_TIME 5 5162
TEST_TIME 6 4872
TEST_TIME 7 4790
TEST_TIME 8 4835
TEST_TIME 9 4989
TEST_TIME 10 5442
TEST_TIME 11 5900
TEST_TIME 12 6012
TEST_TIME 13 6509
TEST_TIME 14 6616
TEST_TIME 15 6554
TEST_TIME 16 6843
TEST_TIME 17 7075
TEST_TIME 18 7087
TEST_TIME 19 7475
TEST_TIME 20 7796
TEST_TIME 21 8189
TEST_TIME 22 8398
TEST_TIME 23 8960
TEST_TIME 24 10068
TEST_TIME 25 10194
TEST_TIME 26 10718
TEST_TIME 27 11111
TEST_TIME 28 10839
TEST_TIME 29 10479
TEST_TIME 30 10537
TEST_TIME 31 10657
TEST_TIME 32 10490
TEST_TIME 33 10347
TEST_TIME 34 10272
TEST_TIME 35 10154
TEST_TIME 36 10212
TEST_TIME 37 10009
TEST_TIME 38 10132
TEST_TIME 39 10006
TEST_TIME 40 9951
TEST_TIME 41 9779
TEST_TIME 42 9974
TEST_TIME 43 9987
TEST_TIME 44 9902
TEST_TIME 45 9940
TEST_TIME 46 10001
TEST_TIME 47 9998
TEST_TIME 48 10013
TEST_TIME 49 10016
TEST_TIME 50 10003
TEST_TIME 51 9906
TEST_TIME 52 9904
TEST_TIME 53 9930
TEST_TIME 54 9870
TEST_TIME 55 9877
TEST_TIME 56 9760
TEST_TIME 57 9660
TEST_TIME 58 9605
TEST_TIME 59 9602
TEST_TIME 60 9572
TEST_TIME 61 9520
TEST_TIME 62 9453
TEST_TIME 63 9420
TEST_TIME 64 9416
TEST_TIME 65 9460
TEST_TIME 66 9430
TEST_TIME 67 9473
TEST_TIME 68 9539
TEST_TIME 69 9466
TEST_TIME 70 9495
TEST_TIME 71 9508
TEST_TIME 72 9496
TEST_TIME 73 9607
TEST_TIME 74 9604
TEST_TIME 75 9646
TEST_TIME 76 9655
TEST_TIME 77 9633
TEST_TIME 78 9616
TEST_TIME 79 9546
TEST_TIME 80 9567
TEST_TIME 81 9512
TEST_TIME 82 9520
TEST_TIME 83 9469
TEST_TIME 84 9401
TEST_TIME 85 9446
TEST_TIME 86 9416
TEST_TIME 87 9400
TEST_TIME 88 9384
TEST_TIME 89 9373
TEST_TIME 90 9363
TEST_TIME 91 9354
TEST_TIME 92 9387
TEST_TIME 93 9393
TEST_TIME 94 9406
TEST_TIME 95 9440
TEST_TIME 96 9434
TEST_TIME 97 9460
TEST_TIME 98 9461
TEST_TIME 99 9447
TEST_TIME 100 9455
TEST_TIME 101 9478
TEST_TIME 102 9527
TEST_TIME 103 9526
TEST_TIME 104 9448
TEST_TIME 105 9413
TEST_TIME 106 9368
TEST_TIME 107 9354
TEST_TIME 108 9354
TEST_TIME 109 9334
TEST_TIME 110 9320
TEST_TIME 111 9345
TEST_TIME 112 9338
TEST_TIME 113 9356
TEST_TIME 114 9344
TEST_TIME 115 9374
TEST_TIME 116 9373
TEST_TIME 117 9372
TEST_TIME 118 9380
TEST_TIME 119 9408
TEST_TIME 120 9415
TEST_TIME 121 9337

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 06-01-2022 16:38:52 to 06-01-2022 16:38:55.

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 1581717 1581717 0 0.00 0 33576 7 0 0
doc_list_biud 1581714 1581714 0 0.00 0 46722 27 0 0
sp_add_invoice_to_stock 5433 5307 126 2.31 19 189055 19007 0 126
sp_cancel_adding_invoice 5582 5582 0 0.00 3 71936 834 0 0
sp_cancel_client_order 1803 1803 0 0.00 4 10376 345 0 0
sp_cancel_customer_reserve 548377 548377 0 0.00 1 36519 62 0 0
sp_cancel_pay_from_customer 724 724 0 0.00 3 6764 113 0 0
sp_cancel_pay_to_supplier 420 420 0 0.00 3 3673 77 0 0
sp_cancel_supplier_invoice 6233 6219 14 0.22 1 41296 819 0 14
sp_cancel_supplier_order 404 404 0 0.00 15 1174205 106313 0 0
sp_cancel_write_off 10437 10437 0 0.00 1 8502 114 0 0
sp_client_order 21712 21712 0 0.00 3 14447 348 0 0
sp_customer_reserve 490885 490885 0 0.00 0 84898 188 0 0
sp_fill_shopping_cart 33280 33280 0 0.00 1 11800 36 0 0
sp_fill_shopping_cart_clo_res 490876 490876 0 0.00 0 28930 15 0 0
sp_get_clo_for_invoice 5294 5294 0 0.00 0 36495 335 0 0
sp_kill_cost_storno 17163 17163 0 0.00 0 7871 61 0 0
sp_kill_qstorno_ret_qs2qd 1113814 1113814 0 0.00 0 41268 33 0 0
sp_kill_qty_storno 588812 588812 0 0.00 0 46720 72 0 0
sp_lock_selected_doc 22007 22007 0 0.00 0 10084 5 0 0
sp_make_cost_storno 29661 29661 0 0.00 0 33564 54 0 0
sp_multiply_rows_for_pdistr 29660 29660 0 0.00 0 7905 30 0 0
sp_multiply_rows_for_qdistr 21712 21712 0 0.00 0 12942 163 0 0
sp_pay_from_customer 7520 7520 0 0.00 4 16215 113 0 0
sp_pay_to_supplier 6151 6151 0 0.00 4 11371 119 0 0
sp_payment_common 13668 13668 0 0.00 1 10696 31 0 0
sp_qd_handle_on_cancel_clo 1803 1803 0 0.00 0 10350 316 0 0
sp_qd_handle_on_invoice_upd_sts 10875 10875 0 0.00 0 46714 329 0 0
sp_qd_handle_on_reserve_upd_sts 10697 10697 0 0.00 0 28990 59 0 0
sp_reserve_write_off 10697 10697 0 0.00 6 29021 179 0 0
sp_supplier_invoice 5802 5802 0 0.00 5 86750 3488 0 0
sp_supplier_order 5797 5797 0 0.00 5 43689 1223 0 0
srv_aggregate_perf_data 108 108 0 0.00 2589 275502 18460 0 0
srv_fill_mon_cache_memory 62 62 0 0.00 1564 153250 49146 0 0
srv_find_qd_qs_mism 1077877 1077877 0 0.00 0 9075 6 0 0
srv_make_invnt_saldo 688 688 0 0.00 32 82838 909 0 0
srv_make_money_saldo 898 898 0 0.00 0 1068 24 0 0
srv_recalc_idx_stat 4 4 0 0.00 163680 291834 240002 0 0
t$perf-abend:sp_add_invoice_to_stock 126 126 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 14 14 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5307 5307 0 0.00 0 13583 163 0 0
t$perf-norm:sp_cancel_adding_invoice 426 426 0 0.00 0 2416 89 0 0
t$perf-norm:sp_cancel_client_order 1803 1803 0 0.00 0 3953 15 0 0
t$perf-norm:sp_cancel_customer_reserve 751 751 0 0.00 0 9489 21 0 0
t$perf-norm:sp_cancel_pay_from_customer 724 724 0 0.00 0 1661 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 420 420 0 0.00 0 1081 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 431 431 0 0.00 0 5290 36 0 0
t$perf-norm:sp_cancel_supplier_order 404 404 0 0.00 0 31365 1682 0 0
t$perf-norm:sp_cancel_write_off 1058 1058 0 0.00 0 2548 11 0 0
t$perf-norm:sp_client_order 21713 21713 0 0.00 0 9450 18 0 0
t$perf-norm:sp_customer_reserve 1115 1115 0 0.00 0 4589 12 0 0
t$perf-norm:sp_pay_from_customer 7520 7520 0 0.00 0 10440 14 0 0
t$perf-norm:sp_pay_to_supplier 6151 6151 0 0.00 0 5871 11 0 0
t$perf-norm:sp_reserve_write_off 10697 10697 0 0.00 0 12184 14 0 0
t$perf-norm:sp_supplier_invoice 5802 5802 0 0.00 0 7525 21 0 0
t$perf-norm:sp_supplier_order 5797 5797 0 0.00 0 3868 15 0 0
t$perf-norm:srv_aggregate_perf_data 108 108 0 0.00 0 1256 15 0 0
t$perf-norm:srv_fill_mon_cache_memory 62 62 0 0.00 0 6 0 0 0
t$perf-norm:srv_make_invnt_saldo 688 688 0 0.00 0 966 18 0 0
t$perf-norm:srv_make_money_saldo 898 898 0 0.00 0 742 10 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 3 2 0 0
v_add_invoice_to_stock 10838 10586 252 2.32 0 5609 18 0 252
v_all_customers 39324 39324 0 0.00 0 40 1 0 0
v_all_suppliers 32208 32208 0 0.00 0 19 1 0 0
v_all_wares 43424 43424 0 0.00 0 19 1 0 0
v_cancel_adding_invoice 852 852 0 0.00 0 6003 16 0 0
v_cancel_client_order 3606 3606 0 0.00 0 5342 7 0 0
v_cancel_customer_prepayment 1448 1448 0 0.00 0 5336 11 0 0
v_cancel_customer_reserve 1502 1502 0 0.00 0 3652 16 0 0
v_cancel_payment_to_supplier 840 840 0 0.00 0 3190 11 0 0
v_cancel_supplier_invoice 890 862 28 3.14 0 3166 19 0 28
v_cancel_supplier_order 808 808 0 0.00 0 1434 8 0 0
v_cancel_write_off 2116 2116 0 0.00 0 3910 17 0 0
v_max_id_clo_ord 5795 5795 0 0.00 0 2773 2 0 0
v_max_id_clo_res 1115 1115 0 0.00 0 1898 12 0 0
v_max_id_ord_sup 5773 5773 0 0.00 0 2991 3 0 0
v_max_non_paid_invoice 1612 1612 0 0.00 0 3568 4 0 0
v_max_non_paid_realizn 4056 4056 0 0.00 0 9462 8 0 0
v_min_id_clo_ord 5795 5795 0 0.00 0 3927 7 0 0
v_min_id_clo_res 1115 1115 0 0.00 0 10002 20 0 0
v_min_id_ord_sup 5773 5773 0 0.00 0 5667 5 0 0
v_min_non_paid_invoice 6148 6148 0 0.00 0 7793 21 0 0
v_min_non_paid_realizn 7520 7520 0 0.00 0 10687 23 0 0
v_our_firm 11028 11028 0 0.00 0 14 1 0 0
v_reserve_write_off 21394 21394 0 0.00 0 5716 7 0 0
x_lock_depdocs_on_canc_invoice 11370 11370 0 0.00 0 22568 116 0 0
x_lock_depdocs_on_canc_sup_ord 404 404 0 0.00 0 11913 379 0 0
x_make_qstorno_1000_1200 5797 5797 0 0.00 2 43682 1143 0 0
x_make_qstorno_1200_2000 5802 5802 0 0.00 2 86683 3349 0 0
x_make_qstorno_2100_3300 490885 490885 0 0.00 0 84896 170 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 06-01-2022 16:38:56 to 06-01-2022 16:39:00.

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
14:08:03 11 8192000000 8811283904 8826953728 15661056 0.190 4 4 5 0 15887808 87456 139296
14:09:04 27304 8192000000 9895596976 10209230848 982193104 10.706 100 88 176 0 1010762544 5736128 22833312
14:10:37 26062 8192000000 9943625664 10263257088 1023372400 11.105 100 94 188 0 1055815872 8367232 24076240
14:12:07 12103 8192000000 9972083360 10304057344 1053917936 11.398 100 83 166 0 1084915536 9886304 21111296
14:13:24 17503 8192000000 10025147696 10373849088 1113997616 11.970 100 76 152 0 1143300944 11290656 18012672
14:14:46 8529 8192000000 10085052704 10443747328 1167364928 12.472 100 75 150 1 1196624096 11696784 17562384
14:15:59 4998 8192000000 10122485904 10496434176 1208082896 12.851 100 69 138 0 1235142928 11490384 15569648
14:17:07 4477 8192000000 10158251328 10539745280 1254756832 13.282 100 66 132 0 1280188624 11068160 14363632
14:18:15 1529 8192000000 10205027440 10590171136 1291357104 13.617 100 95 191 0 1327075872 13926448 21792320
14:19:18 33232 8192000000 10200801600 10607079424 1305114624 13.742 100 45 90 0 1323747024 8347136 10285264
14:20:54 5789 8192000000 10199874816 10616111104 1315966976 13.840 100 20 40 2 1326579808 5889568 4723264
14:22:07 6131 8192000000 10202224336 10625245184 1321968944 13.895 100 29 58 0 1335817200 7590000 6258256
14:23:15 69562 8192000000 10216379648 10641985536 1325074544 13.923 100 21 42 0 1334808784 4991024 4743216
14:25:27 8454 8192000000 10221060672 10645413888 1330885152 13.975 100 25 51 2 1342034016 5155008 5993856
14:26:36 14781 8192000000 10221699504 10646917120 1334000304 14.003 100 20 41 1 1344360272 5487936 4872032
14:27:54 62030 8192000000 10203621712 10608349184 1228831424 13.043 93 35 69 1 1241710576 5572880 7306272
14:29:57 5083 8192000000 10161844320 10568720384 1244641456 13.189 97 25 50 0 1257112224 7144384 5326384
14:31:05 8404 8192000000 10130942800 10540290048 1238238464 13.130 99 19 38 1 1248009728 5369120 4402144
14:32:14 53387 8192000000 10148865872 10546237440 1231930544 13.072 97 32 64 0 1245376432 5136128 8309760
14:34:08 6036 8192000000 10184726320 10598133760 1293150880 13.633 100 43 84 2 1314132800 11077152 9904768
14:35:14 6244 8192000000 10188628304 10600218624 1296703360 13.665 100 30 61 0 1310051456 6673856 6674240
14:36:22 8714 8192000000 10207546112 10624036864 1314441488 13.826 100 22 44 0 1324939504 5810768 4687248
14:37:31 102942 8192000000 10241731120 10657832960 1329942800 13.967 100 40 77 1 1344388224 5226544 9218880
14:40:22 14250 8192000000 10268824352 10686582784 1362419920 14.259 100 45 90 0 1381793312 9253856 10119536
14:41:40 16155 8192000000 10291598736 10715881472 1382783280 14.441 100 46 92 1 1408523696 15289344 10451072
14:43:12 5074 8192000000 10316599616 10737414144 1398090752 14.578 100 54 108 0 1430201536 19434832 12675952
14:44:26 14558 8192000000 10336992096 10760060928 1408664832 14.672 100 58 113 0 1444252624 22760288 12827504
14:45:46 5000 8192000000 10345400096 10769223680 1416982640 14.746 100 63 127 2 1459780016 27687200 15110176
14:46:58 3158 8192000000 10365397584 10786607104 1425233216 14.819 100 71 139 0 1473073968 31498720 16342032
14:48:04 8991 8192000000 10363590736 10785210368 1423704800 14.806 100 70 139 2 1474244032 33144896 17394336
14:49:18 3731 8192000000 10380635008 10799915008 1419672272 14.770 99 76 150 4 1480568848 42172736 18723840
14:50:26 3327 8192000000 10388516336 10801795072 1430131344 14.862 100 77 153 1 1489383024 40341856 18909824
14:51:37 12120 8192000000 10367064176 10788024320 1420386464 14.776 100 57 112 0 1476344944 40781440 15177040
14:53:00 5004 8192000000 10379774928 10798866432 1424374816 14.811 100 66 131 0 1489059312 48012976 16671520
14:54:10 2320 8192000000 10379690064 10785898496 1400951760 14.603 99 88 176 1 1474034704 49447808 23635136
14:55:19 1564 8192000000 10381007328 10787831808 1405270400 14.642 100 89 178 0 1479422544 51933328 22218816
14:56:30 3731 8192000000 10370916640 10782838784 1401280032 14.606 100 85 173 1 1477704992 53952656 22472304
14:57:41 5839 8192000000 10325281456 10731143168 1343581728 14.090 97 67 134 1 1417656480 55589056 18485696
14:58:54 9206 8192000000 10319559456 10740400128 1346635360 14.117 99 41 82 0 1416957616 58165840 12156416
15:00:13 2372 8192000000 10348726816 10759225344 1367185424 14.302 100 69 138 1 1450897424 64540080 19171920
15:01:17 23877 8192000000 10298963520 10752401408 1362374752 14.259 100 26 52 1 1428538336 58338640 7824944
15:02:51 32681 8192000000 10295694032 10754793472 1362005968 14.255 100 15 30 1 1403681792 37370144 4305680
15:04:24 39514 8192000000 10280843472 10716962816 1340623184 14.063 98 14 28 2 1358201952 13859024 3719744
15:06:07 88853 8192000000 10262709104 10706919424 1335587856 14.018 99 34 69 1 1361908464 17107968 9212640
15:08:51 153249 8192000000 10294090128 10727387136 1303772992 13.730 95 38 76 1 1326930272 13951568 9205712
15:12:25 16597 8192000000 10294913520 10744258560 1379186320 14.409 100 44 83 3 1410916464 21235872 10494272
15:13:53 84955 8192000000 10300875040 10758160384 1382208080 14.436 100 14 28 2 1411199392 25203712 3787600
15:16:20 31907 8192000000 10283273424 10737885184 1367028512 14.300 99 11 22 0 1385634496 16127824 2478160
15:17:53 77797 8192000000 10311899280 10755964928 1383982320 14.452 100 24 46 0 1407218544 17429888 5806336
15:20:20 58427 8192000000 10295893792 10753953792 1374679232 14.369 99 12 24 0 1389259808 11399888 3180688
15:22:21 70372 8192000000 10290326560 10753085440 1377640016 14.395 99 13 26 1 1397866192 16802288 3423888
15:24:52 34147 8192000000 10291632304 10731622400 1336385184 14.025 96 29 57 0 1354029680 11356544 6287952
15:26:32 98529 8192000000 10288027504 10738966528 1364403328 14.277 98 7 14 0 1379251808 13425264 1423216
15:29:15 46920 8192000000 10297721568 10746978304 1363282752 14.267 98 31 62 1 1380509392 10752256 6474384
15:31:06 111416 8192000000 10290583152 10734039040 1317052816 13.850 95 27 54 1 1333711632 10672448 5986368
15:33:58 116884 8192000000 10286214640 10741026816 1380825408 14.424 100 26 52 0 1399305600 12552448 5927744
15:38:19 41255 8192000000 10262539664 10720882688 1356575520 14.207 98 13 26 0 1366374112 7040272 2758320
15:40:01 57235 8192000000 10274097136 10745384960 1371926880 14.344 99 8 16 0 1383344160 9552048 1865232
15:41:58 51577 8192000000 10307306160 10769350656 1395432096 14.554 100 27 54 1 1413523936 11973936 6117904
15:44:11 84703 8192000000 10287461776 10744807424 1361585696 14.252 98 16 32 1 1379359104 13862848 3910560
15:47:40 57973 8192000000 10280662816 10725462016 1324100288 13.914 96 13 26 0 1339473872 12106768 3266816
15:49:39 94335 8192000000 10282657040 10735419392 1346169344 14.113 98 5 10 0 1357489504 10472128 848032
15:52:13 84559 8192000000 10275937360 10721054720 1325222624 13.924 96 23 46 0 1343183472 12890816 5070032
15:54:39 22140 8192000000 10279959568 10713624576 1345404272 14.106 99 42 84 0 1369764192 15000064 9359856
15:56:15 124703 8192000000 10251142192 10703773696 1324281984 13.915 98 21 42 1 1343821424 14641104 4898336
15:59:54 58187 8192000000 10248977360 10697977856 1326700736 13.937 97 14 27 1 1337024528 7292128 3031664
16:01:53 59180 8192000000 10259004064 10720952320 1351525520 14.161 99 17 34 1 1368683088 12282432 4875136
16:03:57 69035 8192000000 10248153728 10708000768 1336148128 14.023 98 11 22 1 1347333520 8939072 2246320
16:06:39 71500 8192000000 10251133488 10697940992 1290570816 13.609 94 23 46 0 1304394144 8879360 4943968
16:08:57 36700 8192000000 10285826528 10728546304 1365824000 14.290 99 25 50 0 1381440512 10339456 5277056
16:10:34 84885 8192000000 10299494432 10754977792 1386524064 14.475 100 20 40 0 1402523920 11565392 4434464
16:13:08 45234 8192000000 10296154208 10729185280 1345512576 14.107 97 22 43 1 1357984656 7813040 4659040
16:14:57 108462 8192000000 10293840832 10725515264 1312885696 13.812 94 27 52 2 1328454464 9899168 5669600
16:17:53 46089 8192000000 10290464624 10725982208 1333322176 13.997 96 31 62 0 1352455280 12000624 7132480
16:19:40 127807 8192000000 10263968608 10705641472 1326063152 13.932 96 17 34 1 1344790608 14770272 3957184
16:23:11 16493 8192000000 10280758704 10723368960 1371353168 14.339 100 40 78 2 1387825392 8289504 8182720
16:24:28 66800 8192000000 10272693408 10734481408 1377510064 14.394 100 14 28 1 1392889056 12102688 3276304
16:26:36 70452 8192000000 10267186976 10714755072 1341079584 14.067 97 16 32 0 1355603312 11096976 3426752
16:28:48 52653 8192000000 10285494768 10740350976 1366442128 14.295 99 17 33 0 1377134352 7093744 3598480
16:30:41 49787 8192000000 10282334016 10735919104 1354851408 14.191 98 20 40 1 1370457360 10584416 5021536
16:32:33 24890 8192000000 10266662880 10711916544 1352703104 14.172 99 20 40 0 1364604656 7166256 4735296
16:34:00 31099 8192000000 10280007584 10723643392 1344452160 14.098 98 33 66 2 1361824848 9967744 7404944
16:35:32 78022 8192000000 10276158224 10728570880 1344058496 14.094 98 19 38 0 1361128288 12999600 4070192
16:37:50 25717 8192000000 8990581840 9183674368 149123376 1.787 12 1 2 0 151567408 2401680 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 06-01-2022 16:39:02 to 06-01-2022 16:39:17.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 126 v_add_invoice_to_stock 335544517
except 14 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 06-01-2022 16:39:18 to 06-01-2022 16:39:20.

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          245545
MON$OLDEST_ACTIVE               245546
MON$OLDEST_SNAPSHOT             245546
MON$NEXT_TRANSACTION            245546
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                       2007616
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


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

06.01.22 16:39:21. 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
2022-01-06 16:39:23 No severe PSQL-related problems occured
06.01.22 16:39:24. End of report.