Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 20.06.2022 04: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 15844228 kB
MemAvailable 31225856 kB
Buffers 20 kB
Cached 15815616 kB
SwapCached 2460 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 4.0.2
DB_NAME                         /home/bases/oltp40-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/oltp40-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp40-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb40/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=3400
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/oltp40-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-oltp40
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-06-20 04:37:18
DTS_END                         2022-06-20 04:37:18.1560
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(68:17)
IP                              ::1/38832
TRN_ID                          209383
ATT_ID                          593
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: 8851.19 34581 1062143
customer order: creation 152.43 516 18291
customer order: refuse 13.65 492 1638
order to supplier: creation 41.99 1455 5039
order to supplier: removal 3.48 190475 417
invoice (draft): creation 42.06 3321 5047
invoice (draft): removal 51.56 1055 6187
invoice accept: apply 38.74 26909 4649
invoice accept: cancel 46.73 1378 5608
customer reserve: creation 3608.98 253 433077
customer reserve: removal 4565.43 114 547851
realization accept: apply 75.17 312 9020
realization accept: cancel 92.47 159 11096
payment from customer: creation 53.71 185 6445
payment from customer: removal 5.13 135 616
payment to supplier: creation 44.84 218 5381
payment to supplier: removal 3.39 125 407
service: total inventory turnovers 3.64 4815 437
service: total monetary turnovers 6.87 378 824
service: aggregate perf. data 0.91 18639 109
service: refresh index statistics 0.03 440685 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 20-06-2022 04:38:43 to 20-06-2022 04:38:45.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7848
TEST_TIME 2 6477
TEST_TIME 3 5829
TEST_TIME 4 5211
TEST_TIME 5 5088
TEST_TIME 6 5090
TEST_TIME 7 5364
TEST_TIME 8 5450
TEST_TIME 9 5987
TEST_TIME 10 5912
TEST_TIME 11 6146
TEST_TIME 12 6533
TEST_TIME 13 6495
TEST_TIME 14 6570
TEST_TIME 15 6606
TEST_TIME 16 6588
TEST_TIME 17 6686
TEST_TIME 18 6744
TEST_TIME 19 6715
TEST_TIME 20 6728
TEST_TIME 21 6999
TEST_TIME 22 7272
TEST_TIME 23 7491
TEST_TIME 24 7564
TEST_TIME 25 7771
TEST_TIME 26 7990
TEST_TIME 27 8135
TEST_TIME 28 8133
TEST_TIME 29 8536
TEST_TIME 30 8562
TEST_TIME 31 8701
TEST_TIME 32 9301
TEST_TIME 33 9696
TEST_TIME 34 9929
TEST_TIME 35 10270
TEST_TIME 36 10496
TEST_TIME 37 10873
TEST_TIME 38 10960
TEST_TIME 39 10694
TEST_TIME 40 10736
TEST_TIME 41 10605
TEST_TIME 42 10524
TEST_TIME 43 10363
TEST_TIME 44 10208
TEST_TIME 45 10148
TEST_TIME 46 10046
TEST_TIME 47 9915
TEST_TIME 48 9858
TEST_TIME 49 9823
TEST_TIME 50 9820
TEST_TIME 51 9922
TEST_TIME 52 9805
TEST_TIME 53 9802
TEST_TIME 54 9641
TEST_TIME 55 9596
TEST_TIME 56 9658
TEST_TIME 57 9618
TEST_TIME 58 9607
TEST_TIME 59 9554
TEST_TIME 60 9554
TEST_TIME 61 9461
TEST_TIME 62 9444
TEST_TIME 63 9390
TEST_TIME 64 9544
TEST_TIME 65 9540
TEST_TIME 66 9566
TEST_TIME 67 9534
TEST_TIME 68 9641
TEST_TIME 69 9594
TEST_TIME 70 9466
TEST_TIME 71 9426
TEST_TIME 72 9432
TEST_TIME 73 9356
TEST_TIME 74 9277
TEST_TIME 75 9197
TEST_TIME 76 9112
TEST_TIME 77 9110
TEST_TIME 78 9038
TEST_TIME 79 9114
TEST_TIME 80 9087
TEST_TIME 81 9045
TEST_TIME 82 9013
TEST_TIME 83 9004
TEST_TIME 84 8987
TEST_TIME 85 8991
TEST_TIME 86 8977
TEST_TIME 87 8971
TEST_TIME 88 8984
TEST_TIME 89 9097
TEST_TIME 90 9047
TEST_TIME 91 9124
TEST_TIME 92 9117
TEST_TIME 93 9182
TEST_TIME 94 9126
TEST_TIME 95 9112
TEST_TIME 96 9125
TEST_TIME 97 9141
TEST_TIME 98 9097
TEST_TIME 99 9059
TEST_TIME 100 9053
TEST_TIME 101 9070
TEST_TIME 102 9088
TEST_TIME 103 9140
TEST_TIME 104 9149
TEST_TIME 105 9173
TEST_TIME 106 9175
TEST_TIME 107 9112
TEST_TIME 108 9064
TEST_TIME 109 9063
TEST_TIME 110 9010
TEST_TIME 111 8974
TEST_TIME 112 8971
TEST_TIME 113 8981
TEST_TIME 114 8970
TEST_TIME 115 8959
TEST_TIME 116 8924
TEST_TIME 117 8864
TEST_TIME 118 8863
TEST_TIME 119 8898
TEST_TIME 120 8874

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 20-06-2022 04:38:46 to 20-06-2022 04:38:50.

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 1462007 1462007 0 0.00 0 28226 13 0 0
doc_list_biud 1461988 1461988 0 0.00 0 35784 49 0 0
sp_add_invoice_to_stock 4715 4649 66 1.39 53 167750 26909 0 66
sp_cancel_adding_invoice 5608 5608 0 0.00 6 76483 1379 0 0
sp_cancel_client_order 1638 1638 0 0.00 7 26843 493 0 0
sp_cancel_customer_reserve 547851 547851 0 0.00 1 32617 115 0 0
sp_cancel_pay_from_customer 616 616 0 0.00 4 4435 136 0 0
sp_cancel_pay_to_supplier 407 407 0 0.00 4 2493 126 0 0
sp_cancel_supplier_invoice 6191 6187 4 0.06 3 21523 1056 0 4
sp_cancel_supplier_order 417 417 0 0.00 13 1827837 190476 0 0
sp_cancel_write_off 11096 11096 0 0.00 2 7927 159 0 0
sp_client_order 18291 18291 0 0.00 6 41550 516 0 0
sp_customer_reserve 433077 433077 0 0.00 1 142456 253 0 0
sp_fill_shopping_cart 28359 28359 0 0.00 2 25935 87 0 0
sp_fill_shopping_cart_clo_res 433041 433041 0 0.00 0 15671 21 0 0
sp_get_clo_for_invoice 4606 4606 0 0.00 0 22082 346 0 0
sp_kill_cost_storno 17727 17727 0 0.00 0 12739 80 0 0
sp_kill_qstorno_ret_qs2qd 1113402 1113402 0 0.00 0 32550 49 0 0
sp_kill_qty_storno 586422 586422 0 0.00 0 35783 113 0 0
sp_lock_selected_doc 19060 19060 0 0.00 0 6825 6 0 0
sp_make_cost_storno 25450 25450 0 0.00 0 28209 92 0 0
sp_multiply_rows_for_pdistr 25449 25449 0 0.00 0 8290 45 0 0
sp_multiply_rows_for_qdistr 18291 18291 0 0.00 0 19206 197 0 0
sp_pay_from_customer 6445 6445 0 0.00 5 11180 186 0 0
sp_pay_to_supplier 5381 5381 0 0.00 6 10866 219 0 0
sp_payment_common 11824 11824 0 0.00 2 8334 48 0 0
sp_qd_handle_on_cancel_clo 1638 1638 0 0.00 1 26831 420 0 0
sp_qd_handle_on_invoice_upd_sts 10213 10213 0 0.00 0 35782 597 0 0
sp_qd_handle_on_reserve_upd_sts 9020 9020 0 0.00 0 32763 76 0 0
sp_reserve_write_off 9020 9020 0 0.00 9 32816 313 0 0
sp_supplier_invoice 5047 5047 0 0.00 9 83566 3322 0 0
sp_supplier_order 5039 5039 0 0.00 7 49289 1456 0 0
srv_aggregate_perf_data 109 109 0 0.00 2741 205891 18640 0 0
srv_fill_mon_cache_memory 68 68 0 0.00 793 201159 38251 0 0
srv_find_qd_qs_mism 1017806 1017806 0 0.00 0 23917 9 0 0
srv_make_invnt_saldo 437 437 0 0.00 69 105673 4816 0 0
srv_make_money_saldo 824 824 0 0.00 1 10915 378 0 0
srv_recalc_idx_stat 4 4 0 0.00 294425 645425 440685 0 0
t$perf-abend:sp_add_invoice_to_stock 66 66 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 4 4 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4652 4652 0 0.00 0 20764 988 0 0
t$perf-norm:sp_cancel_adding_invoice 381 381 0 0.00 1 6357 501 0 0
t$perf-norm:sp_cancel_client_order 1638 1638 0 0.00 0 2340 33 0 0
t$perf-norm:sp_cancel_customer_reserve 650 650 0 0.00 0 547 25 0 0
t$perf-norm:sp_cancel_pay_from_customer 616 616 0 0.00 0 4161 22 0 0
t$perf-norm:sp_cancel_pay_to_supplier 407 407 0 0.00 0 372 12 0 0
t$perf-norm:sp_cancel_supplier_invoice 375 375 0 0.00 0 1251 39 0 0
t$perf-norm:sp_cancel_supplier_order 417 417 0 0.00 0 118615 7831 0 0
t$perf-norm:sp_cancel_write_off 956 956 0 0.00 0 25326 49 0 0
t$perf-norm:sp_client_order 18291 18291 0 0.00 0 5781 39 0 0
t$perf-norm:sp_customer_reserve 942 942 0 0.00 0 2514 17 0 0
t$perf-norm:sp_pay_from_customer 6445 6445 0 0.00 0 4178 20 0 0
t$perf-norm:sp_pay_to_supplier 5381 5381 0 0.00 0 6250 21 0 0
t$perf-norm:sp_reserve_write_off 9020 9020 0 0.00 0 15948 28 0 0
t$perf-norm:sp_supplier_invoice 5047 5047 0 0.00 0 4145 33 0 0
t$perf-norm:sp_supplier_order 5040 5040 0 0.00 0 15851 35 0 0
t$perf-norm:srv_aggregate_perf_data 109 109 0 0.00 0 849 37 0 0
t$perf-norm:srv_fill_mon_cache_memory 68 68 0 0.00 0 545 17 0 0
t$perf-norm:srv_make_invnt_saldo 437 437 0 0.00 0 414 12 0 0
t$perf-norm:srv_make_money_saldo 824 824 0 0.00 0 5133 15 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 9 158 53 0 0
v_add_invoice_to_stock 9332 9200 132 1.41 0 7238 26 0 132
v_all_customers 33856 33856 0 0.00 0 209 4 0 0
v_all_suppliers 28094 28094 0 0.00 0 57 4 0 0
v_all_wares 36568 36568 0 0.00 0 209 4 0 0
v_cancel_adding_invoice 762 762 0 0.00 0 2101 22 0 0
v_cancel_client_order 3276 3276 0 0.00 0 2408 11 0 0
v_cancel_customer_prepayment 1232 1232 0 0.00 0 3175 14 0 0
v_cancel_customer_reserve 1300 1300 0 0.00 1 1760 14 0 0
v_cancel_payment_to_supplier 814 814 0 0.00 0 659 10 0 0
v_cancel_supplier_invoice 758 750 8 1.05 0 13158 43 0 8
v_cancel_supplier_order 834 834 0 0.00 0 688 11 0 0
v_cancel_write_off 1912 1912 0 0.00 0 2745 24 0 0
v_max_id_clo_ord 5034 5034 0 0.00 0 1083 6 0 0
v_max_id_clo_res 942 942 0 0.00 0 1636 11 0 0
v_max_id_ord_sup 5039 5039 0 0.00 0 3821 6 0 0
v_max_non_paid_invoice 1405 1405 0 0.00 0 541 8 0 0
v_max_non_paid_realizn 3226 3226 0 0.00 0 1077 7 0 0
v_min_id_clo_ord 5034 5034 0 0.00 0 6726 14 0 0
v_min_id_clo_res 942 942 0 0.00 0 4070 16 0 0
v_min_id_ord_sup 5039 5039 0 0.00 0 7548 11 0 0
v_min_non_paid_invoice 5380 5380 0 0.00 0 8299 24 0 0
v_min_non_paid_realizn 6444 6444 0 0.00 0 6224 17 0 0
v_our_firm 9148 9148 0 0.00 0 61 5 0 0
v_reserve_write_off 18038 18038 0 0.00 0 3477 11 0 0
x_lock_depdocs_on_canc_invoice 11420 11420 0 0.00 0 28887 141 0 0
x_lock_depdocs_on_canc_sup_ord 417 417 0 0.00 0 3060 408 0 0
x_make_qstorno_1000_1200 5039 5039 0 0.00 3 49280 1253 0 0
x_make_qstorno_1200_2000 5047 5047 0 0.00 4 83516 3107 0 0
x_make_qstorno_2100_3300 433077 433077 0 0.00 0 142453 220 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 20-06-2022 04:38:50 to 20-06-2022 04:38:55.

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
02:07:21 2 8192000000 8796669024 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
02:08:22 26218 8192000000 9723610496 10019282944 791125984 8.806 100 90 180 0 820596560 7694640 21775936
02:09:55 13509 8192000000 9752231136 10057728000 822779792 9.127 100 93 187 0 857189664 11838848 22571024
02:11:14 19927 8192000000 9792699344 10106454016 850815296 9.408 100 87 174 0 892990288 21911808 20263184
02:12:42 11279 8192000000 9849380720 10182148096 912657664 10.024 100 81 162 0 965545680 35420176 17467840
02:14:03 8897 8192000000 9908372928 10250711040 951761072 10.408 100 86 169 0 1029190336 59660640 17768624
02:15:14 2904 8192000000 9973800528 10323034112 975356912 10.639 100 92 179 1 1086919312 93049904 18512496
02:16:19 2096 8192000000 9975582096 10334048256 997707104 10.856 100 95 180 1 1094214096 78557888 17949104
02:17:23 1427 8192000000 10001167632 10364575744 1024699696 11.117 100 87 167 0 1113008384 72254480 16054208
02:18:26 964 8192000000 10026644288 10402979840 1044432944 11.307 100 98 188 0 1148572560 84512000 19627616
02:19:28 1141 8192000000 10033870816 10410221568 1055864016 11.417 100 99 193 0 1154472624 78852944 19755664
02:20:30 1118 8192000000 10040854224 10419077120 1060991584 11.466 100 95 182 0 1159455040 80112064 18351392
02:21:33 1112 8192000000 10043874848 10425057280 1065721984 11.511 100 95 183 0 1162486128 78219600 18544544
02:22:36 2623 8192000000 10036321056 10424668160 1073464320 11.585 100 73 139 1 1154365552 67345104 13556128
02:23:40 1247 8192000000 10064261968 10451234816 1075313744 11.603 100 95 181 0 1181475904 87683984 18478176
02:24:43 865 8192000000 10048400848 10438066176 1085086400 11.696 100 79 156 1 1168424800 68482912 14855488
02:25:45 8825 8192000000 10027168480 10422382592 1093108736 11.772 100 69 130 0 1173047568 67254032 12684800
02:26:55 1283 8192000000 10071206336 10460110848 1092995040 11.771 100 93 185 0 1190859200 80284592 17579568
02:27:58 1303 8192000000 10059560160 10449731584 1099502336 11.833 100 98 183 0 1183811216 65831488 18477392
02:29:00 1000 8192000000 10060764496 10451492864 1088118896 11.725 100 85 160 1 1181345408 76986896 16239616
02:30:01 3519 8192000000 10029798032 10411102208 1069764000 11.550 99 76 140 1 1138868352 54860880 14243472
02:31:06 1056 8192000000 10044135968 10432638976 1088204912 11.726 100 92 176 2 1165024976 57948944 18871120
02:32:08 5450 8192000000 9995962080 10371940352 1049818784 11.359 100 76 144 2 1115246704 50836832 14591088
02:33:15 1385 8192000000 10028701472 10405089280 1047491552 11.337 100 86 159 2 1143942960 79792512 16658896
02:34:20 1482 8192000000 10019419584 10392395776 1045762048 11.320 100 98 186 0 1138863856 74457072 18644736
02:35:22 867 8192000000 9962824848 10332725248 1023587824 11.107 99 89 167 3 1083881248 41551568 18741856
02:36:23 3058 8192000000 9989350208 10375491584 1043203456 11.295 100 72 126 4 1114347184 58406528 12737200
02:37:32 29931 8192000000 9989799680 10367946752 1028052976 11.150 99 56 109 2 1102518320 64003552 10461792
02:39:10 1104 8192000000 10000859904 10374844416 1044653312 11.309 99 89 171 1 1121918896 57764112 19501472
02:40:16 2996 8192000000 10038933008 10424438784 1074733376 11.597 100 63 123 0 1159052880 71420064 12899440
02:41:36 13613 8192000000 10068246000 10461429760 1079773840 11.645 99 52 103 1 1190587248 99521488 11291920
02:42:53 11920 8192000000 10103576032 10496425984 1082400096 11.670 99 59 117 0 1213157888 118362240 12395552
02:44:09 1702 8192000000 10173727312 10563403776 1103267456 11.869 100 93 177 1 1295320912 173205056 18848400
02:45:22 6058 8192000000 10211004656 10622799872 1114409104 11.974 100 60 120 1 1326613712 199297952 12906656
02:46:35 954 8192000000 10183861296 10590932992 1126867296 12.092 100 95 182 4 1292083952 145421504 19795152
02:47:39 944 8192000000 10217794048 10613837824 1137388240 12.191 100 97 189 2 1332558256 173660224 21509792
02:48:48 1273 8192000000 10264972960 10683777024 1161393328 12.416 100 94 185 0 1374015088 191604816 21016944
02:49:54 1992 8192000000 10287129392 10689052672 1181497968 12.604 100 89 175 0 1397689664 197564560 18627136
02:50:58 1119 8192000000 10337930112 10741264384 1189844304 12.682 100 94 183 1 1443614320 233982832 19787184
02:52:03 1574 8192000000 10368631520 10774966272 1200062464 12.777 100 91 180 0 1482443632 260647072 21734096
02:53:07 2457 8192000000 10445860224 10851885056 1210917200 12.878 100 92 174 2 1551366736 319655616 20793920
02:54:13 1416 8192000000 10465913136 10889830400 1216629904 12.930 100 90 175 1 1575594128 339010400 19953824
02:55:17 1752 8192000000 10523878048 10940796928 1215186128 12.917 100 90 178 0 1630328864 393835248 21307488
02:56:25 844 8192000000 10553427664 10964250624 1206315920 12.835 100 96 188 1 1660184384 431400368 22468096
02:57:28 782 8192000000 10562788832 10992467968 1200670080 12.783 100 95 186 0 1669260592 445563744 23026768
02:58:32 944 8192000000 10567776144 11012599808 1197594128 12.754 100 97 188 0 1676370560 454441952 24334480
02:59:36 1277 8192000000 10581673680 11020992512 1204322144 12.816 100 90 176 0 1688150432 463241088 20587200
03:00:41 988 8192000000 10580647504 11023069184 1203984960 12.813 100 99 194 1 1689711376 461266144 24460272
03:01:46 930 8192000000 10594412912 11027587072 1213826944 12.905 100 98 189 0 1698564336 461010432 23726960
03:02:48 3037 8192000000 10580209200 11047645184 1212761760 12.895 100 67 134 2 1688007776 458198848 17047168
03:03:53 2022 8192000000 10607948544 11057573888 1208079408 12.851 100 70 140 0 1712467920 486885392 17503120
03:05:08 2726 8192000000 10605445008 11034480640 1198277920 12.760 100 62 120 1 1719998400 506404528 15315952
03:06:13 5170 8192000000 10590113712 11101036544 1187444384 12.660 100 51 101 0 1693913088 493129632 13339072
03:07:30 3882 8192000000 10588141920 11024728064 1192662944 12.708 100 54 104 1 1698557536 492333616 13560976
03:08:37 3964 8192000000 10523442736 11048075264 1180031424 12.590 100 54 107 0 1630834016 437119440 13683152
03:09:44 16091 8192000000 10450036224 10915811328 1162495728 12.427 100 49 97 0 1596171632 421492112 12183792
03:11:17 41243 8192000000 10345036848 10836889600 1163574400 12.437 100 23 45 0 1454672816 285770592 5327824
03:13:52 45213 8192000000 10183865040 10784059392 1129003792 12.112 99 15 30 0 1340387984 207481376 3902816
03:15:41 101536 8192000000 10121945376 10577063936 1140107664 12.217 100 30 58 0 1220446384 72866528 7472192
03:18:45 69735 8192000000 10061199488 10504216576 1111436896 11.946 97 47 88 1 1147296336 26150608 9708832
03:20:58 77302 8192000000 10106377120 10561351680 1149348768 12.303 100 36 72 1 1211135456 54201280 7585408
03:23:17 39196 8192000000 10166172800 10606047232 1160050528 12.404 100 39 78 0 1232766592 63671024 9045040
03:25:21 20306 8192000000 10196311920 10653569024 1156865968 12.374 100 57 105 1 1299145136 130625104 11654064
03:27:27 45529 8192000000 10141152576 10672984064 1142732048 12.241 99 10 20 0 1257864320 112574176 2558096
03:29:24 140760 8192000000 10112407456 10587570176 1139672752 12.212 99 22 44 0 1215221808 70359856 5189200
03:32:46 155700 8192000000 10091124976 10583064576 1102697440 11.863 96 9 18 1 1158727888 54568208 1462240
03:36:24 53365 8192000000 10074942480 10522955776 1095208320 11.792 96 27 54 0 1130579824 29632960 5738544
03:38:20 29584 8192000000 10108181040 10543390720 1115123312 11.981 98 46 88 5 1186748704 62816464 8808928
03:39:55 43771 8192000000 10115833312 10557288448 1091252048 11.755 97 29 56 1 1183623968 85919312 6452608
03:41:41 99705 8192000000 10112383136 10574135296 1062016208 11.476 94 22 44 0 1153807536 86988864 4802464
03:44:58 54187 8192000000 10070720192 10537508864 1108941744 11.922 99 19 38 1 1192174832 78653328 4579760
03:47:05 143320 8192000000 10052767440 10552946688 1093573520 11.777 97 36 70 0 1178142864 77709664 6859680
03:50:30 98722 8192000000 10073578560 10525564928 1121276864 12.039 99 13 26 0 1177644096 53458000 2909232
03:53:09 55730 8192000000 10094078032 10586685440 1131714096 12.138 100 9 18 0 1202442144 68594160 2133888
03:55:25 83582 8192000000 10050553824 10504482816 1112542784 11.956 98 10 20 0 1164549152 50181984 1824384
03:57:49 37144 8192000000 10088162544 10536722432 1134405776 12.163 100 28 56 0 1186103408 45458448 6239184
03:59:28 29532 8192000000 10170817872 10611978240 1137414016 12.191 99 46 92 0 1247582992 100236464 9932512
04:01:03 35665 8192000000 10186040000 10613669888 1121434464 12.041 98 44 89 0 1239110944 108105456 9571024
04:02:43 15159 8192000000 10183801520 10610499584 1112750816 11.958 97 39 77 1 1253028912 131076368 9201728
04:04:01 12959 8192000000 10222306576 10654924800 1144828240 12.261 100 56 113 2 1318530720 161676112 12026368
04:05:16 15556 8192000000 10242696912 10679324672 1150062112 12.310 100 49 96 1 1342614992 182012528 10540352
04:06:44 48142 8192000000 10199068976 10630750208 1131513888 12.136 99 33 64 2 1300900848 161906384 7480576
04:08:37 57646 8192000000 10161268912 10663157760 1133532720 12.155 100 38 76 0 1268783280 127249968 8000592
04:10:37 64419 8192000000 10089381824 10542272512 1097848176 11.817 97 9 18 0 1126537888 26925392 1764320
04:12:42 54325 8192000000 10070862848 10556006400 1117887536 12.007 99 14 28 0 1177430672 56815664 2727472
04:14:38 82722 8192000000 10081678576 10524004352 1111132208 11.943 98 27 55 0 1152796064 36332768 5331088
04:17:08 43810 8192000000 10116750528 10576310272 1125988400 12.084 99 26 52 1 1210215520 78524848 5702272
04:18:52 201158 8192000000 10106362016 10585190400 1121640256 12.042 98 13 26 1 1175854464 51718432 2495776
04:23:21 32600 8192000000 10090589664 10539462656 1136059536 12.178 100 27 52 1 1177132096 35134352 5938208
04:25:00 118054 8192000000 10069383968 10511511552 1121946144 12.045 98 35 68 0 1192241424 63280736 7014544
04:27:59 5763 8192000000 10068609472 10503688192 1129049728 12.112 100 53 100 0 1169836000 30835216 9951056
04:29:06 53842 8192000000 10101982544 10553348096 1084372048 11.689 95 26 50 1 1183998800 94029120 5597632
04:31:01 47748 8192000000 10064327472 10537127936 1099992768 11.838 97 9 14 2 1152682016 51294368 1394880
04:33:12 41499 8192000000 10068483360 10530512896 1099147056 11.830 98 11 22 0 1155214320 53787392 2279872
04:35:00 81108 8192000000 10084437888 10595405824 1087705920 11.721 98 17 34 0 1207566704 116309664 3551120

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 20-06-2022 04:38:56 to 20-06-2022 04:39:12.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 66 v_add_invoice_to_stock 335544517
except 4 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 20-06-2022 04:39:13 to 20-06-2022 04:39:15.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp40-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   13
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          209589
MON$OLDEST_ACTIVE               209590
MON$OLDEST_SNAPSHOT             209590
MON$NEXT_TRANSACTION            209590
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-30 07:30:08.6030 GMT
MON$PAGES                       2077088
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             758
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2780 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2780 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2780 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2780 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
on disk structure version 13.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-oltp40 according to config parameter 'remove_isql_logs'

20.06.22 04:39:16. There are 3 logs in /var/tmp/logs-oltp40 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-06-20 04:39:18 No severe PSQL-related problems occured
20.06.22 04:39:19. End of report.