Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 01.05.2022 13:37
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 16475636 kB
MemAvailable 31498036 kB
Buffers 0 kB
Cached 15199616 kB
SwapCached 3196 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-05-01 13:37:14
DTS_END                         2022-05-01 13:37:14.9920
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/42266
TRN_ID                          217286
ATT_ID                          616
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: 9140.40 24462 1096848
customer order: creation 164.68 464 19762
customer order: refuse 13.52 389 1622
order to supplier: creation 43.67 1362 5240
order to supplier: removal 3.63 166576 436
invoice (draft): creation 43.01 2891 5161
invoice (draft): removal 52.73 991 6327
invoice accept: apply 40.42 25286 4851
invoice accept: cancel 48.48 1228 5817
customer reserve: creation 3749.56 240 449947
customer reserve: removal 4694.73 102 563367
realization accept: apply 80.78 271 9694
realization accept: cancel 80.66 187 9679
payment from customer: creation 57.07 173 6848
payment from customer: removal 5.10 116 612
payment to supplier: creation 46.65 184 5598
payment to supplier: removal 3.62 135 434
service: total inventory turnovers 3.91 3678 469
service: total monetary turnovers 7.30 279 876
service: aggregate perf. data 0.86 19637 103
service: refresh index statistics 0.04 265055 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 01-05-2022 13:38:16 to 01-05-2022 13:38:18.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7031
TEST_TIME 2 5586
TEST_TIME 3 5754
TEST_TIME 4 4924
TEST_TIME 5 5147
TEST_TIME 6 5240
TEST_TIME 7 5231
TEST_TIME 8 5501
TEST_TIME 9 5938
TEST_TIME 10 6370
TEST_TIME 11 6850
TEST_TIME 12 7046
TEST_TIME 13 7265
TEST_TIME 14 7280
TEST_TIME 15 7307
TEST_TIME 16 7386
TEST_TIME 17 7392
TEST_TIME 18 7401
TEST_TIME 19 7481
TEST_TIME 20 7544
TEST_TIME 21 7499
TEST_TIME 22 7433
TEST_TIME 23 7819
TEST_TIME 24 7868
TEST_TIME 25 8094
TEST_TIME 26 8401
TEST_TIME 27 8965
TEST_TIME 28 9405
TEST_TIME 29 10019
TEST_TIME 30 10971
TEST_TIME 31 11043
TEST_TIME 32 11468
TEST_TIME 33 11234
TEST_TIME 34 10948
TEST_TIME 35 10761
TEST_TIME 36 10594
TEST_TIME 37 10461
TEST_TIME 38 10298
TEST_TIME 39 10160
TEST_TIME 40 10117
TEST_TIME 41 10205
TEST_TIME 42 10162
TEST_TIME 43 10018
TEST_TIME 44 9978
TEST_TIME 45 9870
TEST_TIME 46 9886
TEST_TIME 47 9855
TEST_TIME 48 9763
TEST_TIME 49 9797
TEST_TIME 50 9794
TEST_TIME 51 9705
TEST_TIME 52 9802
TEST_TIME 53 9719
TEST_TIME 54 9767
TEST_TIME 55 9745
TEST_TIME 56 9775
TEST_TIME 57 9710
TEST_TIME 58 9801
TEST_TIME 59 9858
TEST_TIME 60 9805
TEST_TIME 61 9806
TEST_TIME 62 9675
TEST_TIME 63 9563
TEST_TIME 64 9500
TEST_TIME 65 9472
TEST_TIME 66 9439
TEST_TIME 67 9474
TEST_TIME 68 9399
TEST_TIME 69 9357
TEST_TIME 70 9300
TEST_TIME 71 9277
TEST_TIME 72 9221
TEST_TIME 73 9271
TEST_TIME 74 9317
TEST_TIME 75 9300
TEST_TIME 76 9267
TEST_TIME 77 9293
TEST_TIME 78 9294
TEST_TIME 79 9264
TEST_TIME 80 9450
TEST_TIME 81 9459
TEST_TIME 82 9441
TEST_TIME 83 9413
TEST_TIME 84 9391
TEST_TIME 85 9469
TEST_TIME 86 9381
TEST_TIME 87 9319
TEST_TIME 88 9264
TEST_TIME 89 9267
TEST_TIME 90 9240
TEST_TIME 91 9182
TEST_TIME 92 9176
TEST_TIME 93 9121
TEST_TIME 94 9092
TEST_TIME 95 9084
TEST_TIME 96 9082
TEST_TIME 97 9123
TEST_TIME 98 9101
TEST_TIME 99 9098
TEST_TIME 100 9067
TEST_TIME 101 9062
TEST_TIME 102 9065
TEST_TIME 103 9113
TEST_TIME 104 9093
TEST_TIME 105 9233
TEST_TIME 106 9297
TEST_TIME 107 9236
TEST_TIME 108 9265
TEST_TIME 109 9237
TEST_TIME 110 9208
TEST_TIME 111 9192
TEST_TIME 112 9169
TEST_TIME 113 9187
TEST_TIME 114 9187
TEST_TIME 115 9125
TEST_TIME 116 9147
TEST_TIME 117 9216
TEST_TIME 118 9235
TEST_TIME 119 9212
TEST_TIME 120 9163

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 01-05-2022 13:38:19 to 01-05-2022 13:38:23.

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 1512421 1512421 0 0.00 0 18690 13 0 0
doc_list_biud 1512417 1512417 0 0.00 0 45886 43 0 0
sp_add_invoice_to_stock 4964 4851 113 2.27 26 188270 25286 0 113
sp_cancel_adding_invoice 5817 5817 0 0.00 6 93432 1229 0 0
sp_cancel_client_order 1622 1622 0 0.00 5 10269 389 0 0
sp_cancel_customer_reserve 563367 563367 0 0.00 1 45898 102 0 0
sp_cancel_pay_from_customer 612 612 0 0.00 4 5835 116 0 0
sp_cancel_pay_to_supplier 434 434 0 0.00 4 6661 136 0 0
sp_cancel_supplier_invoice 6337 6327 10 0.15 2 27391 992 0 10
sp_cancel_supplier_order 436 436 0 0.00 9 1705437 166577 0 0
sp_cancel_write_off 9679 9679 0 0.00 2 10091 187 0 0
sp_client_order 19762 19762 0 0.00 6 18048 464 0 0
sp_customer_reserve 449947 449947 0 0.00 1 52272 241 0 0
sp_fill_shopping_cart 30156 30156 0 0.00 2 16183 78 0 0
sp_fill_shopping_cart_clo_res 449923 449923 0 0.00 0 11455 21 0 0
sp_get_clo_for_invoice 4820 4820 0 0.00 0 32609 376 0 0
sp_kill_cost_storno 16542 16542 0 0.00 0 10064 71 0 0
sp_kill_qstorno_ret_qs2qd 1143176 1143176 0 0.00 0 45869 45 0 0
sp_kill_qty_storno 601759 601759 0 0.00 0 45885 101 0 0
sp_lock_selected_doc 20106 20106 0 0.00 0 9518 7 0 0
sp_make_cost_storno 26958 26958 0 0.00 0 14448 80 0 0
sp_multiply_rows_for_pdistr 26958 26958 0 0.00 0 8219 37 0 0
sp_multiply_rows_for_qdistr 19762 19762 0 0.00 0 12035 188 0 0
sp_pay_from_customer 6848 6848 0 0.00 6 18922 173 0 0
sp_pay_to_supplier 5598 5598 0 0.00 7 12201 185 0 0
sp_payment_common 12446 12446 0 0.00 2 9814 44 0 0
sp_qd_handle_on_cancel_clo 1622 1622 0 0.00 0 10242 324 0 0
sp_qd_handle_on_invoice_upd_sts 10635 10635 0 0.00 0 16747 490 0 0
sp_qd_handle_on_reserve_upd_sts 9693 9693 0 0.00 0 13467 58 0 0
sp_reserve_write_off 9694 9694 0 0.00 9 20204 271 0 0
sp_supplier_invoice 5161 5161 0 0.00 9 71269 2891 0 0
sp_supplier_order 5240 5240 0 0.00 7 40690 1363 0 0
srv_aggregate_perf_data 103 103 0 0.00 2401 204571 19638 0 0
srv_fill_mon_cache_memory 68 68 0 0.00 602 135028 38640 0 0
srv_find_qd_qs_mism 1050349 1050349 0 0.00 0 18687 10 0 0
srv_make_invnt_saldo 469 469 0 0.00 45 68332 3679 0 0
srv_make_money_saldo 876 876 0 0.00 1 8724 279 0 0
srv_recalc_idx_stat 5 5 0 0.00 180385 369191 265056 0 0
t$perf-abend:sp_add_invoice_to_stock 113 113 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 10 10 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4852 4852 0 0.00 0 16976 864 0 0
t$perf-norm:sp_cancel_adding_invoice 420 420 0 0.00 0 7148 527 0 0
t$perf-norm:sp_cancel_client_order 1622 1622 0 0.00 0 1236 24 0 0
t$perf-norm:sp_cancel_customer_reserve 678 678 0 0.00 0 2615 28 0 0
t$perf-norm:sp_cancel_pay_from_customer 612 612 0 0.00 0 1756 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 434 434 0 0.00 0 1841 20 0 0
t$perf-norm:sp_cancel_supplier_invoice 390 390 0 0.00 0 1026 33 0 0
t$perf-norm:sp_cancel_supplier_order 436 436 0 0.00 0 89223 6404 0 0
t$perf-norm:sp_cancel_write_off 1003 1003 0 0.00 0 3478 20 0 0
t$perf-norm:sp_client_order 19762 19762 0 0.00 0 4013 32 0 0
t$perf-norm:sp_customer_reserve 950 950 0 0.00 0 798 14 0 0
t$perf-norm:sp_pay_from_customer 6848 6848 0 0.00 0 6259 16 0 0
t$perf-norm:sp_pay_to_supplier 5598 5598 0 0.00 0 4997 22 0 0
t$perf-norm:sp_reserve_write_off 9694 9694 0 0.00 0 4195 21 0 0
t$perf-norm:sp_supplier_invoice 5161 5161 0 0.00 0 3177 30 0 0
t$perf-norm:sp_supplier_order 5240 5240 0 0.00 0 3755 32 0 0
t$perf-norm:srv_aggregate_perf_data 103 103 0 0.00 0 418 17 0 0
t$perf-norm:srv_fill_mon_cache_memory 68 68 0 0.00 0 36 4 0 0
t$perf-norm:srv_make_invnt_saldo 469 469 0 0.00 0 4702 27 0 0
t$perf-norm:srv_make_money_saldo 876 876 0 0.00 0 796 7 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 4 191 45 0 0
v_add_invoice_to_stock 9862 9636 226 2.29 0 9614 28 0 226
v_all_customers 36324 36324 0 0.00 0 156 3 0 0
v_all_suppliers 29056 29056 0 0.00 0 215 4 0 0
v_all_wares 39522 39522 0 0.00 0 51 3 0 0
v_cancel_adding_invoice 840 840 0 0.00 0 596 13 0 0
v_cancel_client_order 3244 3244 0 0.00 0 1392 9 0 0
v_cancel_customer_prepayment 1224 1224 0 0.00 0 316 10 0 0
v_cancel_customer_reserve 1356 1356 0 0.00 0 2432 15 0 0
v_cancel_payment_to_supplier 868 868 0 0.00 0 1979 15 0 0
v_cancel_supplier_invoice 800 780 20 2.50 0 451 20 0 20
v_cancel_supplier_order 872 872 0 0.00 0 241 9 0 0
v_cancel_write_off 2006 2006 0 0.00 0 3449 23 0 0
v_max_id_clo_ord 5238 5238 0 0.00 0 4920 6 0 0
v_max_id_clo_res 950 950 0 0.00 0 2268 18 0 0
v_max_id_ord_sup 5157 5157 0 0.00 0 3051 7 0 0
v_max_non_paid_invoice 1465 1465 0 0.00 0 1382 9 0 0
v_max_non_paid_realizn 3485 3485 0 0.00 0 1957 8 0 0
v_min_id_clo_ord 5238 5238 0 0.00 0 6935 8 0 0
v_min_id_clo_res 950 950 0 0.00 0 3494 12 0 0
v_min_id_ord_sup 5157 5157 0 0.00 0 9451 18 0 0
v_min_non_paid_invoice 5598 5598 0 0.00 0 5600 15 0 0
v_min_non_paid_realizn 6848 6848 0 0.00 0 9808 19 0 0
v_our_firm 9924 9924 0 0.00 0 117 4 0 0
v_reserve_write_off 19386 19386 0 0.00 0 10564 11 0 0
x_lock_depdocs_on_canc_invoice 11754 11754 0 0.00 0 15333 125 0 0
x_lock_depdocs_on_canc_sup_ord 436 436 0 0.00 0 30175 479 0 0
x_make_qstorno_1000_1200 5240 5240 0 0.00 3 40669 1204 0 0
x_make_qstorno_1200_2000 5161 5161 0 0.00 4 71215 2668 0 0
x_make_qstorno_2100_3300 449947 449947 0 0.00 0 52269 209 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 01-05-2022 13:38:24 to 01-05-2022 13:38:28.

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
11:07:18 3 8192000000 8796669024 8807174144 3189120 0.038 1 1 2 0 3286736 61840 35776
11:08:20 11900 8192000000 9716977440 10016935936 803532816 8.932 100 85 170 0 831536864 7869872 20134176
11:09:41 16535 8192000000 9761523360 10072711168 836474192 9.264 100 88 176 0 868878800 11062720 21341888
11:11:05 12904 8192000000 9802793856 10124718080 878486880 9.685 100 83 166 1 914460336 17410624 18562832
11:12:23 11410 8192000000 9872658080 10204545024 915323760 10.050 100 77 154 0 975758016 44075936 16358320
11:13:43 6098 8192000000 9918061760 10264997888 955884112 10.449 100 77 152 0 1030662400 58626928 16151360
11:14:52 2850 8192000000 9968353072 10323914752 996507264 10.845 100 93 186 1 1086022992 70577600 18938128
11:15:58 1693 8192000000 9997541136 10362118144 1017177184 11.045 100 89 178 0 1115941392 80390096 18374112
11:17:01 3262 8192000000 10011977728 10384314368 1040747808 11.272 100 77 147 1 1132212528 76612976 14851744
11:18:06 1183 8192000000 10029277616 10410102784 1065299552 11.507 100 98 182 0 1151885856 66874656 19711648
11:19:08 1168 8192000000 10023602368 10400038912 1065320272 11.507 100 97 188 4 1140652048 56204768 19127008
11:20:11 4755 8192000000 10038910512 10421243904 1075117920 11.601 100 87 163 2 1160690000 68997632 16574448
11:21:18 1491 8192000000 10034701952 10421383168 1081207904 11.659 100 92 166 3 1155255136 56259664 17787568
11:22:21 1569 8192000000 10039094496 10434125824 1081752512 11.664 100 79 151 1 1163326000 65375264 16198224
11:23:23 1368 8192000000 10065323760 10460303360 1084616512 11.691 100 74 141 0 1175591072 76842352 14132208
11:24:26 1492 8192000000 10066487744 10454925312 1087836816 11.722 100 80 156 1 1188519088 84771040 15911232
11:25:29 3007 8192000000 10067287328 10453909504 1089332768 11.736 100 85 156 2 1186892576 81375760 16184048
11:26:32 7360 8192000000 10036151616 10438352896 1092062800 11.762 100 69 123 3 1169398224 64551776 12783648
11:27:43 747 8192000000 10060776384 10451140608 1093348048 11.774 100 91 173 0 1180672800 68791088 18533664
11:28:45 1287 8192000000 10058441472 10447310848 1093304208 11.774 100 96 184 2 1178980096 66562976 19112912
11:29:47 852 8192000000 10043708928 10437038080 1089387808 11.737 100 80 158 0 1168443840 62578528 16477504
11:30:49 1143 8192000000 10033480128 10419204096 1068755248 11.540 99 91 178 1 1158938752 71187792 18995712
11:31:50 898 8192000000 10027456048 10406899712 1067733696 11.530 100 94 176 3 1145741488 59294304 18713488
11:32:53 946 8192000000 10015905696 10396725248 1053070160 11.390 100 81 157 3 1138389776 69486576 15833040
11:33:55 1056 8192000000 10021069776 10403033088 1058310352 11.440 100 86 167 2 1143139856 68079024 16750480
11:34:57 926 8192000000 10009864208 10390224896 1044316368 11.306 100 93 175 1 1134170928 70869936 18984624
11:35:58 3405 8192000000 9981005536 10362408960 1029319584 11.162 99 66 122 2 1103585200 62362592 11903024
11:37:02 16346 8192000000 10003357984 10397925376 1041456032 11.279 99 54 100 0 1136730352 85390400 9883920
11:38:36 10956 8192000000 9983859504 10371133440 1066761920 11.521 100 58 92 3 1108213872 32073040 9378912
11:39:52 5849 8192000000 10065944016 10451677184 1083252224 11.678 100 72 141 1 1185894176 87423712 15218240
11:41:02 11303 8192000000 10092163872 10479357952 1101410544 11.851 100 75 140 0 1202744384 86755824 14578016
11:42:19 601 8192000000 10143986224 10531213312 1106319136 11.898 100 77 145 0 1262922736 142239664 14363936
11:43:24 11997 8192000000 10164337680 10563702784 1122336848 12.049 100 63 123 0 1271146112 135617760 13191504
11:44:39 2432 8192000000 10215511424 10618769408 1132631184 12.146 100 72 133 2 1335576848 188223152 14722512
11:45:49 998 8192000000 10251542928 10649903104 1144608848 12.259 100 77 152 0 1366935152 205666160 16660144
11:46:52 987 8192000000 10275496032 10686001152 1146067296 12.273 100 92 176 2 1385408400 219310928 20030176
11:47:56 883 8192000000 10316730944 10720051200 1169936000 12.496 100 92 178 0 1429849552 240621984 19291568
11:48:59 1104 8192000000 10315290032 10731773952 1174138368 12.535 100 93 180 1 1424941168 230982960 19819840
11:50:05 738 8192000000 10379382512 10787229696 1193173424 12.713 100 95 184 0 1490918256 276076064 21668768
11:51:10 1653 8192000000 10400544288 10808381440 1202707888 12.801 100 92 180 0 1513912608 291253952 19950768
11:52:14 831 8192000000 10423640080 10825916416 1193755456 12.718 100 93 185 4 1527975104 313144256 21075392
11:53:18 1056 8192000000 10445323664 10858987520 1180651168 12.596 99 95 183 1 1541741024 339492736 21597120
11:54:23 845 8192000000 10509552688 10919841792 1213569584 12.902 100 91 180 0 1616309984 381088560 21651840
11:55:25 1569 8192000000 10543722864 10974240768 1215978528 12.924 100 92 184 0 1651851664 413478096 22395040
11:56:29 748 8192000000 10580456448 10991869952 1221873120 12.979 100 99 196 1 1688043968 442406400 23764448
11:57:33 1045 8192000000 10627424176 11040063488 1216682720 12.931 100 96 189 1 1732949600 493827664 22439216
11:58:36 1108 8192000000 10700684304 11118997504 1221647104 12.977 100 87 174 0 1807147328 564513168 20987056
11:59:43 1090 8192000000 10701075840 11154214912 1214386240 12.910 100 95 179 4 1800110768 563869248 21855280
12:00:46 7092 8192000000 10684331824 11136114688 1191723424 12.699 99 58 116 0 1783685440 576814080 15147936
12:02:03 4486 8192000000 10694623728 11154993152 1191014768 12.693 100 52 103 0 1795705616 591184000 13506848
12:03:20 11693 8192000000 10690586480 11168575488 1186839136 12.654 100 50 100 1 1807188368 607189136 13160096
12:04:35 18843 8192000000 10499432624 11000143872 1164330288 12.444 99 37 74 0 1635513504 461327632 9855584
12:05:58 10643 8192000000 10482427840 10942251008 1139576288 12.212 98 34 66 0 1582433248 433933840 8923120
12:07:10 20922 8192000000 10214544944 10810744832 1157155472 12.377 100 28 55 1 1380339280 215443936 7739872
12:09:02 93580 8192000000 10076031952 10540797952 1129859376 12.120 98 9 18 0 1207713600 75734080 2120144
12:11:38 112523 8192000000 10054358288 10527735808 1137591232 12.193 99 33 58 2 1176423744 32563584 6268928
12:14:34 38147 8192000000 10085873232 10514771968 1104140064 11.877 96 43 86 0 1152121312 38491792 9489456
12:16:15 95951 8192000000 10162662752 10600132608 1110064624 11.933 97 32 64 1 1241775472 124097040 7613808
12:19:03 63628 8192000000 10109840064 10597482496 1149665904 12.306 100 16 32 0 1243339680 89870160 3803616
12:21:07 63854 8192000000 10131674624 10619719680 1140028448 12.216 99 13 26 0 1239543920 96684624 2830848
12:23:16 98478 8192000000 10070764416 10552610816 1126257792 12.086 98 12 24 2 1170627760 41646592 2723376
12:25:59 24171 8192000000 10112018048 10573389824 1128553328 12.108 99 31 59 2 1215536448 80088576 6894544
12:27:28 67389 8192000000 10096088432 10555166720 1102276400 11.859 96 15 30 0 1145890400 40372336 3241664
12:29:36 56722 8192000000 10092479200 10563612672 1087199680 11.716 96 23 46 0 1176651360 84711920 4739760
12:31:39 77005 8192000000 10092617984 10550190080 1133529104 12.155 100 24 48 0 1181708704 43413568 4766032
12:33:57 117455 8192000000 10140007552 10633056256 1101233440 11.849 96 20 40 0 1162466208 57141248 4091520
12:36:59 83977 8192000000 10100529744 10558963712 1121164432 12.038 98 20 40 2 1152988368 27631920 4192016
12:39:26 135025 8192000000 10094249312 10548506624 1125920976 12.083 99 35 69 1 1185795792 52343088 7531728
12:42:41 57312 8192000000 10095731776 10560942080 1117017968 11.999 98 23 46 1 1187746544 65858512 4870064
12:46:15 51934 8192000000 10078351776 10555211776 1133154528 12.151 99 9 19 0 1177053856 42023584 1875744
12:48:32 39420 8192000000 10120591472 10562838528 1153134576 12.339 100 21 42 0 1218231264 59744592 5352096
12:50:13 48017 8192000000 10137630752 10608115712 1149000864 12.300 99 29 58 1 1245769920 90829120 5939936
12:52:03 63220 8192000000 10129310016 10581712896 1111544432 11.947 96 17 34 1 1168118384 53282448 3291504
12:54:13 28946 8192000000 10174212736 10612707328 1162375472 12.426 100 25 50 1 1255746288 87770528 5600288
12:55:46 42867 8192000000 10193704080 10631868416 1141652944 12.231 98 28 54 1 1270516240 122671440 6191856
12:57:33 29554 8192000000 10093662656 10542407680 1125223728 12.076 98 23 46 0 1178141648 48482240 4435680
12:59:06 30206 8192000000 10100286592 10520461312 1128317600 12.105 99 45 90 0 1186195184 48999520 8878064
13:00:39 35280 8192000000 10116836176 10541158400 1117224992 12.001 98 36 70 1 1182336432 57825184 7286256
13:02:24 88709 8192000000 10049126256 10498703360 1125450480 12.078 100 20 40 0 1169088960 39395264 4243216
13:04:59 57695 8192000000 10088491616 10531684352 1119837856 12.025 99 38 76 1 1186002176 58793120 7371200
13:06:58 34865 8192000000 10062724352 10531631104 1113122976 11.962 99 17 33 1 1161913296 45333632 3456688
13:08:37 58497 8192000000 10065828960 10515255296 1070744832 11.559 95 18 35 1 1132411808 57549632 4117344
13:11:08 121920 8192000000 10100358896 10578345984 1092917648 11.770 97 13 26 0 1162090064 66287280 2885136
13:14:31 28375 8192000000 10080172512 10524241920 1096534928 11.805 97 28 54 2 1161042640 58600432 5907280
13:16:01 27997 8192000000 10135639424 10574946304 1130292992 12.124 99 35 69 1 1214577264 76255184 8029088
13:17:30 20615 8192000000 10172206864 10609582080 1120540816 12.032 98 30 60 2 1256801040 129622800 6637424
13:18:54 15140 8192000000 10210958384 10641043456 1102054432 11.857 97 52 104 0 1276789408 162586128 12148848
13:20:11 43245 8192000000 10192787872 10658398208 1094848112 11.789 96 27 54 0 1270712640 169448704 6415824
13:21:55 35675 8192000000 10169206080 10662162432 1135524032 12.173 100 40 79 2 1291976672 147862864 8589776
13:23:35 77119 8192000000 10127058496 10606858240 1126856480 12.092 100 37 74 2 1252081536 117446944 7778112
13:27:39 50818 8192000000 10082678688 10520018944 1131267904 12.133 99 39 72 1 1183361664 45269072 6824688
13:29:35 32636 8192000000 10127454928 10557693952 1145637312 12.269 100 32 62 3 1219322048 67227280 6457456
13:31:15 77860 8192000000 10124631248 10554994688 1112267872 11.954 97 34 67 2 1178801088 59772320 6760896
13:33:38 54918 8192000000 10163329680 10623361024 1122094144 12.047 98 17 34 0 1238883472 113055520 3733808
13:35:44 98730 8192000000 9853936624 10274217984 864958496 9.550 75 20 40 1 943374272 73954672 4461104

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 01-05-2022 13:38:30 to 01-05-2022 13:38:46.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 113 v_add_invoice_to_stock 335544517
except 10 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 01-05-2022 13:38:47 to 01-05-2022 13:38:49.

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          214993
MON$OLDEST_ACTIVE               217475
MON$OLDEST_SNAPSHOT             217475
MON$NEXT_TRANSACTION            217475
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                       2048288
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             767
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2762 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2762 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2762 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2762 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 ---
:24: 
:25: mscs-test-161.budzdorov.ru    Sun May  1 13:37:26 2022
:26:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:27: 
--- end of diff output ---

Final processing ISQL logs in /var/tmp/logs-oltp40 according to config parameter 'remove_isql_logs'

01.05.22 13:38:49. 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-05-01 13:38:52 No severe PSQL-related problems occured
01.05.22 13:38:53. End of report.