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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15447872 kB
MemAvailable 30456772 kB
Buffers 0 kB
Cached 16292620 kB
SwapCached 5052 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.3
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 2023-02-10 13:37:25
DTS_END                         2023-02-10 13:37:25.9100
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/47214
TRN_ID                          213422
ATT_ID                          591
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: 8498.61 22579 1019833
customer order: creation 166.24 483 19949
customer order: refuse 14.47 386 1736
order to supplier: creation 42.03 1327 5044
order to supplier: removal 3.22 167770 386
invoice (draft): creation 43.18 3218 5182
invoice (draft): removal 46.51 1095 5581
invoice accept: apply 40.19 26799 4823
invoice accept: cancel 42.17 1095 5060
customer reserve: creation 3703.32 258 444398
customer reserve: removal 4123.17 102 494780
realization accept: apply 80.63 262 9676
realization accept: cancel 67.73 174 8128
payment from customer: creation 56.92 175 6830
payment from customer: removal 6.15 107 738
payment to supplier: creation 47.11 176 5653
payment to supplier: removal 3.47 108 416
service: total inventory turnovers 3.83 3931 460
service: total monetary turnovers 7.36 361 883
service: aggregate perf. data 0.88 13810 105
service: refresh index statistics 0.04 229940 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-02-2023 13:39:41 to 10-02-2023 13:39:43.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4669
TEST_TIME 2 5076
TEST_TIME 3 4225
TEST_TIME 4 4916
TEST_TIME 5 4764
TEST_TIME 6 4913
TEST_TIME 7 5491
TEST_TIME 8 5526
TEST_TIME 9 5677
TEST_TIME 10 6061
TEST_TIME 11 6367
TEST_TIME 12 6341
TEST_TIME 13 6551
TEST_TIME 14 6716
TEST_TIME 15 6713
TEST_TIME 16 6707
TEST_TIME 17 6742
TEST_TIME 18 6968
TEST_TIME 19 6914
TEST_TIME 20 6982
TEST_TIME 21 7713
TEST_TIME 22 8243
TEST_TIME 23 8122
TEST_TIME 24 8220
TEST_TIME 25 8598
TEST_TIME 26 9215
TEST_TIME 27 9424
TEST_TIME 28 9784
TEST_TIME 29 10323
TEST_TIME 30 10367
TEST_TIME 31 10554
TEST_TIME 32 10404
TEST_TIME 33 10116
TEST_TIME 34 10312
TEST_TIME 35 10280
TEST_TIME 36 10164
TEST_TIME 37 10005
TEST_TIME 38 9936
TEST_TIME 39 9852
TEST_TIME 40 9737
TEST_TIME 41 9734
TEST_TIME 42 9538
TEST_TIME 43 9473
TEST_TIME 44 9507
TEST_TIME 45 9327
TEST_TIME 46 9360
TEST_TIME 47 9249
TEST_TIME 48 9077
TEST_TIME 49 9003
TEST_TIME 50 8990
TEST_TIME 51 8903
TEST_TIME 52 8898
TEST_TIME 53 8897
TEST_TIME 54 8923
TEST_TIME 55 8848
TEST_TIME 56 8737
TEST_TIME 57 8697
TEST_TIME 58 8608
TEST_TIME 59 8585
TEST_TIME 60 8611
TEST_TIME 61 8541
TEST_TIME 62 8527
TEST_TIME 63 8501
TEST_TIME 64 8527
TEST_TIME 65 8564
TEST_TIME 66 8566
TEST_TIME 67 8647
TEST_TIME 68 8723
TEST_TIME 69 8868
TEST_TIME 70 8881
TEST_TIME 71 8822
TEST_TIME 72 8860
TEST_TIME 73 8882
TEST_TIME 74 9090
TEST_TIME 75 8982
TEST_TIME 76 8918
TEST_TIME 77 8883
TEST_TIME 78 8881
TEST_TIME 79 8810
TEST_TIME 80 8779
TEST_TIME 81 8703
TEST_TIME 82 8687
TEST_TIME 83 8631
TEST_TIME 84 8673
TEST_TIME 85 8703
TEST_TIME 86 8674
TEST_TIME 87 8648
TEST_TIME 88 8635
TEST_TIME 89 8686
TEST_TIME 90 8706
TEST_TIME 91 8694
TEST_TIME 92 8726
TEST_TIME 93 8832
TEST_TIME 94 8778
TEST_TIME 95 8773
TEST_TIME 96 8748
TEST_TIME 97 8699
TEST_TIME 98 8690
TEST_TIME 99 8652
TEST_TIME 100 8614
TEST_TIME 101 8589
TEST_TIME 102 8558
TEST_TIME 103 8540
TEST_TIME 104 8576
TEST_TIME 105 8583
TEST_TIME 106 8583
TEST_TIME 107 8583
TEST_TIME 108 8633
TEST_TIME 109 8645
TEST_TIME 110 8628
TEST_TIME 111 8660
TEST_TIME 112 8693
TEST_TIME 113 8678
TEST_TIME 114 8688
TEST_TIME 115 8641
TEST_TIME 116 8661
TEST_TIME 117 8613
TEST_TIME 118 8597
TEST_TIME 119 8560
TEST_TIME 120 8521

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 10-02-2023 13:39:45 to 10-02-2023 13:39:48.

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 1427819 1427819 0 0.00 0 20166 13 0 0
doc_list_biud 1427814 1427814 0 0.00 0 72751 41 0 0
sp_add_invoice_to_stock 4993 4823 170 3.40 29 205573 26799 0 170
sp_cancel_adding_invoice 5060 5060 0 0.00 6 87261 1095 0 0
sp_cancel_client_order 1736 1736 0 0.00 6 9777 387 0 0
sp_cancel_customer_reserve 494780 494780 0 0.00 1 50072 102 0 0
sp_cancel_pay_from_customer 738 738 0 0.00 3 2243 107 0 0
sp_cancel_pay_to_supplier 416 416 0 0.00 4 1315 109 0 0
sp_cancel_supplier_invoice 5591 5581 10 0.17 2 72788 1095 0 10
sp_cancel_supplier_order 386 386 0 0.00 13 1391230 167770 0 0
sp_cancel_write_off 8128 8128 0 0.00 2 12287 174 0 0
sp_client_order 19949 19949 0 0.00 5 30199 483 0 0
sp_customer_reserve 444398 444398 0 0.00 0 57176 258 0 0
sp_fill_shopping_cart 30165 30165 0 0.00 1 42944 82 0 0
sp_fill_shopping_cart_clo_res 444362 444362 0 0.00 0 13047 22 0 0
sp_get_clo_for_invoice 4781 4781 0 0.00 0 35498 418 0 0
sp_kill_cost_storno 14342 14342 0 0.00 0 12262 72 0 0
sp_kill_qstorno_ret_qs2qd 1003655 1003655 0 0.00 0 72744 45 0 0
sp_kill_qty_storno 530126 530126 0 0.00 0 72748 103 0 0
sp_lock_selected_doc 20067 20067 0 0.00 0 4389 5 0 0
sp_make_cost_storno 26940 26940 0 0.00 0 14279 78 0 0
sp_multiply_rows_for_pdistr 26939 26939 0 0.00 0 9079 37 0 0
sp_multiply_rows_for_qdistr 19949 19949 0 0.00 0 23948 212 0 0
sp_pay_from_customer 6830 6830 0 0.00 6 16952 176 0 0
sp_pay_to_supplier 5653 5653 0 0.00 6 13515 177 0 0
sp_payment_common 12483 12483 0 0.00 2 11845 43 0 0
sp_qd_handle_on_cancel_clo 1736 1736 0 0.00 0 7981 316 0 0
sp_qd_handle_on_invoice_upd_sts 9839 9839 0 0.00 0 41174 498 0 0
sp_qd_handle_on_reserve_upd_sts 9676 9676 0 0.00 0 8065 60 0 0
sp_reserve_write_off 9676 9676 0 0.00 8 14342 263 0 0
sp_supplier_invoice 5182 5182 0 0.00 7 99856 3218 0 0
sp_supplier_order 5044 5044 0 0.00 7 37303 1327 0 0
srv_aggregate_perf_data 105 105 0 0.00 2595 105164 13810 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 921 125306 36909 0 0
srv_find_qd_qs_mism 972166 972166 0 0.00 0 20162 11 0 0
srv_make_invnt_saldo 460 460 0 0.00 45 134324 3932 0 0
srv_make_money_saldo 883 883 0 0.00 1 24070 361 0 0
srv_recalc_idx_stat 5 5 0 0.00 118135 424841 229940 0 0
t$perf-abend:sp_add_invoice_to_stock 170 170 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 4828 4828 0 0.00 1 35368 878 0 0
t$perf-norm:sp_cancel_adding_invoice 393 393 0 0.00 2 6564 318 0 0
t$perf-norm:sp_cancel_client_order 1736 1736 0 0.00 0 4807 32 0 0
t$perf-norm:sp_cancel_customer_reserve 657 657 0 0.00 0 1929 28 0 0
t$perf-norm:sp_cancel_pay_from_customer 738 738 0 0.00 0 730 11 0 0
t$perf-norm:sp_cancel_pay_to_supplier 416 416 0 0.00 0 246 11 0 0
t$perf-norm:sp_cancel_supplier_invoice 356 356 0 0.00 0 2143 38 0 0
t$perf-norm:sp_cancel_supplier_order 386 386 0 0.00 0 108765 6299 0 0
t$perf-norm:sp_cancel_write_off 935 935 0 0.00 0 1179 18 0 0
t$perf-norm:sp_client_order 19949 19949 0 0.00 0 31120 40 0 0
t$perf-norm:sp_customer_reserve 905 905 0 0.00 0 2054 15 0 0
t$perf-norm:sp_pay_from_customer 6830 6830 0 0.00 0 7526 20 0 0
t$perf-norm:sp_pay_to_supplier 5653 5653 0 0.00 0 38002 30 0 0
t$perf-norm:sp_reserve_write_off 9676 9676 0 0.00 0 27890 35 0 0
t$perf-norm:sp_supplier_invoice 5182 5182 0 0.00 0 12177 35 0 0
t$perf-norm:sp_supplier_order 5044 5044 0 0.00 0 20632 39 0 0
t$perf-norm:srv_aggregate_perf_data 105 105 0 0.00 0 502 18 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 3163 51 0 0
t$perf-norm:srv_make_invnt_saldo 460 460 0 0.00 0 841 16 0 0
t$perf-norm:srv_make_money_saldo 883 883 0 0.00 0 14379 23 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 20 177 86 0 0
v_add_invoice_to_stock 9886 9546 340 3.43 0 7842 27 0 340
v_all_customers 35900 35900 0 0.00 0 68 3 0 0
v_all_suppliers 28795 28795 0 0.00 0 71 4 0 0
v_all_wares 39898 39898 0 0.00 0 161 3 0 0
v_cancel_adding_invoice 786 786 0 0.00 0 220 11 0 0
v_cancel_client_order 3472 3472 0 0.00 0 5338 11 0 0
v_cancel_customer_prepayment 1476 1476 0 0.00 0 1771 13 0 0
v_cancel_customer_reserve 1314 1314 0 0.00 0 1749 11 0 0
v_cancel_payment_to_supplier 832 832 0 0.00 0 627 11 0 0
v_cancel_supplier_invoice 732 712 20 2.73 0 1219 24 0 20
v_cancel_supplier_order 772 772 0 0.00 0 3496 14 0 0
v_cancel_write_off 1870 1870 0 0.00 0 7365 27 0 0
v_max_id_clo_ord 5044 5044 0 0.00 0 182 4 0 0
v_max_id_clo_res 905 905 0 0.00 0 905 11 0 0
v_max_id_ord_sup 5171 5171 0 0.00 0 9829 14 0 0
v_max_non_paid_invoice 1470 1470 0 0.00 0 72 7 0 0
v_max_non_paid_realizn 3743 3743 0 0.00 0 2704 8 0 0
v_min_id_clo_ord 5044 5044 0 0.00 0 1853 7 0 0
v_min_id_clo_res 905 905 0 0.00 0 3493 22 0 0
v_min_id_ord_sup 5171 5171 0 0.00 0 6170 13 0 0
v_min_non_paid_invoice 5653 5653 0 0.00 0 6756 13 0 0
v_min_non_paid_realizn 6830 6830 0 0.00 0 11835 20 0 0
v_our_firm 10172 10172 0 0.00 0 49 4 0 0
v_reserve_write_off 19350 19350 0 0.00 0 4231 10 0 0
x_lock_depdocs_on_canc_invoice 10285 10285 0 0.00 0 14543 131 0 0
x_lock_depdocs_on_canc_sup_ord 386 386 0 0.00 0 5267 369 0 0
x_make_qstorno_1000_1200 5044 5044 0 0.00 3 37182 1184 0 0
x_make_qstorno_1200_2000 5182 5182 0 0.00 3 87376 2956 0 0
x_make_qstorno_2100_3300 444397 444397 0 0.00 0 54436 225 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-02-2023 13:39:49 to 10-02-2023 13:39:53.

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:29 894 8192000000 8934082832 8991387648 27776560 0.337 6 5 9 0 28578384 223488 578336
11:08:31 23466 8192000000 9720881376 10018410496 797783376 8.874 100 87 174 0 826518320 7402752 21332192
11:09:56 10185 8192000000 9757708704 10065154048 833473840 9.234 100 89 178 0 865609648 11214864 20920944
11:11:10 16568 8192000000 9786691904 10101489664 859520992 9.495 100 84 168 0 895031008 16621936 18888080
11:12:41 13305 8192000000 9851786064 10184691712 917481712 10.071 100 82 162 1 966040768 31049504 17509552
11:13:58 4897 8192000000 9904912720 10247647232 954237488 10.433 100 85 166 1 1024382928 53398400 16747040
11:15:08 1578 8192000000 9966418208 10317053952 986094464 10.743 100 89 168 0 1093554832 90041856 17418512
11:16:12 1304 8192000000 9989261120 10345021440 1011387792 10.989 100 93 184 1 1099855312 70582032 17885488
11:17:16 1394 8192000000 10019358512 10384154624 1031682016 11.185 100 91 174 1 1136061648 87208608 17171024
11:18:18 942 8192000000 10021538656 10395959296 1053592272 11.395 100 92 175 0 1142685280 69874896 19218112
11:19:20 1608 8192000000 10029281600 10404057088 1062616224 11.482 100 91 172 0 1148545456 68208368 17720864
11:20:25 1357 8192000000 10040660864 10415726592 1072786160 11.579 100 88 166 3 1161114624 71980672 16347792
11:21:27 1163 8192000000 10044669584 10427441152 1080565776 11.653 100 88 167 1 1164986272 66315968 18104528
11:22:29 1225 8192000000 10050888464 10436366336 1084606144 11.691 100 98 185 1 1174244464 71397072 18241248
11:23:31 1608 8192000000 10061574336 10448519168 1093432960 11.775 100 94 174 3 1183944720 72939744 17572016
11:24:33 1297 8192000000 10057410384 10442747904 1094076160 11.781 100 96 180 4 1179851920 65735680 20040080
11:25:36 970 8192000000 10067405728 10459774976 1093896896 11.780 100 90 176 1 1195817568 84207472 17713200
11:26:38 1132 8192000000 10059559408 10447101952 1095434224 11.794 100 95 190 1 1183507216 68137456 19935536
11:27:40 957 8192000000 10050623872 10447609856 1093641744 11.777 100 81 159 1 1176918432 67187232 16089456
11:28:42 1052 8192000000 10048969616 10440192000 1092605840 11.767 100 96 184 0 1174899664 62829536 19464288
11:29:44 1175 8192000000 10027823344 10411614208 1078663856 11.635 100 92 174 1 1152262736 56802176 16796704
11:30:46 5447 8192000000 10032159248 10428358656 1090658304 11.749 100 65 126 0 1161303056 58350256 12294496
11:31:53 1224 8192000000 10048678768 10434629632 1074988400 11.600 100 96 175 2 1172600032 79136144 18475488
11:32:55 1108 8192000000 10025452896 10404536320 1059274592 11.450 100 96 183 4 1149641152 70167408 20199152
11:33:56 1615 8192000000 9969570432 10333745152 1014638416 11.020 97 94 179 3 1091902400 57923888 19340096
11:34:59 7847 8192000000 9978283872 10360156160 1029317520 11.162 99 62 118 2 1087700912 46712720 11670672
11:36:08 1012 8192000000 9988376192 10361241600 1040519472 11.270 100 88 161 1 1106693808 49123120 17051216
11:37:10 3416 8192000000 10010283152 10387439616 1042284544 11.287 100 78 140 0 1131318624 75168800 13865280
11:38:22 26144 8192000000 10001533904 10384560128 1052520176 11.385 99 63 119 0 1116346288 52503248 11322864
11:39:55 33721 8192000000 10059394320 10446221312 1088466352 11.728 100 60 112 1 1176535136 76875760 11193024
11:41:57 11753 8192000000 10144742256 10525290496 1109136624 11.924 100 83 162 1 1255732096 130217200 16378272
11:43:15 7095 8192000000 10185424192 10581151744 1118313984 12.011 100 70 136 0 1307659680 174622976 14722720
11:44:32 1415 8192000000 10202163968 10600349696 1124609792 12.071 100 92 172 0 1309575536 166033104 18932640
11:45:38 7740 8192000000 10205341328 10600947712 1138913648 12.205 100 75 139 0 1325448704 172631920 13903136
11:46:57 3356 8192000000 10244055312 10651992064 1156720192 12.373 100 90 173 1 1356356736 181083584 18552960
11:48:05 903 8192000000 10291135824 10700443648 1162484672 12.427 100 89 164 2 1401338800 219473760 19380368
11:49:09 2506 8192000000 10311757472 10723053568 1176247664 12.555 100 76 149 0 1419697728 226449216 17000848
11:50:17 1755 8192000000 10357080032 10774552576 1186025744 12.646 100 85 165 1 1468149984 262551664 19572576
11:51:21 2648 8192000000 10393269152 10804252672 1194057056 12.721 100 91 178 1 1501516112 286207360 21251696
11:52:27 3675 8192000000 10449933232 10851463168 1201000832 12.786 100 89 174 0 1555887616 334916992 19969792
11:53:38 1240 8192000000 10496755168 10904281088 1205465184 12.827 100 94 189 2 1603972832 375920432 22587216
11:54:43 1262 8192000000 10529349952 10964381696 1214178816 12.908 100 96 188 2 1630898144 393882112 22837216
11:55:49 1141 8192000000 10530045696 10961129472 1212884144 12.896 100 84 163 0 1638953904 406645840 19423920
11:56:54 947 8192000000 10582398144 11029544960 1219516928 12.957 100 98 196 0 1689249712 446277792 23454992
11:57:57 2049 8192000000 10604024672 11084099584 1215030128 12.916 100 98 193 0 1709830160 469317824 25482208
11:59:00 2245 8192000000 10575570528 11023228928 1206670832 12.838 100 75 149 0 1681346688 456588592 18087264
12:00:09 13694 8192000000 10518721568 10952925184 1180734064 12.597 99 42 84 1 1600552784 408046800 11771920
12:01:33 10803 8192000000 10519201152 10971963392 1167417840 12.473 100 50 100 0 1620577520 440006528 13153152
12:02:46 18911 8192000000 10432684592 10910031872 1148690880 12.297 99 42 84 2 1555309776 395679280 10939616
12:04:25 10829 8192000000 10365755376 10850865152 1166402000 12.463 100 30 60 0 1507311120 333298336 7610784
12:06:01 38689 8192000000 10179853760 10676932608 1143903312 12.252 99 25 51 0 1319978128 170544480 5530336
12:07:41 13741 8192000000 10119476544 10591465472 1110062752 11.933 97 37 72 0 1199613280 81735968 7814560
12:09:02 91002 8192000000 10167129072 10596663296 1139929376 12.215 100 49 91 0 1261338928 111639584 9769968
12:11:34 27196 8192000000 10112182560 10615562240 1135597744 12.174 100 16 32 0 1220989648 81819552 3572352
12:13:17 29232 8192000000 10086300080 10570321920 1138541376 12.202 100 10 16 0 1186631600 46346608 1743616
12:14:47 94282 8192000000 10069039664 10536300544 1090246304 11.745 95 27 50 0 1124402384 29602032 4554048
12:17:21 82654 8192000000 10116924656 10556653568 1112214384 11.953 98 30 60 2 1180542592 61085936 7242272
12:19:44 31752 8192000000 10118738864 10567405568 1125357872 12.078 99 40 77 0 1225844032 92957728 7528432
12:21:35 61882 8192000000 10074556464 10544988160 1123029808 12.056 100 42 77 1 1211345696 78738128 9577760
12:23:55 31976 8192000000 10059214240 10498953216 1114995536 11.980 99 44 82 1 1155903792 30392528 10515728
12:25:44 18785 8192000000 10094226240 10532950016 1141011792 12.225 100 47 93 0 1202456080 51667792 9776496
12:27:04 50957 8192000000 10132795504 10595766272 1128534784 12.108 100 30 60 0 1238429872 103831856 6063232
12:28:55 61381 8192000000 10113905568 10575503360 1098631776 11.825 97 19 38 0 1185685840 82769584 4284480
12:32:28 51997 8192000000 10040910160 10491879424 1097130768 11.810 97 11 22 1 1119564336 20354160 2079408
12:34:34 79947 8192000000 10046744240 10521796608 1086327968 11.708 96 11 22 0 1121542384 32725008 2489408
12:36:56 61159 8192000000 10050044912 10501726208 1115456368 11.984 99 12 24 0 1151542176 33712368 2373440
12:39:05 24432 8192000000 10101221792 10547576832 1137149296 12.189 99 36 72 0 1199121008 53703008 8268704
12:40:29 30331 8192000000 10134688624 10573901824 1116443968 11.993 98 33 64 0 1215103056 91559376 7099712
12:42:02 40379 8192000000 10167226608 10602786816 1112479648 11.956 98 37 72 0 1243549680 122055360 9014672
12:43:44 47542 8192000000 10188857632 10655916032 1131128448 12.132 99 33 66 1 1251176368 113100144 6947776
12:45:42 60349 8192000000 10101336480 10549936128 1125878256 12.082 99 25 50 0 1243625504 112334480 5412768
12:47:42 45257 8192000000 10137961776 10563833856 1143412672 12.248 100 31 62 0 1238735536 88841056 6481808
12:49:28 48950 8192000000 10188027152 10647457792 1125611104 12.080 98 31 62 0 1262489744 130562832 6315808
12:51:21 125304 8192000000 10082121008 10532298752 1136699680 12.184 100 21 42 0 1185284576 44094944 4489952
12:54:34 21760 8192000000 10084070352 10523668480 1124380896 12.068 99 36 70 3 1180975360 49352480 7241984
12:56:01 58927 8192000000 10024828688 10492784640 1083403904 11.680 97 6 12 0 1119034144 34695728 934512
12:58:00 53600 8192000000 10060846928 10532249600 1109706304 11.930 99 12 24 0 1154557456 42355440 2495712
12:59:54 51813 8192000000 10087218624 10540744704 1134666032 12.165 100 17 34 0 1195163344 57063104 3434208
13:01:57 46328 8192000000 10057634992 10549297152 1118455904 12.012 98 16 30 0 1178997696 57305344 3236448
13:03:45 9933 8192000000 10097970384 10530283520 1138621568 12.203 100 52 102 1 1196228528 46592288 11014672
13:05:05 34943 8192000000 10127199904 10583707648 1143042512 12.244 100 31 60 0 1233194720 83942224 6209984
13:06:54 30911 8192000000 10093304464 10546782208 1116429856 11.993 99 37 72 1 1195692416 71916928 7345632
13:08:28 35200 8192000000 10126625920 10570735616 1094202560 11.783 97 42 84 1 1177163136 74532416 8428160
13:10:08 69966 8192000000 10051304736 10550964224 1095222880 11.792 98 25 50 0 1198909024 98652256 5033888
13:12:18 79808 8192000000 10106030192 10581475328 1128042880 12.103 100 39 78 0 1228807536 92516736 8247920
13:14:56 29958 8192000000 10091323536 10527092736 1131288448 12.134 100 55 110 0 1191587632 49429488 10869696
13:16:33 71409 8192000000 10066071104 10541031424 1113690960 11.967 98 12 24 0 1167655440 51482992 2481488
13:18:45 58256 8192000000 10088261984 10535542784 1128005824 12.103 99 19 38 0 1161667520 29493232 4168464
13:20:45 26467 8192000000 10128533088 10566930432 1122106176 12.047 98 26 50 0 1195746432 68042160 5598096
13:22:12 38480 8192000000 10116384128 10586599424 1137402336 12.191 99 28 54 1 1222384000 79145744 5835920
13:23:51 92382 8192000000 10113016208 10582687744 1112657616 11.958 97 18 36 0 1207369120 90936928 3774576
13:26:33 20384 8192000000 10073883056 10507419648 1129256720 12.114 100 30 60 0 1171599136 36214912 6127504
13:27:57 40999 8192000000 10150384096 10604937216 1136253296 12.180 100 49 98 0 1209590016 63642944 9693776
13:29:39 40992 8192000000 10111842592 10543894528 1145275632 12.265 100 37 74 0 1208744624 55611616 7857376
13:31:23 121089 8192000000 10120429904 10575994880 1129760512 12.119 99 30 60 1 1239417792 102795392 6861888
13:35:00 76078 8192000000 10095456096 10564251648 1136541984 12.183 99 24 48 0 1199404448 58156512 4705952
13:37:17 21728 8192000000 9329364672 9675628544 460303008 5.320 41 2 4 0 483458896 23018960 136928

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 10-02-2023 13:39:55 to 10-02-2023 13:40:11.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 170 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 10-02-2023 13:40:12 to 10-02-2023 13:40:14.

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          212763
MON$OLDEST_ACTIVE               213726
MON$OLDEST_SNAPSHOT             213726
MON$NEXT_TRANSACTION            213726
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                       2022400
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             759
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2899 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2899 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2899 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2899 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 ---
:104: 
:105: mscs-test-161.budzdorov.ru    Fri Feb 10 13:37:45 2023
:106:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:107: 
--- end of diff output ---

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

10.02.23 13:40: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
2023-02-10 13:40:18 No severe PSQL-related problems occured
10.02.23 13:40:20. End of report.