Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 12.12.2022 01: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 14924136 kB
MemAvailable 30116576 kB
Buffers 0 kB
Cached 16806452 kB
SwapCached 3264 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 2022-12-12 01:38:30
DTS_END                         2022-12-12 01:38:30.6950
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/39302
TRN_ID                          243444
ATT_ID                          636
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: 9457.91 25170 1134949
customer order: creation 169.60 335 20352
customer order: refuse 14.91 353 1789
order to supplier: creation 44.35 1191 5322
order to supplier: removal 3.38 109572 405
invoice (draft): creation 45.20 3265 5424
invoice (draft): removal 54.17 805 6500
invoice accept: apply 42.16 16459 5059
invoice accept: cancel 48.99 744 5879
customer reserve: creation 3900.07 161 468008
customer reserve: removal 4834.52 60 580143
realization accept: apply 82.76 182 9931
realization accept: cancel 89.18 108 10701
payment from customer: creation 59.68 136 7162
payment from customer: removal 5.35 128 642
payment to supplier: creation 48.46 145 5815
payment to supplier: removal 3.34 91 401
service: total inventory turnovers 4.42 1405 530
service: total monetary turnovers 6.50 43 780
service: aggregate perf. data 0.85 18837 102
service: refresh index statistics 0.03 349380 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 12-12-2022 01:41:09 to 12-12-2022 01:41:12.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 3709
TEST_TIME 2 3456
TEST_TIME 3 3462
TEST_TIME 4 3596
TEST_TIME 5 3576
TEST_TIME 6 3766
TEST_TIME 7 3906
TEST_TIME 8 4002
TEST_TIME 9 3953
TEST_TIME 10 4254
TEST_TIME 11 4424
TEST_TIME 12 4922
TEST_TIME 13 5132
TEST_TIME 14 5722
TEST_TIME 15 6126
TEST_TIME 16 6494
TEST_TIME 17 6754
TEST_TIME 18 7271
TEST_TIME 19 7337
TEST_TIME 20 7767
TEST_TIME 21 8241
TEST_TIME 22 8774
TEST_TIME 23 8887
TEST_TIME 24 9042
TEST_TIME 25 9180
TEST_TIME 26 9647
TEST_TIME 27 9851
TEST_TIME 28 10792
TEST_TIME 29 10900
TEST_TIME 30 10712
TEST_TIME 31 10498
TEST_TIME 32 10570
TEST_TIME 33 10616
TEST_TIME 34 10649
TEST_TIME 35 10579
TEST_TIME 36 10311
TEST_TIME 37 10246
TEST_TIME 38 10054
TEST_TIME 39 10045
TEST_TIME 40 9985
TEST_TIME 41 9971
TEST_TIME 42 9932
TEST_TIME 43 9945
TEST_TIME 44 9829
TEST_TIME 45 9776
TEST_TIME 46 9716
TEST_TIME 47 9670
TEST_TIME 48 9546
TEST_TIME 49 9595
TEST_TIME 50 9539
TEST_TIME 51 9526
TEST_TIME 52 9466
TEST_TIME 53 9496
TEST_TIME 54 9516
TEST_TIME 55 9474
TEST_TIME 56 9420
TEST_TIME 57 9448
TEST_TIME 58 9663
TEST_TIME 59 9739
TEST_TIME 60 9750
TEST_TIME 61 9799
TEST_TIME 62 9823
TEST_TIME 63 9842
TEST_TIME 64 9878
TEST_TIME 65 9966
TEST_TIME 66 9865
TEST_TIME 67 9813
TEST_TIME 68 9829
TEST_TIME 69 9731
TEST_TIME 70 9813
TEST_TIME 71 9767
TEST_TIME 72 9766
TEST_TIME 73 9705
TEST_TIME 74 9669
TEST_TIME 75 9582
TEST_TIME 76 9574
TEST_TIME 77 9521
TEST_TIME 78 9481
TEST_TIME 79 9438
TEST_TIME 80 9417
TEST_TIME 81 9526
TEST_TIME 82 9540
TEST_TIME 83 9512
TEST_TIME 84 9493
TEST_TIME 85 9556
TEST_TIME 86 9675
TEST_TIME 87 9626
TEST_TIME 88 9685
TEST_TIME 89 9740
TEST_TIME 90 9711
TEST_TIME 91 9770
TEST_TIME 92 9757
TEST_TIME 93 9685
TEST_TIME 94 9682
TEST_TIME 95 9650
TEST_TIME 96 9607
TEST_TIME 97 9596
TEST_TIME 98 9547
TEST_TIME 99 9612
TEST_TIME 100 9607
TEST_TIME 101 9578
TEST_TIME 102 9558
TEST_TIME 103 9533
TEST_TIME 104 9551
TEST_TIME 105 9575
TEST_TIME 106 9603
TEST_TIME 107 9585
TEST_TIME 108 9624
TEST_TIME 109 9698
TEST_TIME 110 9688
TEST_TIME 111 9745
TEST_TIME 112 9674
TEST_TIME 113 9625
TEST_TIME 114 9618
TEST_TIME 115 9623
TEST_TIME 116 9620
TEST_TIME 117 9590
TEST_TIME 118 9560
TEST_TIME 119 9515
TEST_TIME 120 9461

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 12-12-2022 01:41:13 to 12-12-2022 01:41:17.

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 1568130 1568130 0 0.00 0 27753 6 0 0
doc_list_biud 1568129 1568129 0 0.00 0 36639 28 0 0
sp_add_invoice_to_stock 5183 5059 124 2.39 21 165812 16459 0 124
sp_cancel_adding_invoice 5879 5879 0 0.00 6 83442 744 0 0
sp_cancel_client_order 1789 1789 0 0.00 4 13125 354 0 0
sp_cancel_customer_reserve 580143 580143 0 0.00 0 16453 60 0 0
sp_cancel_pay_from_customer 642 642 0 0.00 3 22463 128 0 0
sp_cancel_pay_to_supplier 401 401 0 0.00 3 7957 91 0 0
sp_cancel_supplier_invoice 6505 6500 5 0.07 2 24229 806 0 5
sp_cancel_supplier_order 405 405 0 0.00 6 1077028 109573 0 0
sp_cancel_write_off 10701 10701 0 0.00 1 15273 108 0 0
sp_client_order 20352 20352 0 0.00 3 25500 335 0 0
sp_customer_reserve 468008 468008 0 0.00 0 98047 162 0 0
sp_fill_shopping_cart 31094 31094 0 0.00 1 14766 38 0 0
sp_fill_shopping_cart_clo_res 468006 468006 0 0.00 0 20298 14 0 0
sp_get_clo_for_invoice 5056 5056 0 0.00 0 24796 314 0 0
sp_kill_cost_storno 17623 17623 0 0.00 0 18003 58 0 0
sp_kill_qstorno_ret_qs2qd 1177892 1177892 0 0.00 0 24179 33 0 0
sp_kill_qty_storno 620404 620404 0 0.00 0 36639 70 0 0
sp_lock_selected_doc 20799 20799 0 0.00 0 5129 4 0 0
sp_make_cost_storno 27964 27964 0 0.00 0 23876 59 0 0
sp_multiply_rows_for_pdistr 27964 27964 0 0.00 0 23485 38 0 0
sp_multiply_rows_for_qdistr 20352 20352 0 0.00 0 17601 148 0 0
sp_pay_from_customer 7162 7162 0 0.00 4 25983 136 0 0
sp_pay_to_supplier 5815 5815 0 0.00 4 22223 145 0 0
sp_payment_common 12977 12977 0 0.00 1 22486 45 0 0
sp_qd_handle_on_cancel_clo 1789 1789 0 0.00 0 13117 322 0 0
sp_qd_handle_on_invoice_upd_sts 10935 10935 0 0.00 0 36637 315 0 0
sp_qd_handle_on_reserve_upd_sts 9931 9931 0 0.00 0 16445 52 0 0
sp_reserve_write_off 9931 9931 0 0.00 5 26569 182 0 0
sp_supplier_invoice 5424 5424 0 0.00 6 94943 3266 0 0
sp_supplier_order 5322 5322 0 0.00 5 47368 1191 0 0
srv_aggregate_perf_data 102 102 0 0.00 3014 171059 18838 0 0
srv_fill_mon_cache_memory 62 62 0 0.00 1471 128181 47596 0 0
srv_find_qd_qs_mism 1087259 1087259 0 0.00 0 9740 5 0 0
srv_make_invnt_saldo 530 530 0 0.00 46 149187 1406 0 0
srv_make_money_saldo 780 780 0 0.00 0 11224 43 0 0
srv_recalc_idx_stat 4 4 0 0.00 268146 441299 349381 0 0
t$perf-abend:sp_add_invoice_to_stock 124 124 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 5 5 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5059 5059 0 0.00 0 17004 176 0 0
t$perf-norm:sp_cancel_adding_invoice 422 422 0 0.00 0 3706 85 0 0
t$perf-norm:sp_cancel_client_order 1789 1789 0 0.00 0 5626 15 0 0
t$perf-norm:sp_cancel_customer_reserve 690 690 0 0.00 0 2792 14 0 0
t$perf-norm:sp_cancel_pay_from_customer 642 642 0 0.00 0 2223 7 0 0
t$perf-norm:sp_cancel_pay_to_supplier 401 401 0 0.00 0 4795 19 0 0
t$perf-norm:sp_cancel_supplier_invoice 412 412 0 0.00 0 3371 25 0 0
t$perf-norm:sp_cancel_supplier_order 405 405 0 0.00 0 30651 1807 0 0
t$perf-norm:sp_cancel_write_off 1051 1051 0 0.00 0 797 5 0 0
t$perf-norm:sp_client_order 20352 20352 0 0.00 0 8224 15 0 0
t$perf-norm:sp_customer_reserve 984 984 0 0.00 0 313 3 0 0
t$perf-norm:sp_pay_from_customer 7162 7162 0 0.00 0 7206 11 0 0
t$perf-norm:sp_pay_to_supplier 5815 5815 0 0.00 0 5343 9 0 0
t$perf-norm:sp_reserve_write_off 9931 9931 0 0.00 0 19386 14 0 0
t$perf-norm:sp_supplier_invoice 5424 5424 0 0.00 0 8165 22 0 0
t$perf-norm:sp_supplier_order 5322 5322 0 0.00 0 5491 20 0 0
t$perf-norm:srv_aggregate_perf_data 102 102 0 0.00 0 266 3 0 0
t$perf-norm:srv_fill_mon_cache_memory 62 62 0 0.00 0 637 13 0 0
t$perf-norm:srv_make_invnt_saldo 530 530 0 0.00 0 1706 23 0 0
t$perf-norm:srv_make_money_saldo 780 780 0 0.00 0 1919 19 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 7 4 0 0
v_add_invoice_to_stock 10360 10112 248 2.39 0 10971 21 0 248
v_all_customers 37116 37116 0 0.00 0 98 1 0 0
v_all_suppliers 29934 29934 0 0.00 0 27 1 0 0
v_all_wares 40702 40702 0 0.00 0 68 1 0 0
v_cancel_adding_invoice 844 844 0 0.00 0 3927 19 0 0
v_cancel_client_order 3578 3578 0 0.00 0 4999 7 0 0
v_cancel_customer_prepayment 1284 1284 0 0.00 0 880 4 0 0
v_cancel_customer_reserve 1380 1380 0 0.00 0 2527 5 0 0
v_cancel_payment_to_supplier 802 802 0 0.00 0 1344 9 0 0
v_cancel_supplier_invoice 834 824 10 1.19 0 3455 22 0 10
v_cancel_supplier_order 810 810 0 0.00 0 3491 8 0 0
v_cancel_write_off 2102 2102 0 0.00 0 6690 18 0 0
v_max_id_clo_ord 5322 5322 0 0.00 0 3795 2 0 0
v_max_id_clo_res 984 984 0 0.00 0 2795 17 0 0
v_max_id_ord_sup 5421 5421 0 0.00 0 8454 8 0 0
v_max_non_paid_invoice 1591 1591 0 0.00 0 413 3 0 0
v_max_non_paid_realizn 3754 3754 0 0.00 0 4350 6 0 0
v_min_id_clo_ord 5322 5322 0 0.00 0 6032 8 0 0
v_min_id_clo_res 984 984 0 0.00 0 3921 9 0 0
v_min_id_ord_sup 5421 5421 0 0.00 0 5449 5 0 0
v_min_non_paid_invoice 5815 5815 0 0.00 0 22155 27 0 0
v_min_non_paid_realizn 7162 7162 0 0.00 0 22473 46 0 0
v_our_firm 10402 10402 0 0.00 0 16 1 0 0
v_reserve_write_off 19862 19862 0 0.00 0 10930 8 0 0
x_lock_depdocs_on_canc_invoice 11967 11967 0 0.00 0 13643 118 0 0
x_lock_depdocs_on_canc_sup_ord 405 405 0 0.00 0 14587 337 0 0
x_make_qstorno_1000_1200 5322 5322 0 0.00 2 47358 1114 0 0
x_make_qstorno_1200_2000 5424 5424 0 0.00 3 94934 3131 0 0
x_make_qstorno_2100_3300 468008 468008 0 0.00 0 98040 145 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 12-12-2022 01:41:18 to 12-12-2022 01:41:22.

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:34 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
23:09:35 22634 8192000000 9887422832 10199916544 975529168 10.641 100 82 164 0 1003094496 6083280 21482048
23:11:01 21872 8192000000 9949201312 10271588352 1035571792 11.222 100 91 182 0 1067317120 8723072 23022256
23:12:26 11164 8192000000 9989176592 10321965056 1073543776 11.586 100 86 172 0 1104652784 10536640 20572368
23:13:45 11024 8192000000 10037135696 10383994880 1123193296 12.057 100 82 163 1 1154898464 12601088 19104080
23:15:00 5508 8192000000 10091699808 10450792448 1175340976 12.547 100 84 166 0 1207736656 13612896 18782784
23:16:07 4321 8192000000 10118019792 10486571008 1206097584 12.833 100 83 163 2 1237154800 12689168 18368048
23:17:14 1904 8192000000 10154387936 10531164160 1247383776 13.214 100 74 147 0 1275566000 11477472 16704752
23:18:17 1251 8192000000 10198541344 10582986752 1281934784 13.531 100 88 175 0 1315150976 13190592 20025600
23:19:20 28082 8192000000 10201440704 10602217472 1301054096 13.705 100 49 98 0 1321476176 9368256 11053824
23:20:56 6388 8192000000 10201055440 10609311744 1308616720 13.774 100 21 41 3 1322956192 9495968 4843504
23:22:03 6496 8192000000 10202048272 10618982400 1317034672 13.850 100 21 43 0 1328323744 6719696 4569376
23:23:10 11238 8192000000 10208939840 10629636096 1326966208 13.940 100 9 18 0 1333922560 5359200 1597152
23:24:23 10473 8192000000 10220214112 10638946304 1331056864 13.977 100 29 57 0 1342559776 5421584 6081328
23:25:37 24779 8192000000 10232987888 10654265344 1335116352 14.013 100 25 48 0 1346269472 6070208 5082912
23:27:05 6342 8192000000 10235936544 10650468352 1330674144 13.973 100 33 66 1 1345693488 7669488 7349856
23:28:13 6949 8192000000 10193627136 10614435840 1299161024 13.688 99 26 52 0 1311417008 6156912 6099072
23:29:23 70033 8192000000 10182081232 10585948160 1219874192 12.961 94 43 86 0 1235738000 5644208 10219600
23:31:37 8032 8192000000 10114025760 10510163968 1166621088 12.465 93 26 52 0 1177938128 4840000 6477040
23:32:46 3004 8192000000 10152071936 10555428864 1258177888 13.313 100 33 65 0 1272416560 6996768 7241904
23:33:49 48112 8192000000 10163667488 10557489152 1248322224 13.223 98 30 61 0 1260768864 4609504 7837136
23:35:38 7059 8192000000 10190051232 10594770944 1289877168 13.603 100 36 72 0 1305894592 7975536 8041888
23:36:46 13004 8192000000 10187068432 10604134400 1298444144 13.681 100 19 37 0 1308788432 5691392 4652896
23:38:03 11997 8192000000 10210796736 10627346432 1318176976 13.860 100 12 21 0 1325084016 4565840 2341200
23:39:23 98772 8192000000 10245168512 10669891584 1341471392 14.071 100 35 70 0 1358279104 8791264 8016448
23:42:31 15872 8192000000 10276482672 10701688832 1368878624 14.317 100 41 81 0 1393261792 14681536 9701632
23:43:50 31974 8192000000 10310659312 10735955968 1385221968 14.463 100 28 56 0 1418580256 26600768 6757520
23:45:47 5384 8192000000 10311141520 10734014464 1387591408 14.484 99 55 108 0 1424100256 22739808 13769040
23:47:06 16482 8192000000 10328968960 10753445888 1393545968 14.537 99 39 76 0 1433116288 30031904 9538416
23:48:34 8209 8192000000 10352117824 10775748608 1407390608 14.661 99 57 115 1 1453316960 31503648 14422704
23:49:48 6903 8192000000 10379876896 10797776896 1427822736 14.842 100 73 146 0 1482967472 36996608 18148128
23:51:02 4598 8192000000 10389606848 10813440000 1438349856 14.935 100 63 123 1 1496311840 42521984 15440000
23:52:13 1471 8192000000 10387884608 10797035520 1418576976 14.760 100 84 169 1 1486096704 46134320 21385408
23:53:18 3297 8192000000 10359837152 10768359424 1397675328 14.574 100 79 156 3 1462721408 45402160 19643920
23:54:26 2998 8192000000 10347027232 10751127552 1379264000 14.410 100 82 161 0 1447665728 48200704 20201024
23:55:35 1785 8192000000 10372017312 10778198016 1403414112 14.625 100 85 170 1 1474997408 50358768 21224528
23:56:40 11359 8192000000 10329201520 10746916864 1358461408 14.224 98 55 108 1 1418597088 45584672 14551008
23:58:01 4546 8192000000 10332976720 10739195904 1362185824 14.257 99 65 127 1 1433764144 55072288 16506032
23:59:12 1765 8192000000 10360366096 10764754944 1384877952 14.460 100 86 171 0 1456951136 50146624 21926560
00:00:17 5071 8192000000 10345268576 10776739840 1387479472 14.483 99 47 94 0 1442250480 41998576 12772432
00:01:25 14828 8192000000 10317646000 10743533568 1369621296 14.324 99 38 75 0 1420637280 40702864 10313120
00:02:40 13407 8192000000 10321981440 10750889984 1353944048 14.183 98 30 60 0 1410268048 48118688 8205312
00:04:04 15290 8192000000 10309950256 10742177792 1358162992 14.221 100 24 48 0 1414060848 48745232 7152624
00:05:31 38897 8192000000 10291216896 10726273024 1340193968 14.059 100 18 36 0 1389985056 44803696 4987392
00:07:27 58158 8192000000 10266814464 10713067520 1360605296 14.243 100 30 57 1 1379329344 12145568 6578480
00:09:29 76427 8192000000 10299461424 10750971904 1380580160 14.422 100 27 54 1 1395470272 9369632 5520480
00:11:46 55930 8192000000 10299644192 10753515520 1346340976 14.115 97 8 16 0 1367404464 19463648 1599840
00:13:43 93899 8192000000 10300690640 10739617792 1382028000 14.435 100 37 73 0 1400291008 9449104 8813904
00:16:24 109665 8192000000 10291859312 10732998656 1317096656 13.850 95 15 29 0 1332822368 12125200 3600512
00:19:17 18711 8192000000 10298708448 10748186624 1386513664 14.475 100 48 96 0 1408499344 10971568 11014112
00:20:45 54326 8192000000 10295535904 10764873728 1381319856 14.428 99 16 32 0 1402059008 16778144 3961008
00:22:43 47875 8192000000 10283821264 10743848960 1371880624 14.344 99 14 27 0 1383672736 8875936 2916176
00:24:33 18570 8192000000 10285581104 10741403648 1381702400 14.432 100 11 23 1 1391605392 7512064 2390928
00:25:54 65142 8192000000 10285230368 10744823808 1370496224 14.331 99 11 22 0 1382544224 9208368 2839632
00:28:24 10909 8192000000 10284065792 10736115712 1376512848 14.385 100 40 81 0 1393818528 8322416 8983264
00:29:36 47042 8192000000 10278543216 10739187712 1374691216 14.369 100 14 28 0 1386707216 8185760 3830240
00:31:27 82311 8192000000 10291356320 10755174400 1387894320 14.487 100 14 28 0 1401315184 10177664 3243200
00:34:05 37843 8192000000 10299675920 10756943872 1388716608 14.494 100 29 58 0 1412812912 17229152 6867152
00:35:52 117762 8192000000 10279841504 10748092416 1315509104 13.836 95 13 26 0 1329556448 11008704 3038640
00:38:54 56967 8192000000 10275145840 10733481984 1339728688 14.055 97 20 40 1 1357986880 13773280 4484912
00:40:53 117851 8192000000 10271527328 10711552000 1254491952 13.279 91 17 34 0 1272529024 14490032 3547040
00:43:52 69601 8192000000 10271773264 10720129024 1306164688 13.751 96 24 48 0 1325313776 14003952 5145136
00:47:09 44750 8192000000 10267372496 10711085056 1341399136 14.070 98 34 67 0 1363590560 14913552 7277872
00:48:55 78036 8192000000 10253383744 10718478336 1335610304 14.018 98 8 16 0 1351186048 13748400 1827344
00:52:06 70416 8192000000 10253940304 10718867456 1333807344 14.002 97 15 30 1 1345978512 8847056 3324112
00:54:23 46045 8192000000 10277685904 10716323840 1323152992 13.905 97 36 70 0 1339853760 8669568 8031200
00:56:16 38644 8192000000 10286821280 10739122176 1368560608 14.314 100 16 32 0 1382951712 11026656 3364448
00:57:57 53428 8192000000 10278297120 10739249152 1375409552 14.375 100 19 38 0 1392357024 12447504 4499968
00:59:51 42979 8192000000 10249425440 10711486464 1315525088 13.836 97 13 25 0 1330369648 12340992 2503568
01:01:35 24201 8192000000 10287382848 10734960640 1365788752 14.289 100 33 67 1 1383738880 11154656 6795472
01:03:01 53968 8192000000 10291266512 10758443008 1370147648 14.328 99 29 58 0 1399015664 22002080 6865936
01:04:56 64449 8192000000 10278136416 10723598336 1286495168 13.572 93 19 38 0 1306174832 15689808 3989856
01:07:01 56563 8192000000 10283062256 10745544704 1372227728 14.347 100 27 54 1 1398779120 20519216 6032176
01:09:00 26943 8192000000 10308022368 10751336448 1375143456 14.373 99 33 66 0 1396919056 14521152 7254448
01:10:28 128181 8192000000 10287107600 10752094208 1365050576 14.283 98 17 34 1 1383500272 14807200 3642496
01:13:47 73774 8192000000 10292722640 10758750208 1374231056 14.365 98 13 26 0 1386906816 8790160 3885600
01:16:01 86972 8192000000 10293869152 10752258048 1322457120 13.899 95 12 24 0 1341101648 16153904 2490624
01:19:13 22260 8192000000 10283277088 10730467328 1348664688 14.135 98 29 58 0 1361615872 6182000 6769184
01:20:45 37015 8192000000 10298359728 10737344512 1364601360 14.279 99 27 54 0 1380454048 10039952 5812736
01:22:23 81264 8192000000 10288397216 10739793920 1320337920 13.880 96 24 48 0 1342645616 16316848 5990848
01:24:48 70065 8192000000 10301467120 10756435968 1385551216 14.466 100 18 36 0 1404511392 14802016 4158160
01:26:58 110635 8192000000 10283164688 10738688000 1320452080 13.881 95 9 18 0 1336841024 14180064 2208880
01:29:56 119333 8192000000 10271315136 10729619456 1352971536 14.174 99 20 40 0 1378590320 20842368 4776416
01:33:06 68849 8192000000 10276973696 10747273216 1380469408 14.421 100 14 28 0 1397507792 13459904 3578480
01:35:25 57493 8192000000 10269959168 10740334592 1366945120 14.300 99 5 10 0 1377413728 9122048 1346560
01:37:28 52704 8192000000 10270506864 10740985856 1364600560 14.279 99 12 24 0 1378330752 10683664 3046528

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 12-12-2022 01:41:24 to 12-12-2022 01:41:39.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 124 v_add_invoice_to_stock 335544517
except 5 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 12-12-2022 01:41:40 to 12-12-2022 01:41:42.

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

12.12.22 01:41:43. There are 6 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
2022-12-12 01:41:46 No severe PSQL-related problems occured
12.12.22 01:41:47. End of report.