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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 14983084 kB
MemAvailable 30051648 kB
Buffers 0 kB
Cached 16705932 kB
SwapCached 3456 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 2022-12-19 01:38:31
DTS_END                         2022-12-19 01:38:31.3500
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_ADD_INVOICE_TO_STOCK(190:30) ==> SP_CUSTOMER_RESERVE(47:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/59284
TRN_ID                          238821
ATT_ID                          648
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: 9527.30 21391 1143276
customer order: creation 168.03 335 20163
customer order: refuse 14.78 353 1774
order to supplier: creation 44.65 1144 5358
order to supplier: removal 3.46 109019 415
invoice (draft): creation 44.91 3012 5389
invoice (draft): removal 56.17 818 6740
invoice accept: apply 40.97 16789 4916
invoice accept: cancel 51.30 733 6156
customer reserve: creation 3761.58 167 451389
customer reserve: removal 5041.43 58 604971
realization accept: apply 83.75 191 10050
realization accept: cancel 89.30 110 10716
payment from customer: creation 58.30 107 6996
payment from customer: removal 5.42 99 650
payment to supplier: creation 48.48 152 5817
payment to supplier: removal 3.34 83 401
service: total inventory turnovers 4.44 1497 533
service: total monetary turnovers 6.12 25 734
service: aggregate perf. data 0.87 22118 104
service: refresh index statistics 0.03 271014 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 19-12-2022 01:39:21 to 19-12-2022 01:39:23.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2980
TEST_TIME 2 3002
TEST_TIME 3 3207
TEST_TIME 4 4301
TEST_TIME 5 4391
TEST_TIME 6 4379
TEST_TIME 7 4593
TEST_TIME 8 4631
TEST_TIME 9 5072
TEST_TIME 10 5402
TEST_TIME 11 5403
TEST_TIME 12 5492
TEST_TIME 13 5684
TEST_TIME 14 6195
TEST_TIME 15 6458
TEST_TIME 16 6544
TEST_TIME 17 6518
TEST_TIME 18 6798
TEST_TIME 19 7360
TEST_TIME 20 7884
TEST_TIME 21 8690
TEST_TIME 22 8774
TEST_TIME 23 8832
TEST_TIME 24 8833
TEST_TIME 25 8638
TEST_TIME 26 9367
TEST_TIME 27 9451
TEST_TIME 28 10263
TEST_TIME 29 10699
TEST_TIME 30 10518
TEST_TIME 31 10447
TEST_TIME 32 10313
TEST_TIME 33 10375
TEST_TIME 34 10370
TEST_TIME 35 10262
TEST_TIME 36 10070
TEST_TIME 37 9948
TEST_TIME 38 9930
TEST_TIME 39 10045
TEST_TIME 40 9981
TEST_TIME 41 9965
TEST_TIME 42 9926
TEST_TIME 43 9745
TEST_TIME 44 9659
TEST_TIME 45 9619
TEST_TIME 46 9539
TEST_TIME 47 9734
TEST_TIME 48 9680
TEST_TIME 49 9791
TEST_TIME 50 9695
TEST_TIME 51 9572
TEST_TIME 52 9676
TEST_TIME 53 9584
TEST_TIME 54 9609
TEST_TIME 55 9607
TEST_TIME 56 9633
TEST_TIME 57 9554
TEST_TIME 58 9608
TEST_TIME 59 9608
TEST_TIME 60 9675
TEST_TIME 61 9641
TEST_TIME 62 9778
TEST_TIME 63 9811
TEST_TIME 64 9750
TEST_TIME 65 9835
TEST_TIME 66 9918
TEST_TIME 67 9823
TEST_TIME 68 9957
TEST_TIME 69 10011
TEST_TIME 70 9937
TEST_TIME 71 9851
TEST_TIME 72 9799
TEST_TIME 73 9816
TEST_TIME 74 9775
TEST_TIME 75 9722
TEST_TIME 76 9732
TEST_TIME 77 9695
TEST_TIME 78 9639
TEST_TIME 79 9589
TEST_TIME 80 9634
TEST_TIME 81 9582
TEST_TIME 82 9511
TEST_TIME 83 9526
TEST_TIME 84 9495
TEST_TIME 85 9481
TEST_TIME 86 9597
TEST_TIME 87 9581
TEST_TIME 88 9572
TEST_TIME 89 9566
TEST_TIME 90 9552
TEST_TIME 91 9526
TEST_TIME 92 9661
TEST_TIME 93 9666
TEST_TIME 94 9748
TEST_TIME 95 9738
TEST_TIME 96 9693
TEST_TIME 97 9766
TEST_TIME 98 9700
TEST_TIME 99 9621
TEST_TIME 100 9644
TEST_TIME 101 9604
TEST_TIME 102 9591
TEST_TIME 103 9530
TEST_TIME 104 9514
TEST_TIME 105 9554
TEST_TIME 106 9576
TEST_TIME 107 9560
TEST_TIME 108 9551
TEST_TIME 109 9530
TEST_TIME 110 9518
TEST_TIME 111 9494
TEST_TIME 112 9518
TEST_TIME 113 9509
TEST_TIME 114 9570
TEST_TIME 115 9535
TEST_TIME 116 9552
TEST_TIME 117 9592
TEST_TIME 118 9584
TEST_TIME 119 9581
TEST_TIME 120 9527

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 19-12-2022 01:39:24 to 19-12-2022 01:39:28.

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 1562466 1562466 0 0.00 0 23379 6 0 0
doc_list_biud 1562466 1562466 0 0.00 0 53790 29 0 0
sp_add_invoice_to_stock 5066 4916 150 2.96 35 172115 16790 0 150
sp_cancel_adding_invoice 6156 6156 0 0.00 4 60216 733 0 0
sp_cancel_client_order 1774 1774 0 0.00 4 11636 354 0 0
sp_cancel_customer_reserve 604971 604971 0 0.00 0 53791 59 0 0
sp_cancel_pay_from_customer 650 650 0 0.00 3 6326 100 0 0
sp_cancel_pay_to_supplier 401 401 0 0.00 2 2166 84 0 0
sp_cancel_supplier_invoice 6748 6740 8 0.11 2 40738 818 0 8
sp_cancel_supplier_order 415 415 0 0.00 10 1090045 109019 0 0
sp_cancel_write_off 10716 10716 0 0.00 0 10836 110 0 0
sp_client_order 20163 20163 0 0.00 3 30883 336 0 0
sp_customer_reserve 451389 451389 0 0.00 0 113889 168 0 0
sp_fill_shopping_cart 30910 30910 0 0.00 1 25016 37 0 0
sp_fill_shopping_cart_clo_res 451388 451388 0 0.00 0 20080 14 0 0
sp_get_clo_for_invoice 4915 4915 0 0.00 0 31920 306 0 0
sp_kill_cost_storno 17923 17923 0 0.00 0 7196 53 0 0
sp_kill_qstorno_ret_qs2qd 1227813 1227813 0 0.00 0 53786 32 0 0
sp_kill_qty_storno 645737 645737 0 0.00 0 53790 69 0 0
sp_lock_selected_doc 20612 20612 0 0.00 0 13464 9 0 0
sp_make_cost_storno 27778 27778 0 0.00 0 23370 57 0 0
sp_multiply_rows_for_pdistr 27778 27778 0 0.00 0 23000 26 0 0
sp_multiply_rows_for_qdistr 20163 20163 0 0.00 0 27035 162 0 0
sp_pay_from_customer 6996 6996 0 0.00 4 44691 107 0 0
sp_pay_to_supplier 5817 5817 0 0.00 4 19991 152 0 0
sp_payment_common 12813 12813 0 0.00 2 44686 35 0 0
sp_qd_handle_on_cancel_clo 1774 1774 0 0.00 0 11631 311 0 0
sp_qd_handle_on_invoice_upd_sts 11071 11071 0 0.00 0 28709 315 0 0
sp_qd_handle_on_reserve_upd_sts 10050 10050 0 0.00 0 27257 72 0 0
sp_reserve_write_off 10050 10050 0 0.00 6 27276 191 0 0
sp_supplier_invoice 5389 5389 0 0.00 6 139577 3012 0 0
sp_supplier_order 5358 5358 0 0.00 5 45905 1145 0 0
srv_aggregate_perf_data 104 104 0 0.00 2819 205467 22118 0 0
srv_fill_mon_cache_memory 61 61 0 0.00 1491 154734 50176 0 0
srv_find_qd_qs_mism 1097170 1097170 0 0.00 0 15799 5 0 0
srv_make_invnt_saldo 533 533 0 0.00 66 95700 1498 0 0
srv_make_money_saldo 734 734 0 0.00 1 374 26 0 0
srv_recalc_idx_stat 4 4 0 0.00 213379 341641 271014 0 0
t$perf-abend:sp_add_invoice_to_stock 150 150 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 8 8 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4917 4917 0 0.00 0 16017 200 0 0
t$perf-norm:sp_cancel_adding_invoice 389 389 0 0.00 0 3584 105 0 0
t$perf-norm:sp_cancel_client_order 1774 1774 0 0.00 0 3993 16 0 0
t$perf-norm:sp_cancel_customer_reserve 648 648 0 0.00 0 1145 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 650 650 0 0.00 0 3260 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 401 401 0 0.00 0 1579 10 0 0
t$perf-norm:sp_cancel_supplier_invoice 363 363 0 0.00 0 3095 18 0 0
t$perf-norm:sp_cancel_supplier_order 415 415 0 0.00 0 27548 1667 0 0
t$perf-norm:sp_cancel_write_off 1007 1007 0 0.00 0 2732 9 0 0
t$perf-norm:sp_client_order 20163 20163 0 0.00 0 18109 19 0 0
t$perf-norm:sp_customer_reserve 990 990 0 0.00 0 1572 6 0 0
t$perf-norm:sp_pay_from_customer 6996 6996 0 0.00 0 18071 16 0 0
t$perf-norm:sp_pay_to_supplier 5817 5817 0 0.00 0 15613 20 0 0
t$perf-norm:sp_reserve_write_off 10050 10050 0 0.00 0 9046 13 0 0
t$perf-norm:sp_supplier_invoice 5389 5389 0 0.00 0 8784 22 0 0
t$perf-norm:sp_supplier_order 5358 5358 0 0.00 0 8321 19 0 0
t$perf-norm:srv_aggregate_perf_data 104 104 0 0.00 0 451 15 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 342 10 0 0
t$perf-norm:srv_make_invnt_saldo 533 533 0 0.00 0 807 29 0 0
t$perf-norm:srv_make_money_saldo 734 734 0 0.00 0 896 15 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 3 2 0 0
v_add_invoice_to_stock 10130 9830 300 2.96 0 9411 23 0 300
v_all_customers 36958 36958 0 0.00 0 25 1 0 0
v_all_suppliers 30052 30052 0 0.00 0 22 1 0 0
v_all_wares 40326 40326 0 0.00 0 30 1 0 0
v_cancel_adding_invoice 778 778 0 0.00 0 3072 12 0 0
v_cancel_client_order 3548 3548 0 0.00 0 3454 8 0 0
v_cancel_customer_prepayment 1300 1300 0 0.00 0 2573 11 0 0
v_cancel_customer_reserve 1296 1296 0 0.00 0 5199 18 0 0
v_cancel_payment_to_supplier 802 802 0 0.00 0 2153 7 0 0
v_cancel_supplier_invoice 742 726 16 2.15 0 638 15 0 16
v_cancel_supplier_order 830 830 0 0.00 0 3452 11 0 0
v_cancel_write_off 2014 2014 0 0.00 0 2399 15 0 0
v_max_id_clo_ord 5358 5358 0 0.00 0 269 1 0 0
v_max_id_clo_res 990 990 0 0.00 0 2758 15 0 0
v_max_id_ord_sup 5389 5389 0 0.00 0 10972 4 0 0
v_max_non_paid_invoice 1538 1538 0 0.00 0 4874 9 0 0
v_max_non_paid_realizn 3651 3651 0 0.00 0 28037 13 0 0
v_min_id_clo_ord 5358 5358 0 0.00 0 7116 7 0 0
v_min_id_clo_res 990 990 0 0.00 0 2902 11 0 0
v_min_id_ord_sup 5389 5389 0 0.00 0 7610 8 0 0
v_min_non_paid_invoice 5817 5817 0 0.00 0 16184 24 0 0
v_min_non_paid_realizn 6996 6996 0 0.00 0 5489 16 0 0
v_our_firm 10058 10058 0 0.00 0 20 1 0 0
v_reserve_write_off 20100 20100 0 0.00 0 3371 7 0 0
x_lock_depdocs_on_canc_invoice 12533 12533 0 0.00 0 19119 110 0 0
x_lock_depdocs_on_canc_sup_ord 415 415 0 0.00 0 21136 438 0 0
x_make_qstorno_1000_1200 5358 5358 0 0.00 1 45885 1072 0 0
x_make_qstorno_1200_2000 5389 5389 0 0.00 3 139537 2879 0 0
x_make_qstorno_2100_3300 451389 451389 0 0.00 0 113887 151 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 19-12-2022 01:39:29 to 19-12-2022 01:39:33.

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:35 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
23:09:35 20083 8192000000 9902458560 10215112704 985362688 10.736 100 85 170 0 1013522384 5959088 22200608
23:11:03 20643 8192000000 9952915440 10275065856 1029880000 11.167 100 87 174 0 1060708640 8582048 22246592
23:12:27 10918 8192000000 9977920592 10306347008 1059520336 11.452 100 91 182 0 1092342192 10122048 22699808
23:13:43 11435 8192000000 10023382336 10367840256 1106207856 11.897 100 84 168 0 1138071488 11377248 20486384
23:14:57 4052 8192000000 10060713072 10414940160 1149997792 12.309 100 83 165 0 1181822752 12185952 19639008
23:16:04 5872 8192000000 10098908320 10464894976 1186814480 12.654 100 80 157 2 1217473536 12925888 17733168
23:17:14 2754 8192000000 10132928960 10505674752 1222286400 12.983 100 82 161 0 1254353376 14067024 17999952
23:18:19 856 8192000000 10176122976 10555478016 1266493856 13.390 100 89 177 0 1298806352 12989072 19323424
23:19:21 1325 8192000000 10208593568 10591956992 1291319712 13.616 100 87 175 2 1323479840 12330096 19830032
23:20:23 19204 8192000000 10211766224 10611355648 1306952672 13.758 100 53 106 1 1326595056 7539312 12103072
23:21:42 3718 8192000000 10220076720 10629013504 1320000512 13.877 100 45 90 0 1338265632 8527984 9737136
23:22:47 8288 8192000000 10208087984 10628620288 1324908752 13.921 100 20 40 0 1335071744 5281328 4881664
23:23:56 15484 8192000000 10217264688 10641035264 1334679872 14.009 100 17 34 0 1344510768 6269472 3561424
23:25:16 60601 8192000000 10240391168 10658902016 1341959376 14.075 100 35 70 0 1355812608 5110144 8743088
23:27:18 4184 8192000000 10234170336 10657923072 1342479040 14.080 100 26 52 0 1354488432 6405408 5603984
23:28:23 4966 8192000000 10209902352 10624589824 1307621248 13.764 99 26 48 0 1319725664 6254736 5849680
23:29:29 14625 8192000000 10158783376 10566549504 1212538496 12.893 94 15 30 0 1221262016 5424800 3298720
23:30:44 26335 8192000000 10140899136 10551644160 1186538864 12.651 93 32 64 0 1199747600 5246080 7962656
23:32:11 6421 8192000000 10150712304 10554753024 1249039920 13.229 99 28 56 0 1261283824 5937440 6306464
23:33:19 8299 8192000000 10164580944 10564472832 1265932144 13.384 100 34 68 0 1280987600 7299760 7755696
23:34:27 66494 8192000000 10174452384 10593558528 1291575104 13.619 100 35 70 0 1304960560 5549952 7835504
23:36:35 9532 8192000000 10198627968 10610970624 1304481120 13.736 100 39 78 0 1319901264 6923984 8496160
23:37:45 11138 8192000000 10196592960 10617864192 1311793904 13.802 100 11 24 0 1319284400 4933024 2557472
23:39:00 4987 8192000000 10247820544 10656571392 1341390688 14.070 100 50 97 0 1358719216 6730704 10597824
23:40:10 102576 8192000000 10264719616 10685104128 1355697728 14.199 100 26 52 0 1369265472 7653872 5913872
23:42:55 10750 8192000000 10288822320 10711105536 1376832336 14.388 100 41 80 1 1397877840 11941456 9104048
23:44:08 11144 8192000000 10293987856 10716291072 1376461040 14.385 99 40 80 0 1399277520 13605056 9211424
23:45:24 13657 8192000000 10304393728 10731012096 1393416960 14.536 100 40 79 1 1421245136 17208736 10619440
23:46:45 19826 8192000000 10318149024 10749272064 1401145056 14.605 100 48 96 0 1434620704 21039968 12435680
23:48:15 4100 8192000000 10336467824 10755829760 1405094848 14.640 100 60 117 2 1445277168 26661408 13520912
23:49:29 3085 8192000000 10350947296 10774540288 1408482288 14.670 99 77 154 1 1453480112 27052992 17944832
23:50:38 2365 8192000000 10367113984 10786643968 1426185008 14.828 100 71 140 2 1475093040 31327280 17580752
23:51:48 1491 8192000000 10342871376 10759032832 1398840864 14.585 99 72 142 0 1452193936 35637152 17715920
23:52:54 3718 8192000000 10350536800 10766737408 1392938512 14.532 98 63 124 2 1444632192 35841696 15851984
23:54:03 2025 8192000000 10364178560 10776276992 1414546896 14.724 100 76 152 1 1471454256 37999440 18907920
23:55:09 4417 8192000000 10343074304 10748850176 1386485392 14.474 100 89 177 0 1453516848 43569984 23461472
23:56:35 6118 8192000000 10354888480 10762002432 1377762256 14.397 99 86 169 1 1451555584 52174048 21619280
23:57:46 17788 8192000000 10358795184 10787631104 1398914224 14.585 100 51 98 2 1474131184 61248288 13968672
23:59:09 9437 8192000000 10343493360 10768064512 1385731088 14.468 100 42 83 0 1450979136 54311152 10936896
00:00:20 17743 8192000000 10346456656 10776281088 1396597440 14.565 100 43 87 1 1454673072 47066160 11009472
00:01:39 17370 8192000000 10345731680 10780618752 1398634016 14.583 100 21 42 0 1450113088 45515536 5963536
00:02:59 17766 8192000000 10335469344 10767794176 1366987168 14.300 99 26 52 0 1425560400 51271440 7301792
00:04:35 25258 8192000000 10311196288 10758361088 1368775888 14.316 100 21 41 1 1420644624 45848160 6020576
00:06:06 55666 8192000000 10289965664 10744061952 1335932000 14.021 98 29 54 2 1391215712 47788448 7495264
00:08:05 20363 8192000000 10280153024 10724622336 1365167296 14.284 99 17 34 0 1378097648 9486352 3444000
00:09:26 126998 8192000000 10294353392 10752417792 1361626832 14.252 98 17 35 0 1380854960 15888256 3339872
00:12:40 37772 8192000000 10285835056 10730442752 1341549728 14.071 97 23 47 1 1355859728 9445696 4864304
00:14:18 154733 8192000000 10296742352 10744365056 1363472144 14.269 99 17 33 0 1385017024 17538512 4006368
00:18:04 123008 8192000000 10282118784 10728005632 1326157840 13.932 96 30 59 1 1348109216 14279104 7672272
00:21:08 69917 8192000000 10307549424 10737045504 1354561680 14.189 97 77 157 1 1384757600 11562928 18632992
00:23:20 90917 8192000000 10296338720 10736717824 1353050976 14.175 97 33 66 1 1382465504 21502736 7911792
00:25:59 29794 8192000000 10291667744 10759876608 1386048944 14.471 100 5 10 0 1404208112 17024224 1134944
00:27:34 66665 8192000000 10295991184 10763362304 1392552544 14.529 100 9 18 0 1405132752 10638624 1941584
00:30:05 101550 8192000000 10304228992 10779365376 1400276384 14.597 100 17 34 1 1421629312 17404096 3948832
00:32:57 39865 8192000000 10321236608 10772107264 1408494848 14.671 100 15 29 1 1425068912 12777872 3796192
00:34:40 48735 8192000000 10309662448 10767273984 1391695440 14.521 99 22 44 0 1404326336 8125376 4505520
00:36:30 65327 8192000000 10299835728 10754400256 1369462016 14.322 98 22 44 1 1388449872 13689328 5298528
00:39:09 36894 8192000000 10273550128 10715983872 1318360640 13.862 94 16 32 0 1330928960 9059712 3508608
00:40:53 78443 8192000000 10302886256 10751832064 1325137296 13.923 95 25 51 1 1347235872 16928752 5169824
00:43:15 105691 8192000000 10281041328 10745856000 1336937232 14.030 96 9 18 0 1359023296 20255712 1830352
00:46:02 94766 8192000000 10278935360 10740830208 1320973584 13.886 96 12 24 0 1347636432 24216896 2445952
00:48:40 87834 8192000000 10263337216 10709258240 1354498256 14.188 99 22 44 0 1367838800 8759520 4581024
00:51:11 57526 8192000000 10271657968 10718990336 1302091760 13.714 94 32 64 0 1318552032 9580640 6879632
00:53:11 26457 8192000000 10287328080 10721984512 1367541920 14.305 100 41 82 1 1385799456 8665632 9591904
00:54:39 41583 8192000000 10252660752 10703294464 1327105904 13.941 98 25 49 1 1341308096 8638000 5564192
00:56:21 53100 8192000000 10262716832 10714607616 1360034560 14.238 100 21 42 0 1380912880 16125056 4753264
00:59:16 42971 8192000000 10258878336 10709635072 1324545136 13.918 97 11 20 1 1339968832 13098960 2324736
01:01:06 30892 8192000000 10266660848 10710712320 1350726928 14.154 99 25 49 1 1364656624 8680592 5249104
01:02:38 67936 8192000000 10276317984 10730610688 1361989696 14.255 99 17 34 0 1379676832 13954416 3732720
01:04:47 116357 8192000000 10271360144 10716794880 1304211616 13.734 95 14 29 0 1320461248 13326784 2922848
01:07:44 74734 8192000000 10285919312 10732531712 1346009280 14.112 98 13 26 0 1363874240 15379584 2485376
01:09:58 28869 8192000000 10290009712 10742108160 1380254560 14.419 100 38 76 0 1405790528 16710224 8825744
01:11:33 69421 8192000000 10296380096 10745032704 1371011296 14.336 99 14 29 1 1390583728 16568496 3003936
01:13:52 27324 8192000000 10316961456 10744782848 1386909664 14.478 100 37 74 2 1404990192 9682048 8398480
01:15:22 141903 8192000000 10300001152 10750525440 1381335648 14.428 99 26 52 2 1398885888 11807408 5742832
01:18:50 44562 8192000000 10300861984 10768478208 1385049872 14.462 99 13 26 0 1404454976 16447984 2957120
01:20:34 63891 8192000000 10286700160 10742423552 1378928032 14.407 99 12 24 0 1392562288 10874608 2759648
01:23:25 59466 8192000000 10296834368 10766888960 1385721616 14.468 99 23 46 0 1411166592 19594656 5850320
01:25:41 51221 8192000000 10285819696 10750251008 1380406656 14.420 100 8 16 0 1397750144 15364016 1979472
01:27:39 54866 8192000000 10286807296 10734133248 1358586560 14.225 98 18 34 0 1372151408 10038304 3526544
01:29:34 40391 8192000000 10274536528 10718810112 1333377488 13.998 97 28 56 0 1352275040 12910832 5986720
01:31:15 74154 8192000000 10271981024 10731384832 1336012864 14.021 97 20 39 0 1355742432 15493024 4236544
01:33:49 72518 8192000000 10282143600 10720141312 1332906160 13.993 97 20 40 0 1349520080 12085536 4528384
01:36:06 89961 8192000000 10286189968 10721132544 1306918992 13.758 95 21 42 0 1325154400 13782160 4453248

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 19-12-2022 01:39:35 to 19-12-2022 01:39:50.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 150 v_add_invoice_to_stock 335544517
except 8 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 19-12-2022 01:39:51 to 19-12-2022 01:39:53.

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

19.12.22 01:39:54. 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-12-19 01:39:57 No severe PSQL-related problems occured
19.12.22 01:39:58. End of report.