Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 23.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 15584720 kB
MemAvailable 31029424 kB
Buffers 0 kB
Cached 16094936 kB
SwapCached 2500 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-23 10:37:19
DTS_END                         2022-07-23 10:37:19.6560
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/35948
TRN_ID                          225563
ATT_ID                          614
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: 9305.28 21292 1116634
customer order: creation 180.41 468 21649
customer order: refuse 14.80 387 1776
order to supplier: creation 47.00 1356 5640
order to supplier: removal 3.45 164299 414
invoice (draft): creation 45.85 2884 5502
invoice (draft): removal 50.65 956 6078
invoice accept: apply 42.69 26637 5123
invoice accept: cancel 45.33 1162 5439
customer reserve: creation 4109.18 247 493102
customer reserve: removal 4475.08 100 537009
realization accept: apply 85.03 241 10203
realization accept: cancel 72.59 168 8711
payment from customer: creation 60.35 163 7242
payment from customer: removal 6.10 124 732
payment to supplier: creation 50.51 170 6061
payment to supplier: removal 3.07 118 368
service: total inventory turnovers 4.21 3355 505
service: total monetary turnovers 8.07 293 968
service: aggregate perf. data 0.89 16900 107
service: refresh index statistics 0.04 205818 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 23-07-2022 10:38:27 to 23-07-2022 10:38:29.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 9765
TEST_TIME 2 8320
TEST_TIME 3 7678
TEST_TIME 4 7574
TEST_TIME 5 7187
TEST_TIME 6 7120
TEST_TIME 7 7056
TEST_TIME 8 6878
TEST_TIME 9 6800
TEST_TIME 10 6925
TEST_TIME 11 6823
TEST_TIME 12 6755
TEST_TIME 13 7224
TEST_TIME 14 7329
TEST_TIME 15 7454
TEST_TIME 16 7622
TEST_TIME 17 7742
TEST_TIME 18 8018
TEST_TIME 19 8108
TEST_TIME 20 8225
TEST_TIME 21 8416
TEST_TIME 22 8857
TEST_TIME 23 8955
TEST_TIME 24 9122
TEST_TIME 25 9151
TEST_TIME 26 9114
TEST_TIME 27 9341
TEST_TIME 28 9764
TEST_TIME 29 10399
TEST_TIME 30 10568
TEST_TIME 31 10888
TEST_TIME 32 11245
TEST_TIME 33 11723
TEST_TIME 34 11761
TEST_TIME 35 11762
TEST_TIME 36 11660
TEST_TIME 37 11710
TEST_TIME 38 11551
TEST_TIME 39 11512
TEST_TIME 40 11284
TEST_TIME 41 11205
TEST_TIME 42 11166
TEST_TIME 43 10968
TEST_TIME 44 10898
TEST_TIME 45 10717
TEST_TIME 46 10621
TEST_TIME 47 10503
TEST_TIME 48 10426
TEST_TIME 49 10376
TEST_TIME 50 10557
TEST_TIME 51 10494
TEST_TIME 52 10412
TEST_TIME 53 10355
TEST_TIME 54 10291
TEST_TIME 55 10311
TEST_TIME 56 10293
TEST_TIME 57 10267
TEST_TIME 58 10214
TEST_TIME 59 10270
TEST_TIME 60 10244
TEST_TIME 61 10203
TEST_TIME 62 10288
TEST_TIME 63 10255
TEST_TIME 64 10227
TEST_TIME 65 10175
TEST_TIME 66 10282
TEST_TIME 67 10262
TEST_TIME 68 10338
TEST_TIME 69 10249
TEST_TIME 70 10172
TEST_TIME 71 10189
TEST_TIME 72 10107
TEST_TIME 73 10077
TEST_TIME 74 10010
TEST_TIME 75 9951
TEST_TIME 76 9934
TEST_TIME 77 9861
TEST_TIME 78 9810
TEST_TIME 79 9834
TEST_TIME 80 9792
TEST_TIME 81 9810
TEST_TIME 82 9776
TEST_TIME 83 9729
TEST_TIME 84 9729
TEST_TIME 85 9818
TEST_TIME 86 9880
TEST_TIME 87 9872
TEST_TIME 88 9935
TEST_TIME 89 9889
TEST_TIME 90 9894
TEST_TIME 91 9841
TEST_TIME 92 9806
TEST_TIME 93 9771
TEST_TIME 94 9756
TEST_TIME 95 9703
TEST_TIME 96 9653
TEST_TIME 97 9629
TEST_TIME 98 9609
TEST_TIME 99 9557
TEST_TIME 100 9617
TEST_TIME 101 9584
TEST_TIME 102 9600
TEST_TIME 103 9587
TEST_TIME 104 9597
TEST_TIME 105 9627
TEST_TIME 106 9602
TEST_TIME 107 9580
TEST_TIME 108 9599
TEST_TIME 109 9584
TEST_TIME 110 9527
TEST_TIME 111 9517
TEST_TIME 112 9490
TEST_TIME 113 9433
TEST_TIME 114 9412
TEST_TIME 115 9412
TEST_TIME 116 9379
TEST_TIME 117 9349
TEST_TIME 118 9330
TEST_TIME 119 9342
TEST_TIME 120 9326

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 23-07-2022 10:38:30 to 23-07-2022 10:38:34.

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 1569249 1569249 0 0.00 0 31654 14 0 0
doc_list_biud 1569238 1569238 0 0.00 0 31896 39 0 0
sp_add_invoice_to_stock 5350 5123 227 4.24 62 266535 26637 0 227
sp_cancel_adding_invoice 5439 5439 0 0.00 4 75541 1163 0 0
sp_cancel_client_order 1776 1776 0 0.00 5 10199 387 0 0
sp_cancel_customer_reserve 537009 537009 0 0.00 1 15980 100 0 0
sp_cancel_pay_from_customer 732 732 0 0.00 4 7443 124 0 0
sp_cancel_pay_to_supplier 368 368 0 0.00 4 2725 118 0 0
sp_cancel_supplier_invoice 6097 6078 19 0.31 3 21793 957 0 19
sp_cancel_supplier_order 414 414 0 0.00 16 1582302 164299 0 0
sp_cancel_write_off 8711 8711 0 0.00 2 9571 169 0 0
sp_client_order 21649 21649 0 0.00 5 26340 468 0 0
sp_customer_reserve 493102 493102 0 0.00 1 96020 247 0 0
sp_fill_shopping_cart 32771 32771 0 0.00 1 13839 73 0 0
sp_fill_shopping_cart_clo_res 493079 493079 0 0.00 0 32644 18 0 0
sp_get_clo_for_invoice 5090 5090 0 0.00 0 19227 261 0 0
sp_kill_cost_storno 15250 15250 0 0.00 0 10305 75 0 0
sp_kill_qstorno_ret_qs2qd 1089221 1089221 0 0.00 0 21740 43 0 0
sp_kill_qty_storno 574717 574717 0 0.00 0 31888 99 0 0
sp_lock_selected_doc 21113 21113 0 0.00 0 8721 7 0 0
sp_make_cost_storno 28596 28596 0 0.00 0 14783 69 0 0
sp_multiply_rows_for_pdistr 28593 28593 0 0.00 0 9456 35 0 0
sp_multiply_rows_for_qdistr 21648 21648 0 0.00 0 11491 186 0 0
sp_pay_from_customer 7242 7242 0 0.00 5 17566 163 0 0
sp_pay_to_supplier 6061 6061 0 0.00 6 13217 170 0 0
sp_payment_common 13301 13301 0 0.00 2 6274 39 0 0
sp_qd_handle_on_cancel_clo 1776 1776 0 0.00 0 10160 323 0 0
sp_qd_handle_on_invoice_upd_sts 10527 10527 0 0.00 0 9110 474 0 0
sp_qd_handle_on_reserve_upd_sts 10202 10202 0 0.00 0 31884 54 0 0
sp_reserve_write_off 10203 10203 0 0.00 8 32104 242 0 0
sp_supplier_invoice 5502 5502 0 0.00 8 103167 2884 0 0
sp_supplier_order 5640 5640 0 0.00 8 45909 1357 0 0
srv_aggregate_perf_data 108 107 1 0.92 2436 170688 16901 0 1
srv_fill_mon_cache_memory 71 71 0 0.00 735 150741 34997 0 0
srv_find_qd_qs_mism 1064792 1064792 0 0.00 0 31654 11 0 0
srv_make_invnt_saldo 505 505 0 0.00 46 68444 3355 0 0
srv_make_money_saldo 968 968 0 0.00 1 15848 294 0 0
srv_recalc_idx_stat 5 5 0 0.00 39088 392816 205818 0 0
t$perf-abend:sp_add_invoice_to_stock 227 227 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 19 19 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 5126 5126 0 0.00 1 26623 892 0 0
t$perf-norm:sp_cancel_adding_invoice 403 403 0 0.00 1 7503 449 0 0
t$perf-norm:sp_cancel_client_order 1776 1776 0 0.00 0 1793 26 0 0
t$perf-norm:sp_cancel_customer_reserve 715 715 0 0.00 0 1070 22 0 0
t$perf-norm:sp_cancel_pay_from_customer 732 732 0 0.00 0 2797 18 0 0
t$perf-norm:sp_cancel_pay_to_supplier 368 368 0 0.00 0 673 14 0 0
t$perf-norm:sp_cancel_supplier_invoice 414 414 0 0.00 0 430 17 0 0
t$perf-norm:sp_cancel_supplier_order 414 414 0 0.00 0 89149 7001 0 0
t$perf-norm:sp_cancel_write_off 1007 1007 0 0.00 0 2440 19 0 0
t$perf-norm:sp_client_order 21649 21649 0 0.00 0 39222 38 0 0
t$perf-norm:sp_customer_reserve 988 988 0 0.00 0 6635 22 0 0
t$perf-norm:sp_pay_from_customer 7242 7242 0 0.00 0 9434 20 0 0
t$perf-norm:sp_pay_to_supplier 6061 6061 0 0.00 0 6359 19 0 0
t$perf-norm:sp_reserve_write_off 10203 10203 0 0.00 0 20345 26 0 0
t$perf-norm:sp_supplier_invoice 5502 5502 0 0.00 0 10169 34 0 0
t$perf-norm:sp_supplier_order 5640 5640 0 0.00 0 12569 31 0 0
t$perf-norm:srv_aggregate_perf_data 107 107 0 0.00 0 576 24 0 0
t$perf-norm:srv_fill_mon_cache_memory 71 71 0 0.00 0 83 5 0 0
t$perf-norm:srv_make_invnt_saldo 505 505 0 0.00 0 628 9 0 0
t$perf-norm:srv_make_money_saldo 968 968 0 0.00 0 2005 6 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 11 218 100 0 0
v_add_invoice_to_stock 10616 10162 454 4.27 0 7434 27 0 454
v_all_customers 39776 39776 0 0.00 0 60 3 0 0
v_all_suppliers 31832 31832 0 0.00 0 68 4 0 0
v_all_wares 43284 43284 0 0.00 0 85 4 0 0
v_cancel_adding_invoice 806 806 0 0.00 0 2167 17 0 0
v_cancel_client_order 3552 3552 0 0.00 0 1603 9 0 0
v_cancel_customer_prepayment 1464 1464 0 0.00 0 2322 11 0 0
v_cancel_customer_reserve 1430 1430 0 0.00 0 4936 21 0 0
v_cancel_payment_to_supplier 736 736 0 0.00 0 2553 15 0 0
v_cancel_supplier_invoice 866 828 38 4.38 0 629 24 0 38
v_cancel_supplier_order 828 828 0 0.00 0 1423 11 0 0
v_cancel_write_off 2014 2014 0 0.00 0 2674 25 0 0
v_max_id_clo_ord 5636 5636 0 0.00 0 114 4 0 0
v_max_id_clo_res 988 988 0 0.00 0 1564 14 0 0
v_max_id_ord_sup 5489 5489 0 0.00 0 7293 11 0 0
v_max_non_paid_invoice 1268 1268 0 0.00 0 590 8 0 0
v_max_non_paid_realizn 3611 3611 0 0.00 0 577 6 0 0
v_min_id_clo_ord 5636 5636 0 0.00 0 2330 7 0 0
v_min_id_clo_res 988 988 0 0.00 0 1591 9 0 0
v_min_id_ord_sup 5489 5489 0 0.00 0 4754 9 0 0
v_min_non_paid_invoice 6059 6059 0 0.00 0 6268 12 0 0
v_min_non_paid_realizn 7242 7242 0 0.00 0 5463 16 0 0
v_our_firm 10770 10770 0 0.00 0 67 4 0 0
v_reserve_write_off 20403 20403 0 0.00 0 4772 11 0 0
x_lock_depdocs_on_canc_invoice 11103 11103 0 0.00 0 17863 117 0 0
x_lock_depdocs_on_canc_sup_ord 414 414 0 0.00 0 8497 324 0 0
x_make_qstorno_1000_1200 5640 5640 0 0.00 2 45900 1215 0 0
x_make_qstorno_1200_2000 5502 5502 0 0.00 3 103134 2673 0 0
x_make_qstorno_2100_3300 493102 493102 0 0.00 0 96011 217 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 23-07-2022 10:38:35 to 23-07-2022 10:38:39.

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:23 1 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
08:08:24 28121 8192000000 9721275376 10019299328 797934656 8.875 100 84 168 0 825680592 7480480 20265456
08:09:55 16415 8192000000 9761434608 10067345408 835611712 9.256 100 88 176 0 869004976 12731776 20661488
08:11:17 17545 8192000000 9799099584 10114973696 865987888 9.560 100 82 165 0 902212704 17481440 18743376
08:12:38 10619 8192000000 9854038576 10182713344 906005760 9.958 100 82 164 0 956824576 32950208 17868608
08:13:51 3602 8192000000 9919988944 10263916544 956774128 10.457 100 83 165 0 1033137088 58879664 17483296
08:14:57 1972 8192000000 9955772640 10306957312 988515904 10.767 100 85 165 0 1070595472 65661632 16417936
08:16:03 1847 8192000000 9989779456 10351648768 1015608656 11.030 100 83 159 2 1109465888 78509504 15347728
08:17:07 1052 8192000000 10013159120 10380517376 1037062448 11.236 100 91 176 1 1138585456 83335552 18187456
08:18:11 1276 8192000000 10012090448 10381705216 1046942752 11.331 100 90 167 0 1130012944 66854384 16215808
08:19:14 1231 8192000000 10021472896 10395844608 1054073808 11.400 100 92 173 2 1142331552 71156016 17101728
08:20:18 1079 8192000000 10027186960 10405183488 1063271328 11.488 100 99 195 1 1148812528 65852576 19688624
08:21:21 1293 8192000000 10031379296 10407247872 1068783968 11.540 100 95 180 0 1152035680 64052688 19199024
08:22:24 1045 8192000000 10038764096 10422833152 1075077824 11.601 100 95 178 0 1162525248 69931424 17516000
08:23:27 1126 8192000000 10057622752 10440962048 1085963712 11.704 100 95 187 0 1182169760 76911216 19294832
08:24:30 1115 8192000000 10048668768 10434748416 1082304480 11.669 100 96 188 0 1173264240 73056112 17903648
08:25:32 1149 8192000000 10044554560 10431242240 1087327808 11.717 100 94 179 2 1172383120 66822320 18232992
08:26:35 1011 8192000000 10054260576 10439434240 1084606016 11.691 100 95 180 1 1176396080 73775744 18014320
08:27:37 5250 8192000000 10005198448 10398842880 1076994576 11.619 100 57 111 1 1135834336 48073904 10765856
08:28:43 1178 8192000000 10053139568 10439835648 1080597248 11.653 100 96 174 0 1175985920 77097040 18291632
08:29:45 1170 8192000000 10036841744 10420097024 1082774656 11.674 100 98 190 0 1161831280 59969360 19087264
08:30:47 1163 8192000000 10038091456 10425298944 1077615408 11.625 100 95 182 0 1164856416 69504000 17737008
08:31:49 1144 8192000000 10053625504 10440822784 1081147504 11.658 100 97 184 1 1176312064 74545152 20619408
08:32:51 1183 8192000000 9987809440 10369798144 1052327888 11.383 100 78 143 1 1111557168 43746336 15482944
08:33:53 2409 8192000000 9971928624 10355654656 1040558544 11.270 99 72 135 0 1103964400 49839968 13565888
08:34:57 3621 8192000000 9995403760 10382581760 1047546256 11.337 100 65 126 0 1125389600 65776384 12066960
08:36:02 1281 8192000000 10002195968 10374008832 1049089232 11.352 100 96 177 2 1125578560 57433520 19055808
08:37:04 1027 8192000000 9983779584 10354630656 1030901056 11.177 100 94 178 1 1105742752 56450176 18391520
08:38:10 1085 8192000000 10015766992 10387042304 1047008112 11.332 99 86 165 0 1136124640 73914528 15202000
08:39:17 5438 8192000000 10024541856 10411966464 1068293856 11.536 100 62 121 1 1143032896 63228752 11510288
08:40:28 2196 8192000000 10050806080 10437238784 1091528656 11.757 100 79 142 1 1168677456 62672112 14476688
08:41:39 1646 8192000000 10102019856 10490880000 1111211392 11.944 100 92 175 1 1221174288 92291680 17671216
08:42:43 2003 8192000000 10145364464 10530701312 1120767056 12.034 100 89 163 2 1257327296 118762912 17797328
08:43:49 1427 8192000000 10202883504 10595450880 1129016704 12.112 100 94 178 1 1319957760 170795408 20145648
08:44:53 2856 8192000000 10178948880 10586001408 1142042240 12.235 100 81 151 0 1299261200 140399648 16819312
08:45:59 2756 8192000000 10248588448 10643292160 1153957536 12.347 100 80 152 3 1360817328 190393088 16466704
08:47:08 2839 8192000000 10285045584 10680709120 1164616288 12.446 100 85 162 0 1395943584 213519856 17807440
08:48:17 9365 8192000000 10315269376 10728210432 1177661824 12.568 100 64 128 0 1435753664 242918624 15173216
08:49:37 784 8192000000 10411433520 10811211776 1191747728 12.700 100 100 195 1 1527255760 313060752 22447280
08:50:42 1016 8192000000 10396836560 10819543040 1193099520 12.712 100 97 190 2 1510476544 295540448 21836576
08:51:45 912 8192000000 10446745168 10858979328 1185069264 12.637 100 99 195 1 1554826848 347213376 22544208
08:52:49 1109 8192000000 10455659232 10877902848 1186782480 12.653 100 94 184 1 1561893664 353089984 22021200
08:53:53 724 8192000000 10479888128 10905665536 1199358592 12.770 100 95 187 3 1586517968 365540192 21619184
08:54:57 1143 8192000000 10491927680 10930057216 1196701792 12.746 99 92 180 0 1601856672 383510144 21644736
08:56:01 1046 8192000000 10516470560 10936229888 1205001648 12.823 100 98 191 1 1620036016 391751136 23283232
08:57:04 1249 8192000000 10519574384 10970955776 1199278384 12.770 100 97 192 1 1625230880 402067248 23885248
08:58:08 1603 8192000000 10515570624 10982555648 1206272560 12.835 100 93 180 2 1625065168 395722752 23069856
08:59:12 2983 8192000000 10529453232 10999697408 1188780976 12.672 100 64 125 0 1632910096 428335328 15793792
09:00:18 6994 8192000000 10512325232 10947227648 1177401104 12.566 99 51 98 2 1611913120 421711472 12800544
09:01:35 10664 8192000000 10488043904 10958364672 1176531360 12.558 100 51 100 0 1590990464 401794864 12664240
09:02:52 16013 8192000000 10537013376 10984951808 1179517408 12.586 99 48 95 0 1624537648 432588672 12431568
09:04:14 9061 8192000000 10537565872 11011076096 1176561152 12.558 100 38 76 0 1656532256 469491760 10479344
09:05:36 14643 8192000000 10416854016 10962337792 1147684784 12.288 98 45 87 0 1556081648 397524752 10872112
09:06:51 19840 8192000000 10357644528 10850738176 1169677104 12.494 100 27 49 1 1471547120 295527728 6342288
09:08:33 51950 8192000000 10229476400 10753810432 1112718160 11.958 96 19 36 0 1331805312 214709472 4377680
09:10:27 40207 8192000000 10095407792 10579079168 1117244992 12.001 98 11 22 0 1201805424 81737504 2822928
09:12:51 81048 8192000000 10078119440 10583351296 1105351984 11.888 97 8 14 0 1172322320 64860624 2109712
09:15:13 65451 8192000000 10065029232 10518130688 1087288624 11.717 96 14 24 0 1122858848 33100912 2469312
09:17:19 29512 8192000000 10093391888 10512420864 1114044192 11.971 99 55 110 0 1178470320 52590576 11835552
09:18:49 150738 8192000000 10024071280 10455502848 1042100608 11.285 93 27 50 2 1078380864 31285120 4995136
09:22:26 74733 8192000000 10058801248 10479513600 1052964992 11.389 94 41 75 0 1103723248 43729952 7028304
09:24:43 17495 8192000000 10135454400 10554216448 1127972176 12.102 100 65 124 2 1228039664 87227152 12840336
09:26:08 29997 8192000000 10150825392 10594529280 1117684240 12.005 99 48 92 0 1251654928 124522912 9447776
09:27:44 53795 8192000000 10048708640 10532466688 1099511824 11.833 98 24 49 0 1155421632 50960736 4949072
09:29:40 29466 8192000000 10081685936 10519379968 1108102944 11.914 98 30 56 1 1167504096 54109776 5291376
09:31:23 59486 8192000000 10089284736 10571452416 1124733824 12.072 100 18 33 1 1206615536 78577104 3304608
09:33:23 41240 8192000000 10063441648 10499538944 1115293056 11.983 99 22 38 1 1156205776 36476976 4435744
09:35:25 57359 8192000000 10104249056 10570735616 1107954208 11.913 98 24 48 0 1173913968 60980624 4979136
09:37:23 42122 8192000000 10104264432 10548011008 1140649472 12.222 100 40 79 1 1182264992 33684016 7931504
09:39:10 68378 8192000000 10051151136 10484436992 1061487456 11.471 93 24 47 0 1100654096 33898464 5268176
09:41:19 40130 8192000000 10105080576 10533888000 1124653408 12.071 99 25 50 1 1189678240 60148656 4876176
09:43:01 23422 8192000000 10122326752 10596724736 1128655664 12.109 99 36 72 0 1236963664 100776496 7531504
09:44:52 91328 8192000000 10095418704 10613014528 1127386752 12.097 100 23 45 0 1201972560 69089808 5496000
09:48:19 62992 8192000000 10078868992 10565091328 1123694112 12.062 99 27 52 0 1185367136 56114576 5558448
09:50:24 77673 8192000000 10074374688 10524233728 1131805504 12.138 100 23 44 0 1186680688 50402048 4473136
09:52:55 71805 8192000000 10097871504 10582310912 1103882880 11.874 97 17 34 0 1186070048 78537904 3649264
09:55:08 49358 8192000000 10085229344 10534162432 1063488496 11.490 95 16 31 0 1141043008 73982336 3572176
09:56:58 44123 8192000000 10095758064 10528096256 1103632976 11.872 98 27 53 1 1181639136 71791664 6214496
09:58:47 51429 8192000000 10143348400 10584203264 1114510976 11.975 98 25 47 0 1211493488 91842880 5139632
10:00:42 35392 8192000000 10188912688 10635821056 1127872048 12.101 99 36 72 0 1280052080 144226976 7953056
10:02:18 58970 8192000000 10112416560 10569347072 1089264528 11.736 96 12 22 0 1181010000 88604864 3140608
10:04:30 31440 8192000000 10119021184 10561662976 1139888640 12.214 100 27 54 0 1241146048 95749200 5508208
10:06:05 14700 8192000000 10090990560 10524565504 1127392112 12.097 99 48 89 0 1173444096 36768768 9283216
10:07:26 27647 8192000000 10146898064 10605674496 1142026064 12.235 100 43 86 0 1244062944 93141600 8895280
10:08:58 80609 8192000000 10076318448 10517753856 1111486416 11.946 97 33 62 1 1177955936 60045040 6424480
10:11:33 84194 8192000000 10055983872 10510000128 1117288256 12.001 98 12 21 0 1149442080 30363104 1790720
10:14:29 50824 8192000000 10091456944 10567127040 1107768992 11.911 97 12 24 1 1161435088 50856848 2809248
10:16:21 51343 8192000000 10079552576 10549731328 1120561296 12.032 99 16 27 0 1200951344 77149344 3240704
10:18:15 41842 8192000000 10114894064 10566090752 1119942256 12.026 98 29 58 0 1170575488 44539776 6093456
10:20:08 80801 8192000000 10117072432 10556309504 1109318080 11.926 97 21 42 0 1179312288 65640416 4353792
10:22:32 77522 8192000000 10051153760 10483048448 1112291008 11.954 98 34 68 0 1156588736 37489312 6808416
10:24:51 32662 8192000000 10120029152 10570674176 1134083616 12.160 100 55 110 0 1198277824 53617920 10576288
10:26:27 11943 8192000000 10130673664 10558873600 1127756080 12.100 100 55 110 0 1207503648 68983376 10764192
10:27:39 62475 8192000000 10118938432 10567303168 1132039440 12.141 100 48 93 1 1222631520 81709664 8882416
10:29:42 77614 8192000000 10058837760 10535514112 1125332048 12.077 99 10 18 0 1165424832 38254496 1838288
10:32:00 47423 8192000000 10057093920 10520313856 1107573504 11.909 98 24 48 0 1154825984 42362144 4890336
10:33:48 36612 8192000000 10120383504 10569773056 1135775536 12.176 100 38 76 0 1210597840 66801824 8020480
10:35:26 36508 8192000000 10133403552 10575855616 1100791792 11.845 97 30 60 0 1196173776 89033840 6348144
10:37:13 17373 8192000000 9091825936 9374064640 240428752 2.851 22 4 8 0 271404880 30432240 543888

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 23-07-2022 10:38:41 to 23-07-2022 10:38:57.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 227 v_add_invoice_to_stock 335544517
except 19 v_cancel_supplier_invoice 335544517

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

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          225407
MON$OLDEST_ACTIVE               225888
MON$OLDEST_SNAPSHOT             225888
MON$NEXT_TRANSACTION            225888
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                       2086624
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             787
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

23.07.22 10:39:01. 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-23 10:39:03 No severe PSQL-related problems occured
23.07.22 10:39:04. End of report.