Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 24.12.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 14919548 kB
MemAvailable 30061536 kB
Buffers 0 kB
Cached 16756920 kB
SwapCached 3192 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 2022-12-24 10:37:24
DTS_END                         2022-12-24 10:37:24.1660
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/43476
TRN_ID                          221412
ATT_ID                          579
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: 8571.75 18704 1028610
customer order: creation 171.19 462 20543
customer order: refuse 14.38 399 1726
order to supplier: creation 46.53 1411 5583
order to supplier: removal 3.38 144838 405
invoice (draft): creation 45.43 3177 5452
invoice (draft): removal 46.73 931 5607
invoice accept: apply 41.28 26103 4953
invoice accept: cancel 42.74 1272 5129
customer reserve: creation 3758.93 252 451071
customer reserve: removal 4105.28 95 492634
realization accept: apply 83.04 273 9965
realization accept: cancel 86.73 158 10408
payment from customer: creation 58.39 177 7007
payment from customer: removal 5.31 129 637
payment to supplier: creation 47.20 203 5664
payment to supplier: removal 3.25 103 390
service: total inventory turnovers 3.95 4048 474
service: total monetary turnovers 7.07 406 848
service: aggregate perf. data 0.92 14958 110
service: refresh index statistics 0.03 174685 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 24-12-2022 10:38:18 to 24-12-2022 10:38:20.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5996
TEST_TIME 2 5880
TEST_TIME 3 5869
TEST_TIME 4 6626
TEST_TIME 5 6337
TEST_TIME 6 6520
TEST_TIME 7 6444
TEST_TIME 8 6738
TEST_TIME 9 6751
TEST_TIME 10 7215
TEST_TIME 11 7224
TEST_TIME 12 7731
TEST_TIME 13 7705
TEST_TIME 14 7749
TEST_TIME 15 7834
TEST_TIME 16 7821
TEST_TIME 17 7810
TEST_TIME 18 7926
TEST_TIME 19 7978
TEST_TIME 20 8041
TEST_TIME 21 8139
TEST_TIME 22 8301
TEST_TIME 23 8602
TEST_TIME 24 9065
TEST_TIME 25 9249
TEST_TIME 26 9182
TEST_TIME 27 9616
TEST_TIME 28 9825
TEST_TIME 29 10016
TEST_TIME 30 10640
TEST_TIME 31 10590
TEST_TIME 32 10829
TEST_TIME 33 10634
TEST_TIME 34 10392
TEST_TIME 35 10426
TEST_TIME 36 10201
TEST_TIME 37 10248
TEST_TIME 38 10224
TEST_TIME 39 10087
TEST_TIME 40 9909
TEST_TIME 41 9862
TEST_TIME 42 9718
TEST_TIME 43 9707
TEST_TIME 44 9654
TEST_TIME 45 9544
TEST_TIME 46 9554
TEST_TIME 47 9408
TEST_TIME 48 9485
TEST_TIME 49 9395
TEST_TIME 50 9355
TEST_TIME 51 9176
TEST_TIME 52 9218
TEST_TIME 53 9272
TEST_TIME 54 9167
TEST_TIME 55 9100
TEST_TIME 56 9089
TEST_TIME 57 9053
TEST_TIME 58 8963
TEST_TIME 59 8898
TEST_TIME 60 8785
TEST_TIME 61 8719
TEST_TIME 62 8754
TEST_TIME 63 8737
TEST_TIME 64 8712
TEST_TIME 65 8655
TEST_TIME 66 8747
TEST_TIME 67 8723
TEST_TIME 68 8731
TEST_TIME 69 8728
TEST_TIME 70 8848
TEST_TIME 71 8817
TEST_TIME 72 8772
TEST_TIME 73 8770
TEST_TIME 74 8830
TEST_TIME 75 8934
TEST_TIME 76 8994
TEST_TIME 77 8888
TEST_TIME 78 8803
TEST_TIME 79 8813
TEST_TIME 80 8781
TEST_TIME 81 8800
TEST_TIME 82 8751
TEST_TIME 83 8721
TEST_TIME 84 8660
TEST_TIME 85 8666
TEST_TIME 86 8614
TEST_TIME 87 8620
TEST_TIME 88 8609
TEST_TIME 89 8638
TEST_TIME 90 8604
TEST_TIME 91 8616
TEST_TIME 92 8598
TEST_TIME 93 8657
TEST_TIME 94 8665
TEST_TIME 95 8680
TEST_TIME 96 8716
TEST_TIME 97 8770
TEST_TIME 98 8753
TEST_TIME 99 8777
TEST_TIME 100 8738
TEST_TIME 101 8818
TEST_TIME 102 8734
TEST_TIME 103 8684
TEST_TIME 104 8636
TEST_TIME 105 8658
TEST_TIME 106 8609
TEST_TIME 107 8599
TEST_TIME 108 8557
TEST_TIME 109 8516
TEST_TIME 110 8493
TEST_TIME 111 8496
TEST_TIME 112 8482
TEST_TIME 113 8486
TEST_TIME 114 8460
TEST_TIME 115 8501
TEST_TIME 116 8544
TEST_TIME 117 8565
TEST_TIME 118 8533
TEST_TIME 119 8611
TEST_TIME 120 8591

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 24-12-2022 10:38:22 to 24-12-2022 10:38:25.

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 1444907 1444907 0 0.00 0 30168 14 0 0
doc_list_biud 1444888 1444888 0 0.00 0 32989 38 0 0
sp_add_invoice_to_stock 5093 4953 140 2.74 54 192416 26103 0 140
sp_cancel_adding_invoice 5129 5129 0 0.00 5 84533 1272 0 0
sp_cancel_client_order 1726 1726 0 0.00 6 6454 400 0 0
sp_cancel_customer_reserve 492634 492634 0 0.00 1 32991 95 0 0
sp_cancel_pay_from_customer 637 637 0 0.00 4 4894 130 0 0
sp_cancel_pay_to_supplier 390 390 0 0.00 4 1432 103 0 0
sp_cancel_supplier_invoice 5622 5607 15 0.26 2 15978 932 0 15
sp_cancel_supplier_order 405 405 0 0.00 13 1385737 144839 0 0
sp_cancel_write_off 10408 10408 0 0.00 2 8733 159 0 0
sp_client_order 20543 20543 0 0.00 6 14881 462 0 0
sp_customer_reserve 451071 451071 0 0.00 0 45245 252 0 0
sp_fill_shopping_cart 31572 31572 0 0.00 1 13721 94 0 0
sp_fill_shopping_cart_clo_res 451044 451044 0 0.00 0 21039 19 0 0
sp_get_clo_for_invoice 4919 4919 0 0.00 0 35103 375 0 0
sp_kill_cost_storno 16564 16564 0 0.00 0 30155 68 0 0
sp_kill_qstorno_ret_qs2qd 1001688 1001688 0 0.00 0 32978 42 0 0
sp_kill_qty_storno 530793 530793 0 0.00 0 32989 96 0 0
sp_lock_selected_doc 20466 20466 0 0.00 0 7028 8 0 0
sp_make_cost_storno 27555 27555 0 0.00 0 23666 79 0 0
sp_multiply_rows_for_pdistr 27555 27555 0 0.00 0 9393 39 0 0
sp_multiply_rows_for_qdistr 20543 20543 0 0.00 0 12206 171 0 0
sp_pay_from_customer 7007 7007 0 0.00 6 15534 178 0 0
sp_pay_to_supplier 5664 5664 0 0.00 6 23673 204 0 0
sp_payment_common 12669 12669 0 0.00 2 15337 47 0 0
sp_qd_handle_on_cancel_clo 1726 1726 0 0.00 0 6444 320 0 0
sp_qd_handle_on_invoice_upd_sts 10048 10048 0 0.00 0 21275 492 0 0
sp_qd_handle_on_reserve_upd_sts 9965 9965 0 0.00 0 17271 58 0 0
sp_reserve_write_off 9965 9965 0 0.00 9 17570 274 0 0
sp_supplier_invoice 5452 5452 0 0.00 9 111467 3178 0 0
sp_supplier_order 5583 5583 0 0.00 7 29051 1412 0 0
srv_aggregate_perf_data 110 110 0 0.00 2420 160960 14958 0 0
srv_fill_mon_cache_memory 70 70 0 0.00 788 138226 36919 0 0
srv_find_qd_qs_mism 981007 981007 0 0.00 0 12740 11 0 0
srv_make_invnt_saldo 474 474 0 0.00 51 98833 4048 0 0
srv_make_money_saldo 848 848 0 0.00 1 15377 406 0 0
srv_recalc_idx_stat 4 4 0 0.00 49195 350066 174685 0 0
t$perf-abend:sp_add_invoice_to_stock 140 140 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 15 15 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4955 4955 0 0.00 1 20987 944 0 0
t$perf-norm:sp_cancel_adding_invoice 421 421 0 0.00 1 6201 492 0 0
t$perf-norm:sp_cancel_client_order 1726 1726 0 0.00 0 1483 24 0 0
t$perf-norm:sp_cancel_customer_reserve 646 646 0 0.00 0 2949 29 0 0
t$perf-norm:sp_cancel_pay_from_customer 637 637 0 0.00 0 3848 18 0 0
t$perf-norm:sp_cancel_pay_to_supplier 390 390 0 0.00 0 2142 16 0 0
t$perf-norm:sp_cancel_supplier_invoice 376 376 0 0.00 0 759 33 0 0
t$perf-norm:sp_cancel_supplier_order 405 405 0 0.00 1 112607 5905 0 0
t$perf-norm:sp_cancel_write_off 983 983 0 0.00 0 558 16 0 0
t$perf-norm:sp_client_order 20543 20543 0 0.00 0 15298 35 0 0
t$perf-norm:sp_customer_reserve 988 988 0 0.00 0 1181 15 0 0
t$perf-norm:sp_pay_from_customer 7007 7007 0 0.00 0 8664 21 0 0
t$perf-norm:sp_pay_to_supplier 5664 5664 0 0.00 0 11370 26 0 0
t$perf-norm:sp_reserve_write_off 9965 9965 0 0.00 0 14491 23 0 0
t$perf-norm:sp_supplier_invoice 5452 5452 0 0.00 0 13762 34 0 0
t$perf-norm:sp_supplier_order 5583 5583 0 0.00 0 5170 32 0 0
t$perf-norm:srv_aggregate_perf_data 110 110 0 0.00 0 608 25 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 390 11 0 0
t$perf-norm:srv_make_invnt_saldo 474 474 0 0.00 0 594 8 0 0
t$perf-norm:srv_make_money_saldo 848 848 0 0.00 0 1189 7 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 164 50 0 0
v_add_invoice_to_stock 10114 9834 280 2.76 0 11977 30 0 280
v_all_customers 37720 37720 0 0.00 0 150 4 0 0
v_all_suppliers 29938 29938 0 0.00 0 72 4 0 0
v_all_wares 41084 41084 0 0.00 0 125 4 0 0
v_cancel_adding_invoice 842 842 0 0.00 0 1246 16 0 0
v_cancel_client_order 3452 3452 0 0.00 0 4873 13 0 0
v_cancel_customer_prepayment 1274 1274 0 0.00 0 4820 17 0 0
v_cancel_customer_reserve 1292 1292 0 0.00 0 8977 17 0 0
v_cancel_payment_to_supplier 780 780 0 0.00 0 1350 13 0 0
v_cancel_supplier_invoice 782 752 30 3.83 0 9187 49 0 30
v_cancel_supplier_order 810 810 0 0.00 0 1472 15 0 0
v_cancel_write_off 1966 1966 0 0.00 0 6564 34 0 0
v_max_id_clo_ord 5583 5583 0 0.00 0 1729 5 0 0
v_max_id_clo_res 988 988 0 0.00 0 1676 15 0 0
v_max_id_ord_sup 5445 5445 0 0.00 0 5945 9 0 0
v_max_non_paid_invoice 1723 1723 0 0.00 0 592 7 0 0
v_max_non_paid_realizn 3523 3523 0 0.00 0 6354 9 0 0
v_min_id_clo_ord 5583 5583 0 0.00 0 2441 9 0 0
v_min_id_clo_res 988 988 0 0.00 0 5572 24 0 0
v_min_id_ord_sup 5445 5445 0 0.00 0 7786 14 0 0
v_min_non_paid_invoice 5664 5664 0 0.00 0 7776 17 0 0
v_min_non_paid_realizn 7005 7005 0 0.00 0 8973 18 0 0
v_our_firm 10328 10328 0 0.00 0 197 5 0 0
v_reserve_write_off 19930 19930 0 0.00 0 8825 13 0 0
x_lock_depdocs_on_canc_invoice 10360 10360 0 0.00 0 18211 130 0 0
x_lock_depdocs_on_canc_sup_ord 405 405 0 0.00 0 19052 438 0 0
x_make_qstorno_1000_1200 5583 5583 0 0.00 3 28997 1240 0 0
x_make_qstorno_1200_2000 5452 5452 0 0.00 4 108842 2893 0 0
x_make_qstorno_2100_3300 451069 451069 0 0.00 0 45243 221 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 24-12-2022 10:38:26 to 24-12-2022 10:38:30.

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:28 2 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
08:08:29 26520 8192000000 9721687232 10021122048 797495744 8.871 100 86 171 0 826256176 7374576 21385856
08:10:00 18543 8192000000 9762363040 10070183936 833988960 9.239 100 87 172 0 866672896 11979072 20704864
08:11:21 11523 8192000000 9811772880 10132123648 870292864 9.603 100 83 166 0 917482768 28176960 19012944
08:12:37 6818 8192000000 9853511760 10189942784 917120432 10.068 100 83 157 0 968958720 33573264 18265024
08:13:45 4014 8192000000 9907912960 10251616256 957316112 10.463 100 84 165 0 1025601168 51489728 16795328
08:14:52 1813 8192000000 9977088496 10325864448 990560144 10.787 100 91 179 0 1086550384 77818224 18172016
08:15:56 889 8192000000 9994396704 10357993472 1011826976 10.993 100 95 184 0 1114093776 84494560 17772240
08:16:59 2196 8192000000 9996017328 10363416576 1031079072 11.179 100 85 158 4 1113030928 66217360 15734496
08:18:03 1174 8192000000 10020991760 10396958720 1054596464 11.405 100 95 184 1 1142812416 69417648 18798304
08:19:05 1103 8192000000 10019973920 10398732288 1060093152 11.457 100 96 182 1 1141934960 63268384 18573424
08:20:07 971 8192000000 10023671328 10406121472 1069059136 11.543 100 93 177 1 1146658224 59840992 17758096
08:21:09 837 8192000000 10034225776 10415501312 1073944672 11.590 100 93 184 1 1155984496 63466752 18573072
08:22:10 7653 8192000000 10021314512 10410491904 1077211968 11.621 100 76 142 0 1149263136 58034912 14016256
08:23:21 883 8192000000 10054372416 10444152832 1083504192 11.681 100 84 158 1 1176154992 76846656 15804144
08:24:23 950 8192000000 10052143808 10437308416 1086913440 11.713 100 90 174 0 1170267424 65883040 17470944
08:25:24 962 8192000000 10053881760 10442256384 1089681040 11.740 100 93 176 1 1168326560 60549808 18095712
08:26:26 859 8192000000 10074674880 10466041856 1093234160 11.773 100 96 186 0 1185207568 72845328 19128080
08:27:31 949 8192000000 10076446592 10471444480 1099085376 11.829 100 93 178 1 1199984720 81843504 19055840
08:28:33 1096 8192000000 10024521568 10407174144 1080871392 11.656 100 95 180 0 1147250464 47425904 18953168
08:29:35 1037 8192000000 10061522176 10451689472 1089685472 11.740 100 94 182 2 1185838816 77738576 18414768
08:30:37 1122 8192000000 10034022576 10414878720 1071432192 11.566 100 94 172 2 1152971184 64538368 17000624
08:31:40 1165 8192000000 10042411520 10420424704 1058917168 11.446 100 97 185 1 1164725824 87257424 18551232
08:32:42 1258 8192000000 9984305312 10360623104 1036458320 11.231 100 83 154 3 1106858272 53993136 16406816
08:33:44 1175 8192000000 10004254128 10381160448 1042922784 11.293 100 90 171 2 1124758656 64862336 16973536
08:34:46 1710 8192000000 10025113136 10408534016 1052867488 11.388 100 78 150 4 1140805952 72726240 15212224
08:35:48 995 8192000000 9978898192 10353524736 1030569008 11.174 99 88 171 0 1101729440 53505232 17655200
08:36:52 1037 8192000000 10006228720 10387951616 1049938304 11.360 100 94 179 3 1127458896 59223536 18297056
08:38:00 26224 8192000000 10001532832 10386518016 1069780688 11.550 100 59 108 3 1138948048 58742208 10425152
08:39:32 2425 8192000000 10074422000 10454056960 1087751616 11.721 100 97 186 0 1193723632 87546192 18425824
08:40:42 9960 8192000000 10079137696 10474319872 1101996032 11.857 100 67 126 1 1197745520 83110528 12638960
08:41:58 1776 8192000000 10105422992 10504028160 1120717152 12.034 100 69 129 0 1228001952 94274704 13010096
08:43:03 14408 8192000000 10171993088 10579890176 1129705440 12.119 100 75 143 1 1293403312 148684240 15013632
08:44:29 6888 8192000000 10188787712 10586566656 1138441600 12.201 100 86 158 0 1293724768 139198752 16084416
08:45:41 2726 8192000000 10183674144 10582003712 1149627296 12.306 100 81 156 0 1298483632 131823808 17032528
08:46:47 3273 8192000000 10212288528 10626289664 1157060672 12.376 100 88 167 3 1329403632 154126880 18216080
08:47:57 3079 8192000000 10234774736 10635460608 1157586416 12.381 100 88 163 6 1349282336 174314080 17381840
08:49:01 1395 8192000000 10273776544 10698731520 1163151552 12.433 100 95 186 1 1389088640 204722880 21214208
08:50:06 1088 8192000000 10281772464 10691514368 1168178976 12.480 100 93 180 2 1393082368 203340272 21563120
08:51:13 1489 8192000000 10279568832 10692014080 1167861184 12.477 99 95 189 0 1393268736 202974512 22433040
08:52:20 1439 8192000000 10318981248 10735235072 1183244256 12.620 100 91 177 0 1432157616 228323232 20590128
08:53:24 1740 8192000000 10369937808 10778423296 1182852944 12.617 100 91 182 0 1474391264 270590096 20948224
08:54:29 976 8192000000 10370815360 10778439680 1175577616 12.549 99 94 184 3 1480830816 282225616 23027584
08:55:34 1156 8192000000 10388167488 10810912768 1173596160 12.530 100 92 179 1 1496158912 301754608 20808144
08:56:37 1299 8192000000 10443321472 10846822400 1177306176 12.565 100 98 189 0 1549610016 350481280 21822560
08:57:41 810 8192000000 10483051968 10904207360 1181993248 12.609 100 94 180 0 1587053472 382521360 22538864
08:58:44 782 8192000000 10489546176 10912239616 1178738320 12.578 100 85 169 2 1596634624 397739200 20157104
08:59:47 904 8192000000 10473257792 10920833024 1168125680 12.479 100 95 187 1 1578433584 388459904 21848000
09:00:50 867 8192000000 10473063792 10911592448 1165871152 12.458 100 94 185 0 1584078976 394843296 23364528
09:01:53 13849 8192000000 10405327616 10858782720 1154784560 12.354 99 34 67 0 1495394256 332151456 8458240
09:03:16 17303 8192000000 10369405584 10833973248 1140979664 12.225 98 33 66 0 1477771136 328822496 7968976
09:04:41 13375 8192000000 10339054512 10785583104 1151179424 12.321 100 35 67 0 1456483392 296783520 8520448
09:05:57 15393 8192000000 10294771328 10725367808 1141253856 12.227 100 40 78 0 1400993616 250647424 9092336
09:07:13 54763 8192000000 10174687680 10640166912 1145067616 12.263 100 19 38 0 1349392240 199894400 4430224
09:09:09 1116 8192000000 10130808928 10571759616 1152902208 12.337 100 71 136 1 1233197712 65042064 15253440
09:10:11 87296 8192000000 10168623088 10609348608 1138752032 12.204 98 32 59 1 1247671552 101584048 7335472
09:12:39 51863 8192000000 10144577168 10581504000 1121288368 12.039 98 11 21 0 1234253904 110850272 2115264
09:14:39 56999 8192000000 10066177200 10524708864 1137544096 12.192 100 26 46 2 1218246576 75474176 5228304
09:16:41 73296 8192000000 10105478880 10543452160 1142605536 12.240 99 43 77 0 1193712128 43416064 7690528
09:19:17 77252 8192000000 10144077024 10606637056 1135114944 12.170 98 24 47 0 1223749776 83561520 5073312
09:21:34 131315 8192000000 10118068192 10595471360 1067265808 11.526 92 16 31 0 1133863792 63172832 3425152
09:24:47 30322 8192000000 10123757168 10609860608 1131053408 12.131 100 7 14 0 1220086848 87382432 1651008
09:26:18 74962 8192000000 10118689376 10577657856 1147145488 12.283 100 26 52 0 1206925360 54439008 5340864
09:29:36 78055 8192000000 10095093392 10617815040 1141390048 12.229 100 21 42 0 1198419776 52706528 4323200
09:32:08 48794 8192000000 10099258448 10546806784 1124395120 12.068 98 20 40 0 1164849296 35726896 4727280
09:34:02 34688 8192000000 10094421936 10542895104 1132139936 12.142 99 46 88 0 1174940368 32931392 9869040
09:35:44 76352 8192000000 10079475776 10550075392 1126129392 12.085 98 21 42 0 1178450784 47334320 4987072
09:38:15 45374 8192000000 10096115264 10575446016 1136663424 12.184 99 11 22 1 1207942000 69387120 1891456
09:40:03 43420 8192000000 10104946752 10567032832 1144609728 12.259 99 34 66 0 1183228720 31662032 6956960
09:41:55 50005 8192000000 10110568096 10559377408 1100480496 11.842 96 19 38 0 1181429200 77014544 3934160
09:43:49 20330 8192000000 10088496064 10522341376 1117196464 12.000 98 46 90 1 1182977776 56120160 9661152
09:45:16 20577 8192000000 10165915280 10606956544 1144344656 12.256 100 39 78 0 1247279216 94056592 8877968
09:46:39 52862 8192000000 10124163632 10613481472 1136846320 12.186 99 42 84 1 1245765936 100450608 8469008
09:48:35 11343 8192000000 10101240752 10531147776 1117354624 12.002 98 37 74 0 1184208784 58996480 7857680
09:49:52 44482 8192000000 10179719440 10624122880 1128002656 12.103 98 52 102 1 1251670688 113407600 10260432
09:51:38 48496 8192000000 10147254800 10626207744 1113008464 11.961 98 17 33 0 1248892480 132169952 3714064
09:53:34 110801 8192000000 10068242784 10512637952 1117265952 12.001 99 19 38 0 1156853312 35613440 3973920
09:56:27 26371 8192000000 10067975920 10537267200 1115260448 11.982 99 37 69 0 1178723200 56661120 6801632
09:57:55 50332 8192000000 10067495152 10539720704 1121655456 12.043 99 42 84 1 1196517216 66322320 8539440
09:59:46 61237 8192000000 10062479520 10537820160 1129589696 12.117 100 11 22 0 1181930112 50086256 2254160
10:01:48 74717 8192000000 10055484416 10542759936 1118267024 12.011 99 10 20 0 1181309440 61029104 2013312
10:04:04 84529 8192000000 10033539760 10464718848 1065721248 11.511 95 28 57 0 1101394752 29255248 6418256
10:06:37 58728 8192000000 10072105680 10511822848 1112125584 11.953 99 21 42 0 1151219456 34980656 4113216
10:08:41 43781 8192000000 10115570480 10554699776 1124363392 12.068 99 37 74 0 1194330352 62357872 7609088
10:10:32 66867 8192000000 10123780384 10572292096 1110080432 11.933 98 32 63 0 1162287568 45489776 6717360
10:12:41 51021 8192000000 10128232016 10569568256 1113518256 11.966 98 18 35 0 1204610608 86656288 4436064
10:14:34 138225 8192000000 10083215856 10557812736 1106143648 11.896 97 12 24 0 1150072720 41610928 2318144
10:18:02 74292 8192000000 10068315808 10585010176 1086077584 11.705 96 16 32 0 1171134608 81975248 3081776
10:20:17 71596 8192000000 10074834336 10501849088 1098534416 11.824 97 48 93 0 1140522544 32572912 9415216
10:22:41 44323 8192000000 10063163744 10525589504 1130989824 12.131 100 10 20 0 1175656112 42577616 2088672
10:25:20 48458 8192000000 10062369280 10517786624 1124193232 12.067 99 6 12 0 1150904080 25567168 1143680
10:27:39 52800 8192000000 10105399936 10557861888 1136721568 12.185 99 19 37 0 1192194512 51258544 4214400
10:29:37 9177 8192000000 10133100512 10561286144 1142121440 12.235 100 54 101 0 1221808544 68636672 11050432
10:30:47 24687 8192000000 10155511840 10603474944 1138892384 12.205 99 35 70 0 1242818800 96147568 7778848
10:32:14 36298 8192000000 10170066384 10626576384 1122021328 12.046 98 28 56 0 1242726592 114521568 6183696
10:33:53 37389 8192000000 10120463904 10561003520 1120787984 12.034 98 12 24 0 1212158336 88663024 2707328
10:35:31 14758 8192000000 10156597136 10589556736 1128558592 12.108 99 33 66 0 1250285744 114225024 7502128
10:36:46 44946 8192000000 9297247936 9620180992 416476656 4.837 37 11 22 0 458792608 39970032 2345920

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 24-12-2022 10:38:32 to 24-12-2022 10:38:48.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 140 v_add_invoice_to_stock 335544517
except 15 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 24-12-2022 10:38:49 to 24-12-2022 10:38:51.

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          220914
MON$OLDEST_ACTIVE               221662
MON$OLDEST_SNAPSHOT             221662
MON$NEXT_TRANSACTION            221662
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                       2045792
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             776
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2885 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2885 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2885 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2885 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 ---
:419: 
:420: mscs-test-161.budzdorov.ru    Sat Dec 24 10:37:38 2022
:421:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:422: 
:423: 
:424: mscs-test-161.budzdorov.ru    Sat Dec 24 10:37:38 2022
:425:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:426: 
--- end of diff output ---

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

24.12.22 10:38:52. 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-12-24 10:38:55 No severe PSQL-related problems occured
24.12.22 10:38:56. End of report.