Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 13.01.2023 16: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 15332844 kB
MemAvailable 30422896 kB
Buffers 0 kB
Cached 16402220 kB
SwapCached 4460 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-13 16:38:37
DTS_END                         2023-01-13 16:38:37.5900
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/57396
TRN_ID                          242513
ATT_ID                          642
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: 9424.13 20314 1130896
customer order: creation 177.52 402 21302
customer order: refuse 14.93 387 1792
order to supplier: creation 45.66 1303 5479
order to supplier: removal 3.40 97571 408
invoice (draft): creation 47.22 3708 5666
invoice (draft): removal 54.40 760 6528
invoice accept: apply 42.20 16214 5064
invoice accept: cancel 49.32 792 5918
customer reserve: creation 3865.93 161 463912
customer reserve: removal 4827.98 54 579358
realization accept: apply 85.62 185 10274
realization accept: cancel 78.79 104 9455
payment from customer: creation 59.46 114 7135
payment from customer: removal 5.38 74 645
payment to supplier: creation 51.13 126 6135
payment to supplier: removal 3.62 63 434
service: total inventory turnovers 4.43 1282 532
service: total monetary turnovers 6.33 35 759
service: aggregate perf. data 0.80 21468 96
service: refresh index statistics 0.03 261477 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 13-01-2023 16:40:25 to 13-01-2023 16:40:27.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 2750
TEST_TIME 2 2330
TEST_TIME 3 2916
TEST_TIME 4 3359
TEST_TIME 5 3845
TEST_TIME 6 4215
TEST_TIME 7 4514
TEST_TIME 8 4547
TEST_TIME 9 4547
TEST_TIME 10 5246
TEST_TIME 11 5405
TEST_TIME 12 5772
TEST_TIME 13 6081
TEST_TIME 14 5967
TEST_TIME 15 6001
TEST_TIME 16 6738
TEST_TIME 17 7386
TEST_TIME 18 7363
TEST_TIME 19 7824
TEST_TIME 20 7821
TEST_TIME 21 7720
TEST_TIME 22 7884
TEST_TIME 23 8519
TEST_TIME 24 9125
TEST_TIME 25 9101
TEST_TIME 26 9056
TEST_TIME 27 9294
TEST_TIME 28 9825
TEST_TIME 29 10294
TEST_TIME 30 10375
TEST_TIME 31 10359
TEST_TIME 32 10061
TEST_TIME 33 9804
TEST_TIME 34 9915
TEST_TIME 35 9908
TEST_TIME 36 9793
TEST_TIME 37 9753
TEST_TIME 38 9695
TEST_TIME 39 9756
TEST_TIME 40 9694
TEST_TIME 41 9708
TEST_TIME 42 9667
TEST_TIME 43 9662
TEST_TIME 44 9561
TEST_TIME 45 9508
TEST_TIME 46 9364
TEST_TIME 47 9308
TEST_TIME 48 9370
TEST_TIME 49 9291
TEST_TIME 50 9192
TEST_TIME 51 9112
TEST_TIME 52 9112
TEST_TIME 53 9188
TEST_TIME 54 9192
TEST_TIME 55 9134
TEST_TIME 56 9003
TEST_TIME 57 8953
TEST_TIME 58 8881
TEST_TIME 59 8890
TEST_TIME 60 8975
TEST_TIME 61 9024
TEST_TIME 62 8991
TEST_TIME 63 9036
TEST_TIME 64 9150
TEST_TIME 65 9169
TEST_TIME 66 9134
TEST_TIME 67 9316
TEST_TIME 68 9326
TEST_TIME 69 9463
TEST_TIME 70 9547
TEST_TIME 71 9533
TEST_TIME 72 9594
TEST_TIME 73 9625
TEST_TIME 74 9554
TEST_TIME 75 9464
TEST_TIME 76 9462
TEST_TIME 77 9430
TEST_TIME 78 9414
TEST_TIME 79 9399
TEST_TIME 80 9382
TEST_TIME 81 9309
TEST_TIME 82 9280
TEST_TIME 83 9265
TEST_TIME 84 9307
TEST_TIME 85 9302
TEST_TIME 86 9313
TEST_TIME 87 9359
TEST_TIME 88 9337
TEST_TIME 89 9360
TEST_TIME 90 9357
TEST_TIME 91 9406
TEST_TIME 92 9371
TEST_TIME 93 9469
TEST_TIME 94 9429
TEST_TIME 95 9597
TEST_TIME 96 9538
TEST_TIME 97 9618
TEST_TIME 98 9615
TEST_TIME 99 9559
TEST_TIME 100 9477
TEST_TIME 101 9420
TEST_TIME 102 9438
TEST_TIME 103 9374
TEST_TIME 104 9327
TEST_TIME 105 9310
TEST_TIME 106 9287
TEST_TIME 107 9304
TEST_TIME 108 9349
TEST_TIME 109 9372
TEST_TIME 110 9386
TEST_TIME 111 9383
TEST_TIME 112 9369
TEST_TIME 113 9475
TEST_TIME 114 9469
TEST_TIME 115 9460
TEST_TIME 116 9440
TEST_TIME 117 9525
TEST_TIME 118 9522
TEST_TIME 119 9500
TEST_TIME 120 9426

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 13-01-2023 16:40:29 to 13-01-2023 16:40:32.

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 1560826 1560826 0 0.00 0 21394 6 0 0
doc_list_biud 1560818 1560818 0 0.00 0 64807 26 0 0
sp_add_invoice_to_stock 5144 5064 80 1.55 47 158467 16215 0 80
sp_cancel_adding_invoice 5918 5918 0 0.00 4 70742 793 0 0
sp_cancel_client_order 1792 1792 0 0.00 4 10775 387 0 0
sp_cancel_customer_reserve 579358 579358 0 0.00 0 64808 54 0 0
sp_cancel_pay_from_customer 645 645 0 0.00 3 3871 75 0 0
sp_cancel_pay_to_supplier 434 434 0 0.00 3 3529 64 0 0
sp_cancel_supplier_invoice 6532 6528 4 0.06 1 16365 761 0 4
sp_cancel_supplier_order 408 408 0 0.00 10 975412 97571 0 0
sp_cancel_write_off 9455 9455 0 0.00 1 8448 104 0 0
sp_client_order 21302 21302 0 0.00 3 23188 402 0 0
sp_customer_reserve 463912 463912 0 0.00 0 47565 161 0 0
sp_fill_shopping_cart 32441 32441 0 0.00 1 22393 40 0 0
sp_fill_shopping_cart_clo_res 463906 463906 0 0.00 0 24119 14 0 0
sp_get_clo_for_invoice 5058 5058 0 0.00 0 40791 306 0 0
sp_kill_cost_storno 16452 16452 0 0.00 0 10421 54 0 0
sp_kill_qstorno_ret_qs2qd 1175107 1175107 0 0.00 0 64804 30 0 0
sp_kill_qty_storno 618787 618787 0 0.00 0 64806 65 0 0
sp_lock_selected_doc 21005 21005 0 0.00 0 8722 7 0 0
sp_make_cost_storno 28600 28600 0 0.00 0 21382 54 0 0
sp_multiply_rows_for_pdistr 28596 28596 0 0.00 0 8099 23 0 0
sp_multiply_rows_for_qdistr 21302 21302 0 0.00 0 19091 174 0 0
sp_pay_from_customer 7135 7135 0 0.00 4 13721 115 0 0
sp_pay_to_supplier 6135 6135 0 0.00 4 14294 126 0 0
sp_payment_common 13264 13264 0 0.00 1 11638 26 0 0
sp_qd_handle_on_cancel_clo 1792 1792 0 0.00 0 9390 341 0 0
sp_qd_handle_on_invoice_upd_sts 10974 10974 0 0.00 0 27873 338 0 0
sp_qd_handle_on_reserve_upd_sts 10272 10272 0 0.00 0 16329 62 0 0
sp_reserve_write_off 10274 10274 0 0.00 6 16378 186 0 0
sp_supplier_invoice 5666 5666 0 0.00 5 94684 3709 0 0
sp_supplier_order 5479 5479 0 0.00 4 27909 1304 0 0
srv_aggregate_perf_data 96 96 0 0.00 3074 239382 21468 0 0
srv_fill_mon_cache_memory 62 62 0 0.00 1689 149627 47031 0 0
srv_find_qd_qs_mism 1082637 1082637 0 0.00 0 17640 5 0 0
srv_make_invnt_saldo 532 532 0 0.00 43 54132 1282 0 0
srv_make_money_saldo 759 759 0 0.00 1 7384 36 0 0
srv_recalc_idx_stat 4 4 0 0.00 106670 542992 261477 0 0
t$perf-abend:sp_add_invoice_to_stock 80 80 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 4 4 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5065 5065 0 0.00 0 18107 172 0 0
t$perf-norm:sp_cancel_adding_invoice 385 385 0 0.00 0 4427 100 0 0
t$perf-norm:sp_cancel_client_order 1792 1792 0 0.00 0 5985 19 0 0
t$perf-norm:sp_cancel_customer_reserve 661 661 0 0.00 0 9393 29 0 0
t$perf-norm:sp_cancel_pay_from_customer 645 645 0 0.00 0 871 5 0 0
t$perf-norm:sp_cancel_pay_to_supplier 434 434 0 0.00 0 2623 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 401 401 0 0.00 0 696 13 0 0
t$perf-norm:sp_cancel_supplier_order 408 408 0 0.00 0 25207 1702 0 0
t$perf-norm:sp_cancel_write_off 951 951 0 0.00 0 2701 7 0 0
t$perf-norm:sp_client_order 21302 21302 0 0.00 0 10676 18 0 0
t$perf-norm:sp_customer_reserve 1055 1055 0 0.00 0 9051 18 0 0
t$perf-norm:sp_pay_from_customer 7135 7135 0 0.00 0 10632 15 0 0
t$perf-norm:sp_pay_to_supplier 6135 6135 0 0.00 0 11147 15 0 0
t$perf-norm:sp_reserve_write_off 10275 10275 0 0.00 0 10347 14 0 0
t$perf-norm:sp_supplier_invoice 5666 5666 0 0.00 0 11685 25 0 0
t$perf-norm:sp_supplier_order 5479 5479 0 0.00 0 8526 19 0 0
t$perf-norm:srv_aggregate_perf_data 96 96 0 0.00 0 819 16 0 0
t$perf-norm:srv_fill_mon_cache_memory 62 62 0 0.00 0 22 1 0 0
t$perf-norm:srv_make_invnt_saldo 532 532 0 0.00 0 4812 24 0 0
t$perf-norm:srv_make_money_saldo 759 759 0 0.00 0 3760 27 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 4 3 0 0
v_add_invoice_to_stock 10272 10112 160 1.55 0 22607 22 0 160
v_all_customers 38432 38432 0 0.00 0 21 1 0 0
v_all_suppliers 31052 31052 0 0.00 0 148 1 0 0
v_all_wares 42600 42600 0 0.00 0 45 1 0 0
v_cancel_adding_invoice 770 770 0 0.00 0 593 9 0 0
v_cancel_client_order 3584 3584 0 0.00 0 4374 7 0 0
v_cancel_customer_prepayment 1290 1290 0 0.00 0 3243 10 0 0
v_cancel_customer_reserve 1322 1322 0 0.00 0 1537 5 0 0
v_cancel_payment_to_supplier 868 868 0 0.00 0 258 3 0 0
v_cancel_supplier_invoice 810 802 8 0.98 0 745 14 0 8
v_cancel_supplier_order 816 816 0 0.00 0 289 4 0 0
v_cancel_write_off 1902 1902 0 0.00 0 3908 17 0 0
v_max_id_clo_ord 5475 5475 0 0.00 0 806 2 0 0
v_max_id_clo_res 1055 1055 0 0.00 0 3454 24 0 0
v_max_id_ord_sup 5662 5662 0 0.00 0 5082 5 0 0
v_max_non_paid_invoice 1743 1743 0 0.00 0 989 3 0 0
v_max_non_paid_realizn 3942 3942 0 0.00 0 1954 4 0 0
v_min_id_clo_ord 5475 5475 0 0.00 0 10933 13 0 0
v_min_id_clo_res 1055 1055 0 0.00 0 4667 17 0 0
v_min_id_ord_sup 5662 5662 0 0.00 0 7993 16 0 0
v_min_non_paid_invoice 6132 6132 0 0.00 0 11633 21 0 0
v_min_non_paid_realizn 7132 7132 0 0.00 0 8180 19 0 0
v_our_firm 10548 10548 0 0.00 0 16 1 0 0
v_reserve_write_off 20544 20544 0 0.00 0 7649 8 0 0
x_lock_depdocs_on_canc_invoice 12045 12045 0 0.00 0 20504 110 0 0
x_lock_depdocs_on_canc_sup_ord 408 408 0 0.00 0 21802 376 0 0
x_make_qstorno_1000_1200 5479 5479 0 0.00 1 27724 1220 0 0
x_make_qstorno_1200_2000 5666 5666 0 0.00 2 93931 3565 0 0
x_make_qstorno_2100_3300 463912 463912 0 0.00 0 47563 145 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 13-01-2023 16:40:33 to 13-01-2023 16:40:37.

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
14:08:41 1 8192000000 8799932912 8811417600 6198352 0.075 2 1 2 0 6297984 56848 42784
14:09:41 32904 8192000000 9913403824 10225348608 989503248 10.777 100 90 180 0 1019323680 6008592 23811840
14:11:28 5921 8192000000 9954192352 10274668544 1037850064 11.244 100 91 182 0 1069596000 8635408 23110528
14:12:39 14480 8192000000 9981011616 10309169152 1061632480 11.472 100 94 188 0 1095915984 10666448 23617056
14:14:02 13498 8192000000 10015114896 10359443456 1100025008 11.838 100 71 142 0 1127561232 10883248 16652976
14:15:18 6285 8192000000 10061598176 10417332224 1149650976 12.306 100 75 150 0 1178801888 12126576 17024336
14:16:27 2965 8192000000 10106738592 10476163072 1201183184 12.787 100 71 139 0 1229285776 12000304 16102288
14:17:32 2197 8192000000 10147030368 10521616384 1239935408 13.146 100 82 160 1 1274158112 16345024 17877680
14:18:38 1942 8192000000 10177801600 10560909312 1269088528 13.413 100 75 148 0 1299192832 13282336 16821968
14:19:42 1936 8192000000 10199240160 10584752128 1290410992 13.608 100 76 152 0 1318240128 10371488 17457648
14:20:47 25854 8192000000 10185296544 10590244864 1294550640 13.646 100 38 77 0 1310286320 7291472 8444208
14:22:19 11727 8192000000 10187282464 10600632320 1304953872 13.740 100 10 20 0 1312800416 5834736 2011808
14:23:31 13386 8192000000 10196622272 10618548224 1318695408 13.865 100 14 28 0 1327603680 5871664 3036608
14:24:45 60145 8192000000 10237794304 10642915328 1327814368 13.947 100 44 87 2 1345339488 5796992 11728128
14:26:47 5200 8192000000 10226173856 10645008384 1322200320 13.897 99 29 59 0 1335681504 7081120 6400064
14:27:55 4536 8192000000 10239003552 10653306880 1341999936 14.075 100 30 60 0 1354958800 6095920 6862944
14:29:01 73312 8192000000 10186717200 10597261312 1219368976 12.956 92 20 40 0 1229148784 5292064 4487744
14:31:19 7839 8192000000 10154262544 10551291904 1188718560 12.671 93 13 26 0 1196525792 4619728 3187504
14:32:27 12683 8192000000 10140007920 10538545152 1235160368 13.102 99 20 41 0 1245620000 6280432 4179200
14:33:40 19823 8192000000 10162876880 10564456448 1270227472 13.424 99 24 48 1 1281372304 5421600 5723232
14:35:00 14626 8192000000 10171597872 10588880896 1285045344 13.559 100 25 50 0 1296256032 5904288 5306400
14:36:15 7968 8192000000 10198552736 10605137920 1297709408 13.674 100 35 68 3 1311400320 6191376 7499536
14:37:26 11295 8192000000 10191896576 10613608448 1307037024 13.759 100 14 28 0 1316737328 5894352 3805952
14:38:37 42402 8192000000 10235874240 10646994944 1332340064 13.988 100 27 50 3 1342320176 4214928 5765184
14:40:30 51494 8192000000 10259175504 10676584448 1351681920 14.163 100 31 62 0 1373416496 14593328 7141248
14:42:25 21996 8192000000 10274976496 10702761984 1361220496 14.248 100 31 62 0 1392212592 23410720 7581376
14:43:50 10935 8192000000 10297932640 10716721152 1376042560 14.381 100 54 108 1 1410439728 21869184 12527984
14:45:10 5104 8192000000 10300144208 10717642752 1375154480 14.373 100 56 111 0 1407897072 19849888 12892704
14:46:20 6717 8192000000 10311910720 10736467968 1385823280 14.469 100 48 96 1 1421111488 23458480 11829728
14:47:37 4980 8192000000 10328182224 10751209472 1399478640 14.590 100 50 101 0 1440791200 29528016 11784544
14:48:46 8527 8192000000 10334739056 10757103616 1406586064 14.654 100 66 129 0 1448488864 25854768 16048032
14:49:59 2727 8192000000 10350328096 10774171648 1412876240 14.709 100 59 115 1 1454718432 28069712 13772480
14:51:07 5484 8192000000 10333484656 10749485056 1380879648 14.424 99 56 111 2 1427496368 33006000 13610720
14:52:17 2593 8192000000 10348592144 10774093824 1407377728 14.661 100 56 110 2 1459066784 37522224 14166832
14:53:22 1688 8192000000 10348895120 10754158592 1385165248 14.463 100 81 158 1 1449227888 43840048 20222592
14:54:30 4143 8192000000 10330991552 10753335296 1382441728 14.438 100 62 124 2 1442076704 43416720 16218256
14:55:38 3289 8192000000 10299585744 10707091456 1355417472 14.196 99 69 136 0 1406412704 34643808 16351424
14:56:47 6624 8192000000 10301946384 10714337280 1350620656 14.153 99 64 124 0 1402898240 36579904 15697680
14:57:58 19349 8192000000 10294347344 10720354304 1348406688 14.133 98 31 62 0 1388033728 31336336 8290704
14:59:35 9175 8192000000 10292855584 10711314432 1345364720 14.106 100 43 82 1 1392930448 36565200 11000528
15:01:02 22688 8192000000 10301295952 10731417600 1345531616 14.107 99 32 64 0 1400479600 46011840 8936144
15:02:30 13693 8192000000 10285529984 10725421056 1359098800 14.229 100 28 56 0 1395993200 29909728 6984672
15:04:00 16519 8192000000 10288063024 10720722944 1356229312 14.203 100 24 48 1 1394466384 31582368 6654704
15:05:19 23143 8192000000 10294443856 10740461568 1363116992 14.265 100 19 36 0 1408198416 39451920 5629504
15:06:48 29969 8192000000 10263864048 10698330112 1308721552 13.774 97 16 33 0 1347538384 34021008 4795824
15:08:22 49539 8192000000 10289594320 10721550336 1366490112 14.296 100 25 50 1 1387170080 15209632 5470336
15:10:18 82647 8192000000 10288446160 10715475968 1368695744 14.315 100 46 91 1 1391821616 12551024 10574848
15:13:44 88330 8192000000 10289619984 10733146112 1362473840 14.260 99 31 60 1 1384146016 13968704 7703472
15:16:12 50779 8192000000 10296855648 10741948416 1380604944 14.422 99 17 34 0 1396904448 12194176 4105328
15:18:09 83552 8192000000 10298749376 10754969600 1380569840 14.422 99 25 49 0 1403186720 16563568 6053312
15:21:17 79451 8192000000 10308732384 10761003008 1401306256 14.607 100 19 38 0 1414577408 8467888 4803264
15:23:45 74286 8192000000 10309085968 10755936256 1398688576 14.583 100 28 56 0 1412957392 7722064 6546752
15:26:13 23070 8192000000 10332621248 10765676544 1403828960 14.629 100 61 119 4 1431604240 14726464 13048816
15:27:57 11171 8192000000 10313453472 10771668992 1411084272 14.694 100 33 64 0 1425124160 6601792 7438096
15:29:23 35990 8192000000 10331392368 10782527488 1419523856 14.768 100 36 71 0 1439142400 11063536 8555008
15:31:02 46230 8192000000 10308995344 10778398720 1402960416 14.621 99 18 36 0 1423311792 15778336 4573040
15:32:49 33259 8192000000 10286552384 10746109952 1385462176 14.465 99 16 32 0 1396149184 7137264 3549744
15:34:50 77765 8192000000 10282020416 10752126976 1380796672 14.424 99 13 26 0 1396123888 12483008 2844208
15:37:08 80359 8192000000 10271948736 10736816128 1310576704 13.791 94 13 26 0 1329950064 16402352 2971008
15:39:33 45582 8192000000 10271003360 10726121472 1349876416 14.146 98 19 38 1 1362485072 8619600 3989056
15:41:20 76396 8192000000 10285147984 10734268416 1313660480 13.819 95 17 34 0 1326502272 9240272 3601520
15:43:37 60517 8192000000 10281591584 10738335744 1358378000 14.223 99 11 22 0 1376100480 15181200 2541280
15:46:08 40113 8192000000 10283249296 10736828416 1346277600 14.114 98 22 44 0 1370426192 18869600 5278992
15:47:48 54490 8192000000 10271129056 10733789184 1329327104 13.961 97 15 29 0 1346820720 14405600 3088016
15:50:03 24087 8192000000 10273830496 10706423808 1322447232 13.899 97 37 74 0 1341918960 11184416 8287312
15:51:34 135828 8192000000 10257522176 10693730304 1297720256 13.675 96 20 41 1 1311453008 9667088 4065664
15:54:55 49223 8192000000 10255756336 10699313152 1348754208 14.136 100 39 77 1 1370060736 12838704 8467824
15:56:53 50741 8192000000 10237315328 10685939712 1303406416 13.726 96 16 32 0 1317262576 9998272 3857888
15:58:52 51284 8192000000 10252968544 10712469504 1344050624 14.094 99 5 10 0 1355339328 10153488 1135216
16:00:44 70860 8192000000 10248620848 10714656768 1343386128 14.088 99 11 22 0 1358541104 12640128 2514848
16:02:56 55505 8192000000 10254086976 10707156992 1328099040 13.950 98 19 38 0 1339947456 7534352 4314064
16:04:53 71310 8192000000 10256989632 10711769088 1333984400 14.003 98 15 30 1 1350421616 13234160 3203056
16:07:07 50345 8192000000 10266353856 10719215616 1349791824 14.146 99 18 36 0 1363974832 10024144 4158864
16:09:04 48029 8192000000 10281752368 10742091776 1374170032 14.364 100 20 40 0 1388888688 10634256 4084400
16:10:57 43641 8192000000 10287654832 10740482048 1355560176 14.197 98 17 34 0 1373286736 13475184 4251376
16:12:43 52910 8192000000 10292495168 10741882880 1339971392 14.057 97 23 47 0 1367904896 22531728 5401776
16:14:45 78835 8192000000 10299056624 10758438912 1378682016 14.405 100 13 26 0 1411985488 29972144 3331328
16:17:05 101753 8192000000 10283844144 10733219840 1347163488 14.122 97 23 45 2 1362157712 9443680 5550544
16:21:28 86250 8192000000 10285648352 10742947840 1350508336 14.152 97 12 24 0 1367340016 13912288 2919392
16:23:54 77240 8192000000 10291596320 10753052672 1387760208 14.486 100 16 32 1 1407283216 15722528 3800480
16:26:50 149627 8192000000 10278598480 10732048384 1288061536 13.587 93 11 22 0 1306541568 15474800 3005232
16:30:20 83108 8192000000 10271513968 10737696768 1347004752 14.121 97 12 24 0 1362682528 12840528 2837248
16:32:43 64870 8192000000 10250491664 10695966720 1286434032 13.572 94 14 26 0 1299730896 10848672 2448192
16:34:50 68357 8192000000 10279558688 10749603840 1355318960 14.195 99 11 22 0 1373780352 16078128 2383264
16:37:26 95267 8192000000 9241785600 9514475520 400352480 4.659 29 17 34 0 408559760 4701312 3505968

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 80 v_add_invoice_to_stock 335544517
except 4 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 13-01-2023 16:40:55 to 13-01-2023 16:40:57.

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

13.01.23 16:40:58. 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-13 16:41:01 No severe PSQL-related problems occured
13.01.23 16:41:02. End of report.