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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15284772 kB
MemAvailable 30379424 kB
Buffers 0 kB
Cached 16405896 kB
SwapCached 4156 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-01-14 10:37:25
DTS_END                         2023-01-14 10:37:25.8070
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/55794
TRN_ID                          211361
ATT_ID                          614
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: 8562.66 27618 1027519
customer order: creation 156.96 511 18835
customer order: refuse 13.29 382 1595
order to supplier: creation 41.26 1358 4951
order to supplier: removal 3.19 175485 383
invoice (draft): creation 40.03 3268 4804
invoice (draft): removal 49.58 978 5950
invoice accept: apply 37.51 28181 4501
invoice accept: cancel 44.54 1085 5345
customer reserve: creation 3558.28 264 426993
customer reserve: removal 4342.51 102 521101
realization accept: apply 75.83 258 9100
realization accept: cancel 82.78 155 9933
payment from customer: creation 54.18 179 6502
payment from customer: removal 4.83 110 579
payment to supplier: creation 43.76 196 5251
payment to supplier: removal 2.93 89 352
service: total inventory turnovers 3.89 3684 467
service: total monetary turnovers 6.43 399 772
service: aggregate perf. data 0.84 16195 101
service: refresh index statistics 0.03 319488 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 14-01-2023 10:38:28 to 14-01-2023 10:38:31.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7450
TEST_TIME 2 6374
TEST_TIME 3 6852
TEST_TIME 4 6390
TEST_TIME 5 6991
TEST_TIME 6 6762
TEST_TIME 7 6921
TEST_TIME 8 6607
TEST_TIME 9 6672
TEST_TIME 10 6514
TEST_TIME 11 6385
TEST_TIME 12 6425
TEST_TIME 13 6398
TEST_TIME 14 6456
TEST_TIME 15 6631
TEST_TIME 16 6840
TEST_TIME 17 6877
TEST_TIME 18 6930
TEST_TIME 19 7043
TEST_TIME 20 7071
TEST_TIME 21 7319
TEST_TIME 22 7337
TEST_TIME 23 8022
TEST_TIME 24 8445
TEST_TIME 25 8734
TEST_TIME 26 8740
TEST_TIME 27 8931
TEST_TIME 28 9357
TEST_TIME 29 9997
TEST_TIME 30 10461
TEST_TIME 31 10859
TEST_TIME 32 10551
TEST_TIME 33 10472
TEST_TIME 34 10340
TEST_TIME 35 10198
TEST_TIME 36 10028
TEST_TIME 37 9937
TEST_TIME 38 9842
TEST_TIME 39 9803
TEST_TIME 40 9768
TEST_TIME 41 9753
TEST_TIME 42 9603
TEST_TIME 43 9503
TEST_TIME 44 9396
TEST_TIME 45 9478
TEST_TIME 46 9348
TEST_TIME 47 9310
TEST_TIME 48 9195
TEST_TIME 49 9180
TEST_TIME 50 9019
TEST_TIME 51 9006
TEST_TIME 52 8933
TEST_TIME 53 8852
TEST_TIME 54 8864
TEST_TIME 55 8817
TEST_TIME 56 8875
TEST_TIME 57 8815
TEST_TIME 58 8811
TEST_TIME 59 8753
TEST_TIME 60 8828
TEST_TIME 61 8847
TEST_TIME 62 8903
TEST_TIME 63 9019
TEST_TIME 64 9035
TEST_TIME 65 9049
TEST_TIME 66 9023
TEST_TIME 67 9140
TEST_TIME 68 9050
TEST_TIME 69 8931
TEST_TIME 70 8891
TEST_TIME 71 8995
TEST_TIME 72 8952
TEST_TIME 73 8916
TEST_TIME 74 8872
TEST_TIME 75 8831
TEST_TIME 76 8807
TEST_TIME 77 8793
TEST_TIME 78 8757
TEST_TIME 79 8767
TEST_TIME 80 8725
TEST_TIME 81 8758
TEST_TIME 82 8779
TEST_TIME 83 8728
TEST_TIME 84 8844
TEST_TIME 85 8942
TEST_TIME 86 8981
TEST_TIME 87 8910
TEST_TIME 88 8901
TEST_TIME 89 8858
TEST_TIME 90 8770
TEST_TIME 91 8718
TEST_TIME 92 8732
TEST_TIME 93 8704
TEST_TIME 94 8677
TEST_TIME 95 8662
TEST_TIME 96 8634
TEST_TIME 97 8621
TEST_TIME 98 8602
TEST_TIME 99 8621
TEST_TIME 100 8630
TEST_TIME 101 8739
TEST_TIME 102 8695
TEST_TIME 103 8744
TEST_TIME 104 8735
TEST_TIME 105 8849
TEST_TIME 106 8850
TEST_TIME 107 8807
TEST_TIME 108 8833
TEST_TIME 109 8782
TEST_TIME 110 8748
TEST_TIME 111 8699
TEST_TIME 112 8676
TEST_TIME 113 8622
TEST_TIME 114 8642
TEST_TIME 115 8618
TEST_TIME 116 8586
TEST_TIME 117 8585
TEST_TIME 118 8590
TEST_TIME 119 8630
TEST_TIME 120 8586

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 14-01-2023 10:38:32 to 14-01-2023 10:38:35.

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 1421088 1421088 0 0.00 0 18930 13 0 0
doc_list_biud 1421065 1421065 0 0.00 0 60329 43 0 0
sp_add_invoice_to_stock 4640 4501 139 2.99 57 263576 28182 0 139
sp_cancel_adding_invoice 5345 5345 0 0.00 6 69500 1086 0 0
sp_cancel_client_order 1595 1595 0 0.00 6 10823 382 0 0
sp_cancel_customer_reserve 521101 521101 0 0.00 1 25280 102 0 0
sp_cancel_pay_from_customer 579 579 0 0.00 3 3080 110 0 0
sp_cancel_pay_to_supplier 352 352 0 0.00 4 1230 90 0 0
sp_cancel_supplier_invoice 5964 5950 14 0.23 3 60339 978 0 14
sp_cancel_supplier_order 383 383 0 0.00 11 1293244 175486 0 0
sp_cancel_write_off 9933 9933 0 0.00 2 12589 156 0 0
sp_client_order 18835 18835 0 0.00 6 56883 511 0 0
sp_customer_reserve 426993 426993 0 0.00 0 57154 265 0 0
sp_fill_shopping_cart 28574 28574 0 0.00 1 11200 82 0 0
sp_fill_shopping_cart_clo_res 426944 426944 0 0.00 0 25460 22 0 0
sp_get_clo_for_invoice 4451 4451 0 0.00 0 33253 371 0 0
sp_kill_cost_storno 16209 16209 0 0.00 0 10342 69 0 0
sp_kill_qstorno_ret_qs2qd 1058468 1058468 0 0.00 0 60328 45 0 0
sp_kill_qty_storno 557856 557856 0 0.00 0 60329 102 0 0
sp_lock_selected_doc 18635 18635 0 0.00 0 8033 7 0 0
sp_make_cost_storno 25303 25303 0 0.00 0 18793 75 0 0
sp_multiply_rows_for_pdistr 25301 25301 0 0.00 0 7327 35 0 0
sp_multiply_rows_for_qdistr 18835 18835 0 0.00 0 56761 203 0 0
sp_pay_from_customer 6502 6502 0 0.00 5 18808 180 0 0
sp_pay_to_supplier 5251 5251 0 0.00 6 20610 197 0 0
sp_payment_common 11751 11751 0 0.00 2 11777 42 0 0
sp_qd_handle_on_cancel_clo 1595 1595 0 0.00 1 10804 319 0 0
sp_qd_handle_on_invoice_upd_sts 9796 9796 0 0.00 0 22926 481 0 0
sp_qd_handle_on_reserve_upd_sts 9098 9098 0 0.00 0 18493 60 0 0
sp_reserve_write_off 9100 9100 0 0.00 8 19335 258 0 0
sp_supplier_invoice 4804 4804 0 0.00 10 82395 3269 0 0
sp_supplier_order 4951 4951 0 0.00 7 50381 1358 0 0
srv_aggregate_perf_data 101 101 0 0.00 2319 107974 16196 0 0
srv_fill_mon_cache_memory 67 67 0 0.00 747 120764 38015 0 0
srv_find_qd_qs_mism 983151 983151 0 0.00 0 18490 10 0 0
srv_make_invnt_saldo 467 467 0 0.00 68 78079 3685 0 0
srv_make_money_saldo 772 772 0 0.00 2 16029 399 0 0
srv_recalc_idx_stat 4 4 0 0.00 75740 534183 319488 0 0
t$perf-abend:sp_add_invoice_to_stock 139 139 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 14 14 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4501 4501 0 0.00 1 11857 914 0 0
t$perf-norm:sp_cancel_adding_invoice 371 371 0 0.00 2 10363 362 0 0
t$perf-norm:sp_cancel_client_order 1595 1595 0 0.00 0 4428 31 0 0
t$perf-norm:sp_cancel_customer_reserve 572 572 0 0.00 0 2247 27 0 0
t$perf-norm:sp_cancel_pay_from_customer 579 579 0 0.00 0 1024 14 0 0
t$perf-norm:sp_cancel_pay_to_supplier 352 352 0 0.00 0 130 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 403 403 0 0.00 0 2312 40 0 0
t$perf-norm:sp_cancel_supplier_order 383 383 0 0.00 0 101969 6766 0 0
t$perf-norm:sp_cancel_write_off 835 835 0 0.00 0 5648 27 0 0
t$perf-norm:sp_client_order 18835 18835 0 0.00 0 10152 36 0 0
t$perf-norm:sp_customer_reserve 899 899 0 0.00 0 886 14 0 0
t$perf-norm:sp_pay_from_customer 6505 6505 0 0.00 0 3212 16 0 0
t$perf-norm:sp_pay_to_supplier 5251 5251 0 0.00 0 8372 23 0 0
t$perf-norm:sp_reserve_write_off 9100 9100 0 0.00 0 8322 23 0 0
t$perf-norm:sp_supplier_invoice 4804 4804 0 0.00 0 3812 27 0 0
t$perf-norm:sp_supplier_order 4951 4951 0 0.00 0 3133 30 0 0
t$perf-norm:srv_aggregate_perf_data 101 101 0 0.00 0 238 14 0 0
t$perf-norm:srv_fill_mon_cache_memory 67 67 0 0.00 0 1269 26 0 0
t$perf-norm:srv_make_invnt_saldo 467 467 0 0.00 0 577 14 0 0
t$perf-norm:srv_make_money_saldo 772 772 0 0.00 0 171 4 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 7 240 124 0 0
v_add_invoice_to_stock 9172 8894 278 3.03 0 2329 23 0 278
v_all_customers 34679 34679 0 0.00 0 111 4 0 0
v_all_suppliers 27408 27408 0 0.00 0 123 4 0 0
v_all_wares 37654 37654 0 0.00 0 66 4 0 0
v_cancel_adding_invoice 742 742 0 0.00 0 2068 16 0 0
v_cancel_client_order 3190 3190 0 0.00 0 2173 10 0 0
v_cancel_customer_prepayment 1158 1158 0 0.00 0 1700 13 0 0
v_cancel_customer_reserve 1144 1144 0 0.00 0 568 10 0 0
v_cancel_payment_to_supplier 704 704 0 0.00 0 87 9 0 0
v_cancel_supplier_invoice 834 806 28 3.35 0 4014 28 0 28
v_cancel_supplier_order 766 766 0 0.00 0 375 10 0 0
v_cancel_write_off 1670 1670 0 0.00 0 4772 27 0 0
v_max_id_clo_ord 4947 4947 0 0.00 0 333 5 0 0
v_max_id_clo_res 899 899 0 0.00 0 2403 19 0 0
v_max_id_ord_sup 4800 4800 0 0.00 0 7205 9 0 0
v_max_non_paid_invoice 1290 1290 0 0.00 0 1580 9 0 0
v_max_non_paid_realizn 3224 3224 0 0.00 0 3026 8 0 0
v_min_id_clo_ord 4947 4947 0 0.00 0 1910 7 0 0
v_min_id_clo_res 899 899 0 0.00 0 18186 48 0 0
v_min_id_ord_sup 4800 4800 0 0.00 0 7966 13 0 0
v_min_non_paid_invoice 5249 5249 0 0.00 0 7067 15 0 0
v_min_non_paid_realizn 6502 6502 0 0.00 0 6642 16 0 0
v_our_firm 9530 9530 0 0.00 0 84 4 0 0
v_reserve_write_off 18194 18194 0 0.00 0 2840 11 0 0
x_lock_depdocs_on_canc_invoice 10892 10892 0 0.00 0 13103 120 0 0
x_lock_depdocs_on_canc_sup_ord 383 383 0 0.00 0 9826 377 0 0
x_make_qstorno_1000_1200 4951 4951 0 0.00 2 50369 1200 0 0
x_make_qstorno_1200_2000 4804 4804 0 0.00 4 82215 3028 0 0
x_make_qstorno_2100_3300 426993 426993 0 0.00 0 57146 231 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 14-01-2023 10:38:36 to 14-01-2023 10:38:41.

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:29 19 8192000000 8814807200 8832221184 15239904 0.185 6 4 5 0 15492960 140512 112544
08:08:29 36682 8192000000 9735503392 10038112256 808517728 8.983 100 87 174 0 838023648 8452016 21053904
08:10:24 20387 8192000000 9775014208 10088615936 848188928 9.382 100 91 182 0 884240000 14745840 21305232
08:11:48 8710 8192000000 9806676352 10128424960 877073968 9.671 100 83 164 1 917249280 21102320 19072992
08:12:59 8747 8192000000 9898314160 10231906304 925664784 10.152 100 91 181 0 1009605312 64737328 19203200
08:14:09 3852 8192000000 9939589312 10286780416 968800256 10.575 100 89 165 1 1050225280 64058512 17366512
08:15:15 2643 8192000000 9979832272 10336129024 1004047488 10.918 100 90 171 0 1095643968 73701408 17895072
08:16:19 1206 8192000000 9997188512 10359095296 1025226688 11.122 100 97 185 0 1114786032 70688128 18871216
08:17:22 789 8192000000 10009601840 10383589376 1052074544 11.381 100 94 170 2 1129714016 60104864 17534608
08:18:24 1108 8192000000 10048527888 10424332288 1062615664 11.482 100 94 186 1 1167902224 86961488 18325072
08:19:26 1075 8192000000 10027246352 10400395264 1068731760 11.540 100 98 191 1 1143998160 55232128 20034272
08:20:28 1111 8192000000 10029011024 10412752896 1072603776 11.577 100 82 150 2 1149683184 61530800 15548608
08:21:30 7704 8192000000 10033831952 10425245696 1077777120 11.626 100 72 139 3 1159949616 68969232 13203264
08:22:39 3473 8192000000 10054820016 10448916480 1087277248 11.717 100 59 115 1 1174801072 76054304 11469520
08:23:44 1155 8192000000 10047784752 10435375104 1095331712 11.793 100 96 180 0 1168799616 55828688 17639216
08:24:45 1355 8192000000 10048369280 10438688768 1095281712 11.793 100 88 168 3 1162658672 50709760 16667200
08:25:47 1138 8192000000 10057926560 10445537280 1100685616 11.844 100 93 177 2 1179246816 59513328 19047872
08:26:50 3823 8192000000 10064635536 10464182272 1102909808 11.865 100 72 144 0 1185872176 68310928 14651440
08:27:55 1345 8192000000 10048760752 10440151040 1094198384 11.783 100 92 162 3 1167370928 54390336 18782208
08:28:57 1138 8192000000 10051931936 10440249344 1092480608 11.766 100 91 167 1 1172685808 62238592 17966608
08:29:59 1156 8192000000 10017326224 10394107904 1060745344 11.464 100 95 179 0 1139979952 61030336 18204272
08:31:01 932 8192000000 9982960576 10356322304 1045674640 11.319 100 92 172 1 1104472960 41348656 17449664
08:32:02 2723 8192000000 9978729776 10356563968 1033599232 11.203 99 77 152 1 1103258640 53963904 15695504
08:33:11 996 8192000000 9992399104 10364420096 1038737248 11.253 100 89 169 1 1111830048 56512208 16580592
08:34:13 1962 8192000000 9965571136 10343804928 1026785216 11.137 99 71 135 0 1093094096 52858128 13450752
08:35:15 982 8192000000 10014793552 10392793088 1036346688 11.230 100 86 160 0 1134111632 81032064 16732880
08:36:17 1159 8192000000 9978675824 10356523008 1042390880 11.288 100 88 171 1 1104730736 44743440 17596416
08:37:20 4142 8192000000 10002267472 10385571840 1048017584 11.342 99 76 139 3 1115795328 53696112 14081632
08:38:29 1296 8192000000 10055181856 10435272704 1075089952 11.601 100 90 171 1 1174101280 81515648 17495680
08:39:33 15639 8192000000 10044233264 10432405504 1074865168 11.599 99 63 120 0 1157188992 70219248 12104576
08:40:52 6396 8192000000 10070796336 10468294656 1099837616 11.836 100 81 157 1 1192756944 74837216 18082112
08:42:01 2252 8192000000 10116712928 10504048640 1111593504 11.948 100 90 165 2 1237127920 105265920 20268496
08:43:06 1230 8192000000 10145533664 10532876288 1126108800 12.085 100 87 170 2 1260487280 116443472 17935008
08:44:09 1579 8192000000 10164456096 10561740800 1129346848 12.115 100 94 181 4 1285954688 137992752 18615088
08:45:14 7952 8192000000 10174008704 10576719872 1127834000 12.101 100 78 152 0 1294023584 149704928 16484656
08:46:31 2370 8192000000 10216303904 10615566336 1145849200 12.271 100 74 145 2 1336756256 175059824 15847232
08:47:38 2349 8192000000 10255114240 10649939968 1156318864 12.369 100 83 162 0 1363432176 188417728 18695584
08:48:46 2331 8192000000 10285460352 10698010624 1163603392 12.437 100 78 152 2 1394562912 213618720 17340800
08:49:55 2831 8192000000 10318315440 10729709568 1169983120 12.497 100 90 177 1 1431799264 240812464 21003680
08:51:02 1713 8192000000 10362139920 10764242944 1184039344 12.628 100 91 171 1 1469990416 265904944 20046128
08:52:07 1818 8192000000 10403508016 10810441728 1191552816 12.698 100 85 166 1 1513408672 303138288 18717568
08:53:12 1593 8192000000 10414257600 10840961024 1190216528 12.685 100 90 176 0 1521969104 311138400 20614176
08:54:17 1981 8192000000 10461016400 10873135104 1191198992 12.695 100 92 180 0 1570384384 357827984 21357408
08:55:21 776 8192000000 10480542464 10886483968 1182893168 12.617 99 98 190 2 1584772608 380076720 21802720
08:56:24 2417 8192000000 10522304928 10930204672 1179752112 12.588 100 97 181 2 1624144080 423351520 21040448
08:57:30 1019 8192000000 10525821536 10954481664 1169625984 12.493 100 94 187 1 1630623616 438646848 22350784
08:58:35 726 8192000000 10547183984 10975031296 1182719168 12.616 100 97 187 1 1654606256 448663808 23223280
08:59:38 2049 8192000000 10538928192 11022442496 1176380144 12.556 100 88 168 0 1643369280 446211520 20777616
09:00:45 7931 8192000000 10500418896 11009548288 1180153088 12.592 100 60 120 1 1617819008 421800448 15865472
09:02:06 28647 8192000000 10495835216 10951319552 1185953888 12.646 100 46 92 1 1609407184 411354752 12098544
09:03:37 14002 8192000000 10475793520 10971107328 1162448656 12.426 99 35 68 0 1594908256 423121152 9338448
09:04:52 29401 8192000000 10406595616 10867257344 1157164016 12.377 100 27 54 0 1525126576 360455232 7507328
09:06:52 26091 8192000000 10232842544 10707718144 1115362048 11.983 99 22 43 0 1347130208 226393040 5375120
09:08:19 35705 8192000000 10086055808 10524880896 1137851072 12.195 99 34 70 0 1188705248 42887424 7966752
09:10:02 32154 8192000000 10100647008 10533134336 1118554480 12.013 98 55 102 2 1178856048 49551152 10750416
09:11:47 22757 8192000000 10081353728 10535231488 1130336448 12.125 100 18 36 0 1185285072 51280992 3667632
09:13:11 42857 8192000000 10117134512 10565861376 1126069296 12.084 99 31 57 1 1205707328 73909568 5728464
09:15:05 48095 8192000000 10124113872 10592169984 1133449952 12.154 99 29 56 0 1241404560 101915856 6038752
09:17:09 69301 8192000000 10097458240 10542878720 1113443296 11.965 98 23 47 0 1183039408 64106608 5489504
09:19:19 78178 8192000000 10132882816 10586574848 1140180560 12.217 100 20 40 0 1208036832 63360224 4496048
09:22:04 94755 8192000000 10074488944 10545995776 1129486608 12.117 99 20 35 0 1179420256 46457536 3476112
09:24:39 68290 8192000000 10106462112 10556284928 1131655632 12.137 99 20 39 1 1192498416 56002016 4840768
09:28:51 27454 8192000000 10054356896 10560815104 1133247952 12.152 100 9 18 0 1168339344 33040752 2050640
09:30:21 56464 8192000000 10061436864 10536398848 1121812016 12.044 98 12 24 0 1166075856 42183632 2080208
09:32:24 96347 8192000000 10074592160 10577485824 1109019568 11.923 97 20 38 0 1176185568 62659088 4506912
09:35:08 34188 8192000000 10104366960 10542530560 1140762896 12.223 100 44 87 2 1201822176 51283040 9776240
09:36:44 58906 8192000000 10118804704 10614870016 1138204096 12.199 99 27 55 0 1249717776 105981344 5532336
09:38:47 95706 8192000000 10111950384 10613563392 1151782208 12.326 100 26 52 0 1250182016 93342960 5056848
09:41:23 62125 8192000000 10105659552 10555699200 1090183696 11.744 94 27 54 0 1159810528 63666592 5960240
09:43:36 21458 8192000000 10144792352 10595102720 1129915728 12.121 100 45 81 1 1239570352 101272016 8382608
09:45:07 17199 8192000000 10125629744 10546253824 1145024816 12.263 100 54 102 0 1209204160 53485696 10693648
09:46:27 106680 8192000000 10171801376 10653999104 1147873776 12.290 100 38 76 0 1289959408 133772224 8313408
09:49:38 40156 8192000000 10069720656 10600620032 1142319904 12.237 100 4 6 0 1187404080 44157568 926608
09:52:22 49658 8192000000 10081032976 10525921280 1129424656 12.116 99 28 55 1 1173054736 38252208 5377872
09:54:13 23320 8192000000 10110158192 10546266112 1128674112 12.109 98 29 56 0 1199591904 64874128 6043664
09:55:40 23801 8192000000 10158994944 10591465472 1137122528 12.188 99 42 80 1 1232650016 86702176 8825312
09:57:08 26172 8192000000 10172290016 10597662720 1128169952 12.104 99 35 69 0 1250158432 114011472 7977008
09:58:35 41181 8192000000 10213191696 10663165952 1151443984 12.323 100 25 50 0 1316900832 159677152 5779696
10:00:20 47542 8192000000 10243898928 10667913216 1120048128 12.027 98 48 96 1 1282987040 153239104 9699808
10:02:14 26291 8192000000 10128522800 10627567616 1135010624 12.169 100 41 80 0 1259203440 115735600 8457216
10:03:43 38880 8192000000 10128797024 10596044800 1117391072 12.002 99 42 84 0 1232393328 106676384 8325872
10:05:52 92951 8192000000 10069001456 10521874432 1132249088 12.143 100 21 42 0 1177217248 40826496 4141664
10:08:25 75783 8192000000 10088173968 10567327744 1121986960 12.046 99 12 24 1 1196342800 71893344 2462496
10:10:41 77779 8192000000 10083711344 10556424192 1117567248 12.004 98 17 34 0 1158179072 37183760 3428064
10:13:16 82816 8192000000 10105786304 10556354560 1095207296 11.792 96 22 44 0 1164729968 64883648 4639024
10:15:50 55866 8192000000 10173464272 10611429376 1141161776 12.226 100 25 46 1 1260381760 114428064 4791920
10:18:16 111387 8192000000 10135029616 10605801472 1109761200 11.930 97 20 41 0 1207328304 93116896 4450208
10:21:09 20610 8192000000 10157247504 10595520512 1136547168 12.183 99 37 74 0 1249208672 105219920 7441584
10:22:30 99507 8192000000 10071382784 10527670272 1110952336 11.941 97 26 51 1 1158891696 42841808 5097552
10:25:10 24486 8192000000 10105969056 10554777600 1137809088 12.195 99 47 92 0 1193421680 46753408 8859184
10:27:10 83121 8192000000 10084901808 10527916032 1141558096 12.230 100 32 56 2 1208678560 61296656 5823808
10:29:34 67495 8192000000 10117076896 10574053376 1148247200 12.293 100 10 20 0 1233483424 83138720 2097504
10:31:42 38169 8192000000 10076525040 10560626688 1121349296 12.040 98 12 24 0 1167796176 43680288 2766592
10:33:26 120764 8192000000 10089144256 10558730240 1090678912 11.749 95 14 28 0 1156130912 62389088 3062912
10:36:27 43953 8192000000 10060052080 10527846400 1117465664 12.003 98 25 50 0 1170139088 47007792 5665632

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 14-01-2023 10:38:43 to 14-01-2023 10:38:59.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 139 v_add_invoice_to_stock 335544517
except 14 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 14-01-2023 10:39:00 to 14-01-2023 10:39:02.

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          210852
MON$OLDEST_ACTIVE               211708
MON$OLDEST_SNAPSHOT             211708
MON$NEXT_TRANSACTION            211708
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                       2036064
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             758
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2890 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2890 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2890 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2890 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 ---
:31: 
:32: mscs-test-161.budzdorov.ru    Sat Jan 14 10:37:27 2023
:33:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:34: 
:35: 
:36: mscs-test-161.budzdorov.ru    Sat Jan 14 10:37:28 2023
:37:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:38: 
--- end of diff output ---

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

14.01.23 10:39:03. 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-01-14 10:39:05 No severe PSQL-related problems occured
14.01.23 10:39:07. End of report.