Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 22.02.2023 16:39
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 15326732 kB
MemAvailable 30398512 kB
Buffers 0 kB
Cached 16357984 kB
SwapCached 3140 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 3.0.11
DB_NAME                         /home/bases/oltp30-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/oltp30-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp30-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb30/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=3333
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/oltp30-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-oltp30
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-02-22 16:38:43
DTS_END                         2023-02-22 16:38:43.9190
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(57:17)
IP                              ::1/50136
TRN_ID                          239851
ATT_ID                          707
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: 9149.90 20287 1097988
customer order: creation 169.36 397 20323
customer order: refuse 14.53 362 1744
order to supplier: creation 45.16 1223 5419
order to supplier: removal 3.68 101464 441
invoice (draft): creation 44.97 3604 5396
invoice (draft): removal 52.44 779 6293
invoice accept: apply 41.36 17842 4963
invoice accept: cancel 47.38 823 5685
customer reserve: creation 3810.03 176 457203
customer reserve: removal 4625.14 63 555017
realization accept: apply 81.39 194 9767
realization accept: cancel 87.48 114 10497
payment from customer: creation 59.04 108 7085
payment from customer: removal 5.73 101 687
payment to supplier: creation 47.38 131 5685
payment to supplier: removal 3.21 93 385
service: total inventory turnovers 4.55 1292 546
service: total monetary turnovers 6.20 30 744
service: aggregate perf. data 0.87 19319 104
service: refresh index statistics 0.03 257629 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 22-02-2023 16:39:58 to 22-02-2023 16:40:00.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 1195
TEST_TIME 2 2768
TEST_TIME 3 3660
TEST_TIME 4 3285
TEST_TIME 5 4164
TEST_TIME 6 4527
TEST_TIME 7 4566
TEST_TIME 8 4476
TEST_TIME 9 4961
TEST_TIME 10 5059
TEST_TIME 11 5191
TEST_TIME 12 5408
TEST_TIME 13 5687
TEST_TIME 14 5708
TEST_TIME 15 6439
TEST_TIME 16 7112
TEST_TIME 17 7738
TEST_TIME 18 8114
TEST_TIME 19 7887
TEST_TIME 20 8023
TEST_TIME 21 8215
TEST_TIME 22 8244
TEST_TIME 23 8624
TEST_TIME 24 8463
TEST_TIME 25 9247
TEST_TIME 26 9550
TEST_TIME 27 9488
TEST_TIME 28 9622
TEST_TIME 29 9698
TEST_TIME 30 9470
TEST_TIME 31 10435
TEST_TIME 32 10412
TEST_TIME 33 10190
TEST_TIME 34 10258
TEST_TIME 35 10117
TEST_TIME 36 9914
TEST_TIME 37 9828
TEST_TIME 38 9873
TEST_TIME 39 9882
TEST_TIME 40 9737
TEST_TIME 41 9586
TEST_TIME 42 9483
TEST_TIME 43 9472
TEST_TIME 44 9456
TEST_TIME 45 9389
TEST_TIME 46 9427
TEST_TIME 47 9583
TEST_TIME 48 9464
TEST_TIME 49 9391
TEST_TIME 50 9328
TEST_TIME 51 9172
TEST_TIME 52 9164
TEST_TIME 53 9104
TEST_TIME 54 9039
TEST_TIME 55 8947
TEST_TIME 56 8967
TEST_TIME 57 8915
TEST_TIME 58 8881
TEST_TIME 59 8900
TEST_TIME 60 8927
TEST_TIME 61 8897
TEST_TIME 62 9022
TEST_TIME 63 9125
TEST_TIME 64 9174
TEST_TIME 65 9183
TEST_TIME 66 9164
TEST_TIME 67 9276
TEST_TIME 68 9221
TEST_TIME 69 9336
TEST_TIME 70 9373
TEST_TIME 71 9343
TEST_TIME 72 9283
TEST_TIME 73 9196
TEST_TIME 74 9244
TEST_TIME 75 9239
TEST_TIME 76 9196
TEST_TIME 77 9219
TEST_TIME 78 9155
TEST_TIME 79 9093
TEST_TIME 80 9159
TEST_TIME 81 9156
TEST_TIME 82 9137
TEST_TIME 83 9173
TEST_TIME 84 9190
TEST_TIME 85 9237
TEST_TIME 86 9224
TEST_TIME 87 9197
TEST_TIME 88 9239
TEST_TIME 89 9274
TEST_TIME 90 9245
TEST_TIME 91 9254
TEST_TIME 92 9317
TEST_TIME 93 9346
TEST_TIME 94 9343
TEST_TIME 95 9401
TEST_TIME 96 9345
TEST_TIME 97 9270
TEST_TIME 98 9252
TEST_TIME 99 9267
TEST_TIME 100 9256
TEST_TIME 101 9250
TEST_TIME 102 9222
TEST_TIME 103 9177
TEST_TIME 104 9118
TEST_TIME 105 9096
TEST_TIME 106 9120
TEST_TIME 107 9122
TEST_TIME 108 9130
TEST_TIME 109 9104
TEST_TIME 110 9177
TEST_TIME 111 9190
TEST_TIME 112 9188
TEST_TIME 113 9183
TEST_TIME 114 9158
TEST_TIME 115 9205
TEST_TIME 116 9196
TEST_TIME 117 9207
TEST_TIME 118 9247
TEST_TIME 119 9222
TEST_TIME 120 9151

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 22-02-2023 16:40:02 to 22-02-2023 16:40:05.

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 1521827 1521827 0 0.00 0 13591 6 0 0
doc_list_biud 1521827 1521827 0 0.00 0 66441 29 0 0
sp_add_invoice_to_stock 5103 4963 140 2.74 23 171643 17842 0 140
sp_cancel_adding_invoice 5685 5685 0 0.00 5 57696 824 0 0
sp_cancel_client_order 1744 1744 0 0.00 4 15095 362 0 0
sp_cancel_customer_reserve 555017 555017 0 0.00 0 36235 64 0 0
sp_cancel_pay_from_customer 687 687 0 0.00 3 7892 101 0 0
sp_cancel_pay_to_supplier 385 385 0 0.00 3 5672 93 0 0
sp_cancel_supplier_invoice 6305 6293 12 0.19 1 66458 780 0 12
sp_cancel_supplier_order 441 441 0 0.00 6 967554 101465 0 0
sp_cancel_write_off 10497 10497 0 0.00 1 18242 114 0 0
sp_client_order 20323 20323 0 0.00 3 37586 397 0 0
sp_customer_reserve 457203 457203 0 0.00 0 51285 177 0 0
sp_fill_shopping_cart 31126 31126 0 0.00 1 11405 41 0 0
sp_fill_shopping_cart_clo_res 457199 457199 0 0.00 0 26076 15 0 0
sp_get_clo_for_invoice 4958 4958 0 0.00 0 28473 324 0 0
sp_kill_cost_storno 17254 17254 0 0.00 0 7887 59 0 0
sp_kill_qstorno_ret_qs2qd 1127265 1127265 0 0.00 0 66430 34 0 0
sp_kill_qty_storno 594399 594399 0 0.00 0 66438 74 0 0
sp_lock_selected_doc 20406 20406 0 0.00 0 8570 8 0 0
sp_make_cost_storno 27492 27492 0 0.00 0 13583 56 0 0
sp_multiply_rows_for_pdistr 27492 27492 0 0.00 0 7881 24 0 0
sp_multiply_rows_for_qdistr 20323 20323 0 0.00 0 37534 178 0 0
sp_pay_from_customer 7085 7085 0 0.00 4 22516 108 0 0
sp_pay_to_supplier 5685 5685 0 0.00 4 15709 132 0 0
sp_payment_common 12770 12770 0 0.00 1 22466 33 0 0
sp_qd_handle_on_cancel_clo 1744 1744 0 0.00 0 15061 331 0 0
sp_qd_handle_on_invoice_upd_sts 10640 10640 0 0.00 0 35684 356 0 0
sp_qd_handle_on_reserve_upd_sts 9767 9767 0 0.00 0 17542 67 0 0
sp_reserve_write_off 9767 9767 0 0.00 5 17691 195 0 0
sp_supplier_invoice 5396 5396 0 0.00 6 84636 3604 0 0
sp_supplier_order 5419 5419 0 0.00 5 64927 1224 0 0
srv_aggregate_perf_data 105 104 1 0.95 2957 296679 19319 0 1
srv_fill_mon_cache_memory 65 65 0 0.00 963 144852 44851 0 0
srv_find_qd_qs_mism 1051200 1051200 0 0.00 0 12642 5 0 0
srv_make_invnt_saldo 546 546 0 0.00 19 103832 1292 0 0
srv_make_money_saldo 744 744 0 0.00 1 2731 30 0 0
srv_recalc_idx_stat 4 4 0 0.00 156016 384264 257629 0 0
t$perf-abend:sp_add_invoice_to_stock 140 140 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 12 12 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 4963 4963 0 0.00 0 18413 205 0 0
t$perf-norm:sp_cancel_adding_invoice 386 386 0 0.00 0 1818 69 0 0
t$perf-norm:sp_cancel_client_order 1744 1744 0 0.00 0 13012 19 0 0
t$perf-norm:sp_cancel_customer_reserve 670 670 0 0.00 0 886 7 0 0
t$perf-norm:sp_cancel_pay_from_customer 687 687 0 0.00 0 1207 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 385 385 0 0.00 0 1637 10 0 0
t$perf-norm:sp_cancel_supplier_invoice 400 400 0 0.00 0 1938 24 0 0
t$perf-norm:sp_cancel_supplier_order 441 441 0 0.00 0 45247 1760 0 0
t$perf-norm:sp_cancel_write_off 971 971 0 0.00 0 1080 9 0 0
t$perf-norm:sp_client_order 20323 20323 0 0.00 0 13665 20 0 0
t$perf-norm:sp_customer_reserve 938 938 0 0.00 0 1983 13 0 0
t$perf-norm:sp_pay_from_customer 7085 7085 0 0.00 0 7558 12 0 0
t$perf-norm:sp_pay_to_supplier 5685 5685 0 0.00 0 10373 17 0 0
t$perf-norm:sp_reserve_write_off 9767 9767 0 0.00 0 10111 15 0 0
t$perf-norm:sp_supplier_invoice 5396 5396 0 0.00 0 5836 23 0 0
t$perf-norm:sp_supplier_order 5419 5419 0 0.00 0 9696 20 0 0
t$perf-norm:srv_aggregate_perf_data 104 104 0 0.00 0 601 18 0 0
t$perf-norm:srv_fill_mon_cache_memory 65 65 0 0.00 0 581 10 0 0
t$perf-norm:srv_make_invnt_saldo 546 546 0 0.00 0 2964 28 0 0
t$perf-norm:srv_make_money_saldo 744 744 0 0.00 0 7729 27 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 5 3 0 0
v_add_invoice_to_stock 10190 9910 280 2.74 0 8570 20 0 280
v_all_customers 37144 37144 0 0.00 0 25 1 0 0
v_all_suppliers 29614 29614 0 0.00 0 29 1 0 0
v_all_wares 40646 40646 0 0.00 0 144 1 0 0
v_cancel_adding_invoice 772 772 0 0.00 0 13458 28 0 0
v_cancel_client_order 3488 3488 0 0.00 0 13462 9 0 0
v_cancel_customer_prepayment 1374 1374 0 0.00 0 4049 9 0 0
v_cancel_customer_reserve 1340 1340 0 0.00 0 6474 11 0 0
v_cancel_payment_to_supplier 770 770 0 0.00 0 4378 10 0 0
v_cancel_supplier_invoice 824 800 24 2.91 0 9668 29 0 24
v_cancel_supplier_order 882 882 0 0.00 0 2610 7 0 0
v_cancel_write_off 1942 1942 0 0.00 0 5387 20 0 0
v_max_id_clo_ord 5419 5419 0 0.00 0 3179 2 0 0
v_max_id_clo_res 938 938 0 0.00 0 2132 10 0 0
v_max_id_ord_sup 5382 5382 0 0.00 0 3511 3 0 0
v_max_non_paid_invoice 1679 1679 0 0.00 0 265 2 0 0
v_max_non_paid_realizn 3712 3712 0 0.00 0 2969 4 0 0
v_min_id_clo_ord 5419 5419 0 0.00 0 3195 7 0 0
v_min_id_clo_res 938 938 0 0.00 0 3245 14 0 0
v_min_id_ord_sup 5382 5382 0 0.00 0 6300 8 0 0
v_min_non_paid_invoice 5685 5685 0 0.00 0 13242 25 0 0
v_min_non_paid_realizn 7085 7085 0 0.00 0 22458 24 0 0
v_our_firm 10248 10248 0 0.00 0 13 1 0 0
v_reserve_write_off 19534 19534 0 0.00 0 13444 7 0 0
x_lock_depdocs_on_canc_invoice 11578 11578 0 0.00 0 11799 122 0 0
x_lock_depdocs_on_canc_sup_ord 441 441 0 0.00 0 7909 389 0 0
x_make_qstorno_1000_1200 5419 5419 0 0.00 1 64911 1140 0 0
x_make_qstorno_1200_2000 5396 5396 0 0.00 3 84493 3454 0 0
x_make_qstorno_2100_3300 457203 457203 0 0.00 0 42612 159 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 22-02-2023 16:40:06 to 22-02-2023 16:40:10.

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
14:08:47 9 8192000000 8799578240 8811216896 5307904 0.064 2 1 2 0 5407504 56816 42784
14:09:48 24628 8192000000 9896924800 10210287616 975630304 10.642 100 87 174 0 1004709488 5984080 23095104
14:11:17 22687 8192000000 9949933408 10268672000 1025389808 11.124 100 92 184 0 1057706288 8556752 23759728
14:12:58 15735 8192000000 9982509312 10317541376 1067100752 11.524 100 77 153 0 1095759968 9849680 18809536
14:14:25 8527 8192000000 10053100208 10399608832 1131709040 12.137 100 80 160 0 1161953136 11372736 18871360
14:15:40 4436 8192000000 10087388592 10449891328 1178858080 12.580 100 80 159 0 1210423728 13015104 18550544
14:16:50 2874 8192000000 10125135552 10493554688 1210596096 12.875 100 84 168 1 1241535072 12229504 18709472
14:17:55 1486 8192000000 10162957456 10538426368 1250951056 13.247 100 80 157 1 1280909456 13229328 16729072
14:18:57 989 8192000000 10196047040 10577108992 1286555136 13.573 100 85 170 0 1318381712 13146608 18679968
14:19:59 14234 8192000000 10189303392 10592346112 1297130784 13.669 100 48 95 0 1314828576 6552896 11144896
14:21:14 5769 8192000000 10202522448 10609377280 1304906736 13.740 100 34 67 0 1322751616 10495728 7349152
14:22:21 5974 8192000000 10202543312 10613211136 1311746048 13.802 100 25 51 1 1324362000 7386032 5229920
14:23:30 8256 8192000000 10203814672 10626306048 1322295280 13.897 100 22 45 0 1333592288 6483968 4813040
14:24:39 53029 8192000000 10226973008 10637803520 1326738176 13.938 100 46 92 0 1342869424 5234304 10896944
14:26:33 7434 8192000000 10229433104 10645884928 1336772192 14.028 100 20 40 0 1347310944 5989984 4548768
14:27:43 11839 8192000000 10208770752 10623574016 1298088992 13.678 97 13 26 1 1305790912 4934848 2767072
14:28:55 19533 8192000000 10169048176 10577457152 1233687872 13.088 95 18 36 0 1242041520 5040016 3313632
14:30:16 8472 8192000000 10161595392 10571067392 1252324256 13.260 98 14 27 0 1264596112 9285488 2986368
14:31:26 7052 8192000000 10137382208 10540548096 1228724288 13.042 98 27 52 0 1240752576 6435968 5592320
14:32:34 7242 8192000000 10142865520 10547896320 1247032224 13.211 99 23 46 1 1258307600 5779744 5495632
14:33:41 41279 8192000000 10172397360 10573078528 1273621440 13.455 100 36 70 1 1287237120 5214608 8401072
14:35:42 5493 8192000000 10192774368 10599510016 1294579824 13.646 100 31 61 0 1307564144 6382832 6601488
14:36:50 8484 8192000000 10198358288 10609098752 1306978160 13.759 100 25 48 1 1318504896 5842992 5683744
14:38:02 13724 8192000000 10210061392 10628542464 1321183504 13.887 100 23 47 1 1331540000 5471520 4884976
14:39:16 71190 8192000000 10242784256 10657865728 1338210576 14.041 100 36 71 0 1354976736 8851856 7914304
14:41:32 17181 8192000000 10279913520 10692022272 1365681776 14.288 100 55 108 0 1392183200 13588304 12913120
14:42:51 10572 8192000000 10294128432 10704470016 1373316832 14.357 100 64 128 1 1404456048 17079312 14059904
14:44:08 19093 8192000000 10294204288 10716823552 1381180224 14.427 100 48 96 1 1408074544 15362768 11531552
14:45:50 11407 8192000000 10308532592 10728820736 1385126848 14.462 99 42 84 0 1413097248 17886832 10083568
14:47:17 18134 8192000000 10316402672 10743107584 1387182000 14.481 99 47 93 0 1420838464 22144128 11512336
14:48:47 7351 8192000000 10322035104 10742321152 1393216592 14.535 100 46 91 1 1426491296 22098688 11176016
14:50:03 1655 8192000000 10333041728 10745511936 1392116832 14.525 99 75 141 3 1438016432 28880368 17019232
14:51:08 5156 8192000000 10342361440 10758139904 1402942384 14.621 100 61 120 1 1450199920 32739424 14518112
14:52:24 8016 8192000000 10326333952 10737393664 1364912800 14.281 99 59 118 0 1428108384 48284928 14910656
14:53:39 6146 8192000000 10317728224 10727686144 1365118768 14.283 100 70 140 0 1426309472 42378928 18811776
14:54:50 3858 8192000000 10335135376 10739417088 1380641408 14.422 100 77 148 0 1446521648 46408736 19471504
14:55:58 3300 8192000000 10315127248 10723094528 1368114080 14.310 100 75 148 0 1418422128 31581248 18726800
14:57:05 7503 8192000000 10317814000 10743877632 1388153824 14.489 100 36 73 0 1425976816 27787488 10035504
14:58:19 9336 8192000000 10319829968 10744647680 1374516208 14.367 99 43 86 0 1423956368 38124832 11315328
14:59:40 3742 8192000000 10338670112 10756468736 1385086256 14.462 100 62 122 1 1444129280 43348272 15694752
15:00:50 2254 8192000000 10357124560 10765201408 1388747104 14.495 100 87 174 2 1457719648 46969968 22002576
15:01:56 5449 8192000000 10344714736 10766512128 1388301488 14.491 100 55 107 1 1447265696 44334688 14629520
15:03:09 960 8192000000 10361631888 10768326656 1385293424 14.464 100 84 169 1 1462053952 54342656 22417872
15:04:12 9494 8192000000 10324391280 10759688192 1377535440 14.395 100 34 68 1 1429379552 42627280 9216832
15:05:23 21225 8192000000 10330628064 10762649600 1375572992 14.377 99 27 54 1 1428471904 45667952 7230960
15:06:45 52197 8192000000 10312282064 10738057216 1348934784 14.138 98 36 72 0 1405430720 46503136 9992800
15:09:52 22203 8192000000 10266391632 10715123712 1359498608 14.233 100 20 38 1 1378450352 14961296 3990448
15:11:22 58391 8192000000 10298649488 10737881088 1375566896 14.377 100 25 45 1 1398661792 18341840 4753056
15:13:21 105353 8192000000 10305770416 10738364416 1367370368 14.303 99 16 33 0 1378486768 7744192 3372208
15:16:08 93154 8192000000 10287719344 10747854848 1371696064 14.342 99 11 22 0 1393612208 19604496 2311648
15:18:43 63289 8192000000 10317949504 10760503296 1394483760 14.546 100 37 72 2 1412619216 9403984 8731472
15:20:56 5259 8192000000 10311958544 10760769536 1403069680 14.622 100 24 48 1 1421104272 12702544 5332048
15:22:08 31578 8192000000 10295331200 10750943232 1367824416 14.308 98 14 28 0 1387838896 16730816 3283664
15:23:53 32584 8192000000 10289477424 10739220480 1382918272 14.443 99 31 61 0 1404040496 13524000 7598224
15:25:26 22841 8192000000 10297168400 10774011904 1392062032 14.524 100 5 10 0 1410362320 17415376 884912
15:26:49 52843 8192000000 10291990768 10751197184 1399944512 14.595 100 16 32 0 1416556000 12656992 3954496
15:28:42 96117 8192000000 10291636512 10748678144 1375454912 14.376 98 23 46 1 1387463456 5978592 6029952
15:31:22 61866 8192000000 10278857616 10746257408 1382157920 14.436 99 12 23 0 1392451232 8135840 2157472
15:33:24 92353 8192000000 10281355152 10758119424 1384296736 14.455 99 11 23 0 1403108592 16202752 2609104
15:36:02 43517 8192000000 10295138752 10759565312 1396526528 14.564 100 11 22 0 1408268208 9280080 2461600
15:37:46 59023 8192000000 10284937712 10749509632 1364572672 14.278 98 16 32 0 1379917312 11386656 3957984
15:39:45 71604 8192000000 10294958704 10759897088 1381333264 14.428 99 16 32 0 1397193104 11934592 3925248
15:41:58 126741 8192000000 10290321872 10743705600 1297864304 13.676 93 15 30 0 1311987632 10623936 3499392
15:45:08 44317 8192000000 10307568544 10770829312 1379443984 14.412 99 17 34 0 1403858848 20534544 3880320
15:47:01 119194 8192000000 10282985584 10743992320 1322114720 13.896 95 13 26 0 1337896384 12718368 3063296
15:50:00 144852 8192000000 10282060960 10730024960 1340106000 14.058 97 39 78 1 1363729232 14163616 9459616
15:53:34 32639 8192000000 10268912096 10731225088 1337951744 14.039 98 20 40 0 1355507104 13591680 3963680
15:55:07 61114 8192000000 10256204592 10713452544 1335266784 14.015 98 11 22 1 1350146832 12495376 2384672
15:57:08 43198 8192000000 10267111312 10724155392 1355705920 14.199 99 13 27 0 1374523632 15591472 3226240
15:58:51 83455 8192000000 10260389584 10722881536 1333105120 13.995 98 16 31 0 1351648000 15288832 3254048
16:01:36 54488 8192000000 10267563056 10713055232 1317401712 13.853 96 21 42 0 1334881008 12515120 4964176
16:03:33 49216 8192000000 10245729344 10706685952 1315110512 13.832 97 4 8 0 1325042304 9113952 817840
16:05:33 19638 8192000000 10262262240 10699444224 1329088880 13.959 98 39 78 0 1349432384 12113232 8230272
16:06:55 89597 8192000000 10270141328 10711539712 1346191648 14.113 99 25 51 0 1361775712 10334672 5249392
16:09:25 10665 8192000000 10297453920 10733727744 1378268000 14.401 100 37 72 0 1397942096 11306736 8367360
16:10:36 84872 8192000000 10284225760 10736771072 1341759680 14.073 97 6 12 0 1357787216 14965664 1061872
16:13:09 97014 8192000000 10287568864 10736967680 1371745968 14.343 99 12 23 0 1383577088 9587776 2243344
16:15:46 81620 8192000000 10289285184 10746003456 1384981744 14.461 99 44 88 0 1408189856 12503600 10704512
16:19:06 41431 8192000000 10287497040 10749083648 1387488160 14.483 99 15 30 1 1398213840 7568928 3156752
16:20:52 71615 8192000000 10292370048 10757849088 1364805920 14.280 97 5 10 0 1378399008 12434784 1158304
16:23:07 61549 8192000000 10301220768 10768748544 1397266448 14.571 100 17 34 0 1413459008 12030512 4162048
16:25:10 39676 8192000000 10288795616 10745331712 1369585008 14.323 98 18 37 0 1381429696 7766272 4078416
16:26:51 48660 8192000000 10272873216 10728624128 1346662080 14.117 97 14 28 0 1358771984 8941824 3168080
16:28:40 33151 8192000000 10261166992 10704191488 1329498160 13.963 96 22 45 0 1341847424 7426048 4923216
16:30:14 60576 8192000000 10272055424 10726301696 1324923808 13.921 96 17 34 0 1336796912 8245328 3627776
16:32:19 17527 8192000000 10300425104 10737733632 1363799408 14.271 99 44 88 0 1384177488 10367264 10010816
16:33:39 83097 8192000000 10281020800 10737696768 1340944000 14.066 97 27 54 2 1358071200 11775088 5352112
16:36:04 46535 8192000000 10273205904 10733125632 1316434656 13.844 95 11 22 1 1331290240 12553488 2302096
16:37:53 61623 8192000000 9028595904 9240227840 178423392 2.131 13 3 6 0 179811680 794592 593696

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 22-02-2023 16:40:12 to 22-02-2023 16:40:28.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 140 v_add_invoice_to_stock 335544517
except 12 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 22-02-2023 16:40:29 to 22-02-2023 16:40:31.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp30-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   12
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          240208
MON$OLDEST_ACTIVE               240209
MON$OLDEST_SNAPSHOT             240209
MON$NEXT_TRANSACTION            240209
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-03 16:41:55.3470
MON$PAGES                       2026784
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


ISQL Version: LI-V3.0.11.33665 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33665 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33665 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33665 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
on disk structure version 12.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-oltp30 according to config parameter 'remove_isql_logs'

22.02.23 16:40:32. There are 3 logs in /var/tmp/logs-oltp30 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-02-22 16:40:34 No severe PSQL-related problems occured
22.02.23 16:40:36. End of report.