Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 02.01.2023 10:40
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 15522856 kB
MemAvailable 30424952 kB
Buffers 0 kB
Cached 16219664 kB
SwapCached 7736 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-02 10:37:23
DTS_END                         2023-01-02 10:37:23.5830
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/40092
TRN_ID                          210373
ATT_ID                          606
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: 8657.54 21091 1038905
customer order: creation 161.40 471 19368
customer order: refuse 12.93 344 1551
order to supplier: creation 41.78 1272 5014
order to supplier: removal 3.47 161483 416
invoice (draft): creation 42.73 2792 5127
invoice (draft): removal 51.27 916 6152
invoice accept: apply 37.30 28219 4476
invoice accept: cancel 46.05 988 5526
customer reserve: creation 3549.89 269 425987
customer reserve: removal 4437.68 100 532521
realization accept: apply 77.47 253 9296
realization accept: cancel 76.93 178 9231
payment from customer: creation 54.34 172 6521
payment from customer: removal 5.41 100 649
payment to supplier: creation 44.18 175 5302
payment to supplier: removal 2.86 107 343
service: total inventory turnovers 4.31 3093 517
service: total monetary turnovers 6.67 287 800
service: aggregate perf. data 0.87 14944 104
service: refresh index statistics 0.03 205648 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 02-01-2023 10:40:33 to 02-01-2023 10:40:35.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5781
TEST_TIME 2 4677
TEST_TIME 3 5151
TEST_TIME 4 4658
TEST_TIME 5 4620
TEST_TIME 6 5352
TEST_TIME 7 5369
TEST_TIME 8 6264
TEST_TIME 9 6357
TEST_TIME 10 6395
TEST_TIME 11 6380
TEST_TIME 12 6421
TEST_TIME 13 6479
TEST_TIME 14 6470
TEST_TIME 15 6532
TEST_TIME 16 6576
TEST_TIME 17 7340
TEST_TIME 18 7532
TEST_TIME 19 7388
TEST_TIME 20 7309
TEST_TIME 21 7701
TEST_TIME 22 8018
TEST_TIME 23 8216
TEST_TIME 24 9273
TEST_TIME 25 10144
TEST_TIME 26 10401
TEST_TIME 27 10623
TEST_TIME 28 11063
TEST_TIME 29 10977
TEST_TIME 30 10699
TEST_TIME 31 10454
TEST_TIME 32 10478
TEST_TIME 33 10309
TEST_TIME 34 10320
TEST_TIME 35 10163
TEST_TIME 36 10050
TEST_TIME 37 10211
TEST_TIME 38 9992
TEST_TIME 39 9880
TEST_TIME 40 9715
TEST_TIME 41 9784
TEST_TIME 42 9709
TEST_TIME 43 9674
TEST_TIME 44 9536
TEST_TIME 45 9577
TEST_TIME 46 9539
TEST_TIME 47 9453
TEST_TIME 48 9476
TEST_TIME 49 9478
TEST_TIME 50 9452
TEST_TIME 51 9400
TEST_TIME 52 9421
TEST_TIME 53 9429
TEST_TIME 54 9379
TEST_TIME 55 9424
TEST_TIME 56 9392
TEST_TIME 57 9498
TEST_TIME 58 9370
TEST_TIME 59 9234
TEST_TIME 60 9218
TEST_TIME 61 9180
TEST_TIME 62 9190
TEST_TIME 63 9133
TEST_TIME 64 9035
TEST_TIME 65 8932
TEST_TIME 66 8995
TEST_TIME 67 8925
TEST_TIME 68 8943
TEST_TIME 69 9030
TEST_TIME 70 9015
TEST_TIME 71 9048
TEST_TIME 72 8992
TEST_TIME 73 9026
TEST_TIME 74 8956
TEST_TIME 75 8930
TEST_TIME 76 9018
TEST_TIME 77 9131
TEST_TIME 78 9142
TEST_TIME 79 9063
TEST_TIME 80 8978
TEST_TIME 81 8961
TEST_TIME 82 8933
TEST_TIME 83 8892
TEST_TIME 84 8874
TEST_TIME 85 8834
TEST_TIME 86 8833
TEST_TIME 87 8810
TEST_TIME 88 8789
TEST_TIME 89 8754
TEST_TIME 90 8736
TEST_TIME 91 8768
TEST_TIME 92 8805
TEST_TIME 93 8824
TEST_TIME 94 8792
TEST_TIME 95 8794
TEST_TIME 96 9050
TEST_TIME 97 9020
TEST_TIME 98 8995
TEST_TIME 99 8927
TEST_TIME 100 8920
TEST_TIME 101 8862
TEST_TIME 102 8880
TEST_TIME 103 8837
TEST_TIME 104 8798
TEST_TIME 105 8767
TEST_TIME 106 8711
TEST_TIME 107 8682
TEST_TIME 108 8709
TEST_TIME 109 8690
TEST_TIME 110 8707
TEST_TIME 111 8724
TEST_TIME 112 8700
TEST_TIME 113 8728
TEST_TIME 114 8773
TEST_TIME 115 8779
TEST_TIME 116 8773
TEST_TIME 117 8767
TEST_TIME 118 8784
TEST_TIME 119 8744
TEST_TIME 120 8678

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 02-01-2023 10:40:36 to 02-01-2023 10:40:40.

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 1433046 1433046 0 0.00 0 27955 13 0 0
doc_list_biud 1433045 1433045 0 0.00 0 40907 42 0 0
sp_add_invoice_to_stock 4602 4476 126 2.73 40 258681 28219 0 126
sp_cancel_adding_invoice 5526 5526 0 0.00 7 74685 988 0 0
sp_cancel_client_order 1551 1551 0 0.00 6 11828 344 0 0
sp_cancel_customer_reserve 532521 532521 0 0.00 1 26143 101 0 0
sp_cancel_pay_from_customer 649 649 0 0.00 4 2358 100 0 0
sp_cancel_pay_to_supplier 343 343 0 0.00 4 2372 107 0 0
sp_cancel_supplier_invoice 6165 6152 13 0.21 3 40915 917 0 13
sp_cancel_supplier_order 416 416 0 0.00 9 1385420 161483 0 0
sp_cancel_write_off 9231 9231 0 0.00 2 12470 178 0 0
sp_client_order 19368 19368 0 0.00 6 30941 471 0 0
sp_customer_reserve 425987 425987 0 0.00 0 69258 269 0 0
sp_fill_shopping_cart 29504 29504 0 0.00 1 13705 70 0 0
sp_fill_shopping_cart_clo_res 425955 425955 0 0.00 0 19190 22 0 0
sp_get_clo_for_invoice 4442 4442 0 0.00 0 47510 336 0 0
sp_kill_cost_storno 15749 15749 0 0.00 0 9054 69 0 0
sp_kill_qstorno_ret_qs2qd 1080841 1080841 0 0.00 0 40906 45 0 0
sp_kill_qty_storno 569135 569135 0 0.00 0 40907 100 0 0
sp_lock_selected_doc 19007 19007 0 0.00 0 9536 7 0 0
sp_make_cost_storno 25561 25561 0 0.00 0 13507 73 0 0
sp_multiply_rows_for_pdistr 25560 25560 0 0.00 0 8339 34 0 0
sp_multiply_rows_for_qdistr 19368 19368 0 0.00 0 9741 194 0 0
sp_pay_from_customer 6521 6521 0 0.00 5 26075 173 0 0
sp_pay_to_supplier 5302 5302 0 0.00 6 20112 175 0 0
sp_payment_common 11822 11822 0 0.00 2 11584 44 0 0
sp_qd_handle_on_cancel_clo 1551 1551 0 0.00 0 11821 285 0 0
sp_qd_handle_on_invoice_upd_sts 9968 9968 0 0.00 0 18992 409 0 0
sp_qd_handle_on_reserve_upd_sts 9296 9296 0 0.00 0 19966 60 0 0
sp_reserve_write_off 9296 9296 0 0.00 8 29939 253 0 0
sp_supplier_invoice 5127 5127 0 0.00 12 50851 2792 0 0
sp_supplier_order 5014 5014 0 0.00 8 56593 1273 0 0
srv_aggregate_perf_data 104 104 0 0.00 3084 139142 14945 0 0
srv_fill_mon_cache_memory 68 68 0 0.00 764 116315 38806 0 0
srv_find_qd_qs_mism 994700 994700 0 0.00 0 27951 11 0 0
srv_make_invnt_saldo 517 517 0 0.00 52 78051 3094 0 0
srv_make_money_saldo 800 800 0 0.00 1 16948 288 0 0
srv_recalc_idx_stat 4 4 0 0.00 110436 357392 205648 0 0
t$perf-abend:sp_add_invoice_to_stock 126 126 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 13 13 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4478 4478 0 0.00 0 31799 717 0 0
t$perf-norm:sp_cancel_adding_invoice 393 393 0 0.00 2 9550 332 0 0
t$perf-norm:sp_cancel_client_order 1551 1551 0 0.00 0 975 20 0 0
t$perf-norm:sp_cancel_customer_reserve 625 625 0 0.00 0 1245 22 0 0
t$perf-norm:sp_cancel_pay_from_customer 649 649 0 0.00 0 493 9 0 0
t$perf-norm:sp_cancel_pay_to_supplier 343 343 0 0.00 0 195 7 0 0
t$perf-norm:sp_cancel_supplier_invoice 385 385 0 0.00 0 1427 19 0 0
t$perf-norm:sp_cancel_supplier_order 416 416 0 0.00 0 82092 5361 0 0
t$perf-norm:sp_cancel_write_off 910 910 0 0.00 0 1102 16 0 0
t$perf-norm:sp_client_order 19368 19368 0 0.00 0 7446 29 0 0
t$perf-norm:sp_customer_reserve 922 922 0 0.00 0 884 11 0 0
t$perf-norm:sp_pay_from_customer 6521 6521 0 0.00 0 6445 15 0 0
t$perf-norm:sp_pay_to_supplier 5302 5302 0 0.00 0 30735 24 0 0
t$perf-norm:sp_reserve_write_off 9296 9296 0 0.00 0 8145 20 0 0
t$perf-norm:sp_supplier_invoice 5127 5127 0 0.00 0 18998 29 0 0
t$perf-norm:sp_supplier_order 5014 5014 0 0.00 0 5686 27 0 0
t$perf-norm:srv_aggregate_perf_data 104 104 0 0.00 0 211 7 0 0
t$perf-norm:srv_fill_mon_cache_memory 68 68 0 0.00 0 714 15 0 0
t$perf-norm:srv_make_invnt_saldo 517 517 0 0.00 0 586 11 0 0
t$perf-norm:srv_make_money_saldo 800 800 0 0.00 0 2298 10 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 79 41 0 0
v_add_invoice_to_stock 9130 8878 252 2.76 0 18405 28 0 252
v_all_customers 35082 35082 0 0.00 0 67 3 0 0
v_all_suppliers 28666 28666 0 0.00 0 79 3 0 0
v_all_wares 38736 38736 0 0.00 0 223 3 0 0
v_cancel_adding_invoice 786 786 0 0.00 0 1295 13 0 0
v_cancel_client_order 3102 3102 0 0.00 0 3007 10 0 0
v_cancel_customer_prepayment 1298 1298 0 0.00 0 1935 12 0 0
v_cancel_customer_reserve 1250 1250 0 0.00 1 11502 18 0 0
v_cancel_payment_to_supplier 686 686 0 0.00 0 887 9 0 0
v_cancel_supplier_invoice 796 770 26 3.26 0 8258 37 0 26
v_cancel_supplier_order 832 832 0 0.00 0 28583 43 0 0
v_cancel_write_off 1820 1820 0 0.00 0 12303 29 0 0
v_max_id_clo_ord 5014 5014 0 0.00 0 1039 4 0 0
v_max_id_clo_res 922 922 0 0.00 0 3710 17 0 0
v_max_id_ord_sup 5122 5122 0 0.00 0 5898 9 0 0
v_max_non_paid_invoice 1104 1104 0 0.00 0 1216 7 0 0
v_max_non_paid_realizn 3348 3348 0 0.00 0 3683 9 0 0
v_min_id_clo_ord 5014 5014 0 0.00 0 2982 8 0 0
v_min_id_clo_res 922 922 0 0.00 0 2557 8 0 0
v_min_id_ord_sup 5122 5122 0 0.00 0 8003 13 0 0
v_min_non_paid_invoice 5301 5301 0 0.00 0 9748 19 0 0
v_min_non_paid_realizn 6521 6521 0 0.00 0 11029 22 0 0
v_our_firm 10000 10000 0 0.00 0 188 4 0 0
v_reserve_write_off 18590 18590 0 0.00 0 29740 13 0 0
x_lock_depdocs_on_canc_invoice 11293 11293 0 0.00 0 13044 115 0 0
x_lock_depdocs_on_canc_sup_ord 416 416 0 0.00 0 2981 308 0 0
x_make_qstorno_1000_1200 5014 5014 0 0.00 3 56573 1145 0 0
x_make_qstorno_1200_2000 5127 5127 0 0.00 6 50831 2582 0 0
x_make_qstorno_2100_3300 425987 425987 0 0.00 0 69255 238 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 02-01-2023 10:40:41 to 02-01-2023 10:40:45.

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:27 3 8192000000 8802664768 8815370240 7792592 0.095 3 2 3 0 7946352 92400 61360
08:08:28 29308 8192000000 9716740224 10012168192 786715344 8.762 100 89 177 0 816792512 7766256 22310912
08:10:06 18732 8192000000 9761299008 10070298624 839970384 9.299 100 88 176 0 871425392 10735264 20719744
08:11:32 18826 8192000000 9794335280 10114633728 866868432 9.569 100 80 160 0 903501520 18243536 18389552
08:12:56 5055 8192000000 9858910304 10195795968 918224064 10.079 100 76 148 0 979488400 44631296 16633040
08:14:04 3087 8192000000 9915190512 10257473536 965594448 10.544 100 88 173 0 1027443968 43684000 18165520
08:15:11 2539 8192000000 9987321584 10341724160 1006930128 10.946 100 86 168 0 1094316896 70291168 17095600
08:16:15 1324 8192000000 9985278384 10344214528 1032321184 11.191 100 92 174 3 1101509248 51881376 17306688
08:17:19 1687 8192000000 10042843664 10408153088 1044267680 11.306 100 91 174 0 1159509696 98521392 16720624
08:18:23 1320 8192000000 10050248592 10429718528 1062886080 11.484 100 92 182 2 1172453376 91030064 18537232
08:19:25 1250 8192000000 10041327824 10419101696 1065780160 11.512 100 94 184 2 1164007120 79069616 19157344
08:20:27 1023 8192000000 10035575872 10414714880 1073622528 11.587 100 93 183 0 1162105056 69715520 18767008
08:21:29 1072 8192000000 10067313616 10445897728 1080730032 11.654 100 92 173 1 1183885856 84662288 18493536
08:22:40 1113 8192000000 10050938016 10436870144 1082129392 11.668 100 90 172 1 1177083392 76545776 18408224
08:23:42 1202 8192000000 10034508560 10418774016 1083554416 11.681 100 96 178 4 1158860208 57949216 17356576
08:24:44 1073 8192000000 10065136240 10451865600 1090738384 11.750 100 97 183 1 1193482144 82974416 19769344
08:25:46 1172 8192000000 10076865584 10464714752 1099710592 11.835 100 97 182 3 1202384592 84670400 18003600
08:26:48 1087 8192000000 10066857760 10458722304 1095030784 11.790 100 95 175 1 1186952624 73674240 18247600
08:27:50 1017 8192000000 10040523872 10431901696 1094584880 11.786 100 89 162 1 1162125424 50330880 17209664
08:28:52 1088 8192000000 10071331952 10462412800 1093853328 11.779 100 96 185 0 1192158800 78894880 19410592
08:29:54 1031 8192000000 10042319184 10427707392 1085346192 11.698 99 95 182 1 1162564656 57155312 20063152
08:30:56 1307 8192000000 10044078064 10424786944 1078536992 11.634 100 86 161 0 1175262272 81492944 15232336
08:31:58 3358 8192000000 10014489936 10402181120 1040809056 11.272 100 72 133 3 1128473248 73517136 14147056
08:33:02 910 8192000000 10000525920 10372747264 1051434432 11.374 100 94 178 3 1119828880 49011088 19383360
08:34:04 3083 8192000000 10001263104 10381713408 1050722720 11.368 100 79 141 1 1122753072 57272112 14758240
08:35:08 1909 8192000000 9950197008 10316402688 1011009104 10.985 98 83 152 7 1071458096 43545392 16903600
08:36:11 1718 8192000000 10017172880 10398412800 1048593776 11.347 100 86 157 3 1138487152 72763856 17129520
08:37:13 1248 8192000000 9992811664 10368077824 1039020928 11.255 98 86 164 4 1113601152 58505152 16075072
08:38:23 23479 8192000000 10007419840 10391535616 1073228512 11.583 100 66 120 0 1128383136 43524928 11629696
08:39:52 4338 8192000000 10062608944 10451759104 1081343456 11.660 99 68 130 0 1185249728 90506192 13400080
08:41:12 11202 8192000000 10122272096 10527666176 1101626992 11.853 100 62 117 3 1234476928 120298656 12551280
08:42:52 2364 8192000000 10168407744 10557075456 1117526896 12.004 100 85 157 3 1281515376 147316544 16671936
08:44:00 1082 8192000000 10176637168 10578481152 1129668224 12.118 100 90 175 0 1296205520 147607760 18929536
08:45:09 1474 8192000000 10230265296 10634412032 1143987872 12.253 100 96 185 0 1346110000 181105408 21016720
08:46:14 917 8192000000 10249263056 10641350656 1143623296 12.250 100 91 173 3 1354972624 193365328 17984000
08:47:18 1876 8192000000 10278227568 10674741248 1157802624 12.383 100 94 169 2 1392530272 215462176 19265472
08:48:22 1427 8192000000 10336206784 10730622976 1165982896 12.459 100 92 172 0 1442319488 257552560 18784032
08:49:27 997 8192000000 10378180816 10777501696 1179964608 12.590 100 90 178 0 1490928688 289148688 21815392
08:50:32 1526 8192000000 10460004016 10864242688 1187601840 12.661 100 93 180 1 1566838736 357700656 21536240
08:51:36 756 8192000000 10493275920 10896957440 1194763088 12.728 100 98 194 1 1602349600 383712688 23873824
08:52:40 2185 8192000000 10557004704 10972176384 1195130624 12.731 100 97 193 1 1659270384 440806880 23332880
08:53:45 1749 8192000000 10553094608 11015127040 1199971072 12.776 100 89 172 0 1662501776 441527984 21002720
08:54:50 2688 8192000000 10537524368 10976112640 1202970848 12.804 100 68 136 0 1646169312 426671024 16527440
08:55:56 11629 8192000000 10547200816 10983366656 1196956896 12.748 100 53 106 0 1651710832 440795712 13958224
08:57:13 5930 8192000000 10611195424 11053084672 1201999040 12.795 100 58 110 0 1715615792 498684704 14932048
08:58:26 7926 8192000000 10601816336 11064209408 1197607312 12.754 100 53 104 2 1702396688 491192912 13596464
08:59:37 14225 8192000000 10597319008 11044343808 1192707184 12.709 100 43 86 0 1706627728 502125664 11794880
09:00:53 23700 8192000000 10518711344 11048370176 1182408448 12.613 100 32 64 0 1700588496 508628288 9551760
09:02:34 30599 8192000000 10235685360 10701434880 1161852048 12.421 99 22 44 1 1371893232 204396176 5645008
09:04:08 68107 8192000000 10128702992 10608644096 1080090256 11.648 94 21 40 1 1201353952 116806832 4456864
09:06:17 116314 8192000000 10125968656 10556375040 1132136992 12.142 100 40 76 1 1212516448 72419552 7959904
09:09:15 83385 8192000000 10092398336 10553634816 1114849648 11.978 97 32 62 0 1203643712 82308368 6485696
09:11:39 47148 8192000000 10103199776 10545307648 1091046256 11.753 95 44 84 2 1162480736 63022880 8411600
09:13:42 51450 8192000000 10140011776 10619641856 1130655632 12.128 99 22 44 0 1251641648 115989360 4996656
09:15:35 40869 8192000000 10123423376 10572406784 1146952384 12.281 100 16 27 0 1210963568 60791744 3219440
09:17:27 69470 8192000000 10129612384 10630090752 1131492128 12.135 99 17 34 0 1250947232 115508096 3947008
09:20:16 74446 8192000000 10090146048 10572820480 1119920320 12.026 98 13 26 1 1172599248 49776512 2902416
09:23:00 66677 8192000000 10075499424 10534096896 1129810928 12.120 99 8 16 0 1158720192 27327920 1581344
09:25:11 35426 8192000000 10068148704 10510995456 1124989424 12.074 99 24 48 0 1163699104 33710720 4998960
09:26:54 52677 8192000000 10089474192 10526547968 1119194496 12.019 98 34 67 0 1182808576 57195856 6418224
09:28:47 52910 8192000000 10080951904 10528198656 1098860736 11.827 97 33 66 0 1184421952 79007120 6554096
09:30:45 14157 8192000000 10071265472 10498785280 1118316832 12.011 100 62 119 0 1168229008 37179424 12732752
09:32:03 34637 8192000000 10127059840 10570313728 1131370240 12.134 100 46 92 0 1221042128 80037984 9633904
09:33:40 106358 8192000000 10083136560 10560495616 1095548880 11.795 97 16 32 0 1175016656 76123856 3343920
09:37:28 67039 8192000000 10072718400 10538745856 1105466096 11.889 98 25 48 0 1167415664 56397328 5552240
09:39:39 48539 8192000000 10074064256 10520608768 1116960768 11.998 99 21 42 1 1153346256 32108400 4277088
09:41:41 81041 8192000000 10107014336 10565804032 1127097136 12.094 100 11 22 0 1189518272 60016976 2404160
09:44:03 47187 8192000000 10133963104 10588221440 1142331968 12.237 100 17 34 0 1232226768 86452144 3442656
09:45:51 47274 8192000000 10073496064 10519646208 1149767232 12.307 100 27 48 0 1197515936 43099888 4648816
09:47:39 82565 8192000000 10059788896 10508800000 1073331088 11.584 94 16 32 0 1101838112 25294288 3212736
09:50:06 53072 8192000000 10079576224 10521317376 1087485056 11.719 96 33 66 0 1157491872 63563088 6443728
09:52:19 31237 8192000000 10194539616 10642886656 1132294080 12.143 99 37 74 0 1272678944 132537968 7846896
09:54:04 84212 8192000000 10062861552 10541051904 1102595360 11.862 97 12 24 0 1174523952 69560992 2367600
09:56:28 89429 8192000000 10121995552 10550472704 1096777984 11.807 97 55 110 0 1179345040 71006416 11560640
09:58:59 20486 8192000000 10087555984 10549489664 1114041648 11.971 99 35 70 0 1190408640 69246256 7120736
10:00:30 69861 8192000000 10067407904 10563440640 1110977328 11.942 99 7 14 0 1160950112 48564080 1408704
10:02:54 38880 8192000000 10096038240 10535043072 1128563744 12.108 100 15 30 0 1198050688 65972272 3514672
10:04:36 27857 8192000000 10127201344 10566451200 1132702704 12.147 99 29 56 0 1231957984 92831200 6424080
10:06:08 23220 8192000000 10147929584 10594267136 1147846656 12.289 100 26 50 0 1253650144 99867936 5935552
10:07:34 20823 8192000000 10203592400 10634608640 1154394720 12.351 100 41 81 0 1296671888 133460240 8816928
10:08:55 40260 8192000000 10151981824 10604982272 1134422832 12.163 98 30 60 0 1258396144 116799776 7173536
10:10:42 38298 8192000000 10209661376 10673250304 1157825984 12.383 100 32 64 0 1303779776 138759680 7194112
10:12:41 59167 8192000000 10134306288 10722095104 1131466480 12.135 99 20 40 0 1304437184 167851824 5118880
10:14:50 47195 8192000000 10088026176 10513481728 1112674384 11.958 98 42 84 0 1177934800 56850576 8409840
10:16:38 85725 8192000000 10050045264 10512035840 1082557280 11.672 97 39 78 0 1142368352 52130720 7680352
10:19:05 67980 8192000000 10053043712 10531610624 1104569728 11.881 99 14 28 0 1162558192 54796096 3192368
10:21:15 32392 8192000000 10044220640 10516664320 1103151056 11.868 99 5 10 0 1140883504 36645824 1086624
10:22:48 50276 8192000000 10078623648 10528657408 1129698960 12.119 100 12 24 0 1184459552 51869792 2890800
10:24:39 82157 8192000000 10087348160 10565439488 1106356464 11.898 98 19 38 0 1172459056 61833136 4269456
10:27:02 38544 8192000000 10112346832 10563633152 1099580256 11.834 97 38 72 1 1199373904 91479520 8314128
10:29:02 21293 8192000000 10128509040 10563915776 1124015104 12.065 99 36 72 0 1206073840 74049184 8009552
10:30:24 46616 8192000000 10120879248 10568224768 1124102528 12.066 100 30 60 0 1216027936 85405360 6520048
10:32:11 31942 8192000000 10065950336 10506911744 1123602656 12.061 100 23 46 0 1172168352 43865952 4699744
10:33:45 21549 8192000000 10092785568 10530746368 1111373424 11.945 99 53 106 0 1181621120 59618544 10629152
10:35:08 4901 8192000000 10102797136 10520842240 1114220448 11.972 100 57 114 0 1198033968 72668544 11144976
10:36:18 71481 8192000000 9720859456 10102775808 774601088 8.638 69 38 76 0 864863616 82273152 7989376

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 02-01-2023 10:40:47 to 02-01-2023 10:41:03.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 126 v_add_invoice_to_stock 335544517
except 13 v_cancel_supplier_invoice 335544517

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

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          210778
MON$OLDEST_ACTIVE               210779
MON$OLDEST_SNAPSHOT             210779
MON$NEXT_TRANSACTION            210779
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                       2013440
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.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 ---
--- end of diff output ---

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

02.01.23 10:41:07. 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-02 10:41:09 No severe PSQL-related problems occured
02.01.23 10:41:11. End of report.