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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15477076 kB
MemAvailable 30425496 kB
Buffers 0 kB
Cached 16264356 kB
SwapCached 5784 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-01-02 22:38:31
DTS_END                         2023-01-02 22:38:31.4060
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/33186
TRN_ID                          241584
ATT_ID                          664
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: 8973.94 23199 1076873
customer order: creation 170.43 345 20452
customer order: refuse 14.87 348 1784
order to supplier: creation 44.54 1194 5345
order to supplier: removal 3.27 94095 392
invoice (draft): creation 45.37 3430 5444
invoice (draft): removal 51.13 693 6136
invoice accept: apply 41.23 16493 4947
invoice accept: cancel 46.07 664 5528
customer reserve: creation 3790.80 163 454896
customer reserve: removal 4475.15 53 537018
realization accept: apply 83.52 171 10022
realization accept: cancel 80.03 100 9604
payment from customer: creation 57.71 117 6925
payment from customer: removal 5.68 58 681
payment to supplier: creation 49.55 121 5946
payment to supplier: removal 3.40 79 408
service: total inventory turnovers 4.22 1262 507
service: total monetary turnovers 6.10 30 732
service: aggregate perf. data 0.85 21825 102
service: refresh index statistics 0.03 322733 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 02-01-2023 22:41:11 to 02-01-2023 22:41:14.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2774
TEST_TIME 2 5024
TEST_TIME 3 4576
TEST_TIME 4 4622
TEST_TIME 5 5072
TEST_TIME 6 5620
TEST_TIME 7 5087
TEST_TIME 8 5167
TEST_TIME 9 5533
TEST_TIME 10 5838
TEST_TIME 11 5975
TEST_TIME 12 6515
TEST_TIME 13 6650
TEST_TIME 14 6763
TEST_TIME 15 6873
TEST_TIME 16 7276
TEST_TIME 17 7900
TEST_TIME 18 8261
TEST_TIME 19 8450
TEST_TIME 20 8927
TEST_TIME 21 9123
TEST_TIME 22 9662
TEST_TIME 23 10287
TEST_TIME 24 10084
TEST_TIME 25 10134
TEST_TIME 26 10184
TEST_TIME 27 10316
TEST_TIME 28 10102
TEST_TIME 29 9962
TEST_TIME 30 9778
TEST_TIME 31 9585
TEST_TIME 32 9856
TEST_TIME 33 9657
TEST_TIME 34 9881
TEST_TIME 35 9716
TEST_TIME 36 9650
TEST_TIME 37 9582
TEST_TIME 38 9498
TEST_TIME 39 9480
TEST_TIME 40 9446
TEST_TIME 41 9470
TEST_TIME 42 9407
TEST_TIME 43 9284
TEST_TIME 44 9145
TEST_TIME 45 9245
TEST_TIME 46 9099
TEST_TIME 47 8982
TEST_TIME 48 9110
TEST_TIME 49 9160
TEST_TIME 50 9234
TEST_TIME 51 9163
TEST_TIME 52 9108
TEST_TIME 53 9166
TEST_TIME 54 9240
TEST_TIME 55 9347
TEST_TIME 56 9364
TEST_TIME 57 9368
TEST_TIME 58 9363
TEST_TIME 59 9344
TEST_TIME 60 9393
TEST_TIME 61 9372
TEST_TIME 62 9229
TEST_TIME 63 9185
TEST_TIME 64 9148
TEST_TIME 65 9106
TEST_TIME 66 9112
TEST_TIME 67 9040
TEST_TIME 68 9021
TEST_TIME 69 9010
TEST_TIME 70 9043
TEST_TIME 71 9032
TEST_TIME 72 9050
TEST_TIME 73 9037
TEST_TIME 74 9054
TEST_TIME 75 9089
TEST_TIME 76 9077
TEST_TIME 77 9066
TEST_TIME 78 9031
TEST_TIME 79 9052
TEST_TIME 80 9099
TEST_TIME 81 9160
TEST_TIME 82 9110
TEST_TIME 83 9248
TEST_TIME 84 9153
TEST_TIME 85 9085
TEST_TIME 86 9033
TEST_TIME 87 9053
TEST_TIME 88 9010
TEST_TIME 89 8978
TEST_TIME 90 8934
TEST_TIME 91 8916
TEST_TIME 92 8878
TEST_TIME 93 8939
TEST_TIME 94 8939
TEST_TIME 95 8980
TEST_TIME 96 9016
TEST_TIME 97 9043
TEST_TIME 98 9034
TEST_TIME 99 9067
TEST_TIME 100 9101
TEST_TIME 101 9059
TEST_TIME 102 9016
TEST_TIME 103 9095
TEST_TIME 104 9131
TEST_TIME 105 9130
TEST_TIME 106 9240
TEST_TIME 107 9207
TEST_TIME 108 9135
TEST_TIME 109 9148
TEST_TIME 110 9159
TEST_TIME 111 9121
TEST_TIME 112 9103
TEST_TIME 113 9074
TEST_TIME 114 9041
TEST_TIME 115 9016
TEST_TIME 116 9035
TEST_TIME 117 8977
TEST_TIME 118 8969
TEST_TIME 119 9024
TEST_TIME 120 8975

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 02-01-2023 22:41:15 to 02-01-2023 22:41:18.

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 1497857 1497857 0 0.00 0 15370 5 0 0
doc_list_biud 1497851 1497851 0 0.00 0 44932 25 0 0
sp_add_invoice_to_stock 5098 4947 151 2.96 18 179781 16493 0 151
sp_cancel_adding_invoice 5528 5528 0 0.00 4 52550 664 0 0
sp_cancel_client_order 1784 1784 0 0.00 4 13443 349 0 0
sp_cancel_customer_reserve 537018 537018 0 0.00 0 16380 54 0 0
sp_cancel_pay_from_customer 681 681 0 0.00 3 1896 58 0 0
sp_cancel_pay_to_supplier 408 408 0 0.00 2 8830 80 0 0
sp_cancel_supplier_invoice 6149 6136 13 0.21 1 16115 694 0 13
sp_cancel_supplier_order 392 392 0 0.00 5 890171 94095 0 0
sp_cancel_write_off 9604 9604 0 0.00 1 6753 100 0 0
sp_client_order 20452 20452 0 0.00 3 18842 345 0 0
sp_customer_reserve 454896 454896 0 0.00 0 41626 164 0 0
sp_fill_shopping_cart 31235 31235 0 0.00 1 32752 47 0 0
sp_fill_shopping_cart_clo_res 454893 454893 0 0.00 0 22814 14 0 0
sp_get_clo_for_invoice 4944 4944 0 0.00 0 28005 355 0 0
sp_kill_cost_storno 16221 16221 0 0.00 0 6620 48 0 0
sp_kill_qstorno_ret_qs2qd 1090168 1090168 0 0.00 0 16371 29 0 0
sp_kill_qty_storno 575425 575425 0 0.00 0 44931 63 0 0
sp_lock_selected_doc 20640 20640 0 0.00 0 10856 6 0 0
sp_make_cost_storno 27837 27837 0 0.00 0 15316 50 0 0
sp_multiply_rows_for_pdistr 27831 27831 0 0.00 0 8145 26 0 0
sp_multiply_rows_for_qdistr 20452 20452 0 0.00 0 10246 145 0 0
sp_pay_from_customer 6925 6925 0 0.00 4 29395 118 0 0
sp_pay_to_supplier 5946 5946 0 0.00 5 15962 121 0 0
sp_payment_common 12868 12868 0 0.00 1 29388 29 0 0
sp_qd_handle_on_cancel_clo 1784 1784 0 0.00 0 13422 311 0 0
sp_qd_handle_on_invoice_upd_sts 10471 10471 0 0.00 0 44931 308 0 0
sp_qd_handle_on_reserve_upd_sts 10020 10020 0 0.00 0 14473 61 0 0
sp_reserve_write_off 10022 10022 0 0.00 6 14498 171 0 0
sp_supplier_invoice 5444 5444 0 0.00 6 78108 3431 0 0
sp_supplier_order 5345 5345 0 0.00 5 33807 1195 0 0
srv_aggregate_perf_data 103 102 1 0.97 3243 314760 21825 0 1
srv_fill_mon_cache_memory 60 60 0 0.00 947 147704 48821 0 0
srv_find_qd_qs_mism 1029663 1029663 0 0.00 0 9563 5 0 0
srv_make_invnt_saldo 507 507 0 0.00 37 68631 1262 0 0
srv_make_money_saldo 732 732 0 0.00 0 2770 31 0 0
srv_recalc_idx_stat 4 4 0 0.00 185610 550642 322733 0 0
t$perf-abend:sp_add_invoice_to_stock 151 151 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 13 13 0 0.00 0 0 0 0 0
t$perf-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4947 4947 0 0.00 0 12810 174 0 0
t$perf-norm:sp_cancel_adding_invoice 387 387 0 0.00 0 2575 75 0 0
t$perf-norm:sp_cancel_client_order 1784 1784 0 0.00 0 6473 22 0 0
t$perf-norm:sp_cancel_customer_reserve 665 665 0 0.00 0 497 5 0 0
t$perf-norm:sp_cancel_pay_from_customer 681 681 0 0.00 0 1026 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 408 408 0 0.00 0 2819 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 387 387 0 0.00 0 2126 25 0 0
t$perf-norm:sp_cancel_supplier_order 392 392 0 0.00 0 24017 1763 0 0
t$perf-norm:sp_cancel_write_off 973 973 0 0.00 0 4240 9 0 0
t$perf-norm:sp_client_order 20452 20452 0 0.00 0 9730 19 0 0
t$perf-norm:sp_customer_reserve 999 999 0 0.00 0 3564 11 0 0
t$perf-norm:sp_pay_from_customer 6925 6925 0 0.00 0 6084 10 0 0
t$perf-norm:sp_pay_to_supplier 5946 5946 0 0.00 0 5610 8 0 0
t$perf-norm:sp_reserve_write_off 10022 10022 0 0.00 0 7936 14 0 0
t$perf-norm:sp_supplier_invoice 5444 5444 0 0.00 0 3849 15 0 0
t$perf-norm:sp_supplier_order 5345 5345 0 0.00 0 7643 18 0 0
t$perf-norm:srv_aggregate_perf_data 102 102 0 0.00 0 447 10 0 0
t$perf-norm:srv_fill_mon_cache_memory 60 60 0 0.00 0 12 1 0 0
t$perf-norm:srv_make_invnt_saldo 507 507 0 0.00 0 613 15 0 0
t$perf-norm:srv_make_money_saldo 732 732 0 0.00 0 5637 25 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 4 3 0 0
v_add_invoice_to_stock 10188 9886 302 2.96 0 5325 19 0 302
v_all_customers 37322 37322 0 0.00 0 41 0 0 0
v_all_suppliers 29780 29780 0 0.00 0 18 1 0 0
v_all_wares 40904 40904 0 0.00 0 19 1 0 0
v_cancel_adding_invoice 774 774 0 0.00 0 795 6 0 0
v_cancel_client_order 3568 3568 0 0.00 0 4186 6 0 0
v_cancel_customer_prepayment 1362 1362 0 0.00 0 1881 6 0 0
v_cancel_customer_reserve 1330 1330 0 0.00 0 3166 8 0 0
v_cancel_payment_to_supplier 816 816 0 0.00 0 1237 5 0 0
v_cancel_supplier_invoice 800 774 26 3.25 0 4484 23 0 26
v_cancel_supplier_order 784 784 0 0.00 0 3752 12 0 0
v_cancel_write_off 1946 1946 0 0.00 0 4505 21 0 0
v_max_id_clo_ord 5345 5345 0 0.00 0 2172 2 0 0
v_max_id_clo_res 999 999 0 0.00 0 2317 10 0 0
v_max_id_ord_sup 5438 5438 0 0.00 0 4260 5 0 0
v_max_non_paid_invoice 1839 1839 0 0.00 0 7274 9 0 0
v_max_non_paid_realizn 3565 3565 0 0.00 0 2429 4 0 0
v_min_id_clo_ord 5345 5345 0 0.00 0 4256 7 0 0
v_min_id_clo_res 999 999 0 0.00 0 3546 14 0 0
v_min_id_ord_sup 5438 5438 0 0.00 0 9955 12 0 0
v_min_non_paid_invoice 5946 5946 0 0.00 0 10011 16 0 0
v_min_non_paid_realizn 6922 6922 0 0.00 0 29384 27 0 0
v_our_firm 10296 10296 0 0.00 0 19 1 0 0
v_reserve_write_off 20040 20040 0 0.00 0 4488 7 0 0
x_lock_depdocs_on_canc_invoice 11277 11277 0 0.00 0 18600 120 0 0
x_lock_depdocs_on_canc_sup_ord 392 392 0 0.00 0 3810 327 0 0
x_make_qstorno_1000_1200 5345 5345 0 0.00 1 33800 1120 0 0
x_make_qstorno_1200_2000 5444 5444 0 0.00 2 75207 3239 0 0
x_make_qstorno_2100_3300 454896 454896 0 0.00 0 41625 147 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 02-01-2023 22:41:19 to 02-01-2023 22:41:24.

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
20:08:35 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:36 32192 8192000000 9921049296 10235297792 990768080 10.789 100 84 168 0 1019264848 6112544 22384224
20:11:11 14319 8192000000 9949063680 10270773248 1031849520 11.186 100 86 172 0 1062177952 7983552 22344880
20:12:28 9400 8192000000 9970657776 10298949632 1055296000 11.411 100 85 170 0 1086852816 9001760 22555056
20:13:48 5725 8192000000 10019563648 10364252160 1108820144 11.921 100 71 140 0 1135305152 10132960 16352048
20:14:57 4194 8192000000 10081792848 10437808128 1169634000 12.493 100 85 169 0 1202616096 13508960 19473136
20:16:02 3685 8192000000 10121445952 10490126336 1209913104 12.868 100 87 173 0 1243120624 13001504 20206016
20:17:12 2643 8192000000 10160175376 10536493056 1245777312 13.199 100 82 163 0 1277025264 13785488 17462464
20:18:16 1290 8192000000 10195256528 10575630336 1278610608 13.500 100 87 172 1 1312032192 14269968 19151616
20:19:19 860 8192000000 10214927952 10604048384 1306210304 13.752 100 84 166 1 1338299136 13471504 18617328
20:20:22 16869 8192000000 10196427536 10612633600 1317285296 13.852 100 45 88 0 1334075456 7396608 9393552
20:21:39 12360 8192000000 10212626544 10629431296 1326591696 13.936 100 12 24 0 1334736896 5448048 2697152
20:22:52 11883 8192000000 10219691376 10641199104 1330388656 13.971 100 14 29 0 1343483248 10201696 2892896
20:24:04 8759 8192000000 10215658816 10642087936 1337121424 14.031 100 21 42 1 1348481744 6122736 5237584
20:25:18 23308 8192000000 10230893040 10656215040 1338062336 14.040 100 44 86 0 1356535232 7549760 10923136
20:26:45 7147 8192000000 10232120288 10654330880 1326317264 13.934 99 22 42 1 1337444400 6102592 5024544
20:27:52 3543 8192000000 10212394848 10630569984 1300095280 13.696 98 24 48 0 1311819136 6182176 5541680
20:28:59 46137 8192000000 10192927024 10610573312 1294915424 13.649 99 16 32 0 1304161520 5633296 3612800
20:30:48 3697 8192000000 10165643744 10567696384 1267238608 13.396 100 25 50 0 1278836448 5584304 6013536
20:31:52 10477 8192000000 10156726112 10561732608 1257301360 13.305 99 28 56 0 1269602992 5608320 6693312
20:33:03 74087 8192000000 10169874480 10581151744 1265784208 13.383 99 32 64 0 1279242144 5475152 7982784
20:35:17 5643 8192000000 10196735024 10605690880 1298337008 13.680 100 20 40 0 1308801728 5699072 4765648
20:36:24 11675 8192000000 10207589712 10624880640 1313883488 13.821 100 17 36 0 1323729408 5047296 4798624
20:37:39 26666 8192000000 10208746256 10634018816 1322648176 13.901 100 30 62 0 1340129248 9621024 7860048
20:39:15 28340 8192000000 10242250256 10659524608 1343289552 14.087 100 38 77 0 1359707104 7628112 8789440
20:40:49 7121 8192000000 10264561584 10682576896 1355645264 14.198 99 46 92 2 1378616064 12148560 10822240
20:41:59 25904 8192000000 10276361408 10707755008 1374789872 14.370 100 31 58 2 1396208560 14644544 6774144
20:43:30 29584 8192000000 10307391888 10735374336 1387656336 14.485 100 30 58 0 1411199024 16556816 6985872
20:45:04 33938 8192000000 10319294256 10745352192 1386206080 14.472 99 29 58 0 1412373584 18561088 7606416
20:46:55 13840 8192000000 10321031552 10740629504 1384176736 14.454 99 62 124 1 1424757840 25171376 15409728
20:48:14 10746 8192000000 10325936016 10748088320 1379283824 14.410 98 42 84 0 1415087696 25105648 10698224
20:49:31 7548 8192000000 10339938592 10758586368 1399352560 14.589 99 63 124 1 1447251056 33358576 14539920
20:50:43 8287 8192000000 10344833904 10761601024 1400136640 14.596 100 55 108 0 1446592976 32838160 13618176
20:51:55 7273 8192000000 10358014000 10772504576 1414925552 14.728 100 69 133 0 1462657072 31843504 15888016
20:53:05 946 8192000000 10344317200 10753982464 1395829904 14.558 100 84 162 0 1450782192 34138400 20813888
20:54:10 3774 8192000000 10339574112 10754252800 1387462976 14.483 100 62 123 1 1442705440 39538112 15704352
20:55:23 1715 8192000000 10358379376 10770391040 1403359312 14.625 100 76 152 1 1462660384 40264384 19036688
20:56:27 7652 8192000000 10334198928 10758721536 1390815184 14.513 99 39 76 0 1430377360 28868192 10693984
20:57:43 10060 8192000000 10299400720 10722926592 1367796576 14.307 100 42 85 0 1408531760 29718128 11017056
20:59:00 15374 8192000000 10297592640 10727616512 1356647952 14.207 99 29 58 0 1397340208 32803600 7888656
21:00:22 10183 8192000000 10292418976 10731143168 1367534176 14.305 100 28 54 0 1403903072 28878960 7489936
21:01:40 55531 8192000000 10276010480 10710495232 1340099664 14.058 99 20 40 0 1363157568 17589152 5468752
21:03:57 22606 8192000000 10285494720 10714415104 1366370128 14.295 100 60 118 1 1395513552 14776784 14366640
21:05:23 19235 8192000000 10280316576 10722164736 1359322272 14.231 100 19 37 0 1383230320 19294176 4613872
21:07:17 65352 8192000000 10271836448 10713821184 1349832480 14.146 99 18 36 0 1370070064 16237680 3999904
21:09:25 112364 8192000000 10266387696 10710077440 1333827888 14.002 97 16 32 0 1350117760 12700720 3589152
21:12:39 65415 8192000000 10266884128 10707304448 1337368096 14.034 97 22 44 0 1356802944 14403664 5031184
21:14:46 53357 8192000000 10275035008 10730074112 1380266832 14.419 100 7 14 0 1388758336 7048528 1442976
21:17:38 38924 8192000000 10318764416 10745622528 1367737776 14.307 98 28 56 0 1386817648 12454960 6624912
21:19:20 35733 8192000000 10288389088 10744553472 1360065920 14.238 98 13 25 0 1378240256 15492512 2681824
21:20:58 56255 8192000000 10296127040 10759618560 1384254240 14.455 100 16 32 0 1408066704 20048320 3764144
21:22:56 34586 8192000000 10303196976 10758246400 1394268576 14.544 100 20 39 1 1415344752 16481392 4594784
21:24:47 55000 8192000000 10303768688 10758156288 1397205600 14.570 100 28 56 0 1422602720 18929056 6468064
21:26:44 94639 8192000000 10305783440 10766979072 1373807904 14.361 98 9 18 0 1392757952 17009072 1940976
21:29:25 43399 8192000000 10290974528 10737700864 1372319008 14.348 98 30 60 0 1387215472 7403664 7492800
21:31:16 37746 8192000000 10303179040 10764210176 1398123408 14.578 100 27 54 0 1416684416 12625536 5935472
21:32:54 147700 8192000000 10286988224 10741989376 1323005984 13.904 95 17 34 0 1340398304 13779488 3612832
21:36:33 48217 8192000000 10295898576 10735263744 1349995808 14.147 97 28 57 0 1368168624 11638464 6534352
21:38:28 55350 8192000000 10303476992 10750922752 1371857984 14.344 99 46 90 0 1396337584 14979184 9500416
21:40:33 83663 8192000000 10267798416 10718318592 1312341344 13.807 94 25 50 2 1327052080 9039296 5671440
21:43:06 37845 8192000000 10291985888 10728222720 1345307600 14.105 97 32 64 0 1364532048 11488864 7735584
21:44:59 61397 8192000000 10277486272 10734800896 1362310752 14.258 99 16 32 0 1378106784 12573488 3222544
21:47:23 50403 8192000000 10260936976 10720079872 1322225072 13.897 96 15 30 0 1342802832 17245408 3332352
21:49:16 40507 8192000000 10245245248 10687889408 1309214944 13.779 97 25 50 0 1322715552 7274192 6226416
21:51:35 16651 8192000000 10263800816 10702413824 1332140464 13.986 98 27 54 0 1347320144 8869216 6310464
21:53:00 58083 8192000000 10246704400 10694131712 1322560960 13.900 98 22 42 0 1338235936 10716288 4958688
21:55:01 118978 8192000000 10258688336 10699165696 1280463136 13.517 94 16 32 0 1298705008 14385808 3856064
21:58:00 79121 8192000000 10273093696 10730885120 1340341568 14.060 98 22 44 0 1359439248 14391184 4706496
22:00:29 13827 8192000000 10300459536 10734882816 1364733408 14.280 99 35 68 1 1389256016 17269344 7253264
22:01:43 108797 8192000000 10288831328 10721456128 1350112272 14.148 98 21 40 1 1371146224 16403568 4630384
22:04:32 32254 8192000000 10272668912 10713956352 1355992384 14.201 99 30 59 0 1370515232 8814496 5708352
22:06:07 54240 8192000000 10264649584 10722643968 1362667264 14.261 99 6 12 0 1371144560 7286000 1191296
22:08:02 81012 8192000000 10297435376 10748715008 1374776960 14.370 99 14 28 0 1386663536 8818816 3067760
22:11:13 67748 8192000000 10299434496 10755497984 1358755168 14.226 97 14 28 0 1376482112 15071472 2655472
22:13:58 52941 8192000000 10289290176 10749231104 1379958640 14.416 99 25 50 0 1395331424 9664016 5708768
22:16:04 84720 8192000000 10287453296 10737106944 1374058512 14.363 99 20 40 0 1389064704 10519264 4486928
22:18:30 86249 8192000000 10296836048 10734321664 1333586544 14.000 96 23 44 0 1353184448 14964144 4633760
22:20:57 74142 8192000000 10279185168 10733944832 1333223168 13.996 96 16 32 0 1352553888 15647968 3682752
22:24:01 99796 8192000000 10263205072 10718126080 1291441120 13.617 94 8 16 0 1314783328 21786128 1556080
22:26:49 109152 8192000000 10254968272 10712137728 1298889600 13.685 95 15 30 0 1316931024 14725584 3315840
22:29:43 48449 8192000000 10259965072 10714824704 1316298512 13.843 96 14 28 0 1334776000 15483888 2993600
22:31:35 90052 8192000000 10272104560 10724499456 1331276608 13.979 97 11 21 1 1345056400 11882896 1896896
22:34:09 92588 8192000000 10274718016 10721005568 1360326704 14.240 99 20 40 0 1378679120 12974720 5377696
22:38:16 22865 8192000000 9154611536 9402089472 320973392 3.770 24 3 6 0 323982864 2622304 387168

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 02-01-2023 22:41:25 to 02-01-2023 22:41:40.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 151 v_add_invoice_to_stock 335544517
except 13 v_cancel_supplier_invoice 335544517

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

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

02.01.23 22:41:44. 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-01-02 22:41:47 No severe PSQL-related problems occured
02.01.23 22:41:48. End of report.