Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 18.03.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 15479600 kB
MemAvailable 30438728 kB
Buffers 0 kB
Cached 16210596 kB
SwapCached 3388 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-03-18 16:38:44
DTS_END                         2023-03-18 16:38:44.0830
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/52006
TRN_ID                          237504
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: 9196.97 24176 1103636
customer order: creation 169.53 405 20344
customer order: refuse 14.83 344 1779
order to supplier: creation 44.57 1233 5348
order to supplier: removal 3.24 130441 389
invoice (draft): creation 44.93 3212 5392
invoice (draft): removal 52.58 956 6309
invoice accept: apply 40.30 19189 4836
invoice accept: cancel 47.08 882 5649
customer reserve: creation 3811.01 185 457321
customer reserve: removal 4674.38 71 560926
realization accept: apply 82.08 193 9850
realization accept: cancel 84.18 119 10102
payment from customer: creation 58.60 114 7032
payment from customer: removal 5.82 85 698
payment to supplier: creation 48.13 139 5775
payment to supplier: removal 3.43 81 411
service: total inventory turnovers 4.78 1112 573
service: total monetary turnovers 6.65 42 798
service: aggregate perf. data 0.83 19871 100
service: refresh index statistics 0.03 304851 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 18-03-2023 16:39:32 to 18-03-2023 16:39:34.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2468
TEST_TIME 2 3469
TEST_TIME 3 4463
TEST_TIME 4 4279
TEST_TIME 5 4389
TEST_TIME 6 4648
TEST_TIME 7 4802
TEST_TIME 8 4719
TEST_TIME 9 5119
TEST_TIME 10 5157
TEST_TIME 11 5030
TEST_TIME 12 5101
TEST_TIME 13 5291
TEST_TIME 14 5996
TEST_TIME 15 6188
TEST_TIME 16 6482
TEST_TIME 17 6526
TEST_TIME 18 6459
TEST_TIME 19 6474
TEST_TIME 20 6511
TEST_TIME 21 7132
TEST_TIME 22 7588
TEST_TIME 23 7836
TEST_TIME 24 8420
TEST_TIME 25 8657
TEST_TIME 26 9318
TEST_TIME 27 11130
TEST_TIME 28 11045
TEST_TIME 29 10728
TEST_TIME 30 10551
TEST_TIME 31 10416
TEST_TIME 32 10233
TEST_TIME 33 9986
TEST_TIME 34 9869
TEST_TIME 35 9988
TEST_TIME 36 9959
TEST_TIME 37 9775
TEST_TIME 38 9595
TEST_TIME 39 9590
TEST_TIME 40 9665
TEST_TIME 41 9591
TEST_TIME 42 9485
TEST_TIME 43 9661
TEST_TIME 44 9616
TEST_TIME 45 9517
TEST_TIME 46 9592
TEST_TIME 47 9530
TEST_TIME 48 9458
TEST_TIME 49 9621
TEST_TIME 50 9587
TEST_TIME 51 9660
TEST_TIME 52 9633
TEST_TIME 53 9575
TEST_TIME 54 9485
TEST_TIME 55 9441
TEST_TIME 56 9395
TEST_TIME 57 9341
TEST_TIME 58 9325
TEST_TIME 59 9233
TEST_TIME 60 9219
TEST_TIME 61 9160
TEST_TIME 62 9168
TEST_TIME 63 9201
TEST_TIME 64 9165
TEST_TIME 65 9197
TEST_TIME 66 9363
TEST_TIME 67 9381
TEST_TIME 68 9356
TEST_TIME 69 9342
TEST_TIME 70 9351
TEST_TIME 71 9407
TEST_TIME 72 9404
TEST_TIME 73 9378
TEST_TIME 74 9422
TEST_TIME 75 9518
TEST_TIME 76 9467
TEST_TIME 77 9483
TEST_TIME 78 9393
TEST_TIME 79 9320
TEST_TIME 80 9344
TEST_TIME 81 9332
TEST_TIME 82 9311
TEST_TIME 83 9249
TEST_TIME 84 9196
TEST_TIME 85 9229
TEST_TIME 86 9193
TEST_TIME 87 9182
TEST_TIME 88 9168
TEST_TIME 89 9131
TEST_TIME 90 9139
TEST_TIME 91 9133
TEST_TIME 92 9136
TEST_TIME 93 9180
TEST_TIME 94 9221
TEST_TIME 95 9232
TEST_TIME 96 9187
TEST_TIME 97 9230
TEST_TIME 98 9234
TEST_TIME 99 9258
TEST_TIME 100 9279
TEST_TIME 101 9288
TEST_TIME 102 9268
TEST_TIME 103 9350
TEST_TIME 104 9349
TEST_TIME 105 9272
TEST_TIME 106 9230
TEST_TIME 107 9186
TEST_TIME 108 9219
TEST_TIME 109 9182
TEST_TIME 110 9123
TEST_TIME 111 9127
TEST_TIME 112 9099
TEST_TIME 113 9095
TEST_TIME 114 9115
TEST_TIME 115 9184
TEST_TIME 116 9165
TEST_TIME 117 9192
TEST_TIME 118 9232
TEST_TIME 119 9217
TEST_TIME 120 9198

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 18-03-2023 16:39:36 to 18-03-2023 16:39:39.

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 1526894 1526894 0 0.00 0 26092 6 0 0
doc_list_biud 1526890 1526890 0 0.00 0 66543 33 0 0
sp_add_invoice_to_stock 5005 4836 169 3.37 23 244542 19190 0 169
sp_cancel_adding_invoice 5649 5649 0 0.00 4 74229 883 0 0
sp_cancel_client_order 1779 1779 0 0.00 3 14264 345 0 0
sp_cancel_customer_reserve 560926 560926 0 0.00 0 66545 71 0 0
sp_cancel_pay_from_customer 698 698 0 0.00 3 6294 85 0 0
sp_cancel_pay_to_supplier 411 411 0 0.00 2 4255 81 0 0
sp_cancel_supplier_invoice 6321 6309 12 0.18 1 17522 957 0 12
sp_cancel_supplier_order 389 389 0 0.00 8 1258783 130442 0 0
sp_cancel_write_off 10102 10102 0 0.00 1 17947 119 0 0
sp_client_order 20344 20344 0 0.00 3 50802 405 0 0
sp_customer_reserve 457321 457321 0 0.00 0 41939 186 0 0
sp_fill_shopping_cart 31073 31073 0 0.00 1 16094 38 0 0
sp_fill_shopping_cart_clo_res 457319 457319 0 0.00 0 18203 15 0 0
sp_get_clo_for_invoice 4833 4833 0 0.00 0 18238 333 0 0
sp_kill_cost_storno 16860 16860 0 0.00 0 12805 59 0 0
sp_kill_qstorno_ret_qs2qd 1138652 1138652 0 0.00 0 66539 39 0 0
sp_kill_qty_storno 599834 599834 0 0.00 0 66542 83 0 0
sp_lock_selected_doc 20393 20393 0 0.00 0 7472 7 0 0
sp_make_cost_storno 27489 27489 0 0.00 0 10918 53 0 0
sp_multiply_rows_for_pdistr 27487 27487 0 0.00 0 26079 28 0 0
sp_multiply_rows_for_qdistr 20344 20344 0 0.00 0 50791 181 0 0
sp_pay_from_customer 7032 7032 0 0.00 4 13091 115 0 0
sp_pay_to_supplier 5775 5775 0 0.00 4 26096 139 0 0
sp_payment_common 12806 12806 0 0.00 1 11503 25 0 0
sp_qd_handle_on_cancel_clo 1779 1779 0 0.00 0 14256 315 0 0
sp_qd_handle_on_invoice_upd_sts 10480 10480 0 0.00 0 40843 375 0 0
sp_qd_handle_on_reserve_upd_sts 9849 9849 0 0.00 0 24357 70 0 0
sp_reserve_write_off 9850 9850 0 0.00 6 24566 194 0 0
sp_supplier_invoice 5392 5392 0 0.00 6 87020 3212 0 0
sp_supplier_order 5348 5348 0 0.00 5 46241 1234 0 0
srv_aggregate_perf_data 101 100 1 0.99 2878 229768 19871 0 1
srv_fill_mon_cache_memory 64 64 0 0.00 1011 128039 45846 0 0
srv_find_qd_qs_mism 1056409 1056409 0 0.00 0 14509 6 0 0
srv_make_invnt_saldo 573 573 0 0.00 19 51255 1112 0 0
srv_make_money_saldo 798 798 0 0.00 0 13583 43 0 0
srv_recalc_idx_stat 4 4 0 0.00 146366 587707 304851 0 0
t$perf-abend:sp_add_invoice_to_stock 169 169 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 4836 4836 0 0.00 0 20182 189 0 0
t$perf-norm:sp_cancel_adding_invoice 387 387 0 0.00 0 7474 115 0 0
t$perf-norm:sp_cancel_client_order 1779 1779 0 0.00 0 20531 21 0 0
t$perf-norm:sp_cancel_customer_reserve 664 664 0 0.00 0 10463 35 0 0
t$perf-norm:sp_cancel_pay_from_customer 698 698 0 0.00 0 12136 26 0 0
t$perf-norm:sp_cancel_pay_to_supplier 411 411 0 0.00 0 2189 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 414 414 0 0.00 0 2128 15 0 0
t$perf-norm:sp_cancel_supplier_order 389 389 0 0.00 0 16669 1558 0 0
t$perf-norm:sp_cancel_write_off 972 972 0 0.00 0 3336 6 0 0
t$perf-norm:sp_client_order 20344 20344 0 0.00 0 17490 20 0 0
t$perf-norm:sp_customer_reserve 973 973 0 0.00 0 5101 23 0 0
t$perf-norm:sp_pay_from_customer 7032 7032 0 0.00 0 19692 13 0 0
t$perf-norm:sp_pay_to_supplier 5775 5775 0 0.00 0 10676 12 0 0
t$perf-norm:sp_reserve_write_off 9850 9850 0 0.00 0 22695 15 0 0
t$perf-norm:sp_supplier_invoice 5392 5392 0 0.00 0 16500 31 0 0
t$perf-norm:sp_supplier_order 5348 5348 0 0.00 0 3339 14 0 0
t$perf-norm:srv_aggregate_perf_data 100 100 0 0.00 0 323 8 0 0
t$perf-norm:srv_fill_mon_cache_memory 64 64 0 0.00 0 10 0 0 0
t$perf-norm:srv_make_invnt_saldo 573 573 0 0.00 0 1291 25 0 0
t$perf-norm:srv_make_money_saldo 798 798 0 0.00 0 2195 20 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 2 2 0 0
v_add_invoice_to_stock 9998 9660 338 3.38 0 8336 23 0 338
v_all_customers 37344 37344 0 0.00 0 19 0 0 0
v_all_suppliers 29772 29772 0 0.00 0 28 1 0 0
v_all_wares 40688 40688 0 0.00 0 255 1 0 0
v_cancel_adding_invoice 774 774 0 0.00 0 3570 16 0 0
v_cancel_client_order 3558 3558 0 0.00 0 4992 8 0 0
v_cancel_customer_prepayment 1396 1396 0 0.00 0 3095 9 0 0
v_cancel_customer_reserve 1328 1328 0 0.00 0 2194 9 0 0
v_cancel_payment_to_supplier 822 822 0 0.00 0 2478 12 0 0
v_cancel_supplier_invoice 852 828 24 2.81 0 4990 22 0 24
v_cancel_supplier_order 778 778 0 0.00 0 5515 11 0 0
v_cancel_write_off 1944 1944 0 0.00 0 5251 22 0 0
v_max_id_clo_ord 5346 5346 0 0.00 0 387 1 0 0
v_max_id_clo_res 973 973 0 0.00 0 5201 29 0 0
v_max_id_ord_sup 5382 5382 0 0.00 0 4489 3 0 0
v_max_non_paid_invoice 1616 1616 0 0.00 0 4502 7 0 0
v_max_non_paid_realizn 3676 3676 0 0.00 0 1869 4 0 0
v_min_id_clo_ord 5346 5346 0 0.00 0 3824 6 0 0
v_min_id_clo_res 973 973 0 0.00 0 7027 30 0 0
v_min_id_ord_sup 5382 5382 0 0.00 0 5733 8 0 0
v_min_non_paid_invoice 5774 5774 0 0.00 0 6751 14 0 0
v_min_non_paid_realizn 7032 7032 0 0.00 0 7015 18 0 0
v_our_firm 10056 10056 0 0.00 0 17 1 0 0
v_reserve_write_off 19696 19696 0 0.00 0 10701 9 0 0
x_lock_depdocs_on_canc_invoice 11544 11544 0 0.00 0 16239 129 0 0
x_lock_depdocs_on_canc_sup_ord 389 389 0 0.00 0 9677 419 0 0
x_make_qstorno_1000_1200 5348 5348 0 0.00 1 46231 1168 0 0
x_make_qstorno_1200_2000 5392 5392 0 0.00 3 86990 3063 0 0
x_make_qstorno_2100_3300 457320 457320 0 0.00 0 41177 168 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 18-03-2023 16:39:40 to 18-03-2023 16:39:44.

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 2 8192000000 8799599504 8811024384 5852176 0.071 2 1 2 0 5951808 56848 42784
14:09:49 19576 8192000000 9892940688 10202644480 978203824 10.667 100 84 168 0 1006202416 5328768 22669824
14:11:17 28617 8192000000 9953286160 10273157120 1032565328 11.193 100 92 184 0 1063900720 7510000 23825392
14:13:06 6504 8192000000 9986624112 10321711104 1074947072 11.599 100 78 156 0 1102909264 8804656 19157536
14:14:18 6176 8192000000 10044160288 10394406912 1133405552 12.153 100 79 157 0 1162192848 10092928 18694368
14:15:27 3762 8192000000 10091727136 10450964480 1175074256 12.544 100 81 160 0 1206183664 13077440 18031968
14:16:37 3004 8192000000 10126555904 10493390848 1217689696 12.940 100 76 151 0 1247254272 12795488 16769088
14:17:43 2263 8192000000 10164252816 10539044864 1245498272 13.197 100 83 161 2 1278884560 16346400 17039888
14:18:49 1450 8192000000 10204174064 10584379392 1287654304 13.583 100 92 184 0 1322860608 14314336 20891968
14:19:53 6963 8192000000 10197541968 10596167680 1300411632 13.699 100 78 157 1 1330565728 12237376 17916720
14:21:01 1731 8192000000 10202316128 10605314048 1312524592 13.809 100 37 74 1 1329411712 8655136 8231984
14:22:03 5504 8192000000 10202265072 10621161472 1324112288 13.914 100 18 36 0 1334818320 6983280 3722752
14:23:09 66520 8192000000 10223474240 10643218432 1329926224 13.966 100 30 60 0 1343452288 6185232 7340832
14:25:16 7798 8192000000 10236467520 10657214464 1337745728 14.037 100 27 54 0 1358532432 14669216 6117488
14:26:26 7591 8192000000 10224878816 10648186880 1325409488 13.926 99 22 44 0 1336159440 5574592 5175360
14:27:34 12627 8192000000 10229840240 10650976256 1338042896 14.040 100 20 38 0 1348651568 4968656 5640016
14:28:47 11373 8192000000 10210994576 10638397440 1309607744 13.783 98 28 56 0 1322496832 6555456 6333632
14:30:04 4611 8192000000 10160087248 10562392064 1228054960 13.036 95 22 45 1 1238049120 4986160 5008000
14:31:10 7356 8192000000 10146765744 10542002176 1236131680 13.111 99 17 33 0 1245056688 4960032 3964976
14:32:19 6156 8192000000 10132328896 10535403520 1236798672 13.117 99 11 22 0 1244233040 5026800 2407568
14:33:25 34008 8192000000 10147025152 10546130944 1196257200 12.742 95 24 47 0 1207262192 5546720 5458272
14:35:01 5626 8192000000 10181378272 10590146560 1289153328 13.597 100 25 48 1 1300504464 5467088 5884048
14:36:08 8862 8192000000 10201132080 10609520640 1302440128 13.717 100 20 40 0 1313041760 5280320 5321312
14:37:19 69875 8192000000 10211242960 10629951488 1315425776 13.835 100 40 80 0 1333083344 8931696 8725872
14:39:39 5877 8192000000 10250271664 10657882112 1339691792 14.055 100 54 104 1 1361612768 10360096 11560880
14:40:51 11444 8192000000 10264202160 10679652352 1356179008 14.203 100 51 99 0 1378872960 11636720 11057232
14:42:13 12022 8192000000 10289863312 10709835776 1374934240 14.371 100 52 102 0 1400803136 12804288 13064608
14:43:51 9938 8192000000 10321261776 10736197632 1398869376 14.585 100 58 113 1 1433071872 20677040 13525456
14:45:07 13533 8192000000 10332787056 10754572288 1405668592 14.645 100 50 99 0 1443510800 26042144 11800064
14:46:41 4575 8192000000 10352627136 10771951616 1418393968 14.758 100 60 117 1 1459032112 26276608 14361536
14:47:50 1917 8192000000 10366261760 10786652160 1428193616 14.845 100 64 127 0 1473204416 29420704 15590096
14:48:56 3397 8192000000 10379836160 10806300672 1439039248 14.941 100 61 120 1 1492757584 38251840 15466496
14:50:03 7015 8192000000 10390086320 10810716160 1440251328 14.952 100 65 125 0 1499258064 43555808 15450928
14:51:16 4320 8192000000 10361032160 10770788352 1388467264 14.492 98 73 145 1 1457629136 51246400 17915472
14:52:26 4222 8192000000 10374878992 10788646912 1409162224 14.676 99 72 138 1 1482127808 54993520 17972064
14:53:37 1010 8192000000 10393043200 10801016832 1418323664 14.758 100 83 166 0 1497798752 58391376 21083712
14:54:42 1049 8192000000 10390366800 10797182976 1403393600 14.625 99 89 176 0 1485523616 60718016 21412000
14:55:47 1767 8192000000 10409296976 10817142784 1424837760 14.816 100 84 168 0 1512777792 66450432 21489600
14:56:54 1850 8192000000 10411155056 10818682880 1419578112 14.769 100 78 156 1 1513891776 73429104 20884560
14:58:02 3351 8192000000 10417748080 10825768960 1419446752 14.768 100 79 157 1 1520644928 80511744 20686432
14:59:10 2305 8192000000 10418411712 10831843328 1413095760 14.711 100 73 147 0 1522493872 89158816 20239296
15:00:24 4090 8192000000 10410133504 10836393984 1409093504 14.676 99 55 107 1 1505169792 80537088 15539200
15:01:36 20817 8192000000 10383059008 10817163264 1405149184 14.641 100 37 74 0 1486354720 70101344 11104192
15:03:04 7076 8192000000 10362530448 10810982400 1382269888 14.437 100 33 66 0 1470577680 78017280 10290512
15:04:39 26308 8192000000 10346696080 10801823744 1365701728 14.289 100 23 46 0 1447534480 74672480 7160272
15:06:06 70999 8192000000 10264997776 10711519232 1348107936 14.130 98 17 31 2 1361831440 10534000 3189504
15:08:19 36467 8192000000 10257685136 10695094272 1347999520 14.129 98 29 58 0 1363455824 9000624 6455680
15:10:02 45062 8192000000 10260548192 10710609920 1358725616 14.226 98 9 18 0 1367845104 7059056 2060432
15:11:48 66341 8192000000 10295905712 10747211776 1373361392 14.357 99 15 30 0 1391118448 14129120 3627936
15:14:25 80982 8192000000 10306757088 10756743168 1381762224 14.432 99 19 37 0 1403550896 17588464 4200208
15:17:28 78606 8192000000 10291733040 10753847296 1355330448 14.195 97 21 42 0 1369933872 9712352 4891072
15:19:47 65027 8192000000 10267823152 10717163520 1301023632 13.705 94 28 54 0 1317066432 9589136 6453664
15:21:57 46159 8192000000 10268847248 10722193408 1339805904 14.056 98 12 24 0 1353199856 11056720 2337232
15:23:44 33772 8192000000 10289870880 10730471424 1368744560 14.316 100 39 78 0 1390184464 12571920 8867984
15:25:25 55042 8192000000 10300123648 10744516608 1368035600 14.309 99 34 68 3 1385099168 8740176 8323392
15:27:21 58994 8192000000 10292626928 10744266752 1374841344 14.370 99 17 34 1 1393010784 14174336 3995104
15:29:52 76269 8192000000 10309413760 10766331904 1382910320 14.443 99 15 30 0 1401770720 15626224 3234176
15:32:09 12097 8192000000 10324809248 10764505088 1401338560 14.607 100 44 88 0 1422219600 11096016 9785024
15:33:22 114432 8192000000 10304048016 10772017152 1390410128 14.510 99 19 38 0 1407261648 12046752 4804768
15:36:19 54836 8192000000 10288572240 10753490944 1372230528 14.347 98 14 28 0 1383239520 7657712 3351280
15:38:14 49044 8192000000 10276995376 10739388416 1372966368 14.354 98 11 22 0 1385718304 10049056 2702880
15:40:05 69995 8192000000 10275364704 10744164352 1362004880 14.255 98 21 40 0 1382592496 16252240 4335376
15:42:19 60967 8192000000 10281165472 10732736512 1314735088 13.829 95 17 32 1 1334198256 15952240 3510928
15:44:23 75437 8192000000 10266102992 10731724800 1289365968 13.598 94 10 20 0 1309909552 17681664 2861920
15:46:40 21568 8192000000 10286589760 10722291712 1370430672 14.331 100 60 115 1 1392042816 8226704 13385440
15:48:01 66737 8192000000 10254403072 10702557184 1286285744 13.570 95 16 32 0 1306721376 16875616 3560016
15:50:32 92008 8192000000 10278042672 10727202816 1352650784 14.171 99 16 32 0 1370224880 13755584 3818512
15:53:28 58695 8192000000 10256823616 10698059776 1305969072 13.749 96 11 22 0 1321226192 12726976 2530144
15:55:31 36762 8192000000 10287558656 10724110336 1362932512 14.264 100 40 80 0 1382740080 11004848 8802720
15:57:08 121429 8192000000 10262351152 10725322752 1328567472 13.954 97 31 62 0 1350330912 14860832 6902608
16:00:09 74970 8192000000 10251755504 10709172224 1321099072 13.887 97 8 16 0 1330511088 7781872 1630144
16:02:24 76022 8192000000 10274634640 10736599040 1370267936 14.329 100 11 22 0 1383660160 10639424 2752800
16:04:50 43693 8192000000 10263720880 10723041280 1348476944 14.134 98 19 38 1 1363226576 9935552 4814080
16:06:41 73829 8192000000 10270634336 10730565632 1350881264 14.155 99 5 10 0 1360265712 8213952 1170496
16:08:58 42865 8192000000 10269068496 10725339136 1333116192 13.995 97 13 26 0 1342444448 6747888 2580368
16:10:41 52534 8192000000 10287188800 10743083008 1367261312 14.303 99 27 54 0 1383983360 9625184 7096864
16:12:34 111752 8192000000 10313743888 10768605184 1383397552 14.447 99 23 46 0 1399056064 10210368 5448144
16:15:34 58539 8192000000 10290604496 10740899840 1333277792 13.997 96 13 26 0 1355040656 19183616 2579248
16:17:33 29566 8192000000 10291388080 10738737152 1374226528 14.365 100 39 78 0 1394672880 11941792 8504560
16:19:12 22197 8192000000 10292103600 10736799744 1354894976 14.191 98 35 70 3 1372470512 9112560 8462976
16:20:36 49145 8192000000 10296351136 10748452864 1329988432 13.967 96 26 52 0 1354739440 18803328 5947680
16:22:25 122544 8192000000 10271315648 10726367232 1338082272 14.040 97 24 46 0 1354955728 11483232 5390224
16:25:28 68173 8192000000 10285631472 10747756544 1378620176 14.404 100 14 28 0 1398617600 16506576 3490848
16:27:45 73527 8192000000 10278418048 10737004544 1368498976 14.314 99 11 21 0 1380449280 9463760 2486544
16:29:58 84309 8192000000 10292466864 10749407232 1354109680 14.184 98 14 28 0 1374364368 16719296 3535392
16:32:23 120751 8192000000 10291670944 10753536000 1341509360 14.071 97 17 34 0 1364620992 19135680 3975952
16:35:24 128039 8192000000 10262721264 10695856128 1216178176 12.926 89 11 22 0 1231000032 12582208 2239648
16:38:41 6009 8192000000 8971197968 9149353984 140445072 1.685 11 9 18 0 143418288 1359632 1613584

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 18-03-2023 16:39:46 to 18-03-2023 16:40:01.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 169 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 18-03-2023 16:40:02 to 18-03-2023 16:40:04.

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          239356
MON$OLDEST_ACTIVE               239357
MON$OLDEST_SNAPSHOT             239357
MON$NEXT_TRANSACTION            239357
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                       2008128
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.33666 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33666 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33666 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33666 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'

18.03.23 16:40:06. 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-03-18 16:40:08 No severe PSQL-related problems occured
18.03.23 16:40:09. End of report.