Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 30.12.2022 07: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 15222396 kB
MemAvailable 30392360 kB
Buffers 0 kB
Cached 16463032 kB
SwapCached 11588 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-30 07:37:19
DTS_END                         2022-12-30 07:37:19.8780
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/48468
TRN_ID                          219551
ATT_ID                          604
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: 9033.98 21650 1084078
customer order: creation 170.59 488 20471
customer order: refuse 13.99 360 1679
order to supplier: creation 45.51 1469 5461
order to supplier: removal 3.40 169944 408
invoice (draft): creation 45.41 3172 5449
invoice (draft): removal 50.63 948 6076
invoice accept: apply 41.51 24006 4981
invoice accept: cancel 45.77 1139 5492
customer reserve: creation 3833.50 231 460020
customer reserve: removal 4498.14 103 539777
realization accept: apply 81.61 251 9793
realization accept: cancel 78.39 148 9407
payment from customer: creation 56.48 188 6777
payment from customer: removal 5.67 121 680
payment to supplier: creation 48.03 162 5763
payment to supplier: removal 3.51 90 421
service: total inventory turnovers 4.25 3219 510
service: total monetary turnovers 6.56 380 787
service: aggregate perf. data 1.01 13719 121
service: refresh index statistics 0.04 212857 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 30-12-2022 07:38:38 to 30-12-2022 07:38:40.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 6250
TEST_TIME 2 5571
TEST_TIME 3 4924
TEST_TIME 4 4778
TEST_TIME 5 4739
TEST_TIME 6 4673
TEST_TIME 7 4899
TEST_TIME 8 5098
TEST_TIME 9 5245
TEST_TIME 10 5421
TEST_TIME 11 6042
TEST_TIME 12 6273
TEST_TIME 13 6550
TEST_TIME 14 6693
TEST_TIME 15 7091
TEST_TIME 16 7241
TEST_TIME 17 7472
TEST_TIME 18 8054
TEST_TIME 19 7899
TEST_TIME 20 7953
TEST_TIME 21 7880
TEST_TIME 22 8000
TEST_TIME 23 7933
TEST_TIME 24 8165
TEST_TIME 25 8393
TEST_TIME 26 8642
TEST_TIME 27 8767
TEST_TIME 28 9291
TEST_TIME 29 9673
TEST_TIME 30 10043
TEST_TIME 31 10409
TEST_TIME 32 11261
TEST_TIME 33 11125
TEST_TIME 34 11100
TEST_TIME 35 11036
TEST_TIME 36 10918
TEST_TIME 37 10935
TEST_TIME 38 10893
TEST_TIME 39 10777
TEST_TIME 40 10599
TEST_TIME 41 10471
TEST_TIME 42 10334
TEST_TIME 43 10220
TEST_TIME 44 10169
TEST_TIME 45 10081
TEST_TIME 46 10006
TEST_TIME 47 10061
TEST_TIME 48 10021
TEST_TIME 49 10065
TEST_TIME 50 9964
TEST_TIME 51 9891
TEST_TIME 52 9993
TEST_TIME 53 9982
TEST_TIME 54 9990
TEST_TIME 55 9922
TEST_TIME 56 10029
TEST_TIME 57 10024
TEST_TIME 58 10041
TEST_TIME 59 10023
TEST_TIME 60 9989
TEST_TIME 61 10022
TEST_TIME 62 10048
TEST_TIME 63 10050
TEST_TIME 64 9905
TEST_TIME 65 9815
TEST_TIME 66 9785
TEST_TIME 67 9710
TEST_TIME 68 9671
TEST_TIME 69 9646
TEST_TIME 70 9558
TEST_TIME 71 9578
TEST_TIME 72 9559
TEST_TIME 73 9543
TEST_TIME 74 9532
TEST_TIME 75 9503
TEST_TIME 76 9521
TEST_TIME 77 9486
TEST_TIME 78 9534
TEST_TIME 79 9476
TEST_TIME 80 9482
TEST_TIME 81 9588
TEST_TIME 82 9563
TEST_TIME 83 9640
TEST_TIME 84 9645
TEST_TIME 85 9555
TEST_TIME 86 9495
TEST_TIME 87 9477
TEST_TIME 88 9457
TEST_TIME 89 9409
TEST_TIME 90 9356
TEST_TIME 91 9348
TEST_TIME 92 9316
TEST_TIME 93 9283
TEST_TIME 94 9343
TEST_TIME 95 9349
TEST_TIME 96 9356
TEST_TIME 97 9385
TEST_TIME 98 9406
TEST_TIME 99 9400
TEST_TIME 100 9444
TEST_TIME 101 9414
TEST_TIME 102 9410
TEST_TIME 103 9424
TEST_TIME 104 9426
TEST_TIME 105 9357
TEST_TIME 106 9323
TEST_TIME 107 9330
TEST_TIME 108 9302
TEST_TIME 109 9272
TEST_TIME 110 9230
TEST_TIME 111 9174
TEST_TIME 112 9156
TEST_TIME 113 9144
TEST_TIME 114 9127
TEST_TIME 115 9099
TEST_TIME 116 9116
TEST_TIME 117 9084
TEST_TIME 118 9071
TEST_TIME 119 9077
TEST_TIME 120 9063

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 30-12-2022 07:38:41 to 30-12-2022 07:38:45.

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 1509417 1509417 0 0.00 0 36154 12 0 0
doc_list_biud 1509407 1509407 0 0.00 0 54414 42 0 0
sp_add_invoice_to_stock 5107 4981 126 2.46 71 188919 24006 0 126
sp_cancel_adding_invoice 5492 5492 0 0.00 6 67084 1140 0 0
sp_cancel_client_order 1679 1679 0 0.00 5 14030 360 0 0
sp_cancel_customer_reserve 539777 539777 0 0.00 1 54418 104 0 0
sp_cancel_pay_from_customer 680 680 0 0.00 4 8046 121 0 0
sp_cancel_pay_to_supplier 421 421 0 0.00 4 2884 91 0 0
sp_cancel_supplier_invoice 6090 6076 14 0.22 2 43251 949 0 14
sp_cancel_supplier_order 408 408 0 0.00 9 1278521 169944 0 0
sp_cancel_write_off 9407 9407 0 0.00 2 8393 149 0 0
sp_client_order 20471 20471 0 0.00 5 49119 488 0 0
sp_customer_reserve 460020 460020 0 0.00 0 111376 232 0 0
sp_fill_shopping_cart 31370 31370 0 0.00 1 18532 76 0 0
sp_fill_shopping_cart_clo_res 459996 459996 0 0.00 0 19084 18 0 0
sp_get_clo_for_invoice 4948 4948 0 0.00 0 26662 299 0 0
sp_kill_cost_storno 16000 16000 0 0.00 0 8389 65 0 0
sp_kill_qstorno_ret_qs2qd 1095445 1095445 0 0.00 0 54405 46 0 0
sp_kill_qty_storno 577577 577577 0 0.00 0 54413 102 0 0
sp_lock_selected_doc 20294 20294 0 0.00 0 9080 9 0 0
sp_make_cost_storno 27280 27280 0 0.00 0 15601 74 0 0
sp_multiply_rows_for_pdistr 27278 27278 0 0.00 0 27549 42 0 0
sp_multiply_rows_for_qdistr 20471 20471 0 0.00 0 17538 208 0 0
sp_pay_from_customer 6777 6777 0 0.00 5 27608 189 0 0
sp_pay_to_supplier 5763 5763 0 0.00 6 15787 163 0 0
sp_payment_common 12539 12539 0 0.00 2 7678 40 0 0
sp_qd_handle_on_cancel_clo 1679 1679 0 0.00 0 14020 299 0 0
sp_qd_handle_on_invoice_upd_sts 10439 10439 0 0.00 0 39205 457 0 0
sp_qd_handle_on_reserve_upd_sts 9791 9791 0 0.00 0 18555 55 0 0
sp_reserve_write_off 9793 9793 0 0.00 9 18601 251 0 0
sp_supplier_invoice 5449 5449 0 0.00 9 105588 3172 0 0
sp_supplier_order 5461 5461 0 0.00 7 86228 1470 0 0
srv_aggregate_perf_data 122 121 1 0.81 2628 201726 13720 0 1
srv_fill_mon_cache_memory 71 71 0 0.00 678 173035 36491 0 0
srv_find_qd_qs_mism 1036686 1036686 0 0.00 0 36147 9 0 0
srv_make_invnt_saldo 510 510 0 0.00 47 84483 3219 0 0
srv_make_money_saldo 787 787 0 0.00 2 14541 380 0 0
srv_recalc_idx_stat 5 5 0 0.00 90006 397006 212857 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 14 14 0 0.00 0 0 0 0 0
t$perf-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4988 4988 0 0.00 1 9541 710 0 0
t$perf-norm:sp_cancel_adding_invoice 409 409 0 0.00 2 7816 404 0 0
t$perf-norm:sp_cancel_client_order 1679 1679 0 0.00 0 1408 24 0 0
t$perf-norm:sp_cancel_customer_reserve 664 664 0 0.00 0 1137 25 0 0
t$perf-norm:sp_cancel_pay_from_customer 680 680 0 0.00 0 1314 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 421 421 0 0.00 0 532 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 376 376 0 0.00 0 2175 30 0 0
t$perf-norm:sp_cancel_supplier_order 408 408 0 0.00 0 76509 6190 0 0
t$perf-norm:sp_cancel_write_off 924 924 0 0.00 0 3170 22 0 0
t$perf-norm:sp_client_order 20473 20473 0 0.00 0 9308 31 0 0
t$perf-norm:sp_customer_reserve 997 997 0 0.00 0 869 13 0 0
t$perf-norm:sp_pay_from_customer 6777 6777 0 0.00 0 6770 18 0 0
t$perf-norm:sp_pay_to_supplier 5763 5763 0 0.00 0 3787 16 0 0
t$perf-norm:sp_reserve_write_off 9793 9793 0 0.00 0 5919 20 0 0
t$perf-norm:sp_supplier_invoice 5450 5450 0 0.00 0 2449 24 0 0
t$perf-norm:sp_supplier_order 5461 5461 0 0.00 0 3289 27 0 0
t$perf-norm:srv_aggregate_perf_data 121 121 0 0.00 0 1216 34 0 0
t$perf-norm:srv_fill_mon_cache_memory 71 71 0 0.00 0 43 4 0 0
t$perf-norm:srv_make_invnt_saldo 510 510 0 0.00 0 552 9 0 0
t$perf-norm:srv_make_money_saldo 787 787 0 0.00 0 1718 7 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 4 301 130 0 0
v_add_invoice_to_stock 10134 9882 252 2.48 0 3690 22 0 252
v_all_customers 36674 36674 0 0.00 0 62 3 0 0
v_all_suppliers 30296 30296 0 0.00 0 130 4 0 0
v_all_wares 40938 40938 0 0.00 0 142 3 0 0
v_cancel_adding_invoice 818 818 0 0.00 0 2007 14 0 0
v_cancel_client_order 3358 3358 0 0.00 0 2023 8 0 0
v_cancel_customer_prepayment 1360 1360 0 0.00 0 2312 11 0 0
v_cancel_customer_reserve 1328 1328 0 0.00 0 1312 11 0 0
v_cancel_payment_to_supplier 842 842 0 0.00 0 600 9 0 0
v_cancel_supplier_invoice 780 752 28 3.58 0 1897 23 0 28
v_cancel_supplier_order 816 816 0 0.00 0 3659 22 0 0
v_cancel_write_off 1848 1848 0 0.00 0 2412 24 0 0
v_max_id_clo_ord 5457 5457 0 0.00 0 339 4 0 0
v_max_id_clo_res 997 997 0 0.00 0 1241 18 0 0
v_max_id_ord_sup 5440 5440 0 0.00 0 8903 8 0 0
v_max_non_paid_invoice 1510 1510 0 0.00 0 225 7 0 0
v_max_non_paid_realizn 3690 3690 0 0.00 0 3339 7 0 0
v_min_id_clo_ord 5457 5457 0 0.00 0 1428 6 0 0
v_min_id_clo_res 997 997 0 0.00 0 5608 15 0 0
v_min_id_ord_sup 5439 5439 0 0.00 0 6520 11 0 0
v_min_non_paid_invoice 5763 5763 0 0.00 0 3398 12 0 0
v_min_non_paid_realizn 6776 6776 0 0.00 0 7667 17 0 0
v_our_firm 10435 10435 0 0.00 0 70 4 0 0
v_reserve_write_off 19582 19582 0 0.00 0 7608 10 0 0
x_lock_depdocs_on_canc_invoice 11192 11192 0 0.00 0 12289 117 0 0
x_lock_depdocs_on_canc_sup_ord 408 408 0 0.00 0 2847 329 0 0
x_make_qstorno_1000_1200 5461 5461 0 0.00 2 86159 1333 0 0
x_make_qstorno_1200_2000 5449 5449 0 0.00 4 100062 2948 0 0
x_make_qstorno_2100_3300 460020 460020 0 0.00 0 111365 203 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 30-12-2022 07:38:46 to 30-12-2022 07:38:50.

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
05:07:23 2 8192000000 8801570096 8813862912 7025968 0.085 3 1 2 0 7127200 65456 35776
05:08:24 42389 8192000000 9741360304 10040811520 808608512 8.983 100 92 184 0 839501424 8306624 22586288
05:10:09 17517 8192000000 9770560640 10078167040 842728384 9.327 100 92 184 0 878162464 13698352 21735728
05:11:31 15446 8192000000 9807074368 10127228928 869558384 9.596 100 83 166 0 914029552 25546800 18924368
05:13:01 5987 8192000000 9860839808 10198011904 930021568 10.195 100 82 160 0 982316064 34548624 17745872
05:14:11 2686 8192000000 9952051488 10294882304 966959936 10.557 100 91 178 1 1060962576 76305248 17697392
05:15:15 815 8192000000 9965227184 10321072128 996324464 10.843 100 90 174 0 1086413440 71696288 18392688
05:16:18 959 8192000000 9998215328 10359463936 1024354880 11.114 100 93 179 0 1116960752 75013952 17591920
05:17:21 1131 8192000000 10018345120 10388865024 1045661296 11.319 100 97 184 2 1144470352 78408768 20400288
05:18:24 1144 8192000000 10027016272 10402406400 1056506224 11.423 100 96 184 2 1145363616 70476560 18380832
05:19:26 1341 8192000000 10011669504 10390749184 1061960960 11.475 100 93 175 2 1134959808 56340368 16658480
05:20:27 1343 8192000000 10025635296 10407964672 1069998944 11.552 100 85 166 3 1146510368 58413840 18097584
05:21:30 1081 8192000000 10064267184 10448957440 1075374080 11.603 100 95 188 1 1185012112 90234800 19403232
05:22:32 1138 8192000000 10038425984 10423816192 1080046256 11.648 100 93 183 0 1157322608 59234016 18042336
05:23:34 5415 8192000000 10053035216 10448359424 1083981632 11.685 100 60 120 0 1173940768 77810944 12148192
05:24:41 1200 8192000000 10050800480 10439221248 1097823184 11.817 100 86 165 2 1170566112 56132192 16610736
05:25:43 1150 8192000000 10049053904 10436292608 1097189584 11.811 100 96 183 3 1172639168 56823424 18626160
05:26:45 1277 8192000000 10068842896 10457751552 1097279136 11.812 100 95 187 2 1193139840 76308928 19551776
05:27:48 3562 8192000000 10048255040 10449129472 1095242096 11.792 100 66 129 2 1175878432 67471584 13164752
05:28:53 1242 8192000000 10036018688 10430087168 1096247840 11.802 100 83 161 0 1156338656 42897808 17193008
05:29:55 2886 8192000000 10020051344 10409635840 1089864976 11.741 100 72 132 2 1140537376 38314992 12357408
05:30:58 1150 8192000000 10029941840 10409037824 1066397904 11.518 100 96 188 2 1158218832 71883376 19937552
05:32:00 1389 8192000000 9981673280 10350583808 1032917200 11.197 99 90 170 3 1108264272 57050864 18296208
05:33:04 2051 8192000000 10007989408 10390675456 1047458624 11.336 100 69 128 4 1134533520 73493152 13581744
05:34:07 848 8192000000 10023051680 10400919552 1046707312 11.329 100 92 180 2 1146084720 81023088 18354320
05:35:14 4244 8192000000 9989237808 10370977792 1045401664 11.317 99 69 134 0 1104959680 45481952 14076064
05:36:23 1235 8192000000 9987231888 10359148544 1039537680 11.260 100 84 157 3 1105105600 49575632 15992288
05:37:33 19088 8192000000 9970302112 10356772864 1036499584 11.231 98 53 94 1 1093732704 47825312 9407808
05:39:00 8018 8192000000 10009119408 10397880320 1077794256 11.626 100 58 108 0 1132114320 42415488 11904576
05:40:14 2100 8192000000 10050590448 10432331776 1093101840 11.772 100 69 130 1 1168746256 62724736 12919680
05:41:25 12487 8192000000 10099382688 10493472768 1105534880 11.890 100 64 126 0 1217153136 98406400 13211856
05:42:52 6423 8192000000 10146322624 10544050176 1116746992 11.996 100 77 142 0 1264977584 133088048 15142544
05:44:04 7747 8192000000 10183475056 10587828224 1122235984 12.048 100 66 128 0 1301759888 165881584 13642320
05:45:18 3435 8192000000 10235254128 10639380480 1140284608 12.218 100 72 137 2 1352037536 196621280 15131648
05:46:28 3499 8192000000 10237849168 10636771328 1142792624 12.242 100 78 152 0 1350418816 189714928 17911264
05:47:36 1111 8192000000 10271097552 10667487232 1153150496 12.339 100 94 184 0 1383364592 209655952 20558144
05:48:38 830 8192000000 10298765008 10721951744 1160619024 12.409 100 98 189 1 1408996480 226610544 21766912
05:49:43 1484 8192000000 10311229296 10737987584 1174530400 12.539 100 90 175 2 1420837328 224537360 21769568
05:50:47 1144 8192000000 10357033216 10766819328 1188918208 12.673 100 99 194 0 1468120800 257073152 22129440
05:51:52 672 8192000000 10373784432 10810306560 1192192512 12.704 100 93 180 1 1484679072 270890016 21596544
05:52:55 4248 8192000000 10373902752 10801340416 1194434320 12.725 100 75 150 0 1505390256 292691664 18264272
05:54:03 4185 8192000000 10422366048 10862325760 1198080480 12.759 100 74 145 0 1527531488 311750624 17700384
05:55:11 9350 8192000000 10388272400 10838310912 1201054208 12.786 100 53 105 0 1496690176 282884416 12751552
05:56:25 6288 8192000000 10406051248 10834030592 1203903904 12.813 100 51 97 0 1517316016 301678896 11733216
05:57:35 744 8192000000 10496882352 10920226816 1209189264 12.862 100 91 176 0 1602996400 372760832 21046304
05:58:38 1491 8192000000 10532749808 10946859008 1217807376 12.941 100 82 158 3 1639078176 402042560 19228240
05:59:42 3643 8192000000 10527086896 10947809280 1184656016 12.634 98 62 123 2 1624786128 424755056 15375056
06:00:51 3926 8192000000 10583369232 11026771968 1195957760 12.739 99 58 116 0 1686896160 475966528 14971872
06:02:01 2304 8192000000 10580873120 11029467136 1191079456 12.693 99 64 120 1 1681963632 475351744 15532432
06:03:15 6576 8192000000 10585137424 11038846976 1183332368 12.621 100 48 96 0 1686433904 490264528 12837008
06:04:39 14444 8192000000 10514919984 11014148096 1159550336 12.399 98 44 88 1 1619651344 448130848 11970160
06:05:55 23265 8192000000 10400570816 10911453184 1168622416 12.484 100 46 92 3 1526760688 347271520 10866752
06:07:24 32875 8192000000 10310249456 10813091840 1115554432 11.985 96 23 44 0 1433860208 312557248 5748528
06:08:58 90763 8192000000 10048341600 10529366016 1038660592 11.252 92 11 22 0 1207114160 166016496 2437072
06:11:30 17032 8192000000 10057303120 10475806720 1129473616 12.116 100 53 97 2 1161117664 21765376 9878672
06:12:50 49905 8192000000 10091301568 10551062528 1143329664 12.247 100 22 43 0 1181935328 34994176 3611488
06:14:51 105120 8192000000 10117970464 10550689792 1112118656 11.952 97 30 56 2 1172246352 54504304 5623392
06:17:44 38209 8192000000 10086153040 10523185152 1117328720 12.002 98 45 88 0 1160588032 33792736 9466576
06:19:24 73371 8192000000 10109114128 10537000960 1124831056 12.073 98 58 98 1 1180055232 45722016 9502160
06:21:38 60757 8192000000 10183429904 10633175040 1142847984 12.242 99 30 60 0 1267817584 117679200 7290400
06:23:46 13037 8192000000 10237641984 10703261696 1151153648 12.320 100 56 103 0 1337573024 174270592 12148784
06:25:19 58850 8192000000 10146153792 10610438144 1135751984 12.176 99 20 40 0 1261163856 120537200 4874672
06:27:51 34744 8192000000 10136637776 10604740608 1134555056 12.164 100 13 26 0 1235283968 97847056 2881856
06:30:13 38738 8192000000 10086820128 10545885184 1117949984 12.008 99 23 46 0 1175616912 51826880 5840048
06:31:59 12522 8192000000 10098773088 10530508800 1119571936 12.023 99 51 102 0 1181961824 52072416 10317472
06:33:17 54294 8192000000 10079238320 10537279488 1109979968 11.932 99 29 58 1 1165180288 49334464 5865856
06:35:22 37595 8192000000 10111365216 10548944896 1130349216 12.125 100 36 72 0 1198908944 61640496 6919232
06:37:00 34085 8192000000 10090173856 10528100352 1112659296 11.958 99 42 82 1 1166376208 45407680 8309232
06:38:36 61293 8192000000 10123265040 10593701888 1133780672 12.157 100 24 48 0 1223380240 84926480 4673088
06:40:43 84431 8192000000 10088616256 10533580800 1119024480 12.018 98 44 82 3 1154192544 26114368 9053696
06:43:09 26430 8192000000 10085805728 10569437184 1141405008 12.229 100 26 51 0 1180893344 34052992 5435344
06:44:42 67227 8192000000 10101462016 10576740352 1138738592 12.204 100 13 25 0 1198235712 56216288 3280832
06:46:50 57752 8192000000 10120430128 10561716224 1135336864 12.172 99 30 59 0 1207010640 65124096 6549680
06:48:48 78820 8192000000 10098606960 10573115392 1103809856 11.874 96 14 28 0 1168154784 61227664 3117264
06:51:07 33525 8192000000 10125762608 10562117632 1150428144 12.314 100 45 88 1 1226672880 67099456 9145280
06:52:46 66880 8192000000 10172220400 10654769152 1155286928 12.359 100 24 48 0 1268960768 108400976 5272864
06:55:00 49273 8192000000 10150069840 10599542784 1132412272 12.144 98 22 42 0 1221933232 84472240 5048720
06:56:54 52303 8192000000 10158683296 10590932992 1093516048 11.776 95 23 46 0 1220654160 121857584 5280528
06:58:49 65900 8192000000 10162644960 10605088768 1128210880 12.104 99 26 50 0 1245883888 111912512 5760496
07:00:57 30493 8192000000 10059945168 10498838528 1109149824 11.924 98 24 46 0 1145729008 32075680 4503504
07:02:36 45434 8192000000 10089670688 10521800704 1112779200 11.959 99 53 105 0 1181239696 58225952 10234544
07:04:37 70263 8192000000 10051094112 10535677952 1084660160 11.692 98 6 12 0 1140492000 54543264 1288576
07:06:48 53641 8192000000 10056171424 10490023936 1077654928 11.625 96 24 46 0 1100679328 18073648 4950752
07:08:44 35966 8192000000 10104594752 10546524160 1125733408 12.081 100 32 62 0 1189243712 57170144 6340160
07:10:24 78105 8192000000 10133184048 10612555776 1121194720 12.038 98 27 54 0 1218171664 91122432 5854512
07:12:52 50954 8192000000 10094146528 10545229824 1125529168 12.079 99 23 46 0 1204344320 73858352 4956800
07:14:47 57136 8192000000 10104232304 10569924608 1096810928 11.807 97 20 40 0 1161017728 59957088 4249712
07:16:45 34747 8192000000 10119561472 10573983744 1111152464 11.943 98 35 70 1 1206555152 88367328 7035360
07:18:20 38248 8192000000 10095176896 10567835648 1119676576 12.024 99 47 90 0 1205469120 76077328 9715216
07:20:01 20874 8192000000 10095816976 10544254976 1103406016 11.870 98 40 77 0 1174940784 63411008 8123760
07:21:22 173034 8192000000 10078200560 10527027200 1072138880 11.573 95 39 75 1 1149437024 69479728 7818416
07:25:16 77771 8192000000 10043464384 10496155648 1097157648 11.811 97 15 30 0 1115208800 15103456 2947696
07:27:34 72407 8192000000 10058665696 10516836352 1119853408 12.026 100 14 27 1 1153040000 30559600 2626992
07:29:50 66683 8192000000 10047268368 10520440832 1117129360 12.000 99 16 31 0 1158231120 37892032 3209728
07:31:59 56742 8192000000 10120960352 10572726272 1139203712 12.208 100 24 48 0 1199950752 55268592 5478448
07:34:00 28528 8192000000 10105975312 10555088896 1132945440 12.149 99 17 32 0 1203179552 66634112 3600000
07:35:29 32326 8192000000 10159275472 10602995712 1132111392 12.141 99 37 70 0 1239412896 99488528 7812976
07:37:14 22958 8192000000 9113301376 9424224256 245235248 2.906 22 5 10 0 284605968 38393504 977216

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 30-12-2022 07:38:52 to 30-12-2022 07:39:08.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 126 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 30-12-2022 07:39:09 to 30-12-2022 07:39:11.

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          220119
MON$OLDEST_ACTIVE               220120
MON$OLDEST_SNAPSHOT             220120
MON$NEXT_TRANSACTION            220120
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                       2046176
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             772
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'

30.12.22 07:39:12. 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-30 07:39:14 No severe PSQL-related problems occured
30.12.22 07:39:16. End of report.