Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 27.12.2021 22: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 16421008 kB
MemAvailable 31322244 kB
Buffers 0 kB
Cached 15211524 kB
SwapCached 436 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 2021-12-27 22:38:14
DTS_END                         2021-12-27 22:37:57.4090
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_FILL_MON_CACHE_MEMORY(20:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/56720
TRN_ID                          240063
ATT_ID                          274
EXC_UNIT                        2


Test workload details

SETTING_NAME SETTING_VALUE
WORKING_MODE SMALL_03
C_WARES_MAX_ID 400
C_CUSTOMER_DOC_MAX_ROWS 10
C_SUPPLIER_DOC_MAX_ROWS 50
C_CUSTOMER_DOC_MAX_QTY 15
C_SUPPLIER_DOC_MAX_QTY 50
C_NUMBER_OF_AGENTS 50

Indexes for heavy-loaded tables

TAB_NAME IDX_NAME IDX_KEY
XQD_1000_1200 XQD_1000_1200_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_1000_3300 XQD_1000_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_1000_3300 XQD_1000_3300_WKR_DOC_ASC WORKER_ID,DOC_ID
XQD_1000_3300 XQD_1000_3300_WKR_DOC_DEC WORKER_ID,DOC_ID
XQD_1200_2000 XQD_1200_2000_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_2000_3300 XQD_2000_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_2100_3300 XQD_2100_3300_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID
XQD_3300_3400 XQD_3300_3400_WA_SO_RO_WKR_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,WORKER_ID,SND_ID

Performance in TOTAL

ACTION AVG_TIMES_PER_MINUTE AVG_ELAPSED_MS SUCCESSFUL_TIMES_DONE
*** OVERALL *** for 120 minutes: 9508.00 22483 1140960
customer order: creation 171.91 330 20629
customer order: refuse 14.78 335 1773
order to supplier: creation 45.74 1283 5489
order to supplier: removal 3.62 101205 434
invoice (draft): creation 45.77 3113 5492
invoice (draft): removal 56.16 838 6739
invoice accept: apply 41.98 16553 5038
invoice accept: cancel 50.23 726 6027
customer reserve: creation 3834.11 165 460093
customer reserve: removal 4946.91 57 593629
realization accept: apply 84.53 178 10143
realization accept: cancel 83.45 113 10014
payment from customer: creation 58.33 128 7000
payment from customer: removal 5.81 87 697
payment to supplier: creation 48.92 130 5870
payment to supplier: removal 3.56 101 427
service: total inventory turnovers 4.81 1048 577
service: total monetary turnovers 6.47 27 776
service: aggregate perf. data 0.91 19769 109
service: refresh index statistics 0.03 303482 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 27-12-2021 22:39:13 to 27-12-2021 22:39:15.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2718
TEST_TIME 2 3678
TEST_TIME 3 3996
TEST_TIME 4 4269
TEST_TIME 5 5305
TEST_TIME 6 5497
TEST_TIME 7 5365
TEST_TIME 8 5417
TEST_TIME 9 5233
TEST_TIME 10 5240
TEST_TIME 11 5752
TEST_TIME 12 5881
TEST_TIME 13 5935
TEST_TIME 14 6175
TEST_TIME 15 6418
TEST_TIME 16 6800
TEST_TIME 17 6907
TEST_TIME 18 6850
TEST_TIME 19 7238
TEST_TIME 20 7433
TEST_TIME 21 7666
TEST_TIME 22 8594
TEST_TIME 23 8581
TEST_TIME 24 9245
TEST_TIME 25 9444
TEST_TIME 26 10031
TEST_TIME 27 10769
TEST_TIME 28 10555
TEST_TIME 29 10592
TEST_TIME 30 10585
TEST_TIME 31 10484
TEST_TIME 32 10598
TEST_TIME 33 10562
TEST_TIME 34 10751
TEST_TIME 35 10786
TEST_TIME 36 10536
TEST_TIME 37 10435
TEST_TIME 38 10254
TEST_TIME 39 10188
TEST_TIME 40 10110
TEST_TIME 41 10071
TEST_TIME 42 10260
TEST_TIME 43 10142
TEST_TIME 44 10066
TEST_TIME 45 9967
TEST_TIME 46 10011
TEST_TIME 47 9874
TEST_TIME 48 9746
TEST_TIME 49 9746
TEST_TIME 50 9648
TEST_TIME 51 9618
TEST_TIME 52 9565
TEST_TIME 53 9466
TEST_TIME 54 9418
TEST_TIME 55 9546
TEST_TIME 56 9586
TEST_TIME 57 9606
TEST_TIME 58 9539
TEST_TIME 59 9561
TEST_TIME 60 9542
TEST_TIME 61 9658
TEST_TIME 62 9673
TEST_TIME 63 9654
TEST_TIME 64 9603
TEST_TIME 65 9734
TEST_TIME 66 9723
TEST_TIME 67 9727
TEST_TIME 68 9827
TEST_TIME 69 9879
TEST_TIME 70 9775
TEST_TIME 71 9731
TEST_TIME 72 9689
TEST_TIME 73 9661
TEST_TIME 74 9637
TEST_TIME 75 9583
TEST_TIME 76 9518
TEST_TIME 77 9554
TEST_TIME 78 9546
TEST_TIME 79 9514
TEST_TIME 80 9472
TEST_TIME 81 9428
TEST_TIME 82 9408
TEST_TIME 83 9424
TEST_TIME 84 9460
TEST_TIME 85 9472
TEST_TIME 86 9527
TEST_TIME 87 9497
TEST_TIME 88 9561
TEST_TIME 89 9525
TEST_TIME 90 9599
TEST_TIME 91 9616
TEST_TIME 92 9623
TEST_TIME 93 9665
TEST_TIME 94 9666
TEST_TIME 95 9613
TEST_TIME 96 9576
TEST_TIME 97 9521
TEST_TIME 98 9534
TEST_TIME 99 9469
TEST_TIME 100 9432
TEST_TIME 101 9451
TEST_TIME 102 9437
TEST_TIME 103 9427
TEST_TIME 104 9388
TEST_TIME 105 9416
TEST_TIME 106 9380
TEST_TIME 107 9378
TEST_TIME 108 9385
TEST_TIME 109 9378
TEST_TIME 110 9423
TEST_TIME 111 9404
TEST_TIME 112 9423
TEST_TIME 113 9495
TEST_TIME 114 9494
TEST_TIME 115 9533
TEST_TIME 116 9591
TEST_TIME 117 9602
TEST_TIME 118 9569
TEST_TIME 119 9505
TEST_TIME 120 9489
TEST_TIME 121 9442

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 27-12-2021 22:39:17 to 27-12-2021 22:39:20.

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 1568202 1568202 0 0.00 0 26955 6 0 0
doc_list_biud 1568202 1568202 0 0.00 0 77759 28 0 0
sp_add_invoice_to_stock 5150 5038 112 2.17 31 169959 16553 0 112
sp_cancel_adding_invoice 6027 6027 0 0.00 5 78481 726 0 0
sp_cancel_client_order 1773 1773 0 0.00 4 15632 336 0 0
sp_cancel_customer_reserve 593629 593629 0 0.00 1 77760 58 0 0
sp_cancel_pay_from_customer 697 697 0 0.00 3 6103 88 0 0
sp_cancel_pay_to_supplier 427 427 0 0.00 2 6710 101 0 0
sp_cancel_supplier_invoice 6746 6739 7 0.10 2 24354 839 0 7
sp_cancel_supplier_order 434 434 0 0.00 8 1074365 101206 0 0
sp_cancel_write_off 10014 10014 0 0.00 1 9258 113 0 0
sp_client_order 20629 20629 0 0.00 3 20284 330 0 0
sp_customer_reserve 460093 460093 0 0.00 0 35378 166 0 0
sp_fill_shopping_cart 31610 31610 0 0.00 1 19410 38 0 0
sp_fill_shopping_cart_clo_res 460076 460076 0 0.00 0 16171 13 0 0
sp_get_clo_for_invoice 5014 5014 0 0.00 0 23451 285 0 0
sp_kill_cost_storno 17165 17165 0 0.00 0 7275 58 0 0
sp_kill_qstorno_ret_qs2qd 1204445 1204445 0 0.00 0 77758 32 0 0
sp_kill_qty_storno 633772 633772 0 0.00 0 77759 68 0 0
sp_lock_selected_doc 21003 21003 0 0.00 0 7231 7 0 0
sp_make_cost_storno 28026 28026 0 0.00 0 26890 56 0 0
sp_multiply_rows_for_pdistr 28026 28026 0 0.00 0 12895 34 0 0
sp_multiply_rows_for_qdistr 20629 20629 0 0.00 0 13923 146 0 0
sp_pay_from_customer 7000 7000 0 0.00 4 16749 129 0 0
sp_pay_to_supplier 5870 5870 0 0.00 4 26903 131 0 0
sp_payment_common 12870 12870 0 0.00 1 7795 30 0 0
sp_qd_handle_on_cancel_clo 1773 1773 0 0.00 0 15627 315 0 0
sp_qd_handle_on_invoice_upd_sts 11040 11040 0 0.00 0 27214 302 0 0
sp_qd_handle_on_reserve_upd_sts 10143 10143 0 0.00 0 11095 60 0 0
sp_reserve_write_off 10143 10143 0 0.00 6 18539 179 0 0
sp_supplier_invoice 5492 5492 0 0.00 7 83660 3114 0 0
sp_supplier_order 5489 5489 0 0.00 5 66713 1284 0 0
srv_aggregate_perf_data 109 109 0 0.00 2604 494292 19770 0 0
srv_fill_mon_cache_memory 61 61 0 0.00 1347 173720 47552 0 0
srv_find_qd_qs_mism 1093992 1093992 0 0.00 0 26946 5 0 0
srv_make_invnt_saldo 577 577 0 0.00 25 82870 1049 0 0
srv_make_money_saldo 776 776 0 0.00 1 3425 27 0 0
srv_recalc_idx_stat 4 4 0 0.00 188293 600049 303483 0 0
t$perf-abend:sp_add_invoice_to_stock 112 112 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 7 7 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5040 5040 0 0.00 0 9107 165 0 0
t$perf-norm:sp_cancel_adding_invoice 428 428 0 0.00 1 2794 63 0 0
t$perf-norm:sp_cancel_client_order 1773 1773 0 0.00 0 3209 15 0 0
t$perf-norm:sp_cancel_customer_reserve 687 687 0 0.00 0 1926 13 0 0
t$perf-norm:sp_cancel_pay_from_customer 697 697 0 0.00 0 1032 3 0 0
t$perf-norm:sp_cancel_pay_to_supplier 427 427 0 0.00 0 4072 23 0 0
t$perf-norm:sp_cancel_supplier_invoice 423 423 0 0.00 0 1356 17 0 0
t$perf-norm:sp_cancel_supplier_order 434 434 0 0.00 0 23906 1738 0 0
t$perf-norm:sp_cancel_write_off 978 978 0 0.00 0 1467 8 0 0
t$perf-norm:sp_client_order 20629 20629 0 0.00 0 9059 19 0 0
t$perf-norm:sp_customer_reserve 1048 1048 0 0.00 0 2285 13 0 0
t$perf-norm:sp_pay_from_customer 7000 7000 0 0.00 0 5667 8 0 0
t$perf-norm:sp_pay_to_supplier 5870 5870 0 0.00 0 9929 13 0 0
t$perf-norm:sp_reserve_write_off 10143 10143 0 0.00 0 9334 13 0 0
t$perf-norm:sp_supplier_invoice 5492 5492 0 0.00 0 9355 15 0 0
t$perf-norm:sp_supplier_order 5489 5489 0 0.00 0 3685 14 0 0
t$perf-norm:srv_aggregate_perf_data 109 109 0 0.00 0 401 5 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 38 1 0 0
t$perf-norm:srv_make_invnt_saldo 577 577 0 0.00 0 2470 19 0 0
t$perf-norm:srv_make_money_saldo 776 776 0 0.00 0 1990 16 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 2 2 0 0
v_add_invoice_to_stock 10250 10026 224 2.18 0 7261 18 0 224
v_all_customers 37426 37426 0 0.00 0 22 1 0 0
v_all_suppliers 30794 30794 0 0.00 0 68 1 0 0
v_all_wares 41258 41258 0 0.00 0 16 1 0 0
v_cancel_adding_invoice 856 856 0 0.00 0 504 7 0 0
v_cancel_client_order 3546 3546 0 0.00 0 1771 4 0 0
v_cancel_customer_prepayment 1394 1394 0 0.00 0 1834 7 0 0
v_cancel_customer_reserve 1374 1374 0 0.00 0 989 5 0 0
v_cancel_payment_to_supplier 854 854 0 0.00 0 6680 11 0 0
v_cancel_supplier_invoice 860 846 14 1.62 0 1374 14 0 14
v_cancel_supplier_order 868 868 0 0.00 0 1353 6 0 0
v_cancel_write_off 1956 1956 0 0.00 0 2048 14 0 0
v_max_id_clo_ord 5489 5489 0 0.00 0 1080 2 0 0
v_max_id_clo_res 1048 1048 0 0.00 0 1810 12 0 0
v_max_id_ord_sup 5492 5492 0 0.00 0 2907 4 0 0
v_max_non_paid_invoice 1454 1454 0 0.00 0 74 2 0 0
v_max_non_paid_realizn 3793 3793 0 0.00 0 2014 3 0 0
v_min_id_clo_ord 5489 5489 0 0.00 0 3317 8 0 0
v_min_id_clo_res 1048 1048 0 0.00 0 8215 19 0 0
v_min_id_ord_sup 5492 5492 0 0.00 0 7332 17 0 0
v_min_non_paid_invoice 5870 5870 0 0.00 0 5902 20 0 0
v_min_non_paid_realizn 7000 7000 0 0.00 0 7784 27 0 0
v_our_firm 10246 10246 0 0.00 0 23 1 0 0
v_reserve_write_off 20286 20286 0 0.00 0 7186 6 0 0
x_lock_depdocs_on_canc_invoice 12343 12343 0 0.00 0 10354 98 0 0
x_lock_depdocs_on_canc_sup_ord 434 434 0 0.00 0 9563 326 0 0
x_make_qstorno_1000_1200 5489 5489 0 0.00 1 66630 1211 0 0
x_make_qstorno_1200_2000 5492 5492 0 0.00 3 83223 2971 0 0
x_make_qstorno_2100_3300 460093 460093 0 0.00 0 35374 150 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 27-12-2021 22:39:21 to 27-12-2021 22:39:25.

Memory consumption, metadata cache, attachments activity

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


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

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
20:08:00 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:01 22804 8192000000 9915380016 10228215808 1000984768 10.888 100 92 184 0 1030514256 5831888 23697600
20:10:31 16016 8192000000 9945611952 10269040640 1030508624 11.173 100 88 175 1 1061730352 8732384 22489344
20:11:56 15796 8192000000 9987396288 10323189760 1069686640 11.549 100 85 170 0 1101429952 10121152 21622160
20:13:20 10473 8192000000 10041745120 10389372928 1123778832 12.063 100 83 166 0 1154893104 11041872 20072400
20:14:42 7911 8192000000 10088182256 10448371712 1170042672 12.497 100 83 166 0 1203904864 14134960 19727232
20:15:56 6088 8192000000 10116086752 10491772928 1208832464 12.858 100 74 149 0 1237874896 12338128 16704304
20:17:04 7395 8192000000 10160968944 10540486656 1250475344 13.243 100 78 155 2 1280745888 13156160 17114384
20:18:13 1556 8192000000 10206156032 10587934720 1287251312 13.579 100 88 179 1 1320851776 13750176 19850288
20:19:16 28448 8192000000 10212305568 10607124480 1305758816 13.748 100 65 128 0 1330068256 8969536 15339904
20:20:46 8582 8192000000 10200790848 10614312960 1312369696 13.808 100 28 56 0 1327158928 8638848 6150384
20:21:57 6367 8192000000 10206153936 10620829696 1319798160 13.875 100 26 52 0 1332892368 6224560 6869648
20:23:06 9341 8192000000 10211230832 10635821056 1330489408 13.972 100 11 22 2 1337977792 5037760 2450624
20:24:22 49676 8192000000 10251681408 10655035392 1339005456 14.048 100 53 108 3 1357323104 5368592 12949056
20:26:12 4545 8192000000 10234312336 10650644480 1337417312 14.034 100 26 53 3 1349127904 5778080 5932512
20:27:18 50764 8192000000 10224044416 10645118976 1311167328 13.797 98 30 60 1 1323793536 5860608 6765600
20:29:09 6088 8192000000 10210567792 10625028096 1317301408 13.852 100 28 55 0 1330987536 7291168 6394960
20:30:18 4650 8192000000 10164758240 10568540160 1249726032 13.236 98 19 38 0 1259821424 5954368 4141024
20:31:27 65346 8192000000 10152394368 10566639616 1256270128 13.296 99 23 46 2 1266892720 5608160 5014432
20:33:36 6141 8192000000 10158804496 10564734976 1258979712 13.321 99 25 50 1 1271325136 6910608 5434816
20:34:44 12734 8192000000 10191071312 10601349120 1296162896 13.660 100 15 30 1 1305086976 5451408 3472672
20:35:57 22235 8192000000 10210647360 10618687488 1308467520 13.772 100 16 32 0 1317963856 5337248 4159088
20:37:21 13941 8192000000 10203495536 10623942656 1314972512 13.831 100 25 50 1 1326373328 5338768 6062048
20:38:40 26876 8192000000 10250039360 10656284672 1335358304 14.016 100 57 112 2 1356377216 9577472 11441440
20:40:12 36823 8192000000 10259647264 10682109952 1356731984 14.208 100 48 96 0 1376797824 8922944 11142896
20:41:56 23088 8192000000 10281866272 10708598784 1376988768 14.390 100 44 88 2 1400206784 12669504 10548512
20:43:24 6643 8192000000 10305186912 10726731776 1392311776 14.526 100 48 96 1 1417727184 13872432 11542976
20:44:33 29003 8192000000 10311964032 10743480320 1397827936 14.576 100 43 85 0 1425753952 18318688 9607328
20:46:06 12617 8192000000 10333809888 10759061504 1412909856 14.710 100 49 97 1 1446559280 22037328 11612096
20:47:27 8392 8192000000 10365766384 10791600128 1433355264 14.891 100 53 106 1 1473547744 27018880 13173600
20:48:40 2187 8192000000 10362802080 10780131328 1421961056 14.790 100 73 146 3 1470154640 30449040 17744544
20:49:47 15085 8192000000 10358527504 10780102656 1421270800 14.784 100 58 116 0 1465499648 29971120 14257728
20:51:06 3130 8192000000 10361037536 10783277056 1413216096 14.713 99 62 124 1 1464778608 35752288 15810224
20:52:16 5427 8192000000 10353928976 10766524416 1401219424 14.606 100 78 156 1 1457435840 37057616 19158800
20:53:34 2983 8192000000 10368227312 10789933056 1421425536 14.785 100 59 116 2 1475238272 38503984 15308752
20:54:42 3398 8192000000 10384496720 10799251456 1427728400 14.841 100 74 148 0 1485070976 39092816 18249760
20:55:51 4572 8192000000 10366186640 10782302208 1407077056 14.658 100 67 134 0 1472453616 47205392 18171168
20:57:04 1346 8192000000 10387321424 10787532800 1407937008 14.666 100 95 190 2 1482677488 50563904 24176576
20:58:09 7920 8192000000 10351137008 10765459456 1366409776 14.295 98 50 100 0 1436809728 55865120 14534832
20:59:21 11266 8192000000 10332422080 10763124736 1385109584 14.462 100 36 73 1 1443721136 48029968 10581584
21:00:34 12571 8192000000 10335817408 10767663104 1389765776 14.504 100 32 62 0 1441953696 43275072 8912848
21:02:01 26686 8192000000 10301582512 10738978816 1344464992 14.098 98 23 46 1 1392452576 41425488 6562096
21:03:32 19738 8192000000 10279131104 10715959296 1328356000 13.952 98 22 43 0 1371363088 36719520 6287568
21:04:53 76549 8192000000 10277197776 10714783744 1346887904 14.119 99 19 39 1 1362988304 11431648 4668752
21:07:34 73327 8192000000 10275081088 10718121984 1348061600 14.130 99 41 80 0 1371175088 14100256 9013232
21:10:56 76025 8192000000 10285227024 10736873472 1346084096 14.112 98 11 22 0 1371208384 22479344 2644944
21:13:13 71848 8192000000 10251905264 10696605696 1324338336 13.916 97 31 62 0 1337614800 5550608 7725856
21:16:44 58332 8192000000 10294787904 10735321088 1349183632 14.140 98 29 58 0 1374517744 17447536 7886576
21:18:51 17459 8192000000 10288727536 10730573824 1361505728 14.251 99 46 90 2 1384759728 12950608 10303392
21:20:13 49861 8192000000 10280313808 10728452096 1369174416 14.320 99 10 20 0 1378612480 6835104 2602960
21:22:03 37521 8192000000 10289232816 10737336320 1371944368 14.344 99 8 16 0 1381857904 8170256 1743280
21:23:43 25372 8192000000 10277744144 10740396032 1374241120 14.365 99 9 18 1 1385653904 9286112 2126672
21:25:11 60512 8192000000 10285265136 10741714944 1376860848 14.388 99 19 38 0 1388734176 7612784 4260544
21:27:14 41771 8192000000 10300766496 10751541248 1395970032 14.559 100 30 60 0 1410736160 8287648 6478480
21:28:57 35420 8192000000 10300162400 10763374592 1399430544 14.590 100 18 37 0 1413325936 9657152 4238240
21:30:33 62638 8192000000 10307094384 10778095616 1406031568 14.649 100 17 34 0 1424008528 14060160 3916800
21:33:08 67528 8192000000 10292663312 10768265216 1386039680 14.471 99 12 24 0 1404030048 15043840 2946528
21:35:43 64730 8192000000 10312244832 10766233600 1369034304 14.318 97 26 50 1 1383741696 9476496 5230896
21:37:48 73029 8192000000 10308833488 10771800064 1369349120 14.321 97 16 32 1 1394077840 20512128 4216592
21:40:11 57801 8192000000 10309855088 10765701120 1357104720 14.211 96 13 26 1 1368819904 9103072 2612112
21:42:10 54706 8192000000 10281340176 10735988736 1302017024 13.714 93 9 18 0 1314383344 10029296 2337024
21:44:06 25916 8192000000 10292017024 10724417536 1338660272 14.045 98 38 76 1 1356397296 9687072 8049952
21:45:33 148889 8192000000 10277439552 10725343232 1308799568 13.775 95 9 18 1 1332315552 21433856 2082128
21:49:20 35031 8192000000 10217514976 10668335104 1303730720 13.729 96 10 20 0 1319644688 14143440 1770528
21:50:56 73644 8192000000 10245246752 10706817024 1329161872 13.960 98 8 16 1 1345471488 14569040 1740576
21:53:10 70114 8192000000 10262768768 10711695360 1334938432 14.012 98 18 36 1 1353076992 14140272 3998288
21:55:31 43360 8192000000 10203713440 10644803584 1269487216 13.417 94 13 26 0 1278986992 6618912 2880864
21:57:16 63088 8192000000 10234948832 10691149824 1314955520 13.831 98 5 10 0 1325462832 9635184 872128
21:59:20 16365 8192000000 10266024064 10709905408 1347715488 14.127 99 31 63 2 1361996336 6778592 7502256
22:00:43 58768 8192000000 10281067680 10736640000 1370914864 14.335 100 17 34 0 1385981328 11390976 3675488
22:02:42 48991 8192000000 10292621872 10744590336 1375737504 14.378 100 16 32 0 1394134000 14637280 3759216
22:04:34 74550 8192000000 10285106448 10746335232 1361260384 14.249 99 14 27 1 1381887520 18029744 2597392
22:06:52 28832 8192000000 10285921280 10730590208 1366958624 14.300 100 42 84 1 1388192288 12300064 8933600
22:08:27 64519 8192000000 10283911104 10732093440 1360038640 14.238 99 20 40 0 1376612784 12117552 4456592
22:10:39 173720 8192000000 10301082128 10760790016 1340870416 14.065 96 12 23 1 1368037424 24763728 2403280
22:14:55 68109 8192000000 10289896000 10758774784 1377948304 14.398 99 11 22 0 1390037440 9621488 2467648
22:17:03 88616 8192000000 10304424672 10767261696 1395891648 14.558 100 12 24 1 1416110192 17105616 3112928
22:19:35 41645 8192000000 10302020928 10759720960 1384676432 14.458 99 21 43 3 1403702464 13650368 5375664
22:21:17 107677 8192000000 10290640576 10767101952 1396420304 14.563 100 7 14 0 1408809968 10653520 1736144
22:24:05 64312 8192000000 10303662096 10766589952 1399747424 14.593 100 25 51 2 1417362624 12000512 5614688
22:26:38 99814 8192000000 10284770128 10743078912 1369882992 14.326 98 5 10 0 1380936448 10098160 955296
22:29:18 96134 8192000000 10301655760 10773733376 1367839152 14.308 97 27 54 0 1389411152 15246704 6325296
22:31:56 78708 8192000000 10282666016 10735173632 1266001088 13.385 91 13 26 2 1289548848 20347088 3200672
22:35:43 65584 8192000000 10262850384 10708897792 1312606448 13.810 96 37 72 1 1334388544 12879824 8902272

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 27-12-2021 22:39:27 to 27-12-2021 22:39:42.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 112 v_add_invoice_to_stock 335544517
except 7 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 27-12-2021 22:39:43 to 27-12-2021 22:39:45.

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

27.12.21 22:39:45. 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
2021-12-27 22:39:48 No severe PSQL-related problems occured
27.12.21 22:39:49. End of report.