Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 01.03.2023 22: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 15513396 kB
MemAvailable 30429644 kB
Buffers 0 kB
Cached 16196532 kB
SwapCached 3084 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-01 22:38:39
DTS_END                         2023-03-01 22:38:39.8400
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_RECALC_IDX_STAT(24:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/48542
TRN_ID                          226407
ATT_ID                          616
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: 8851.42 21820 1062171
customer order: creation 159.99 321 19199
customer order: refuse 14.17 321 1700
order to supplier: creation 41.69 1259 5003
order to supplier: removal 3.42 94715 410
invoice (draft): creation 43.46 3141 5215
invoice (draft): removal 54.05 767 6486
invoice accept: apply 36.67 17671 4400
invoice accept: cancel 48.63 691 5836
customer reserve: creation 3420.03 174 410404
customer reserve: removal 4750.99 52 570119
realization accept: apply 76.60 170 9192
realization accept: cancel 82.50 124 9900
payment from customer: creation 53.76 122 6451
payment from customer: removal 5.48 65 658
payment to supplier: creation 45.73 126 5488
payment to supplier: removal 3.25 60 390
service: total inventory turnovers 4.15 1109 498
service: total monetary turnovers 5.99 22 719
service: aggregate perf. data 0.83 21650 99
service: refresh index statistics 0.03 293841 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 01-03-2023 22:40:06 to 01-03-2023 22:40:08.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2333
TEST_TIME 2 4387
TEST_TIME 3 4574
TEST_TIME 4 4644
TEST_TIME 5 4371
TEST_TIME 6 4300
TEST_TIME 7 4290
TEST_TIME 8 4212
TEST_TIME 9 4842
TEST_TIME 10 5208
TEST_TIME 11 5389
TEST_TIME 12 5379
TEST_TIME 13 6090
TEST_TIME 14 6826
TEST_TIME 15 6869
TEST_TIME 16 6821
TEST_TIME 17 7103
TEST_TIME 18 7023
TEST_TIME 19 7586
TEST_TIME 20 8171
TEST_TIME 21 8425
TEST_TIME 22 8814
TEST_TIME 23 8979
TEST_TIME 24 9086
TEST_TIME 25 9303
TEST_TIME 26 9511
TEST_TIME 27 10315
TEST_TIME 28 10521
TEST_TIME 29 10488
TEST_TIME 30 10309
TEST_TIME 31 10493
TEST_TIME 32 10275
TEST_TIME 33 10038
TEST_TIME 34 10010
TEST_TIME 35 9882
TEST_TIME 36 9730
TEST_TIME 37 9626
TEST_TIME 38 9573
TEST_TIME 39 9557
TEST_TIME 40 9333
TEST_TIME 41 9509
TEST_TIME 42 9481
TEST_TIME 43 9373
TEST_TIME 44 9274
TEST_TIME 45 9211
TEST_TIME 46 9232
TEST_TIME 47 9167
TEST_TIME 48 9046
TEST_TIME 49 8913
TEST_TIME 50 8976
TEST_TIME 51 9017
TEST_TIME 52 8958
TEST_TIME 53 8892
TEST_TIME 54 9009
TEST_TIME 55 8976
TEST_TIME 56 9093
TEST_TIME 57 9026
TEST_TIME 58 9050
TEST_TIME 59 9057
TEST_TIME 60 9219
TEST_TIME 61 9205
TEST_TIME 62 9294
TEST_TIME 63 9311
TEST_TIME 64 9358
TEST_TIME 65 9437
TEST_TIME 66 9454
TEST_TIME 67 9329
TEST_TIME 68 9332
TEST_TIME 69 9251
TEST_TIME 70 9175
TEST_TIME 71 9151
TEST_TIME 72 9049
TEST_TIME 73 9046
TEST_TIME 74 9022
TEST_TIME 75 9000
TEST_TIME 76 8970
TEST_TIME 77 8961
TEST_TIME 78 8917
TEST_TIME 79 8932
TEST_TIME 80 8962
TEST_TIME 81 8902
TEST_TIME 82 8975
TEST_TIME 83 8981
TEST_TIME 84 9090
TEST_TIME 85 9055
TEST_TIME 86 9033
TEST_TIME 87 9038
TEST_TIME 88 9133
TEST_TIME 89 9145
TEST_TIME 90 9120
TEST_TIME 91 9113
TEST_TIME 92 9234
TEST_TIME 93 9137
TEST_TIME 94 9081
TEST_TIME 95 9039
TEST_TIME 96 9012
TEST_TIME 97 8984
TEST_TIME 98 8947
TEST_TIME 99 8909
TEST_TIME 100 8882
TEST_TIME 101 8863
TEST_TIME 102 8859
TEST_TIME 103 8853
TEST_TIME 104 8852
TEST_TIME 105 8805
TEST_TIME 106 8829
TEST_TIME 107 8822
TEST_TIME 108 8804
TEST_TIME 109 8840
TEST_TIME 110 8843
TEST_TIME 111 8864
TEST_TIME 112 8883
TEST_TIME 113 8890
TEST_TIME 114 8919
TEST_TIME 115 8908
TEST_TIME 116 8913
TEST_TIME 117 8924
TEST_TIME 118 8951
TEST_TIME 119 8924
TEST_TIME 120 8852

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 01-03-2023 22:40:10 to 01-03-2023 22:40:13.

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 1444440 1444440 0 0.00 0 18384 6 0 0
doc_list_biud 1444440 1444440 0 0.00 0 25241 26 0 0
sp_add_invoice_to_stock 4510 4400 110 2.43 26 144944 17671 0 110
sp_cancel_adding_invoice 5836 5836 0 0.00 4 61197 692 0 0
sp_cancel_client_order 1700 1700 0 0.00 4 11290 321 0 0
sp_cancel_customer_reserve 570119 570119 0 0.00 0 17014 52 0 0
sp_cancel_pay_from_customer 658 658 0 0.00 3 2872 65 0 0
sp_cancel_pay_to_supplier 390 390 0 0.00 3 2711 60 0 0
sp_cancel_supplier_invoice 6495 6486 9 0.13 2 17114 767 0 9
sp_cancel_supplier_order 410 410 0 0.00 9 993242 94716 0 0
sp_cancel_write_off 9900 9900 0 0.00 1 10416 125 0 0
sp_client_order 19199 19199 0 0.00 3 31360 322 0 0
sp_customer_reserve 410404 410404 0 0.00 0 51652 175 0 0
sp_fill_shopping_cart 29411 29411 0 0.00 1 25933 44 0 0
sp_fill_shopping_cart_clo_res 410403 410403 0 0.00 0 19239 14 0 0
sp_get_clo_for_invoice 4399 4399 0 0.00 0 20698 331 0 0
sp_kill_cost_storno 16784 16784 0 0.00 0 10485 57 0 0
sp_kill_qstorno_ret_qs2qd 1157034 1157034 0 0.00 0 19588 29 0 0
sp_kill_qty_storno 608041 608041 0 0.00 0 25238 62 0 0
sp_lock_selected_doc 19037 19037 0 0.00 0 5916 4 0 0
sp_make_cost_storno 25529 25529 0 0.00 0 16893 53 0 0
sp_multiply_rows_for_pdistr 25529 25529 0 0.00 0 18378 29 0 0
sp_multiply_rows_for_qdistr 19199 19199 0 0.00 0 31349 145 0 0
sp_pay_from_customer 6451 6451 0 0.00 4 19965 122 0 0
sp_pay_to_supplier 5488 5488 0 0.00 4 18387 126 0 0
sp_payment_common 11939 11939 0 0.00 1 19956 34 0 0
sp_qd_handle_on_cancel_clo 1700 1700 0 0.00 0 11220 294 0 0
sp_qd_handle_on_invoice_upd_sts 10234 10234 0 0.00 0 25234 300 0 0
sp_qd_handle_on_reserve_upd_sts 9192 9192 0 0.00 0 13572 56 0 0
sp_reserve_write_off 9192 9192 0 0.00 6 13598 171 0 0
sp_supplier_invoice 5215 5215 0 0.00 5 82023 3142 0 0
sp_supplier_order 5003 5003 0 0.00 4 31698 1259 0 0
srv_aggregate_perf_data 99 99 0 0.00 2289 381735 21651 0 0
srv_fill_mon_cache_memory 61 61 0 0.00 2958 170813 52131 0 0
srv_find_qd_qs_mism 1019750 1019750 0 0.00 0 13118 5 0 0
srv_make_invnt_saldo 498 498 0 0.00 45 71718 1110 0 0
srv_make_money_saldo 719 719 0 0.00 1 827 23 0 0
srv_recalc_idx_stat 4 4 0 0.00 108234 425081 293842 0 0
t$perf-abend:sp_add_invoice_to_stock 110 110 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 9 9 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4400 4400 0 0.00 0 20014 190 0 0
t$perf-norm:sp_cancel_adding_invoice 394 394 0 0.00 0 6691 98 0 0
t$perf-norm:sp_cancel_client_order 1700 1700 0 0.00 0 6687 19 0 0
t$perf-norm:sp_cancel_customer_reserve 607 607 0 0.00 0 2996 15 0 0
t$perf-norm:sp_cancel_pay_from_customer 658 658 0 0.00 0 8923 21 0 0
t$perf-norm:sp_cancel_pay_to_supplier 390 390 0 0.00 0 693 4 0 0
t$perf-norm:sp_cancel_supplier_invoice 369 369 0 0.00 0 8795 38 0 0
t$perf-norm:sp_cancel_supplier_order 410 410 0 0.00 0 25505 1782 0 0
t$perf-norm:sp_cancel_write_off 919 919 0 0.00 0 4132 17 0 0
t$perf-norm:sp_client_order 19199 19199 0 0.00 0 17634 22 0 0
t$perf-norm:sp_customer_reserve 880 880 0 0.00 0 2530 10 0 0
t$perf-norm:sp_pay_from_customer 6451 6451 0 0.00 0 22836 18 0 0
t$perf-norm:sp_pay_to_supplier 5488 5488 0 0.00 0 6139 13 0 0
t$perf-norm:sp_reserve_write_off 9192 9192 0 0.00 0 17632 16 0 0
t$perf-norm:sp_supplier_invoice 5215 5215 0 0.00 0 4827 17 0 0
t$perf-norm:sp_supplier_order 5003 5003 0 0.00 0 6196 17 0 0
t$perf-norm:srv_aggregate_perf_data 99 99 0 0.00 0 2500 30 0 0
t$perf-norm:srv_fill_mon_cache_memory 61 61 0 0.00 0 862 21 0 0
t$perf-norm:srv_make_invnt_saldo 498 498 0 0.00 0 725 15 0 0
t$perf-norm:srv_make_money_saldo 719 719 0 0.00 0 3896 26 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 2 1 0 0
v_add_invoice_to_stock 9014 8794 220 2.44 0 4830 18 0 220
v_all_customers 34774 34774 0 0.00 0 15 0 0 0
v_all_suppliers 28646 28646 0 0.00 0 119 1 0 0
v_all_wares 38398 38398 0 0.00 0 19 1 0 0
v_cancel_adding_invoice 788 788 0 0.00 0 1010 10 0 0
v_cancel_client_order 3400 3400 0 0.00 0 1358 4 0 0
v_cancel_customer_prepayment 1316 1316 0 0.00 0 2098 6 0 0
v_cancel_customer_reserve 1214 1214 0 0.00 0 1461 7 0 0
v_cancel_payment_to_supplier 780 780 0 0.00 0 1286 5 0 0
v_cancel_supplier_invoice 756 738 18 2.38 0 1179 14 0 18
v_cancel_supplier_order 820 820 0 0.00 0 876 6 0 0
v_cancel_write_off 1838 1838 0 0.00 0 4327 13 0 0
v_max_id_clo_ord 5000 5000 0 0.00 0 615 1 0 0
v_max_id_clo_res 880 880 0 0.00 0 1557 15 0 0
v_max_id_ord_sup 5212 5212 0 0.00 0 5812 5 0 0
v_max_non_paid_invoice 1377 1377 0 0.00 0 596 3 0 0
v_max_non_paid_realizn 3372 3372 0 0.00 0 3925 4 0 0
v_min_id_clo_ord 5000 5000 0 0.00 0 13321 19 0 0
v_min_id_clo_res 880 880 0 0.00 0 3401 9 0 0
v_min_id_ord_sup 5212 5212 0 0.00 0 9152 9 0 0
v_min_non_paid_invoice 5488 5488 0 0.00 0 7030 22 0 0
v_min_non_paid_realizn 6451 6451 0 0.00 1 13681 27 0 0
v_our_firm 9782 9782 0 0.00 0 16 1 0 0
v_reserve_write_off 18384 18384 0 0.00 0 3828 5 0 0
x_lock_depdocs_on_canc_invoice 11953 11953 0 0.00 0 13660 111 0 0
x_lock_depdocs_on_canc_sup_ord 410 410 0 0.00 0 10433 380 0 0
x_make_qstorno_1000_1200 5003 5003 0 0.00 1 31687 1180 0 0
x_make_qstorno_1200_2000 5215 5215 0 0.00 2 69486 2978 0 0
x_make_qstorno_2100_3300 410404 410404 0 0.00 0 51631 159 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 01-03-2023 22:40:14 to 01-03-2023 22:40:18.

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:43 3 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
20:09:44 27371 8192000000 9902396832 10212933632 981956320 10.703 100 84 168 0 1009394064 5453088 21984656
20:11:18 17078 8192000000 9947332416 10269937664 1031702688 11.185 100 85 170 0 1061061248 7477824 21880736
20:12:39 14075 8192000000 9984281504 10318110720 1073268192 11.583 100 84 169 0 1102797568 9322960 20206416
20:13:56 8604 8192000000 10035858816 10382372864 1120336640 12.030 100 77 154 1 1149210736 10501056 18373040
20:15:08 9125 8192000000 10077760096 10435563520 1163450304 12.436 100 73 146 0 1192308976 12010368 16848304
20:16:20 4752 8192000000 10118640576 10486726656 1206526672 12.837 100 74 147 0 1234880464 11742704 16611088
20:17:29 2827 8192000000 10151956080 10525937664 1242519008 13.169 100 81 162 0 1274043280 14008224 17516048
20:18:33 4583 8192000000 10163734144 10546102272 1258172272 13.313 100 65 123 0 1283134848 11817792 13144784
20:19:41 1463 8192000000 10199461232 10584424448 1283830000 13.548 100 87 174 2 1315698672 12838096 19030576
20:20:44 15164 8192000000 10215309808 10610937856 1306491344 13.754 100 64 124 0 1329594720 9918208 13185168
20:22:01 43200 8192000000 10195941968 10610642944 1314631184 13.828 100 36 74 0 1328796912 5554288 8611440
20:23:47 8012 8192000000 10197864432 10619908096 1319501216 13.872 100 18 36 1 1328718000 5513584 3703200
20:24:55 10943 8192000000 10207465904 10630529024 1327859296 13.948 100 19 39 0 1338718064 5680752 5178016
20:26:07 10683 8192000000 10216545344 10640101376 1336228800 14.023 100 11 21 0 1343481104 5023360 2228944
20:27:18 42087 8192000000 10229752896 10654584832 1336656496 14.027 100 28 55 0 1347795248 5199856 5938896
20:29:05 4267 8192000000 10208094224 10624036864 1304827312 13.739 99 21 42 1 1314938432 5656208 4454912
20:30:10 11400 8192000000 10190990640 10603741184 1276171280 13.478 98 21 40 1 1285566720 5478544 3916896
20:31:22 52751 8192000000 10131115840 10520092672 1161569408 12.418 92 22 44 0 1171343920 4690528 5083984
20:33:16 6847 8192000000 10145668416 10543239168 1234717840 13.098 98 50 98 0 1253045040 7263408 11063792
20:34:24 8892 8192000000 10156645568 10562682880 1258120816 13.313 100 29 59 1 1274708352 9491296 7096240
20:35:34 22579 8192000000 10174005408 10580234240 1273143936 13.450 99 25 50 1 1284764256 5299920 6320400
20:37:01 9839 8192000000 10174763952 10594263040 1294771136 13.648 100 21 42 0 1305523200 5977280 4774784
20:38:11 6424 8192000000 10217063280 10635026432 1326793536 13.938 100 30 60 0 1339553248 6177536 6582176
20:39:24 12375 8192000000 10249767328 10660810752 1344642336 14.099 100 42 84 0 1361497008 7616656 9238016
20:40:39 13692 8192000000 10278159808 10693058560 1362951760 14.264 100 43 84 0 1385779136 13460272 9367104
20:42:04 13375 8192000000 10299160736 10716217344 1382525984 14.439 100 49 98 0 1410794512 16723488 11545040
20:43:24 35569 8192000000 10311654416 10739314688 1396989360 14.568 100 30 60 0 1424102128 20153904 6958864
20:45:04 14916 8192000000 10336404496 10761981952 1410993344 14.693 100 46 92 0 1447622272 25873968 10754960
20:46:24 6610 8192000000 10351378992 10772963328 1414760832 14.726 100 59 118 2 1460642848 32143376 13738640
20:47:34 4422 8192000000 10353835072 10780336128 1418805088 14.762 100 57 113 1 1463575744 30670624 14100032
20:48:43 3818 8192000000 10353837328 10785726464 1423103440 14.800 100 55 103 3 1466712512 30427440 13181632
20:49:54 2956 8192000000 10375155344 10795884544 1420432688 14.777 100 82 163 1 1480358528 40372464 19553376
20:51:05 2962 8192000000 10381441792 10812067840 1417565296 14.751 99 69 135 0 1474700128 39175344 17959488
20:52:10 3415 8192000000 10383195136 10808803328 1428843744 14.851 100 65 127 0 1487585376 42996576 15745056
20:53:19 10885 8192000000 10356431312 10792890368 1419510576 14.768 100 41 82 0 1468414960 38467616 10436768
20:54:38 3560 8192000000 10387737504 10807508992 1430136720 14.862 100 61 119 0 1484541504 39110448 15294336
20:55:47 10265 8192000000 10373182720 10806419456 1404653696 14.636 98 40 80 0 1462426096 47080480 10691920
20:57:01 5288 8192000000 10362767120 10776391680 1369975712 14.327 98 72 140 1 1443060272 53885424 19199136
20:58:11 3356 8192000000 10364086752 10778566656 1387965872 14.488 99 72 139 1 1456216320 50499376 17751072
20:59:19 16537 8192000000 10325102160 10759782400 1386833312 14.478 100 33 64 2 1430790320 35060016 8896992
21:00:49 18387 8192000000 10317934768 10755276800 1389984912 14.506 100 22 44 0 1427776880 31566096 6225872
21:02:30 19548 8192000000 10314687968 10740817920 1337622432 14.036 97 25 50 0 1387496848 42508416 7366000
21:04:07 11785 8192000000 10292916272 10728415232 1329663968 13.964 98 22 44 0 1379434016 43221152 6548896
21:05:24 30863 8192000000 10288221360 10744041472 1350747152 14.154 100 16 32 0 1402474656 46306144 5421360
21:06:56 92747 8192000000 10261605648 10700017664 1320736576 13.883 97 24 48 0 1338578880 12052048 5790256
21:09:30 92566 8192000000 10249164528 10705453056 1305800688 13.748 96 9 18 0 1323950528 16458160 1691680
21:12:03 121364 8192000000 10256309392 10701434880 1290326144 13.607 95 18 36 0 1303214864 9270784 3617936
21:16:07 118120 8192000000 10271357968 10722787328 1346013264 14.112 98 23 46 0 1367483200 15774464 5695472
21:19:12 100128 8192000000 10269578192 10726146048 1353825392 14.182 99 19 37 1 1372529296 14043936 4659968
21:21:55 28870 8192000000 10286781136 10734018560 1381345712 14.429 100 32 64 0 1397016944 8636608 7034624
21:23:24 15867 8192000000 10288607056 10738974720 1389913168 14.505 100 29 56 0 1405624592 9726144 5985280
21:24:46 63654 8192000000 10275463952 10732929024 1370509872 14.332 99 5 10 0 1379356784 7772800 1074112
21:26:50 95078 8192000000 10293314752 10759815168 1388812320 14.495 100 17 34 0 1410566320 17562336 4191664
21:29:29 65098 8192000000 10289166016 10749689856 1391227696 14.517 100 10 18 1 1411487952 18112448 2147808
21:31:34 47089 8192000000 10292663568 10759122944 1395357600 14.554 100 22 44 0 1410909968 10546992 5005376
21:33:24 20797 8192000000 10308950848 10764562432 1406904320 14.656 100 22 44 0 1420155584 8585024 4666240
21:34:52 69136 8192000000 10326814288 10785173504 1413671664 14.717 100 12 24 0 1426324592 10002064 2650864
21:37:21 54463 8192000000 10325691648 10792517632 1413216592 14.713 100 28 56 0 1438142128 18435632 6489904
21:39:16 59483 8192000000 10303155072 10749095936 1354389376 14.187 96 18 36 0 1369620896 11551504 3680016
21:41:22 72821 8192000000 10312035616 10772791296 1381551392 14.430 98 15 30 0 1402069664 17499856 3018416
21:43:38 170813 8192000000 10288557424 10735677440 1273495152 13.454 91 26 52 0 1288840176 9600688 5744336
21:47:32 28220 8192000000 10262816192 10729254912 1368505920 14.314 100 4 8 0 1379694944 10532800 656224
21:49:01 105868 8192000000 10256489824 10710839296 1343847520 14.092 97 13 24 0 1357854224 11078656 2928048
21:51:47 57450 8192000000 10265072480 10718990336 1334216448 14.005 97 19 38 0 1354465024 15269664 4978912
21:53:58 44063 8192000000 10268110496 10723885056 1356829648 14.209 99 16 32 0 1369331904 8895584 3606672
21:55:45 58599 8192000000 10266114832 10731245568 1352643584 14.171 98 11 22 0 1363020496 8027600 2349312
21:57:44 45308 8192000000 10258350064 10704789504 1321125408 13.887 96 14 28 1 1335677792 11389136 3163248
21:59:29 39125 8192000000 10274508992 10714116096 1336633936 14.027 98 31 63 0 1356181040 12519856 7027248
22:01:08 79367 8192000000 10266030576 10730557440 1341314608 14.069 98 16 32 0 1367626848 22267056 4045184
22:03:31 38492 8192000000 10261416384 10696806400 1294194464 13.642 95 34 68 0 1314656528 13288528 7173536
22:05:16 44495 8192000000 10286433840 10731880448 1357550368 14.215 100 26 50 0 1376946960 14082432 5314160
22:07:01 106822 8192000000 10287164336 10731532288 1343552560 14.089 98 20 40 0 1361630832 13903072 4175200
22:09:51 15430 8192000000 10292154320 10731085824 1359314704 14.231 99 44 88 0 1384312080 15579616 9417760
22:11:08 118146 8192000000 10266799616 10725507072 1375570864 14.377 100 12 23 0 1390473792 12369920 2533008
22:14:08 64262 8192000000 10283433328 10746900480 1388621040 14.494 100 11 23 0 1401741232 10856784 2263408
22:16:32 76259 8192000000 10278025584 10734211072 1343696752 14.091 97 13 26 1 1358941072 11973808 3270512
22:19:00 113673 8192000000 10279434736 10740998144 1361620656 14.252 98 14 28 0 1383685600 18740240 3324704
22:21:55 115092 8192000000 10298506176 10769846272 1383535664 14.448 99 6 10 0 1398278752 13664592 1078496
22:24:50 22971 8192000000 10304633024 10758057984 1392460064 14.528 99 43 86 0 1409604656 7492272 9652320
22:26:21 29532 8192000000 10322516240 10775781376 1409842352 14.683 100 25 50 0 1426769840 11304512 5622976
22:27:55 117923 8192000000 10314381680 10773991424 1388919040 14.496 98 10 20 0 1403453840 12289520 2245280
22:31:13 101358 8192000000 10312611696 10781044736 1372906624 14.353 97 12 24 0 1385838720 10289408 2642688
22:34:08 152191 8192000000 10294124736 10751356928 1298571760 13.682 92 5 10 0 1310427360 10539472 1316128
22:37:41 72606 8192000000 9888593760 10280083456 1013232272 11.007 73 14 28 0 1025557376 9187136 3137968

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 01-03-2023 22:40:20 to 01-03-2023 22:40:35.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 110 v_add_invoice_to_stock 335544517
except 9 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 01-03-2023 22:40:36 to 01-03-2023 22:40:38.

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          226406
MON$OLDEST_ACTIVE               226574
MON$OLDEST_SNAPSHOT             226574
MON$NEXT_TRANSACTION            226574
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                       2005568
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'

01.03.23 22:40:39. 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-01 22:40:42 No severe PSQL-related problems occured
01.03.23 22:40:43. End of report.