Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 10.03.2023 04: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 14782244 kB
MemAvailable 30435584 kB
Buffers 20 kB
Cached 16881652 kB
SwapCached 3032 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 4.0.3
DB_NAME                         /home/bases/oltp40-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/oltp40-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp40-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb40/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=3400
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/oltp40-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-oltp40
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-10 04:37:28
DTS_END                         2023-03-10 04:37:28.1520
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_INVOICE(39:5) ==> X_MAKE_QSTORNO_1200_2000(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/49074
TRN_ID                          216750
ATT_ID                          652
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: 9242.62 29640 1109114
customer order: creation 158.64 462 19037
customer order: refuse 13.98 411 1678
order to supplier: creation 43.48 1345 5217
order to supplier: removal 3.58 160999 429
invoice (draft): creation 43.37 3034 5204
invoice (draft): removal 55.43 942 6652
invoice accept: apply 39.65 24631 4758
invoice accept: cancel 50.18 1153 6022
customer reserve: creation 3654.73 236 438568
customer reserve: removal 4889.04 93 586685
realization accept: apply 78.55 262 9426
realization accept: cancel 89.04 161 10685
payment from customer: creation 56.93 149 6832
payment from customer: removal 5.36 119 643
payment to supplier: creation 45.58 195 5470
payment to supplier: removal 3.37 114 404
service: total inventory turnovers 3.68 4146 442
service: total monetary turnovers 7.18 369 862
service: aggregate perf. data 0.80 18756 96
service: refresh index statistics 0.03 375232 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-03-2023 04:40:15 to 10-03-2023 04:40:17.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7538
TEST_TIME 2 5764
TEST_TIME 3 6009
TEST_TIME 4 5633
TEST_TIME 5 5434
TEST_TIME 6 5352
TEST_TIME 7 4981
TEST_TIME 8 5166
TEST_TIME 9 5348
TEST_TIME 10 5563
TEST_TIME 11 5915
TEST_TIME 12 6268
TEST_TIME 13 6582
TEST_TIME 14 6820
TEST_TIME 15 7114
TEST_TIME 16 7271
TEST_TIME 17 7367
TEST_TIME 18 7481
TEST_TIME 19 7710
TEST_TIME 20 7870
TEST_TIME 21 7985
TEST_TIME 22 8418
TEST_TIME 23 8644
TEST_TIME 24 8492
TEST_TIME 25 8521
TEST_TIME 26 8342
TEST_TIME 27 8623
TEST_TIME 28 9131
TEST_TIME 29 9695
TEST_TIME 30 9720
TEST_TIME 31 10301
TEST_TIME 32 10378
TEST_TIME 33 10439
TEST_TIME 34 10706
TEST_TIME 35 11107
TEST_TIME 36 11231
TEST_TIME 37 11311
TEST_TIME 38 11097
TEST_TIME 39 11034
TEST_TIME 40 10966
TEST_TIME 41 10875
TEST_TIME 42 10869
TEST_TIME 43 10675
TEST_TIME 44 10621
TEST_TIME 45 10564
TEST_TIME 46 10432
TEST_TIME 47 10344
TEST_TIME 48 10290
TEST_TIME 49 10223
TEST_TIME 50 10185
TEST_TIME 51 10157
TEST_TIME 52 10086
TEST_TIME 53 10007
TEST_TIME 54 10042
TEST_TIME 55 9908
TEST_TIME 56 10215
TEST_TIME 57 10148
TEST_TIME 58 10156
TEST_TIME 59 10261
TEST_TIME 60 10275
TEST_TIME 61 10220
TEST_TIME 62 10276
TEST_TIME 63 10168
TEST_TIME 64 10227
TEST_TIME 65 10227
TEST_TIME 66 10237
TEST_TIME 67 10150
TEST_TIME 68 10049
TEST_TIME 69 9999
TEST_TIME 70 9919
TEST_TIME 71 9858
TEST_TIME 72 9827
TEST_TIME 73 9781
TEST_TIME 74 9729
TEST_TIME 75 9667
TEST_TIME 76 9698
TEST_TIME 77 9678
TEST_TIME 78 9639
TEST_TIME 79 9588
TEST_TIME 80 9580
TEST_TIME 81 9591
TEST_TIME 82 9570
TEST_TIME 83 9558
TEST_TIME 84 9558
TEST_TIME 85 9628
TEST_TIME 86 9694
TEST_TIME 87 9722
TEST_TIME 88 9817
TEST_TIME 89 9766
TEST_TIME 90 9795
TEST_TIME 91 9728
TEST_TIME 92 9669
TEST_TIME 93 9618
TEST_TIME 94 9635
TEST_TIME 95 9575
TEST_TIME 96 9514
TEST_TIME 97 9502
TEST_TIME 98 9484
TEST_TIME 99 9426
TEST_TIME 100 9420
TEST_TIME 101 9388
TEST_TIME 102 9366
TEST_TIME 103 9357
TEST_TIME 104 9389
TEST_TIME 105 9382
TEST_TIME 106 9371
TEST_TIME 107 9380
TEST_TIME 108 9437
TEST_TIME 109 9393
TEST_TIME 110 9404
TEST_TIME 111 9452
TEST_TIME 112 9478
TEST_TIME 113 9502
TEST_TIME 114 9557
TEST_TIME 115 9483
TEST_TIME 116 9417
TEST_TIME 117 9398
TEST_TIME 118 9382
TEST_TIME 119 9323
TEST_TIME 120 9269

Performance per minute, chart


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

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 1515873 1515873 0 0.00 0 16487 12 0 0
doc_list_biud 1515861 1515861 0 0.00 0 43528 42 0 0
sp_add_invoice_to_stock 4883 4758 125 2.55 56 215421 24632 0 125
sp_cancel_adding_invoice 6022 6022 0 0.00 6 75870 1154 0 0
sp_cancel_client_order 1678 1678 0 0.00 6 13142 411 0 0
sp_cancel_customer_reserve 586685 586685 0 0.00 1 19795 94 0 0
sp_cancel_pay_from_customer 643 643 0 0.00 4 4958 120 0 0
sp_cancel_pay_to_supplier 404 404 0 0.00 4 1697 114 0 0
sp_cancel_supplier_invoice 6665 6652 13 0.19 3 43531 943 0 13
sp_cancel_supplier_order 429 429 0 0.00 13 1389688 160999 0 0
sp_cancel_write_off 10685 10685 0 0.00 2 13024 162 0 0
sp_client_order 19037 19037 0 0.00 5 22643 463 0 0
sp_customer_reserve 438568 438568 0 0.00 0 47673 236 0 0
sp_fill_shopping_cart 29442 29442 0 0.00 1 24182 80 0 0
sp_fill_shopping_cart_clo_res 438528 438528 0 0.00 0 19183 18 0 0
sp_get_clo_for_invoice 4713 4713 0 0.00 0 26339 322 0 0
sp_kill_cost_storno 17754 17754 0 0.00 0 8789 66 0 0
sp_kill_qstorno_ret_qs2qd 1191136 1191136 0 0.00 0 43526 41 0 0
sp_kill_qty_storno 626288 626288 0 0.00 0 43528 94 0 0
sp_lock_selected_doc 19628 19628 0 0.00 0 15414 9 0 0
sp_make_cost_storno 26441 26441 0 0.00 0 16169 75 0 0
sp_multiply_rows_for_pdistr 26440 26440 0 0.00 0 9036 37 0 0
sp_multiply_rows_for_qdistr 19037 19037 0 0.00 0 19438 199 0 0
sp_pay_from_customer 6832 6832 0 0.00 6 16494 150 0 0
sp_pay_to_supplier 5470 5470 0 0.00 7 16215 195 0 0
sp_payment_common 12302 12302 0 0.00 2 7771 40 0 0
sp_qd_handle_on_cancel_clo 1678 1678 0 0.00 0 13131 342 0 0
sp_qd_handle_on_invoice_upd_sts 10735 10735 0 0.00 0 15916 487 0 0
sp_qd_handle_on_reserve_upd_sts 9424 9424 0 0.00 0 10491 61 0 0
sp_reserve_write_off 9426 9426 0 0.00 9 15433 262 0 0
sp_supplier_invoice 5204 5204 0 0.00 8 81881 3034 0 0
sp_supplier_order 5217 5217 0 0.00 7 39400 1346 0 0
srv_aggregate_perf_data 96 96 0 0.00 2384 239866 18756 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 798 144492 36501 0 0
srv_find_qd_qs_mism 1064422 1064422 0 0.00 0 9884 9 0 0
srv_make_invnt_saldo 442 442 0 0.00 33 72185 4147 0 0
srv_make_money_saldo 862 862 0 0.00 1 13181 370 0 0
srv_recalc_idx_stat 4 4 0 0.00 263144 472818 375232 0 0
t$perf-abend:sp_add_invoice_to_stock 125 125 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 4761 4761 0 0.00 0 23529 925 0 0
t$perf-norm:sp_cancel_adding_invoice 384 384 0 0.00 1 8924 570 0 0
t$perf-norm:sp_cancel_client_order 1678 1678 0 0.00 0 6252 29 0 0
t$perf-norm:sp_cancel_customer_reserve 612 612 0 0.00 0 2396 27 0 0
t$perf-norm:sp_cancel_pay_from_customer 643 643 0 0.00 0 1420 18 0 0
t$perf-norm:sp_cancel_pay_to_supplier 404 404 0 0.00 0 7171 42 0 0
t$perf-norm:sp_cancel_supplier_invoice 374 374 0 0.00 0 2849 36 0 0
t$perf-norm:sp_cancel_supplier_order 429 429 0 0.00 0 77444 6358 0 0
t$perf-norm:sp_cancel_write_off 975 975 0 0.00 0 12936 36 0 0
t$perf-norm:sp_client_order 19037 19037 0 0.00 0 13386 40 0 0
t$perf-norm:sp_customer_reserve 987 987 0 0.00 0 2543 20 0 0
t$perf-norm:sp_pay_from_customer 6832 6832 0 0.00 0 7651 20 0 0
t$perf-norm:sp_pay_to_supplier 5470 5470 0 0.00 0 12235 25 0 0
t$perf-norm:sp_reserve_write_off 9426 9426 0 0.00 0 8625 22 0 0
t$perf-norm:sp_supplier_invoice 5204 5204 0 0.00 0 13375 32 0 0
t$perf-norm:sp_supplier_order 5217 5217 0 0.00 0 17736 34 0 0
t$perf-norm:srv_aggregate_perf_data 96 96 0 0.00 0 83 3 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 829 19 0 0
t$perf-norm:srv_make_invnt_saldo 442 442 0 0.00 0 6695 29 0 0
t$perf-norm:srv_make_money_saldo 862 862 0 0.00 0 8061 22 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 5 178 52 0 0
v_add_invoice_to_stock 9660 9410 250 2.58 0 5925 24 0 250
v_all_customers 35575 35575 0 0.00 0 59 3 0 0
v_all_suppliers 28959 28959 0 0.00 0 340 4 0 0
v_all_wares 38068 38068 0 0.00 0 84 4 0 0
v_cancel_adding_invoice 768 768 0 0.00 0 1310 16 0 0
v_cancel_client_order 3356 3356 0 0.00 0 3184 10 0 0
v_cancel_customer_prepayment 1286 1286 0 0.00 0 1410 12 0 0
v_cancel_customer_reserve 1224 1224 0 0.00 0 257 9 0 0
v_cancel_payment_to_supplier 808 808 0 0.00 0 1603 11 0 0
v_cancel_supplier_invoice 774 748 26 3.35 0 3678 26 0 26
v_cancel_supplier_order 858 858 0 0.00 0 1746 13 0 0
v_cancel_write_off 1950 1950 0 0.00 0 6397 27 0 0
v_max_id_clo_ord 5213 5213 0 0.00 0 1872 5 0 0
v_max_id_clo_res 987 987 0 0.00 0 1939 14 0 0
v_max_id_ord_sup 5193 5193 0 0.00 0 5950 8 0 0
v_max_non_paid_invoice 1396 1396 0 0.00 0 242 8 0 0
v_max_non_paid_realizn 3313 3313 0 0.00 0 297 7 0 0
v_min_id_clo_ord 5213 5213 0 0.00 0 3071 9 0 0
v_min_id_clo_res 987 987 0 0.00 0 5683 16 0 0
v_min_id_ord_sup 5193 5193 0 0.00 0 8374 13 0 0
v_min_non_paid_invoice 5469 5469 0 0.00 0 4953 13 0 0
v_min_non_paid_realizn 6831 6831 0 0.00 0 6285 14 0 0
v_our_firm 9523 9523 0 0.00 0 81 4 0 0
v_reserve_write_off 18843 18843 0 0.00 0 3203 9 0 0
x_lock_depdocs_on_canc_invoice 12300 12300 0 0.00 0 18927 107 0 0
x_lock_depdocs_on_canc_sup_ord 429 429 0 0.00 0 12153 328 0 0
x_make_qstorno_1000_1200 5217 5217 0 0.00 3 39272 1184 0 0
x_make_qstorno_1200_2000 5204 5204 0 0.00 4 72304 2816 0 0
x_make_qstorno_2100_3300 438566 438566 0 0.00 0 41739 207 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-03-2023 04:40:23 to 10-03-2023 04:40:27.

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
02:07:31 534 8192000000 8894722064 8940949504 53754240 0.651 11 10 13 0 54458016 342672 361104
02:08:33 30933 8192000000 9731112064 10032369664 808605456 8.983 100 88 176 0 837287376 7735840 20946080
02:10:14 22242 8192000000 9775404304 10088370176 847900704 9.379 100 92 183 0 882692064 12729856 22061504
02:11:41 15592 8192000000 9813008112 10133946368 876473456 9.665 100 83 166 0 916894704 21406144 19015104
02:13:00 6559 8192000000 9864448256 10199351296 918037776 10.077 100 83 164 0 976775984 40951696 17786512
02:14:10 4677 8192000000 9927778560 10271739904 957006704 10.460 100 86 169 1 1041137648 66200096 17930848
02:15:18 2673 8192000000 9965137760 10320289792 1000267664 10.881 100 85 167 0 1075923600 58194608 17461328
02:16:24 1018 8192000000 10005165792 10365792256 1023737488 11.108 100 93 180 2 1122412224 80325712 18349024
02:17:27 1321 8192000000 10017504704 10389684224 1042578992 11.289 100 83 163 2 1137371856 79205056 15587808
02:18:30 1069 8192000000 10036816672 10411089920 1056629648 11.424 100 98 188 0 1155370016 79915600 18824768
02:19:33 1132 8192000000 10057187936 10434588672 1068205968 11.535 100 94 179 2 1176685984 89232832 19247184
02:20:36 1407 8192000000 10053015008 10435379200 1072142736 11.573 100 86 166 1 1181052000 91686944 17222320
02:21:38 1037 8192000000 10056344432 10438561792 1077432368 11.623 100 95 189 0 1174458384 78237600 18788416
02:22:42 1205 8192000000 10055584416 10440753152 1081650112 11.663 100 96 178 1 1175471408 74873136 18948160
02:23:44 1071 8192000000 10058959744 10448756736 1092201456 11.764 100 87 163 0 1185820432 77663568 15955408
02:24:47 1119 8192000000 10051419552 10443538432 1091794208 11.760 100 81 150 1 1177063840 70318496 14951136
02:25:49 1157 8192000000 10079639264 10468405248 1096593648 11.805 100 95 182 2 1204193184 90043504 17556032
02:26:52 1244 8192000000 10072888640 10460241920 1096116144 11.801 100 95 185 2 1193747920 79386592 18245184
02:27:54 1145 8192000000 10062848144 10455719936 1099504656 11.833 100 92 174 4 1185960752 67408656 19047440
02:28:56 1295 8192000000 10048760400 10440515584 1085699552 11.702 100 91 173 0 1170506016 68270864 16535600
02:29:59 1175 8192000000 10029175312 10414796800 1080834864 11.655 100 91 174 1 1149211248 51512880 16863504
02:31:00 987 8192000000 10042440944 10418728960 1059725664 11.454 99 97 184 1 1164577632 85989008 18862960
02:32:02 1101 8192000000 10005971056 10386374656 1052424480 11.384 100 92 166 5 1128579456 58429456 17725520
02:33:04 1036 8192000000 10026157280 10407473152 1066294688 11.517 100 93 173 1 1148956352 64394032 18267632
02:34:07 1113 8192000000 10033321808 10412220416 1067261568 11.526 100 100 185 0 1157713248 70089216 20362464
02:35:09 1017 8192000000 9980087728 10352525312 1035851376 11.225 99 96 182 0 1099345904 45749424 17745104
02:36:11 1444 8192000000 10012011040 10389364736 1042956544 11.293 99 89 168 2 1137506480 76987536 17562400
02:37:14 2103 8192000000 10001865760 10382438400 1057858192 11.436 100 83 159 4 1121498480 47505488 16134800
02:38:21 1525 8192000000 10003836208 10383699968 1056933296 11.427 100 88 161 4 1126820256 51826768 18060192
02:39:29 1029 8192000000 10022889312 10405859328 1076900208 11.618 100 93 173 2 1146603216 50330880 19372128
02:40:36 5068 8192000000 10067716736 10457292800 1096777328 11.807 100 74 141 0 1187093360 75762128 14553904
02:41:47 4122 8192000000 10102167072 10493759488 1112068896 11.952 100 75 142 3 1226607152 99174288 15363968
02:43:02 5870 8192000000 10143218592 10538786816 1111955840 11.951 100 71 132 0 1251312704 124864736 14492128
02:44:12 4828 8192000000 10156354576 10562088960 1122147184 12.047 100 77 143 4 1276269520 137701664 16420672
02:45:34 8517 8192000000 10202229232 10604503040 1130615120 12.127 100 66 128 0 1317891120 173393408 13882592
02:46:50 2688 8192000000 10247938096 10642911232 1154923344 12.356 100 82 158 0 1355084240 182981056 17179840
02:47:57 1050 8192000000 10301230736 10696556544 1170598496 12.502 100 93 182 0 1414795024 224085472 20111056
02:49:01 788 8192000000 10331346448 10733244416 1182808272 12.616 100 98 185 2 1443122304 238607904 21706128
02:50:06 1449 8192000000 10325820016 10749599744 1185482416 12.641 100 94 185 0 1444660224 237626224 21551584
02:51:09 1446 8192000000 10342755552 10762141696 1181098480 12.600 100 96 189 0 1454288000 250788864 22400656
02:52:13 1135 8192000000 10357021680 10783072256 1193105232 12.712 100 94 177 1 1462581184 249738784 19737168
02:53:17 1118 8192000000 10410133200 10822967296 1203377520 12.808 100 96 188 2 1522259376 297613296 21268560
02:54:21 907 8192000000 10440021504 10845257728 1197395856 12.752 100 99 192 1 1549321504 330026592 21899056
02:55:24 943 8192000000 10459124944 10875465728 1205555264 12.828 100 96 186 1 1562667760 335454432 21658064
02:56:27 791 8192000000 10460745184 10889809920 1207525872 12.846 100 96 186 0 1568711888 339349920 21836096
02:57:30 1193 8192000000 10503224240 10929913856 1215981216 12.924 100 92 179 0 1608884256 372495312 20407728
02:58:35 1033 8192000000 10503058912 10939404288 1209929520 12.868 100 93 177 1 1629654816 397995296 21730000
02:59:38 1816 8192000000 10480775936 10927075328 1187205696 12.657 99 69 130 3 1596438768 392440208 16792864
03:00:46 16428 8192000000 10471654256 10915168256 1197470624 12.753 100 45 90 0 1571171840 362325648 11375568
03:02:05 6281 8192000000 10492218608 10934771712 1178277296 12.574 100 43 82 1 1599634976 410521616 10836064
03:03:13 10542 8192000000 10546799936 10985988096 1180533680 12.595 100 46 90 1 1649968448 457060976 12373792
03:04:27 13340 8192000000 10507984000 11035860992 1165955280 12.459 100 36 72 0 1629761632 453723664 10082688
03:05:44 17909 8192000000 10363116080 10909609984 1134455344 12.163 97 50 97 1 1541583552 395188848 11939360
03:07:16 45590 8192000000 10300135920 10788655104 1127389328 12.097 98 27 54 0 1417103856 282976064 6738464
03:09:03 13335 8192000000 10225083232 10700042240 1133481408 12.154 100 32 64 0 1336825696 195882064 7462224
03:10:39 48081 8192000000 10254361264 10746982400 1150835968 12.317 100 21 42 1 1368966208 212750416 5379824
03:12:28 64563 8192000000 10067823520 10572853248 1078382128 11.632 95 6 12 0 1185522912 105658416 1482368
03:14:48 64552 8192000000 10069685376 10493636608 1105723744 11.892 98 39 70 1 1141183136 27477248 7982144
03:17:02 85763 8192000000 10092510192 10572611584 1105587968 11.891 97 19 38 0 1172511616 63122256 3801392
03:19:28 82331 8192000000 10069206464 10527698944 1126456800 12.088 100 35 60 1 1160316896 27450928 6409168
03:21:56 52535 8192000000 10093921104 10558775296 1140414112 12.219 100 47 83 0 1199537280 50246544 8876624
03:23:55 38913 8192000000 10112601952 10553860096 1129136512 12.113 99 25 50 1 1206072944 71156752 5779680
03:25:48 17639 8192000000 10144779744 10585194496 1143353808 12.247 99 41 80 0 1244840736 92658208 8828720
03:27:07 10578 8192000000 10178867920 10602143744 1146392064 12.276 99 55 105 0 1257866960 98937344 12537552
03:28:19 32714 8192000000 10222234656 10689155072 1159340272 12.397 100 36 73 0 1327447280 159929984 8177024
03:30:20 35282 8192000000 10215530944 10682028032 1141715696 12.232 99 21 40 0 1308878016 162255264 4907056
03:32:13 20577 8192000000 10214773040 10678771712 1128843472 12.110 99 20 37 0 1309122528 176011120 4267936
03:35:11 59469 8192000000 10110128096 10606882816 1128228128 12.105 99 16 32 1 1245162128 113122304 3811696
03:37:11 64352 8192000000 10068326304 10494763008 1080297040 11.650 95 21 41 0 1127642944 42861168 4484736
03:39:21 52866 8192000000 10116757216 10583588864 1116172944 11.991 98 19 37 0 1210697552 90760320 3764288
03:41:14 35034 8192000000 10087080000 10529087488 1137453856 12.192 100 25 46 0 1185459408 43450272 4555280
03:42:50 58178 8192000000 10099811488 10567741440 1146712960 12.279 100 15 30 0 1225756368 75748016 3295392
03:44:54 128658 8192000000 10052199360 10515574784 1130306128 12.124 100 24 48 1 1167531936 31630816 5594992
03:48:22 35696 8192000000 10102242944 10570555392 1148282000 12.293 100 20 36 1 1193668800 41502064 3884736
03:50:11 48150 8192000000 10141295152 10609295360 1157195952 12.377 100 23 44 0 1234447392 72105536 5145904
03:53:16 71520 8192000000 10069743408 10563801088 1107358048 11.907 97 8 16 0 1142005456 33021904 1625504
03:55:36 41552 8192000000 10080193552 10526945280 1094568864 11.786 97 23 46 0 1173226384 73781776 4875744
03:57:20 47859 8192000000 10122516848 10585464832 1125599168 12.080 99 25 50 0 1227536112 96540304 5396640
03:59:13 44463 8192000000 10162533936 10611834880 1112597088 11.957 97 36 72 0 1231222848 110313616 8312144
04:00:59 37639 8192000000 10208738208 10642608128 1100807408 11.845 96 32 64 0 1260161472 152195552 7158512
04:02:40 35720 8192000000 10118870528 10574839808 1109540016 11.928 99 17 34 0 1223676368 110391872 3744480
04:04:19 58236 8192000000 10094720544 10574204928 1127385248 12.097 100 18 36 0 1224043760 92700240 3958272
04:06:23 15417 8192000000 10085742560 10507436032 1101289872 11.850 98 52 103 0 1162420224 50668176 10462176
04:07:39 144492 8192000000 10058621344 10510467072 1095723296 11.797 98 39 76 0 1138924032 34719168 8481568
04:11:07 56040 8192000000 10035371440 10497503232 1066799296 11.522 96 24 47 1 1101826368 30764048 4263024
04:13:13 52454 8192000000 10056517056 10497531904 1056888576 11.427 95 17 32 1 1111341552 51091840 3361136
04:15:20 95125 8192000000 10044624624 10498531328 1094896016 11.789 99 17 33 1 1136904016 38999792 3008208
04:17:55 85354 8192000000 10089894176 10566488064 1125976016 12.083 100 11 22 0 1186921184 58426416 2518752
04:20:21 49043 8192000000 10093213856 10557509632 1117098592 12.000 98 30 58 0 1186093728 62116176 6878960
04:22:13 29063 8192000000 10126613104 10563411968 1146967168 12.281 100 39 77 0 1216305392 61468336 7869888
04:23:45 77374 8192000000 10126475792 10580819968 1098578960 11.824 96 37 74 0 1195253488 89256880 7417648
04:26:21 102927 8192000000 10153480112 10644365312 1115532128 11.985 97 26 52 0 1234983696 113641472 5810096
04:29:05 18103 8192000000 10158008640 10598404096 1153361808 12.341 100 67 133 0 1247761248 80754656 13644784
04:30:24 39425 8192000000 10133453296 10611777536 1114041680 11.971 97 19 38 0 1195638272 77856784 3739808
04:32:05 122772 8192000000 10067925072 10519248896 1111340976 11.945 98 20 38 1 1142556640 27146368 4069296
04:35:08 66949 8192000000 10077019264 10582552576 1130042032 12.122 100 13 26 1 1209595744 76714304 2839408
04:37:16 20178 8192000000 9041815456 9299230720 202533248 2.412 18 2 4 0 215292624 12383456 375920

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 10-03-2023 04:40:29 to 10-03-2023 04:40:45.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 125 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 10-03-2023 04:40:46 to 10-03-2023 04:40:48.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp40-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   13
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          217210
MON$OLDEST_ACTIVE               217211
MON$OLDEST_SNAPSHOT             217211
MON$NEXT_TRANSACTION            217211
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-30 07:30:08.6030 GMT
MON$PAGES                       2086112
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             768
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2906 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2906 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2906 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2906 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
on disk structure version 13.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-oltp40 according to config parameter 'remove_isql_logs'

10.03.23 04:40:49. There are 3 logs in /var/tmp/logs-oltp40 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-10 04:40:52 No severe PSQL-related problems occured
10.03.23 04:40:53. End of report.