Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 17.03.2023 01: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 15271688 kB
MemAvailable 30432240 kB
Buffers 0 kB
Cached 16449956 kB
SwapCached 3188 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-17 01:38:41
DTS_END                         2023-03-17 01:38:41.4580
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_INVOICE(39:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/55236
TRN_ID                          237828
ATT_ID                          649
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: 9490.61 20698 1138873
customer order: creation 167.46 340 20095
customer order: refuse 14.54 338 1745
order to supplier: creation 45.30 1166 5436
order to supplier: removal 3.35 102558 402
invoice (draft): creation 44.43 3386 5331
invoice (draft): removal 55.66 716 6679
invoice accept: apply 41.05 17197 4926
invoice accept: cancel 50.59 729 6071
customer reserve: creation 3862.26 167 463471
customer reserve: removal 4904.58 54 588549
realization accept: apply 81.58 191 9790
realization accept: cancel 92.48 112 11097
payment from customer: creation 57.24 106 6869
payment from customer: removal 5.82 67 698
payment to supplier: creation 48.70 156 5844
payment to supplier: removal 3.47 74 416
service: total inventory turnovers 4.53 1025 543
service: total monetary turnovers 6.78 30 813
service: aggregate perf. data 0.78 23139 94
service: refresh index statistics 0.03 262409 4

Performance in TOTAL, chart


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

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4212
TEST_TIME 2 4386
TEST_TIME 3 4051
TEST_TIME 4 4981
TEST_TIME 5 4520
TEST_TIME 6 4664
TEST_TIME 7 4866
TEST_TIME 8 4858
TEST_TIME 9 4741
TEST_TIME 10 5071
TEST_TIME 11 5183
TEST_TIME 12 5241
TEST_TIME 13 5359
TEST_TIME 14 5463
TEST_TIME 15 5593
TEST_TIME 16 6205
TEST_TIME 17 6236
TEST_TIME 18 6342
TEST_TIME 19 6439
TEST_TIME 20 6557
TEST_TIME 21 7553
TEST_TIME 22 7936
TEST_TIME 23 8181
TEST_TIME 24 8782
TEST_TIME 25 9181
TEST_TIME 26 9574
TEST_TIME 27 9870
TEST_TIME 28 10124
TEST_TIME 29 10316
TEST_TIME 30 10477
TEST_TIME 31 10537
TEST_TIME 32 10542
TEST_TIME 33 10414
TEST_TIME 34 10205
TEST_TIME 35 9949
TEST_TIME 36 9852
TEST_TIME 37 9717
TEST_TIME 38 9989
TEST_TIME 39 9820
TEST_TIME 40 9829
TEST_TIME 41 9926
TEST_TIME 42 9832
TEST_TIME 43 9715
TEST_TIME 44 9776
TEST_TIME 45 9723
TEST_TIME 46 9562
TEST_TIME 47 9576
TEST_TIME 48 9463
TEST_TIME 49 9422
TEST_TIME 50 9359
TEST_TIME 51 9237
TEST_TIME 52 9223
TEST_TIME 53 9199
TEST_TIME 54 9353
TEST_TIME 55 9350
TEST_TIME 56 9366
TEST_TIME 57 9361
TEST_TIME 58 9464
TEST_TIME 59 9433
TEST_TIME 60 9457
TEST_TIME 61 9540
TEST_TIME 62 9614
TEST_TIME 63 9621
TEST_TIME 64 9746
TEST_TIME 65 9729
TEST_TIME 66 9703
TEST_TIME 67 9573
TEST_TIME 68 9546
TEST_TIME 69 9570
TEST_TIME 70 9573
TEST_TIME 71 9553
TEST_TIME 72 9466
TEST_TIME 73 9471
TEST_TIME 74 9423
TEST_TIME 75 9421
TEST_TIME 76 9367
TEST_TIME 77 9404
TEST_TIME 78 9440
TEST_TIME 79 9458
TEST_TIME 80 9432
TEST_TIME 81 9566
TEST_TIME 82 9574
TEST_TIME 83 9682
TEST_TIME 84 9669
TEST_TIME 85 9629
TEST_TIME 86 9747
TEST_TIME 87 9720
TEST_TIME 88 9671
TEST_TIME 89 9660
TEST_TIME 90 9591
TEST_TIME 91 9674
TEST_TIME 92 9616
TEST_TIME 93 9570
TEST_TIME 94 9549
TEST_TIME 95 9528
TEST_TIME 96 9511
TEST_TIME 97 9531
TEST_TIME 98 9592
TEST_TIME 99 9597
TEST_TIME 100 9562
TEST_TIME 101 9665
TEST_TIME 102 9654
TEST_TIME 103 9623
TEST_TIME 104 9636
TEST_TIME 105 9628
TEST_TIME 106 9656
TEST_TIME 107 9722
TEST_TIME 108 9738
TEST_TIME 109 9674
TEST_TIME 110 9638
TEST_TIME 111 9634
TEST_TIME 112 9592
TEST_TIME 113 9611
TEST_TIME 114 9572
TEST_TIME 115 9525
TEST_TIME 116 9493
TEST_TIME 117 9499
TEST_TIME 118 9461
TEST_TIME 119 9470
TEST_TIME 120 9495

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 17-03-2023 01:40:09 to 17-03-2023 01: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 1566868 1566868 0 0.00 0 27775 6 0 0
doc_list_biud 1566868 1566868 0 0.00 0 37316 26 0 0
sp_add_invoice_to_stock 5056 4926 130 2.57 47 182835 17197 0 130
sp_cancel_adding_invoice 6071 6071 0 0.00 4 64846 730 0 0
sp_cancel_client_order 1745 1745 0 0.00 4 15279 338 0 0
sp_cancel_customer_reserve 588549 588549 0 0.00 0 17952 55 0 0
sp_cancel_pay_from_customer 698 698 0 0.00 2 4628 67 0 0
sp_cancel_pay_to_supplier 416 416 0 0.00 2 3775 74 0 0
sp_cancel_supplier_invoice 6692 6679 13 0.19 1 37327 716 0 13
sp_cancel_supplier_order 402 402 0 0.00 7 1039186 102558 0 0
sp_cancel_write_off 11097 11097 0 0.00 1 9941 112 0 0
sp_client_order 20095 20095 0 0.00 3 34336 340 0 0
sp_customer_reserve 463471 463471 0 0.00 0 137756 168 0 0
sp_fill_shopping_cart 30861 30861 0 0.00 1 12103 40 0 0
sp_fill_shopping_cart_clo_res 463468 463468 0 0.00 0 16247 14 0 0
sp_get_clo_for_invoice 4922 4922 0 0.00 0 31213 262 0 0
sp_kill_cost_storno 18282 18282 0 0.00 0 6100 54 0 0
sp_kill_qstorno_ret_qs2qd 1195276 1195276 0 0.00 0 37311 30 0 0
sp_kill_qty_storno 629255 629255 0 0.00 0 37314 64 0 0
sp_lock_selected_doc 20453 20453 0 0.00 0 6778 6 0 0
sp_make_cost_storno 27425 27425 0 0.00 0 20125 71 0 0
sp_multiply_rows_for_pdistr 27425 27425 0 0.00 0 7728 26 0 0
sp_multiply_rows_for_qdistr 20095 20095 0 0.00 0 11365 155 0 0
sp_pay_from_customer 6869 6869 0 0.00 3 16211 107 0 0
sp_pay_to_supplier 5844 5844 0 0.00 4 21129 157 0 0
sp_payment_common 12713 12713 0 0.00 1 15900 35 0 0
sp_qd_handle_on_cancel_clo 1745 1745 0 0.00 0 9673 310 0 0
sp_qd_handle_on_invoice_upd_sts 10993 10993 0 0.00 0 23261 314 0 0
sp_qd_handle_on_reserve_upd_sts 9790 9790 0 0.00 0 18145 63 0 0
sp_reserve_write_off 9790 9790 0 0.00 6 19041 191 0 0
sp_supplier_invoice 5331 5331 0 0.00 5 83322 3387 0 0
sp_supplier_order 5436 5436 0 0.00 5 33304 1166 0 0
srv_aggregate_perf_data 94 94 0 0.00 2383 672165 23139 0 0
srv_fill_mon_cache_memory 62 62 0 0.00 1486 117260 45715 0 0
srv_find_qd_qs_mism 1091149 1091149 0 0.00 0 27773 5 0 0
srv_make_invnt_saldo 543 543 0 0.00 47 38328 1025 0 0
srv_make_money_saldo 813 813 0 0.00 1 7030 31 0 0
srv_recalc_idx_stat 4 4 0 0.00 100138 409849 262409 0 0
t$perf-abend:sp_add_invoice_to_stock 130 130 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-norm:sp_add_invoice_to_stock 4927 4927 0 0.00 0 11514 155 0 0
t$perf-norm:sp_cancel_adding_invoice 408 408 0 0.00 0 4969 98 0 0
t$perf-norm:sp_cancel_client_order 1745 1745 0 0.00 0 2018 7 0 0
t$perf-norm:sp_cancel_customer_reserve 676 676 0 0.00 0 1772 12 0 0
t$perf-norm:sp_cancel_pay_from_customer 698 698 0 0.00 0 3148 17 0 0
t$perf-norm:sp_cancel_pay_to_supplier 416 416 0 0.00 0 2447 13 0 0
t$perf-norm:sp_cancel_supplier_invoice 368 368 0 0.00 0 1791 12 0 0
t$perf-norm:sp_cancel_supplier_order 402 402 0 0.00 0 19843 1648 0 0
t$perf-norm:sp_cancel_write_off 1028 1028 0 0.00 0 803 6 0 0
t$perf-norm:sp_client_order 20095 20095 0 0.00 0 12503 17 0 0
t$perf-norm:sp_customer_reserve 945 945 0 0.00 0 4410 20 0 0
t$perf-norm:sp_pay_from_customer 6869 6869 0 0.00 0 16047 13 0 0
t$perf-norm:sp_pay_to_supplier 5844 5844 0 0.00 0 6740 10 0 0
t$perf-norm:sp_reserve_write_off 9790 9790 0 0.00 0 14546 14 0 0
t$perf-norm:sp_supplier_invoice 5331 5331 0 0.00 0 5316 20 0 0
t$perf-norm:sp_supplier_order 5436 5436 0 0.00 0 6808 15 0 0
t$perf-norm:srv_aggregate_perf_data 94 94 0 0.00 0 15587 175 0 0
t$perf-norm:srv_fill_mon_cache_memory 62 62 0 0.00 0 290 9 0 0
t$perf-norm:srv_make_invnt_saldo 543 543 0 0.00 0 1195 22 0 0
t$perf-norm:srv_make_money_saldo 813 813 0 0.00 0 4937 21 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 6 4 0 0
v_add_invoice_to_stock 10104 9844 260 2.57 0 2574 15 0 260
v_all_customers 36708 36708 0 0.00 0 27 1 0 0
v_all_suppliers 30344 30344 0 0.00 0 31 1 0 0
v_all_wares 40190 40190 0 0.00 0 21 1 0 0
v_cancel_adding_invoice 816 816 0 0.00 0 283 6 0 0
v_cancel_client_order 3490 3490 0 0.00 0 2959 4 0 0
v_cancel_customer_prepayment 1396 1396 0 0.00 0 1382 4 0 0
v_cancel_customer_reserve 1352 1352 0 0.00 0 3334 5 0 0
v_cancel_payment_to_supplier 832 832 0 0.00 0 551 5 0 0
v_cancel_supplier_invoice 762 736 26 3.41 0 3093 20 0 26
v_cancel_supplier_order 804 804 0 0.00 0 842 4 0 0
v_cancel_write_off 2056 2056 0 0.00 0 3482 16 0 0
v_max_id_clo_ord 5436 5436 0 0.00 0 299 1 0 0
v_max_id_clo_res 945 945 0 0.00 0 1382 9 0 0
v_max_id_ord_sup 5330 5330 0 0.00 0 7553 6 0 0
v_max_non_paid_invoice 1438 1438 0 0.00 0 2499 5 0 0
v_max_non_paid_realizn 3556 3556 0 0.00 0 6500 6 0 0
v_min_id_clo_ord 5436 5436 0 0.00 0 4951 9 0 0
v_min_id_clo_res 945 945 0 0.00 0 2444 9 0 0
v_min_id_ord_sup 5330 5330 0 0.00 0 5327 11 0 0
v_min_non_paid_invoice 5844 5844 0 0.00 0 9503 30 0 0
v_min_non_paid_realizn 6869 6869 0 0.00 0 15893 25 0 0
v_our_firm 10108 10108 0 0.00 0 18 1 0 0
v_reserve_write_off 19580 19580 0 0.00 0 6152 6 0 0
x_lock_depdocs_on_canc_invoice 12382 12382 0 0.00 0 25062 102 0 0
x_lock_depdocs_on_canc_sup_ord 402 402 0 0.00 0 8282 411 0 0
x_make_qstorno_1000_1200 5436 5436 0 0.00 1 33296 1093 0 0
x_make_qstorno_1200_2000 5331 5331 0 0.00 2 83313 3233 0 0
x_make_qstorno_2100_3300 463471 463471 0 0.00 0 137755 151 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 17-03-2023 01:40:14 to 17-03-2023 01: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
23:08:45 26 8192000000 8809971744 8825053184 11684400 0.142 3 3 4 0 11868320 76800 107120
23:09:45 15416 8192000000 9899814768 10209300480 986517104 10.748 100 90 180 0 1015945808 5841968 23586736
23:11:13 25260 8192000000 9955887024 10278477824 1030811568 11.176 100 86 172 0 1060518064 7264704 22441792
23:12:49 15647 8192000000 9985366064 10319372288 1073971264 11.590 100 81 162 0 1102384144 8055936 20356944
23:14:10 9061 8192000000 10022175648 10373091328 1116451904 11.993 100 73 144 1 1143350208 9853376 17044928
23:15:26 4431 8192000000 10078807888 10438537216 1170734768 12.504 100 77 150 1 1199556848 11293312 17528768
23:16:32 3724 8192000000 10118116400 10482257920 1206751088 12.839 100 87 175 1 1239219952 13093280 19375584
23:17:38 2595 8192000000 10158946640 10536235008 1246649440 13.207 100 84 167 1 1278333632 13848592 17835600
23:18:42 1417 8192000000 10194330544 10577657856 1279451648 13.508 100 79 154 1 1308343744 12261024 16631072
23:19:44 1097 8192000000 10206029248 10593464320 1300784512 13.702 100 88 171 1 1334525216 13620544 20120160
23:20:46 5424 8192000000 10201451104 10602921984 1306947632 13.758 100 23 47 0 1319724192 7229056 5547504
23:21:53 28996 8192000000 10225037776 10626813952 1316109168 13.841 100 55 110 0 1335570352 6033456 13427728
23:23:23 3520 8192000000 10207477792 10627710976 1322073728 13.895 100 31 62 0 1336207120 7223088 6910304
23:24:28 13612 8192000000 10215953888 10637119488 1329943776 13.967 100 12 25 1 1337929584 5280192 2705616
23:25:42 58556 8192000000 10241833824 10658365440 1341419856 14.070 100 31 62 0 1355098656 5385568 8293232
23:27:42 6356 8192000000 10233371648 10656059392 1343376000 14.088 100 26 52 0 1355516416 6649744 5490672
23:28:51 7677 8192000000 10216258992 10639056896 1328793184 13.956 100 20 40 2 1339885776 6674496 4418096
23:30:00 11750 8192000000 10161617152 10563190784 1216411408 12.928 93 27 52 5 1227944208 4689424 6843376
23:31:16 25698 8192000000 10154343264 10557775872 1154081424 12.348 90 15 30 0 1162240032 4869040 3289568
23:32:43 7560 8192000000 10155041536 10552131584 1227586032 13.032 97 30 60 0 1239614208 5331344 6696832
23:33:54 9983 8192000000 10151813936 10553634816 1260117296 13.331 99 20 40 0 1269844704 4980800 4746608
23:35:07 56788 8192000000 10186665904 10590650368 1284266224 13.552 100 24 48 0 1295486480 5277776 5942480
23:37:04 6540 8192000000 10190573696 10602721280 1302113216 13.714 100 27 53 0 1313745600 5127168 6505216
23:38:15 9349 8192000000 10215819200 10625691648 1321363392 13.889 100 22 44 0 1331184928 4695008 5126528
23:39:33 10198 8192000000 10237778544 10653061120 1338729632 14.046 100 47 94 2 1357267408 8242976 10294800
23:40:58 65196 8192000000 10253710336 10676527104 1351539312 14.161 100 37 74 0 1370198928 9287952 9371664
23:43:12 51576 8192000000 10277186608 10705719296 1371005584 14.336 100 30 60 0 1393305504 14429376 7870544
23:45:06 5376 8192000000 10306199088 10728865792 1389195232 14.499 100 50 98 0 1419286192 18543488 11547472
23:46:16 19279 8192000000 10305572704 10732781568 1382317728 14.437 99 43 86 2 1411928128 19385920 10224480
23:47:45 17905 8192000000 10326047872 10750562304 1403069248 14.622 100 40 80 0 1433227424 20649632 9508544
23:49:07 21191 8192000000 10334124288 10764640256 1415928112 14.737 100 43 86 1 1449411360 22820080 10663168
23:50:33 11255 8192000000 10344873840 10768183296 1415754288 14.735 100 43 86 0 1456556816 29343360 11459168
23:51:50 4215 8192000000 10365226096 10787557376 1422824288 14.798 100 65 129 1 1475844576 36630400 16389888
23:53:01 2876 8192000000 10367374496 10784608256 1405456576 14.644 99 75 150 2 1467087392 43025264 18605552
23:54:15 1484 8192000000 10371237264 10782453760 1408938048 14.675 100 81 162 0 1477962272 48609376 20414848
23:55:23 1885 8192000000 10359199584 10763210752 1390944256 14.514 100 85 169 2 1458585440 47177072 20464112
23:56:31 2835 8192000000 10363114512 10772271104 1396883056 14.567 100 86 172 0 1470152176 51726864 21542256
23:57:44 5857 8192000000 10342140560 10755084288 1364456448 14.277 98 58 116 0 1435986928 56160416 15370064
23:58:58 1567 8192000000 10376732416 10785021952 1392348560 14.527 100 81 161 1 1478317056 65305312 20663184
00:00:02 7724 8192000000 10351762384 10785779712 1389979808 14.506 100 34 68 0 1457396560 57627152 9789600
00:01:25 15214 8192000000 10320104256 10747125760 1351507792 14.161 99 39 78 0 1416355840 53396800 11451248
00:02:43 13881 8192000000 10326473776 10757275648 1363662800 14.270 99 40 80 2 1423928480 49918336 10347344
00:04:25 20292 8192000000 10275506224 10717483008 1345951392 14.111 99 19 36 0 1378698064 28400768 4345904
00:05:53 35704 8192000000 10288358176 10730557440 1303355632 13.726 96 25 50 0 1342566384 32386480 6824272
00:07:30 62607 8192000000 10259058944 10709475328 1327015792 13.940 99 10 20 0 1354919760 25121456 2782512
00:09:41 39573 8192000000 10254030768 10696667136 1335553216 14.017 99 20 39 1 1350147984 10378784 4215984
00:11:25 50545 8192000000 10283864160 10698878976 1302038832 13.714 95 36 72 0 1324551056 14064288 8447936
00:13:18 90112 8192000000 10266720192 10712264704 1348177520 14.131 99 22 44 0 1370285008 17320784 4786704
00:15:49 39867 8192000000 10286917008 10726100992 1336371776 14.025 98 35 70 0 1372778848 27464112 8942960
00:17:34 77363 8192000000 10292557152 10755538944 1385315552 14.464 100 42 82 0 1412065552 17267024 9482976
00:19:57 42425 8192000000 10288027056 10748342272 1376435600 14.385 99 11 22 0 1395580240 16650336 2494304
00:21:40 117260 8192000000 10304982672 10770681856 1394345920 14.545 100 12 24 1 1413588720 16353568 2889232
00:25:53 34546 8192000000 10303950336 10776776704 1408114736 14.667 100 12 21 3 1419706720 9314032 2277952
00:27:30 32288 8192000000 10308421264 10778460160 1412549728 14.707 100 9 17 0 1421377296 7169504 1658064
00:29:35 62916 8192000000 10304040416 10784727040 1393175584 14.534 98 20 40 0 1412838032 14809296 4853152
00:31:46 58706 8192000000 10321436240 10809720832 1418826528 14.762 100 20 41 0 1441874608 17918944 5129136
00:34:07 47214 8192000000 10316261136 10787225600 1409185792 14.677 99 14 28 0 1420451616 8080848 3184976
00:35:55 34445 8192000000 10311699520 10773602304 1371737056 14.343 97 29 58 0 1391798752 13612624 6449072
00:37:40 56044 8192000000 10327637872 10784620544 1407520272 14.662 100 29 56 0 1424693040 11413680 5759088
00:39:37 57493 8192000000 10320017472 10786172928 1377981072 14.398 97 17 33 1 1399302064 18115232 3205760
00:41:36 46646 8192000000 10293395360 10746474496 1336559104 14.026 95 17 34 0 1354787552 14663232 3565216
00:44:45 79413 8192000000 10283248768 10727718912 1347580624 14.126 98 32 64 2 1365938496 11049440 7308432
00:47:05 22484 8192000000 10299396912 10748760064 1377961552 14.398 100 38 76 0 1405847824 19653680 8232592
00:48:43 66661 8192000000 10262259584 10724397056 1303658464 13.728 95 7 14 0 1313974384 8851072 1464848
00:50:50 54034 8192000000 10265967840 10726084608 1347586080 14.126 98 11 22 0 1361374000 11298208 2489712
00:52:51 61544 8192000000 10248133328 10704277504 1316718880 13.847 96 14 28 1 1328383696 8499072 3165744
00:55:03 52005 8192000000 10269535376 10730749952 1356539552 14.206 99 30 61 0 1375039408 11744832 6755024
00:56:55 71317 8192000000 10291539104 10744406016 1368487024 14.313 99 21 40 0 1396246624 23543616 4215984
00:59:11 58914 8192000000 10261280080 10706472960 1293785792 13.639 95 17 34 0 1307323904 9704224 3833888
01:01:10 59997 8192000000 10257159024 10709446656 1294329632 13.644 95 7 14 0 1314212880 18236880 1646368
01:03:12 37446 8192000000 10264251632 10703335424 1327373584 13.943 98 25 49 0 1342302544 8877104 6051856
01:04:54 48423 8192000000 10283959712 10728714240 1339888480 14.056 98 23 46 0 1361514576 16175152 5450944
01:06:48 116211 8192000000 10277370912 10720964608 1339451888 14.052 98 19 38 0 1358458592 15180560 3826144
01:09:44 46107 8192000000 10269221984 10743611392 1375487824 14.376 100 14 26 0 1391243792 12862496 2893472
01:11:31 72026 8192000000 10274950112 10738413568 1359360528 14.232 98 8 16 0 1367299680 6364592 1574560
01:13:46 94453 8192000000 10315548896 10770984960 1393805040 14.540 100 12 24 0 1409668480 13167344 2696096
01:16:29 82559 8192000000 10306172192 10775674880 1391717680 14.521 99 22 44 1 1413848560 17806384 4324496
01:18:52 51214 8192000000 10314329168 10786738176 1409076688 14.676 100 22 44 0 1430622240 16396576 5148976
01:20:44 75935 8192000000 10319031648 10779512832 1381221536 14.427 98 11 20 1 1398745936 15509312 2015088
01:24:25 37099 8192000000 10303497680 10765803520 1366830080 14.299 98 29 58 0 1389018592 15894576 6293936
01:26:03 62364 8192000000 10298251360 10741166080 1310693872 13.792 94 20 41 2 1328984960 13947984 4343104
01:28:15 88499 8192000000 10265192080 10714460160 1288847184 13.594 93 25 46 0 1304081440 9341856 5892400
01:30:56 46052 8192000000 10280527296 10733858816 1360877296 14.245 99 26 52 1 1375245776 7995888 6372592
01:33:24 65889 8192000000 10270563488 10725388288 1347724176 14.127 98 15 30 0 1363880848 12806160 3350512
01:35:51 82328 8192000000 10253873872 10711388160 1312584880 13.810 95 19 38 0 1326239168 9204688 4449600
01:38:14 35676 8192000000 9219026400 9494888448 379671472 4.429 28 3 6 0 386569392 6229952 667968

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 130 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 17-03-2023 01:40:36 to 17-03-2023 01: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          238108
MON$OLDEST_ACTIVE               238109
MON$OLDEST_SNAPSHOT             238109
MON$NEXT_TRANSACTION            238109
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                       2029728
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'

17.03.23 01: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-17 01:40:41 No severe PSQL-related problems occured
17.03.23 01:40:43. End of report.