Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 17.07.2022 10:38
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 15690252 kB
MemAvailable 31113260 kB
Buffers 0 kB
Cached 16041356 kB
SwapCached 2492 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.2
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 2022-07-17 10:37:20
DTS_END                         2022-07-17 10:37:20.6450
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(68:17)
IP                              ::1/56798
TRN_ID                          213494
ATT_ID                          606
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: 8777.38 20830 1053285
customer order: creation 162.76 502 19531
customer order: refuse 14.42 388 1730
order to supplier: creation 42.67 1387 5120
order to supplier: removal 3.36 199162 403
invoice (draft): creation 41.88 3030 5026
invoice (draft): removal 51.37 1040 6164
invoice accept: apply 38.16 26236 4579
invoice accept: cancel 47.03 1256 5644
customer reserve: creation 3546.59 248 425591
customer reserve: removal 4544.27 116 545312
realization accept: apply 78.38 281 9405
realization accept: cancel 85.78 180 10294
payment from customer: creation 55.98 185 6717
payment from customer: removal 5.36 142 643
payment to supplier: creation 44.13 192 5295
payment to supplier: removal 3.32 135 398
service: total inventory turnovers 3.87 4626 464
service: total monetary turnovers 7.16 439 859
service: aggregate perf. data 0.88 16602 105
service: refresh index statistics 0.04 160460 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 17-07-2022 10:39:08 to 17-07-2022 10:39:10.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 8414
TEST_TIME 2 7740
TEST_TIME 3 6990
TEST_TIME 4 6701
TEST_TIME 5 6777
TEST_TIME 6 6616
TEST_TIME 7 6461
TEST_TIME 8 6702
TEST_TIME 9 6805
TEST_TIME 10 7122
TEST_TIME 11 7260
TEST_TIME 12 7241
TEST_TIME 13 7384
TEST_TIME 14 7359
TEST_TIME 15 7558
TEST_TIME 16 7381
TEST_TIME 17 7291
TEST_TIME 18 7376
TEST_TIME 19 7416
TEST_TIME 20 7382
TEST_TIME 21 7411
TEST_TIME 22 7710
TEST_TIME 23 7715
TEST_TIME 24 7658
TEST_TIME 25 7722
TEST_TIME 26 7845
TEST_TIME 27 8017
TEST_TIME 28 8407
TEST_TIME 29 8946
TEST_TIME 30 9379
TEST_TIME 31 9985
TEST_TIME 32 9983
TEST_TIME 33 10427
TEST_TIME 34 10856
TEST_TIME 35 11467
TEST_TIME 36 11403
TEST_TIME 37 11303
TEST_TIME 38 11022
TEST_TIME 39 10824
TEST_TIME 40 10763
TEST_TIME 41 10652
TEST_TIME 42 10504
TEST_TIME 43 10349
TEST_TIME 44 10201
TEST_TIME 45 10109
TEST_TIME 46 10066
TEST_TIME 47 10051
TEST_TIME 48 10021
TEST_TIME 49 9890
TEST_TIME 50 9866
TEST_TIME 51 9784
TEST_TIME 52 9729
TEST_TIME 53 9617
TEST_TIME 54 9549
TEST_TIME 55 9423
TEST_TIME 56 9383
TEST_TIME 57 9278
TEST_TIME 58 9271
TEST_TIME 59 9294
TEST_TIME 60 9256
TEST_TIME 61 9181
TEST_TIME 62 9140
TEST_TIME 63 9088
TEST_TIME 64 9145
TEST_TIME 65 9273
TEST_TIME 66 9346
TEST_TIME 67 9336
TEST_TIME 68 9494
TEST_TIME 69 9493
TEST_TIME 70 9432
TEST_TIME 71 9492
TEST_TIME 72 9473
TEST_TIME 73 9422
TEST_TIME 74 9342
TEST_TIME 75 9264
TEST_TIME 76 9254
TEST_TIME 77 9285
TEST_TIME 78 9232
TEST_TIME 79 9175
TEST_TIME 80 9109
TEST_TIME 81 9021
TEST_TIME 82 8982
TEST_TIME 83 8955
TEST_TIME 84 9038
TEST_TIME 85 8995
TEST_TIME 86 8989
TEST_TIME 87 9005
TEST_TIME 88 8991
TEST_TIME 89 8946
TEST_TIME 90 8997
TEST_TIME 91 8956
TEST_TIME 92 9001
TEST_TIME 93 9069
TEST_TIME 94 9150
TEST_TIME 95 9183
TEST_TIME 96 9187
TEST_TIME 97 9093
TEST_TIME 98 9127
TEST_TIME 99 9051
TEST_TIME 100 9013
TEST_TIME 101 8978
TEST_TIME 102 8974
TEST_TIME 103 8975
TEST_TIME 104 8924
TEST_TIME 105 8901
TEST_TIME 106 8881
TEST_TIME 107 8924
TEST_TIME 108 8902
TEST_TIME 109 8871
TEST_TIME 110 8861
TEST_TIME 111 9048
TEST_TIME 112 9065
TEST_TIME 113 9015
TEST_TIME 114 8960
TEST_TIME 115 8917
TEST_TIME 116 8892
TEST_TIME 117 8893
TEST_TIME 118 8832
TEST_TIME 119 8812
TEST_TIME 120 8799

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 17-07-2022 10:39:12 to 17-07-2022 10:39:15.

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 1447097 1447097 0 0.00 0 30019 13 0 0
doc_list_biud 1447090 1447090 0 0.00 0 37610 49 0 0
sp_add_invoice_to_stock 4720 4579 141 2.98 40 230066 26237 0 141
sp_cancel_adding_invoice 5644 5644 0 0.00 5 91754 1256 0 0
sp_cancel_client_order 1730 1730 0 0.00 7 8705 388 0 0
sp_cancel_customer_reserve 545312 545312 0 0.00 1 37624 116 0 0
sp_cancel_pay_from_customer 643 643 0 0.00 4 4680 143 0 0
sp_cancel_pay_to_supplier 398 398 0 0.00 4 2199 135 0 0
sp_cancel_supplier_invoice 6172 6164 8 0.12 3 34382 1040 0 8
sp_cancel_supplier_order 403 403 0 0.00 14 1322427 199162 0 0
sp_cancel_write_off 10294 10294 0 0.00 2 23204 181 0 0
sp_client_order 19531 19531 0 0.00 5 38394 502 0 0
sp_customer_reserve 425591 425591 0 0.00 0 55402 249 0 0
sp_fill_shopping_cart 29657 29657 0 0.00 1 12433 84 0 0
sp_fill_shopping_cart_clo_res 425565 425565 0 0.00 0 19880 22 0 0
sp_get_clo_for_invoice 4545 4545 0 0.00 0 46798 343 0 0
sp_kill_cost_storno 16979 16979 0 0.00 0 16075 79 0 0
sp_kill_qstorno_ret_qs2qd 1107485 1107485 0 0.00 0 37552 50 0 0
sp_kill_qty_storno 583494 583494 0 0.00 0 37609 113 0 0
sp_lock_selected_doc 19385 19385 0 0.00 0 8929 7 0 0
sp_make_cost_storno 25960 25960 0 0.00 0 30014 80 0 0
sp_multiply_rows_for_pdistr 25959 25959 0 0.00 0 10051 38 0 0
sp_multiply_rows_for_qdistr 19531 19531 0 0.00 0 26987 204 0 0
sp_pay_from_customer 6717 6717 0 0.00 5 12552 186 0 0
sp_pay_to_supplier 5295 5295 0 0.00 6 20295 192 0 0
sp_payment_common 12012 12012 0 0.00 2 12023 51 0 0
sp_qd_handle_on_cancel_clo 1730 1730 0 0.00 0 7688 323 0 0
sp_qd_handle_on_invoice_upd_sts 10186 10186 0 0.00 0 36770 555 0 0
sp_qd_handle_on_reserve_upd_sts 9405 9405 0 0.00 0 18687 62 0 0
sp_reserve_write_off 9405 9405 0 0.00 8 30029 281 0 0
sp_supplier_invoice 5026 5026 0 0.00 9 74384 3030 0 0
sp_supplier_order 5120 5120 0 0.00 7 39925 1388 0 0
srv_aggregate_perf_data 106 105 1 0.94 2392 254750 16602 0 1
srv_fill_mon_cache_memory 70 70 0 0.00 880 94882 35122 0 0
srv_find_qd_qs_mism 1008782 1008782 0 0.00 0 15441 9 0 0
srv_make_invnt_saldo 464 464 0 0.00 40 212334 4626 0 0
srv_make_money_saldo 859 859 0 0.00 1 23896 439 0 0
srv_recalc_idx_stat 5 5 0 0.00 55630 288694 160461 0 0
t$perf-abend:sp_add_invoice_to_stock 141 141 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 8 8 0 0.00 0 0 0 0 0
t$perf-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4585 4585 0 0.00 1 24844 964 0 0
t$perf-norm:sp_cancel_adding_invoice 394 394 0 0.00 1 6984 459 0 0
t$perf-norm:sp_cancel_client_order 1730 1730 0 0.00 0 4199 36 0 0
t$perf-norm:sp_cancel_customer_reserve 587 587 0 0.00 0 398 23 0 0
t$perf-norm:sp_cancel_pay_from_customer 643 643 0 0.00 0 1648 17 0 0
t$perf-norm:sp_cancel_pay_to_supplier 398 398 0 0.00 0 2738 22 0 0
t$perf-norm:sp_cancel_supplier_invoice 385 385 0 0.00 0 3660 52 0 0
t$perf-norm:sp_cancel_supplier_order 403 403 0 0.00 0 80054 7480 0 0
t$perf-norm:sp_cancel_write_off 902 902 0 0.00 0 547 16 0 0
t$perf-norm:sp_client_order 19531 19531 0 0.00 0 21334 38 0 0
t$perf-norm:sp_customer_reserve 946 946 0 0.00 0 578 13 0 0
t$perf-norm:sp_pay_from_customer 6717 6717 0 0.00 0 4180 19 0 0
t$perf-norm:sp_pay_to_supplier 5295 5295 0 0.00 0 2198 18 0 0
t$perf-norm:sp_reserve_write_off 9405 9405 0 0.00 0 4425 23 0 0
t$perf-norm:sp_supplier_invoice 5026 5026 0 0.00 0 18592 36 0 0
t$perf-norm:sp_supplier_order 5120 5120 0 0.00 0 2719 30 0 0
t$perf-norm:srv_aggregate_perf_data 105 105 0 0.00 0 411 14 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 363 12 0 0
t$perf-norm:srv_make_invnt_saldo 464 464 0 0.00 0 1160 16 0 0
t$perf-norm:srv_make_money_saldo 859 859 0 0.00 0 4494 10 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 7 712 219 0 0
v_add_invoice_to_stock 9356 9074 282 3.01 0 6310 26 0 282
v_all_customers 35917 35917 0 0.00 0 63 4 0 0
v_all_suppliers 28152 28152 0 0.00 0 122 4 0 0
v_all_wares 39041 39041 0 0.00 0 81 4 0 0
v_cancel_adding_invoice 788 788 0 0.00 0 1399 15 0 0
v_cancel_client_order 3460 3460 0 0.00 0 977 9 0 0
v_cancel_customer_prepayment 1286 1286 0 0.00 0 4588 16 0 0
v_cancel_customer_reserve 1174 1174 0 0.00 0 2061 14 0 0
v_cancel_payment_to_supplier 796 796 0 0.00 0 2112 16 0 0
v_cancel_supplier_invoice 786 770 16 2.03 0 1697 23 0 16
v_cancel_supplier_order 806 806 0 0.00 0 387 11 0 0
v_cancel_write_off 1804 1804 0 0.00 0 4502 27 0 0
v_max_id_clo_ord 5118 5118 0 0.00 0 1984 6 0 0
v_max_id_clo_res 946 946 0 0.00 0 2898 16 0 0
v_max_id_ord_sup 5012 5012 0 0.00 0 5377 9 0 0
v_max_non_paid_invoice 1349 1349 0 0.00 0 91 9 0 0
v_max_non_paid_realizn 3403 3403 0 0.00 0 4194 10 0 0
v_min_id_clo_ord 5118 5118 0 0.00 0 2523 9 0 0
v_min_id_clo_res 946 946 0 0.00 0 2309 12 0 0
v_min_id_ord_sup 5012 5012 0 0.00 0 5345 11 0 0
v_min_non_paid_invoice 5295 5295 0 0.00 0 12016 21 0 0
v_min_non_paid_realizn 6717 6717 0 0.00 0 5215 20 0 0
v_our_firm 9750 9750 0 0.00 0 59 5 0 0
v_reserve_write_off 18810 18810 0 0.00 0 6022 12 0 0
x_lock_depdocs_on_canc_invoice 11423 11423 0 0.00 0 19753 141 0 0
x_lock_depdocs_on_canc_sup_ord 403 403 0 0.00 0 14151 470 0 0
x_make_qstorno_1000_1200 5120 5120 0 0.00 2 38848 1218 0 0
x_make_qstorno_1200_2000 5026 5026 0 0.00 4 74362 2801 0 0
x_make_qstorno_2100_3300 425590 425590 0 0.00 0 55392 215 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 17-07-2022 10:39:16 to 17-07-2022 10:39:20.

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
08:07:24 2 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
08:08:26 27245 8192000000 9717064704 10015318016 798156368 8.878 100 92 182 0 828593072 8063664 22373040
08:10:03 18793 8192000000 9757183216 10063020032 829238560 9.192 100 87 174 0 862544272 12375952 20929760
08:11:28 13608 8192000000 9790710352 10111303680 866552592 9.566 100 78 154 0 902635696 18132880 17950224
08:12:46 7268 8192000000 9854769712 10188705792 914681392 10.044 100 80 161 0 971977648 39448912 17847344
08:13:55 3497 8192000000 9934213968 10279149568 966870080 10.556 100 86 166 2 1044094816 59292352 17932384
08:15:00 1423 8192000000 9968419008 10321063936 1005754672 10.934 100 91 173 1 1087135680 64606640 16774368
08:16:04 1003 8192000000 10003656976 10367008768 1027778208 11.147 100 92 180 1 1123544560 78376880 17389472
08:17:06 1405 8192000000 10019693408 10390183936 1044428528 11.307 100 95 185 0 1139437184 75952992 19055664
08:18:08 1083 8192000000 10018992992 10398052352 1056989968 11.428 100 95 188 1 1137723184 60459488 20273728
08:19:11 6570 8192000000 10039066624 10411728896 1064635904 11.501 100 91 179 2 1156929312 74424192 17869216
08:20:19 1156 8192000000 10030552848 10415788032 1067003488 11.523 100 85 164 2 1152372560 67592560 17776512
08:21:20 1013 8192000000 10024378544 10415435776 1070321488 11.555 100 70 136 0 1147199936 63053728 13824720
08:22:23 1326 8192000000 10032497104 10415099904 1073676864 11.587 100 84 163 0 1153075376 62605008 16793504
08:23:25 1031 8192000000 10046332656 10430238720 1084277312 11.688 100 92 179 1 1173523104 72297776 16948016
08:24:28 1203 8192000000 10055676720 10440572928 1085211328 11.697 100 96 181 1 1176778592 72355152 19212112
08:25:30 1193 8192000000 10062860736 10452250624 1088510416 11.728 100 98 192 4 1186745568 78743376 19491776
08:26:32 1544 8192000000 10037117344 10426081280 1087438064 11.718 100 76 147 0 1161571984 59317568 14816352
08:27:34 3409 8192000000 10047370048 10433576960 1090511696 11.748 100 84 154 3 1163718256 58123856 15082704
08:28:38 899 8192000000 10061054816 10451349504 1090055120 11.743 100 93 175 3 1184144576 75507472 18581984
08:29:42 1217 8192000000 10049863904 10432700416 1075461744 11.604 100 88 168 1 1168611952 75499904 17650304
08:30:45 1982 8192000000 10029152480 10410913792 1063393472 11.489 99 95 177 1 1152604288 69669680 19541136
08:31:47 1160 8192000000 9968143280 10332520448 1010684256 10.982 99 95 181 3 1090710784 61649280 18377248
08:32:50 1169 8192000000 9998442320 10370662400 1035973808 11.226 100 86 167 1 1112443664 60733072 15736784
08:33:52 3546 8192000000 9983831312 10370932736 1039342256 11.258 100 63 122 1 1118965920 66870480 12753184
08:34:57 1201 8192000000 9993948960 10371182592 1035399824 11.220 99 93 170 2 1117174752 64616528 17158400
08:35:59 3234 8192000000 9990905904 10370555904 1047934976 11.341 100 73 135 1 1108641072 47358256 13347840
08:37:03 7281 8192000000 9976142288 10362372096 1045433952 11.317 99 58 105 1 1106079856 50292896 10353008
08:38:19 1337 8192000000 9980159872 10355957760 1040033024 11.265 98 78 131 2 1098205136 45958832 12213280
08:39:27 9027 8192000000 10054539888 10448576512 1092562000 11.767 100 65 126 1 1175843184 70119856 13161328
08:40:40 15673 8192000000 10088713984 10476388352 1105305872 11.888 100 73 136 1 1206723824 87954544 13463408
08:41:59 6910 8192000000 10101284176 10498293760 1114482528 11.975 100 77 148 0 1219084080 88867344 15734208
08:43:12 2872 8192000000 10129032304 10535620608 1119991152 12.027 100 62 112 0 1252294448 120448928 11854368
08:44:20 9870 8192000000 10139742336 10554769408 1133042832 12.150 100 62 113 1 1261450784 116000240 12407712
08:45:37 5520 8192000000 10136639664 10555301888 1144543392 12.258 100 60 117 2 1252518624 95480176 12495056
08:46:46 2500 8192000000 10183054528 10596188160 1162157440 12.423 100 69 136 1 1296910032 120325120 14427472
08:47:52 4297 8192000000 10211503712 10616025088 1178397824 12.575 100 74 132 3 1330233024 137606880 14228320
08:49:00 1380 8192000000 10258638608 10656120832 1184097424 12.628 100 91 180 3 1369087728 165771872 19218432
08:50:04 1018 8192000000 10298561248 10698379264 1177051456 12.563 99 97 188 1 1405111824 206855024 21205344
08:51:09 1329 8192000000 10333485600 10742931456 1199383904 12.771 100 86 165 1 1446069584 226423648 20262032
08:52:11 1117 8192000000 10351722576 10772316160 1204720128 12.820 100 88 168 3 1462086544 238213632 19152784
08:53:18 923 8192000000 10382415616 10786811904 1188592544 12.670 100 95 188 1 1491065360 280066400 22406416
08:54:23 2069 8192000000 10412450176 10824663040 1200899728 12.785 99 91 178 1 1521886096 299793424 21192944
08:55:33 1907 8192000000 10454442768 10886152192 1208529312 12.855 100 88 176 1 1560771264 331105056 21136896
08:56:39 2315 8192000000 10499758432 10909908992 1205125008 12.824 100 87 174 1 1608706976 382525056 21056912
08:57:44 1340 8192000000 10540930960 10964381696 1199916208 12.776 100 94 183 2 1648231296 424959568 23355520
08:58:48 1032 8192000000 10549096208 11000524800 1205295088 12.825 100 96 189 0 1658232832 428822384 24115360
08:59:52 870 8192000000 10588066544 11004977152 1205394240 12.826 100 96 188 2 1701151648 473355696 22401712
09:00:59 1228 8192000000 10634300288 11046305792 1206355472 12.835 99 96 190 0 1737618192 508871264 22391456
09:02:05 981 8192000000 10666109744 11103510528 1207252400 12.844 100 87 169 4 1771765520 542570576 21942544
09:03:12 977 8192000000 10694150848 11120492544 1205895072 12.831 100 91 181 1 1794860544 566033360 22932112
09:04:16 5520 8192000000 10720962192 11179057152 1208663280 12.857 100 76 152 0 1825178144 596008352 20506512
09:05:26 3467 8192000000 10686370640 11201232896 1183744128 12.625 99 67 130 1 1790036800 588692080 17600592
09:07:03 4415 8192000000 10577142800 11093303296 1190942032 12.692 100 45 90 0 1679881920 476954480 11985408
09:08:08 27004 8192000000 10415772160 10896986112 1149711632 12.307 98 32 62 0 1538734080 380933136 8089312
09:09:36 32116 8192000000 10412896272 10928742400 1172278384 12.518 100 31 62 1 1558728192 378549664 7900144
09:11:25 24332 8192000000 10281219632 10808156160 1147210768 12.283 98 19 38 0 1370724304 218982688 4530848
09:13:04 38938 8192000000 10102904032 10558271488 1162489696 12.427 100 21 40 1 1229172064 61104448 5577920
09:14:44 94881 8192000000 10091250384 10542329856 1150054304 12.310 99 40 79 2 1181494272 22358224 9081744
09:17:26 41870 8192000000 10097191632 10566856704 1123812896 12.063 97 47 93 0 1199308368 66155152 9340320
09:19:16 65360 8192000000 10080440384 10538422272 1113859024 11.969 97 21 42 0 1158138144 39679936 4599184
09:21:34 94360 8192000000 10178003856 10623406080 1155988064 12.366 100 30 59 1 1261708736 98656576 7064096
09:24:09 56560 8192000000 10153618448 10650046464 1085415744 11.699 94 23 43 0 1218765584 128312080 5037760
09:26:06 89033 8192000000 10102737664 10576183296 1126136880 12.085 99 19 38 0 1219065840 88273664 4655296
09:28:42 92706 8192000000 10037161552 10477518848 1102510992 11.861 97 17 34 0 1140681088 34777248 3392848
09:31:23 74377 8192000000 10065172560 10534678528 1138996288 12.206 100 13 25 0 1174689968 32935920 2757760
09:33:43 59820 8192000000 10066377184 10546864128 1117012400 11.999 98 9 16 0 1157922720 39469728 1440592
09:35:43 54744 8192000000 10091538592 10577182720 1137844544 12.195 99 18 33 0 1202924224 61157824 3921856
09:37:41 37109 8192000000 10103331104 10543931392 1135662544 12.175 99 16 30 0 1195154880 55918848 3573488
09:39:25 22936 8192000000 10153582336 10594746368 1143520192 12.249 99 31 62 0 1250592192 100468128 6603872
09:40:49 36317 8192000000 10221148848 10665676800 1147009584 12.281 99 32 64 1 1289424672 135682672 6732416
09:42:36 57179 8192000000 10129844800 10595524608 1140779072 12.223 99 20 39 0 1232763472 87905792 4078608
09:44:39 65851 8192000000 10113568272 10610876416 1142580288 12.240 99 18 36 0 1241158976 94416528 4162160
09:46:47 35856 8192000000 10104466272 10537304064 1136790480 12.185 99 41 81 0 1180372816 35055968 8526368
09:48:23 36615 8192000000 10090354032 10557730816 1119380288 12.021 98 29 58 0 1176480336 51489840 5610208
09:50:24 44348 8192000000 10126063952 10586968064 1132488176 12.145 99 33 66 0 1208330912 68912016 6930720
09:52:56 57090 8192000000 10116426448 10591014912 1114940576 11.979 98 39 75 0 1211103072 87744032 8418464
09:54:57 66201 8192000000 10045903248 10503135232 1115313664 11.983 99 11 22 0 1139557808 22204320 2039824
09:57:04 34100 8192000000 10077967728 10530304000 1137910752 12.196 100 19 36 0 1179393136 37456704 4025680
09:58:52 76316 8192000000 10113021088 10595409920 1120645696 12.033 98 9 18 0 1191830496 68594448 2590352
10:01:17 68005 8192000000 10049855328 10515869696 1074397456 11.594 95 11 22 0 1113940352 37216512 2326384
10:03:25 39183 8192000000 10070110016 10537537536 1120110784 12.028 99 24 47 0 1200976608 75343184 5522640
10:05:10 22372 8192000000 10128587088 10568691712 1132665728 12.146 99 36 72 1 1209713104 69317408 7729968
10:06:34 33144 8192000000 10177207440 10640445440 1133680800 12.156 99 39 78 0 1281004880 138493840 8830240
10:08:16 17961 8192000000 10178703680 10609766400 1133687776 12.156 98 36 70 0 1257096944 116225776 7183392
10:09:39 43398 8192000000 10135771168 10626347008 1092206032 11.764 96 29 58 0 1237918080 139440288 6271760
10:11:32 61900 8192000000 10073625056 10537136128 1113981136 11.970 99 18 36 0 1177898224 60237792 3679296
10:13:36 89886 8192000000 10151537968 10606919680 1147854256 12.289 100 40 80 0 1249453664 93069472 8529936
10:16:12 57355 8192000000 10106160912 10581610496 1147195872 12.283 100 7 14 0 1225501616 76733664 1572080
10:18:25 74995 8192000000 10079653808 10552012800 1114256528 11.973 97 9 18 0 1147951696 31494736 2200432
10:20:41 66649 8192000000 10122681312 10575351808 1159239616 12.396 100 22 44 0 1214742208 51003648 4498944
10:22:48 27797 8192000000 10138815536 10577276928 1129280032 12.115 98 27 54 0 1221380752 86025008 6075712
10:24:16 58743 8192000000 10130038928 10576703488 1124036256 12.065 97 28 56 0 1216060800 86005280 6019264
10:26:22 34585 8192000000 10195562320 10631282688 1134299440 12.162 99 38 76 1 1266108560 123931360 7877760
10:28:12 78120 8192000000 10101666288 10579828736 1121813472 12.044 98 10 20 0 1197639328 74022240 1803616
10:31:12 85972 8192000000 10118832048 10559537152 1139700416 12.213 100 59 118 0 1210137904 58569344 11868144
10:34:01 75123 8192000000 10115545536 10609876992 1141165456 12.226 99 15 28 0 1222472288 78316000 2990832
10:37:15 17131 8192000000 9245409136 9605922816 378615696 4.417 33 3 4 2 406557824 27149936 792192

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 17-07-2022 10:39:22 to 17-07-2022 10:39:38.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 141 v_add_invoice_to_stock 335544517
except 8 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 17-07-2022 10:39:39 to 17-07-2022 10:39:41.

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          213863
MON$OLDEST_ACTIVE               213864
MON$OLDEST_SNAPSHOT             213864
MON$NEXT_TRANSACTION            213864
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                       2084128
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             763
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.2.2799 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.2.2799 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.2.2799 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.2.2799 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'

17.07.22 10:39:42. 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
2022-07-17 10:39:45 No severe PSQL-related problems occured
17.07.22 10:39:46. End of report.