Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 27.07.2022 10: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 15680388 kB
MemAvailable 31010400 kB
Buffers 0 kB
Cached 16007452 kB
SwapCached 2516 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-07-27 10:37:19
DTS_END                         2022-07-27 10:37:19.9840
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_ORDER(38:5) ==> X_MAKE_QSTORNO_1000_1200(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/41478
TRN_ID                          212358
ATT_ID                          596
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: 8668.56 25288 1040227
customer order: creation 164.02 512 19682
customer order: refuse 13.75 483 1650
order to supplier: creation 42.86 1578 5143
order to supplier: removal 3.23 191229 388
invoice (draft): creation 42.83 3428 5139
invoice (draft): removal 48.65 1049 5838
invoice accept: apply 40.17 28765 4821
invoice accept: cancel 44.10 1394 5292
customer reserve: creation 3689.35 272 442722
customer reserve: removal 4291.68 114 515001
realization accept: apply 79.09 310 9491
realization accept: cancel 86.48 192 10377
payment from customer: creation 55.06 206 6607
payment from customer: removal 5.43 135 651
payment to supplier: creation 46.70 230 5604
payment to supplier: removal 2.95 121 354
service: total inventory turnovers 3.67 4573 440
service: total monetary turnovers 7.56 409 907
service: aggregate perf. data 0.97 13513 116
service: refresh index statistics 0.03 257248 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 27-07-2022 10:38:05 to 27-07-2022 10:38:08.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 8393
TEST_TIME 2 6200
TEST_TIME 3 6741
TEST_TIME 4 6931
TEST_TIME 5 6606
TEST_TIME 6 6536
TEST_TIME 7 6160
TEST_TIME 8 6260
TEST_TIME 9 6471
TEST_TIME 10 6461
TEST_TIME 11 6522
TEST_TIME 12 6617
TEST_TIME 13 6584
TEST_TIME 14 6842
TEST_TIME 15 6824
TEST_TIME 16 6998
TEST_TIME 17 7384
TEST_TIME 18 7424
TEST_TIME 19 7623
TEST_TIME 20 7600
TEST_TIME 21 7663
TEST_TIME 22 7634
TEST_TIME 23 7666
TEST_TIME 24 7595
TEST_TIME 25 7755
TEST_TIME 26 7869
TEST_TIME 27 7921
TEST_TIME 28 8142
TEST_TIME 29 8255
TEST_TIME 30 8183
TEST_TIME 31 8794
TEST_TIME 32 8981
TEST_TIME 33 9354
TEST_TIME 34 9551
TEST_TIME 35 9872
TEST_TIME 36 10201
TEST_TIME 37 10114
TEST_TIME 38 10239
TEST_TIME 39 10037
TEST_TIME 40 9851
TEST_TIME 41 10013
TEST_TIME 42 9881
TEST_TIME 43 9904
TEST_TIME 44 9905
TEST_TIME 45 9768
TEST_TIME 46 9647
TEST_TIME 47 9623
TEST_TIME 48 9468
TEST_TIME 49 9498
TEST_TIME 50 9381
TEST_TIME 51 9331
TEST_TIME 52 9255
TEST_TIME 53 9156
TEST_TIME 54 9133
TEST_TIME 55 8989
TEST_TIME 56 8943
TEST_TIME 57 8900
TEST_TIME 58 8828
TEST_TIME 59 8764
TEST_TIME 60 8739
TEST_TIME 61 8701
TEST_TIME 62 8659
TEST_TIME 63 8772
TEST_TIME 64 8916
TEST_TIME 65 8995
TEST_TIME 66 8972
TEST_TIME 67 8943
TEST_TIME 68 8898
TEST_TIME 69 8926
TEST_TIME 70 8965
TEST_TIME 71 8957
TEST_TIME 72 8947
TEST_TIME 73 9007
TEST_TIME 74 8985
TEST_TIME 75 8974
TEST_TIME 76 9036
TEST_TIME 77 8968
TEST_TIME 78 8901
TEST_TIME 79 8841
TEST_TIME 80 8753
TEST_TIME 81 8774
TEST_TIME 82 8756
TEST_TIME 83 8697
TEST_TIME 84 8687
TEST_TIME 85 8618
TEST_TIME 86 8566
TEST_TIME 87 8618
TEST_TIME 88 8728
TEST_TIME 89 8691
TEST_TIME 90 8719
TEST_TIME 91 8723
TEST_TIME 92 8699
TEST_TIME 93 8749
TEST_TIME 94 8791
TEST_TIME 95 8808
TEST_TIME 96 8858
TEST_TIME 97 8913
TEST_TIME 98 8900
TEST_TIME 99 8887
TEST_TIME 100 8860
TEST_TIME 101 8840
TEST_TIME 102 8807
TEST_TIME 103 8778
TEST_TIME 104 8741
TEST_TIME 105 8692
TEST_TIME 106 8673
TEST_TIME 107 8608
TEST_TIME 108 8570
TEST_TIME 109 8586
TEST_TIME 110 8555
TEST_TIME 111 8584
TEST_TIME 112 8610
TEST_TIME 113 8642
TEST_TIME 114 8616
TEST_TIME 115 8616
TEST_TIME 116 8610
TEST_TIME 117 8639
TEST_TIME 118 8743
TEST_TIME 119 8761
TEST_TIME 120 8698

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 27-07-2022 10:38:09 to 27-07-2022 10:38:12.

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 1447595 1447595 0 0.00 0 44151 15 0 0
doc_list_biud 1447581 1447581 0 0.00 0 53447 47 0 0
sp_add_invoice_to_stock 4925 4821 104 2.11 45 214830 28765 0 104
sp_cancel_adding_invoice 5292 5292 0 0.00 5 94733 1394 0 0
sp_cancel_client_order 1650 1650 0 0.00 6 8506 484 0 0
sp_cancel_customer_reserve 515001 515001 0 0.00 1 44635 114 0 0
sp_cancel_pay_from_customer 651 651 0 0.00 4 4089 135 0 0
sp_cancel_pay_to_supplier 354 354 0 0.00 4 1407 122 0 0
sp_cancel_supplier_invoice 5844 5838 6 0.10 2 53506 1049 0 6
sp_cancel_supplier_order 388 388 0 0.00 15 1536552 191229 0 0
sp_cancel_write_off 10377 10377 0 0.00 2 43860 193 0 0
sp_client_order 19682 19682 0 0.00 5 44224 513 0 0
sp_customer_reserve 442722 442722 0 0.00 1 53454 273 0 0
sp_fill_shopping_cart 29953 29953 0 0.00 1 14545 91 0 0
sp_fill_shopping_cart_clo_res 442684 442684 0 0.00 0 20744 19 0 0
sp_get_clo_for_invoice 4772 4772 0 0.00 0 23217 337 0 0
sp_kill_cost_storno 16674 16674 0 0.00 0 43845 86 0 0
sp_kill_qstorno_ret_qs2qd 1046605 1046605 0 0.00 0 53432 50 0 0
sp_kill_qty_storno 552807 552807 0 0.00 0 53445 113 0 0
sp_lock_selected_doc 19720 19720 0 0.00 0 9634 10 0 0
sp_make_cost_storno 26474 26474 0 0.00 0 44088 90 0 0
sp_multiply_rows_for_pdistr 26472 26472 0 0.00 0 9551 45 0 0
sp_multiply_rows_for_qdistr 19681 19681 0 0.00 0 43965 192 0 0
sp_pay_from_customer 6607 6607 0 0.00 5 23513 206 0 0
sp_pay_to_supplier 5604 5604 0 0.00 6 11295 230 0 0
sp_payment_common 12211 12211 0 0.00 2 8319 51 0 0
sp_qd_handle_on_cancel_clo 1650 1650 0 0.00 0 8493 381 0 0
sp_qd_handle_on_invoice_upd_sts 10062 10062 0 0.00 0 19253 572 0 0
sp_qd_handle_on_reserve_upd_sts 9491 9491 0 0.00 0 14190 75 0 0
sp_reserve_write_off 9491 9491 0 0.00 8 14361 310 0 0
sp_supplier_invoice 5139 5139 0 0.00 10 80030 3428 0 0
sp_supplier_order 5143 5143 0 0.00 7 59107 1578 0 0
srv_aggregate_perf_data 116 116 0 0.00 2226 174246 13513 0 0
srv_fill_mon_cache_memory 72 72 0 0.00 763 103527 33736 0 0
srv_find_qd_qs_mism 993607 993607 0 0.00 0 24751 11 0 0
srv_make_invnt_saldo 440 440 0 0.00 51 104047 4573 0 0
srv_make_money_saldo 907 907 0 0.00 1 12449 409 0 0
srv_recalc_idx_stat 4 4 0 0.00 30487 444390 257249 0 0
t$perf-abend:sp_add_invoice_to_stock 104 104 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 6 6 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4825 4825 0 0.00 1 12617 1120 0 0
t$perf-norm:sp_cancel_adding_invoice 414 414 0 0.00 1 7511 507 0 0
t$perf-norm:sp_cancel_client_order 1650 1650 0 0.00 0 831 28 0 0
t$perf-norm:sp_cancel_customer_reserve 660 660 0 0.00 0 1380 28 0 0
t$perf-norm:sp_cancel_pay_from_customer 651 651 0 0.00 0 6139 21 0 0
t$perf-norm:sp_cancel_pay_to_supplier 354 354 0 0.00 0 188 12 0 0
t$perf-norm:sp_cancel_supplier_invoice 406 406 0 0.00 0 1471 39 0 0
t$perf-norm:sp_cancel_supplier_order 388 388 0 0.00 0 130635 7572 0 0
t$perf-norm:sp_cancel_write_off 941 941 0 0.00 0 1233 18 0 0
t$perf-norm:sp_client_order 19682 19682 0 0.00 0 4218 41 0 0
t$perf-norm:sp_customer_reserve 984 984 0 0.00 0 3324 19 0 0
t$perf-norm:sp_pay_from_customer 6607 6607 0 0.00 0 5804 21 0 0
t$perf-norm:sp_pay_to_supplier 5604 5604 0 0.00 0 4361 22 0 0
t$perf-norm:sp_reserve_write_off 9491 9491 0 0.00 0 4564 25 0 0
t$perf-norm:sp_supplier_invoice 5139 5139 0 0.00 0 5391 35 0 0
t$perf-norm:sp_supplier_order 5143 5143 0 0.00 0 4411 38 0 0
t$perf-norm:srv_aggregate_perf_data 116 116 0 0.00 0 590 20 0 0
t$perf-norm:srv_fill_mon_cache_memory 72 72 0 0.00 0 88 7 0 0
t$perf-norm:srv_make_invnt_saldo 440 440 0 0.00 0 1148 21 0 0
t$perf-norm:srv_make_money_saldo 907 907 0 0.00 0 3396 11 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 4 145 51 0 0
v_add_invoice_to_stock 9740 9532 208 2.13 0 10181 27 0 208
v_all_customers 35882 35882 0 0.00 0 176 4 0 0
v_all_suppliers 28920 28920 0 0.00 0 84 5 0 0
v_all_wares 39358 39358 0 0.00 0 71 4 0 0
v_cancel_adding_invoice 828 828 0 0.00 0 1576 17 0 0
v_cancel_client_order 3300 3300 0 0.00 0 6910 16 0 0
v_cancel_customer_prepayment 1302 1302 0 0.00 0 1906 13 0 0
v_cancel_customer_reserve 1320 1320 0 0.00 0 2443 12 0 0
v_cancel_payment_to_supplier 708 708 0 0.00 0 393 13 0 0
v_cancel_supplier_invoice 824 812 12 1.45 0 2462 28 0 12
v_cancel_supplier_order 776 776 0 0.00 0 605 14 0 0
v_cancel_write_off 1882 1882 0 0.00 0 1669 27 0 0
v_max_id_clo_ord 5139 5139 0 0.00 0 386 6 0 0
v_max_id_clo_res 984 984 0 0.00 0 934 11 0 0
v_max_id_ord_sup 5134 5134 0 0.00 0 7584 7 0 0
v_max_non_paid_invoice 1416 1416 0 0.00 0 209 9 0 0
v_max_non_paid_realizn 3396 3396 0 0.00 0 297 7 0 0
v_min_id_clo_ord 5139 5139 0 0.00 0 4074 10 0 0
v_min_id_clo_res 984 984 0 0.00 0 12757 28 0 0
v_min_id_ord_sup 5134 5134 0 0.00 0 9010 13 0 0
v_min_non_paid_invoice 5604 5604 0 0.00 0 7062 18 0 0
v_min_non_paid_realizn 6607 6607 0 0.00 0 7119 20 0 0
v_our_firm 9895 9895 0 0.00 0 80 5 0 0
v_reserve_write_off 18979 18979 0 0.00 0 6908 12 0 0
x_lock_depdocs_on_canc_invoice 10724 10724 0 0.00 0 16812 144 0 0
x_lock_depdocs_on_canc_sup_ord 388 388 0 0.00 0 31993 497 0 0
x_make_qstorno_1000_1200 5143 5143 0 0.00 2 58658 1392 0 0
x_make_qstorno_1200_2000 5139 5139 0 0.00 4 79968 3171 0 0
x_make_qstorno_2100_3300 442722 442722 0 0.00 0 53425 239 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 27-07-2022 10:38:13 to 27-07-2022 10:38:17.

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
08:07:23 1 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
08:08:24 8834 8192000000 9707114960 10001031168 786286128 8.757 100 89 178 0 815931680 7368848 22276704
08:09:37 19767 8192000000 9746158848 10049556480 821005760 9.109 100 90 180 0 853257376 10049328 22202288
08:11:01 18110 8192000000 9779542016 10093981696 850148512 9.402 100 88 172 0 886678720 15765200 20765008
08:12:27 11123 8192000000 9825191328 10153926656 896561120 9.864 100 74 148 0 938941040 25739696 16640224
08:13:46 5379 8192000000 9915455968 10255990784 944844368 10.341 100 86 165 1 1019684096 57095952 17743776
08:14:58 2772 8192000000 9951850784 10299772928 984142288 10.725 100 91 178 1 1067670736 65775568 17752880
08:16:04 1211 8192000000 9998199136 10358751232 1011488304 10.990 100 94 180 1 1116727600 87513808 17725488
08:17:08 1009 8192000000 10021305536 10390089728 1037746352 11.243 100 89 178 0 1148453632 92485424 18221856
08:18:11 1243 8192000000 10028335696 10404175872 1050645936 11.367 100 95 187 2 1143992896 75164176 18182784
08:19:13 1046 8192000000 10046835728 10422816768 1064235152 11.497 100 99 186 3 1167914688 84398336 19281200
08:20:17 4136 8192000000 10016634624 10389417984 1064669600 11.501 100 91 172 2 1134853472 54408464 15775408
08:21:22 1051 8192000000 10035755824 10416644096 1073602016 11.586 100 98 190 2 1160919488 67437408 19880064
08:22:25 903 8192000000 10030360944 10410106880 1078037856 11.629 100 92 182 2 1153536256 57653184 17845216
08:23:28 1918 8192000000 10046074192 10428755968 1081815152 11.665 100 92 172 1 1163719648 65001216 16903280
08:24:32 1157 8192000000 10078546048 10465660928 1087248528 11.716 100 92 175 0 1195834160 90408032 18177600
08:25:34 1089 8192000000 10096443600 10483994624 1091123104 11.753 100 93 179 3 1219081664 109182320 18776240
08:26:37 961 8192000000 10064601264 10455703552 1100727008 11.845 100 91 177 2 1186138880 67487392 17924480
08:27:39 874 8192000000 10039463568 10428698624 1099510416 11.833 100 87 162 1 1163255824 47335376 16410032
08:28:41 881 8192000000 10030760352 10418073600 1091424208 11.756 100 80 149 6 1154492720 47849520 15218992
08:29:43 1162 8192000000 10034966048 10425188352 1087643232 11.720 100 77 138 2 1156859792 53736288 15480272
08:30:46 3801 8192000000 10027914592 10424815616 1080988880 11.657 100 68 131 1 1149892848 56188384 12715584
08:31:57 1056 8192000000 10040474144 10424795136 1071134544 11.563 99 95 180 0 1167986976 77479424 19373008
08:32:59 1202 8192000000 10013591264 10388353024 1051460048 11.375 100 97 192 5 1137682720 66675152 19547520
08:34:02 791 8192000000 9979159648 10353471488 1029841232 11.167 100 89 166 0 1105867664 56292304 19734128
08:35:06 4165 8192000000 9997913744 10382303232 1042921408 11.293 99 80 154 1 1115624080 56747232 15955440
08:36:11 9408 8192000000 9978101984 10362687488 1032094032 11.189 100 47 87 0 1101041824 60473968 8473824
08:37:22 7583 8192000000 10018496880 10396835840 1057988704 11.437 100 79 148 1 1136933376 65362160 13582512
08:38:34 10550 8192000000 10029115296 10412806144 1073273264 11.583 100 72 133 0 1155575424 69144336 13157824
08:39:49 2726 8192000000 10062513792 10446200832 1086218208 11.707 100 83 159 0 1174177680 73422304 14537168
08:41:08 1019 8192000000 10091827408 10478379008 1105781872 11.892 100 92 168 1 1210304880 85967520 18555488
08:42:13 1010 8192000000 10091365808 10480394240 1118556656 12.013 100 96 177 1 1214456080 75486192 20413232
08:43:16 1388 8192000000 10139385584 10524803072 1123770544 12.063 100 94 178 2 1255388224 111885696 19731984
08:44:22 8895 8192000000 10154496992 10552147968 1135920672 12.177 100 66 124 3 1255555440 106634400 13000368
08:45:35 1203 8192000000 10206585120 10603167744 1151692224 12.325 100 95 187 0 1321410992 149708704 20010064
08:46:40 3163 8192000000 10221484576 10623860736 1152282528 12.331 100 68 136 1 1334946272 168005232 14658512
08:47:48 1512 8192000000 10256766816 10652438528 1159299616 12.397 100 83 165 1 1372229584 194802512 18127456
08:48:54 1590 8192000000 10318057360 10716798976 1174217200 12.536 100 90 174 1 1428087168 233506256 20363712
08:50:00 1610 8192000000 10346067840 10746171392 1176883984 12.561 100 87 165 2 1455148960 258100112 20164864
08:51:09 1449 8192000000 10353972400 10763108352 1179660320 12.587 100 89 175 1 1464081936 263955056 20466560
08:52:15 1533 8192000000 10383066832 10792316928 1185370592 12.640 100 92 184 2 1487033968 280535040 21128336
08:53:22 2655 8192000000 10363210768 10817548288 1188579600 12.670 100 93 178 0 1486500112 277145936 20774576
08:54:27 1279 8192000000 10379722864 10787143680 1190755040 12.690 100 93 181 1 1485227424 273539264 20933120
08:55:33 1449 8192000000 10399962480 10835296256 1195220928 12.732 100 95 187 2 1505467376 288172288 22074160
08:56:38 1730 8192000000 10412092928 10831814656 1196072016 12.740 100 95 183 0 1523748160 306640272 21035872
08:57:44 1344 8192000000 10436406224 10853265408 1196608672 12.745 100 100 196 0 1541248432 321809424 22830336
08:58:49 1114 8192000000 10451930624 10862075904 1198554592 12.763 100 98 188 2 1556797984 335946528 22296864
08:59:53 855 8192000000 10500106832 10907656192 1179453696 12.585 100 99 194 0 1602495520 399664384 23377440
09:00:57 772 8192000000 10542152272 10946699264 1194473696 12.725 100 99 195 1 1646236368 428286944 23475728
09:02:04 1086 8192000000 10558467904 11007705088 1194501872 12.725 100 95 178 0 1660858080 443968608 22387600
09:03:08 751 8192000000 10546337072 10957148160 1195441184 12.734 100 96 184 0 1646133168 428883008 21808976
09:04:12 2188 8192000000 10522734000 10970832896 1182298272 12.612 100 90 170 0 1629133616 426859152 19976192
09:05:18 1242 8192000000 10592105280 11023384576 1187709360 12.662 100 94 186 0 1693542128 483833504 21999264
09:06:23 11576 8192000000 10585583104 11027939328 1187253872 12.658 100 60 120 0 1684965408 482250880 15460656
09:07:40 8516 8192000000 10566475296 11035750400 1182251488 12.611 100 58 112 1 1660789200 463998592 14539120
09:08:56 24516 8192000000 10427882992 10905530368 1175096576 12.544 100 39 79 0 1561763328 376420432 10246320
09:10:30 18796 8192000000 10332793456 10818555904 1152429008 12.332 99 29 58 0 1468665776 308481920 7754848
09:11:55 19213 8192000000 10234926256 10719830016 1144567552 12.258 100 23 44 0 1336693088 186745296 5380240
09:13:17 81370 8192000000 10174588400 10613862400 1120443184 12.031 97 16 32 0 1250398848 126010880 3944784
09:15:39 103522 8192000000 10186442608 10623696896 1168990096 12.487 100 54 98 1 1280320864 100423920 10906848
09:18:26 16604 8192000000 10229216656 10677075968 1160950128 12.412 100 58 102 0 1326530896 154919264 10661504
09:19:46 25469 8192000000 10138314256 10668343296 1152110608 12.329 100 13 26 0 1244688624 89741888 2836128
09:23:02 80122 8192000000 10094708224 10576924672 1143695360 12.250 99 17 32 0 1191214496 44438176 3080960
09:25:30 79774 8192000000 10093232096 10566889472 1105534624 11.890 96 28 56 0 1163749392 51860688 6354080
09:27:50 97421 8192000000 10064034256 10575114240 1146285152 12.275 100 19 38 0 1188203904 37991920 3926832
09:30:32 68361 8192000000 10050806944 10521985024 1103454656 11.870 96 29 58 0 1147101824 37583776 6063392
09:32:42 8431 8192000000 10051058080 10494287872 1128116640 12.104 99 45 81 1 1155103312 18346944 8639728
09:34:05 56137 8192000000 10104072496 10551721984 1118011344 12.008 97 50 88 3 1209320752 81453440 9855968
09:36:02 45932 8192000000 10189830944 10643570688 1133590272 12.155 98 24 47 0 1257900672 119038432 5271968
09:37:48 60702 8192000000 10217204624 10723520512 1153493536 12.342 100 18 36 0 1330157088 172209840 4453712
09:39:50 65614 8192000000 10128877536 10621493248 1123449616 12.060 98 19 33 0 1294416672 167283808 3683248
09:42:27 86360 8192000000 10073451824 10534506496 1134561488 12.164 99 11 22 0 1187755904 51132896 2061520
09:44:55 8221 8192000000 10090681712 10526253056 1143676608 12.250 100 45 89 0 1188199120 34872880 9649632
09:46:04 38866 8192000000 10132167200 10602360832 1151555856 12.324 100 35 70 0 1225752752 67034560 7162336
09:47:43 64460 8192000000 10084694320 10529759232 1130193392 12.123 98 39 69 1 1176345008 38496128 7655488
09:49:50 8939 8192000000 10110227776 10541514752 1108645392 11.920 98 43 85 1 1183097104 66209328 8242384
09:51:02 29224 8192000000 10107136576 10549633024 1124330736 12.068 99 43 84 1 1188769632 55780240 8658656
09:52:32 49680 8192000000 10132449456 10567454720 1131615536 12.137 99 35 68 0 1205259376 66969664 6674176
09:54:22 82379 8192000000 10077883408 10509402112 1112924736 11.960 98 51 99 1 1154071904 30387312 10759856
09:57:00 42947 8192000000 10079164864 10506788864 1106233040 11.897 99 51 100 1 1159750752 42638656 10879056
09:58:44 73910 8192000000 10072357072 10563584000 1087989424 11.724 97 14 28 0 1173258272 82139776 3129072
10:01:00 57855 8192000000 10094707056 10571755520 1112123776 11.953 99 15 30 0 1200026064 84523616 3378672
10:03:42 59941 8192000000 10171489264 10621501440 1101288320 11.850 98 17 34 0 1247333776 141839840 4205616
10:05:51 50906 8192000000 10042761424 10474840064 1049053200 11.352 94 31 60 1 1086429024 30666112 6709712
10:07:44 69864 8192000000 10064473984 10496077824 1074022192 11.590 96 16 26 1 1108030176 31540768 2467216
10:09:57 55353 8192000000 10119257216 10580709376 1122009936 12.046 99 28 54 0 1217102304 89271952 5820416
10:11:58 30459 8192000000 10097802560 10536165376 1104244320 11.878 98 22 41 1 1183079808 74379536 4455952
10:13:32 41354 8192000000 10110695632 10570838016 1114742736 11.977 99 40 78 0 1192774112 69685488 8345888
10:15:17 81962 8192000000 10109929168 10562736128 1100180896 11.839 97 26 50 0 1159044880 54010240 4853744
10:17:43 101019 8192000000 10079584432 10549952512 1137251120 12.190 100 26 52 1 1231971312 89370432 5349760
10:20:54 52536 8192000000 10097636384 10565283840 1149950336 12.309 100 20 40 0 1200556864 46105296 4501232
10:22:59 56153 8192000000 10100726768 10561740800 1123463952 12.060 98 25 47 1 1194379312 65873936 5041424
10:25:16 69053 8192000000 10138448816 10615349248 1140488720 12.220 99 13 26 0 1238692656 95216944 2986992
10:27:32 94668 8192000000 10137236512 10582351872 1125568720 12.080 98 14 28 0 1199874208 71063152 3242336
10:30:07 43272 8192000000 10116499536 10570059776 1089176976 11.735 95 15 30 0 1161533056 68648528 3707552
10:31:51 15511 8192000000 10151503344 10588409856 1131960880 12.140 99 47 90 2 1230003328 88033264 10009184
10:33:13 35349 8192000000 10166832032 10642092032 1125415552 12.078 98 32 63 1 1260861408 128693200 6752656
10:34:53 28422 8192000000 10160240800 10623885312 1135147280 12.170 100 36 66 0 1254663984 113473712 6042992
10:36:25 65912 8192000000 9054134976 9345126400 175736272 2.100 16 7 14 0 184322384 7533040 1053072

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 27-07-2022 10:38:19 to 27-07-2022 10:38:35.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 104 v_add_invoice_to_stock 335544517
except 6 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 27-07-2022 10:38:36 to 27-07-2022 10:38:38.

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          212666
MON$OLDEST_ACTIVE               212667
MON$OLDEST_SNAPSHOT             212667
MON$NEXT_TRANSACTION            212667
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                       2075104
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             761
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2811 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2811 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2811 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2811 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'

27.07.22 10:38:39. 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-07-27 10:38:42 No severe PSQL-related problems occured
27.07.22 10:38:43. End of report.