Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 16.05.2022 13:37
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 16533552 kB
MemAvailable 31412288 kB
Buffers 0 kB
Cached 15152108 kB
SwapCached 2628 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-05-16 13:37:13
DTS_END                         2022-05-16 13:37:13.8130
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_CLIENT_ORDER(57:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/43332
TRN_ID                          211564
ATT_ID                          626
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: 8553.16 27646 1026379
customer order: creation 156.18 445 18741
customer order: refuse 13.57 352 1628
order to supplier: creation 41.93 1345 5031
order to supplier: removal 3.29 170905 395
invoice (draft): creation 41.91 3042 5029
invoice (draft): removal 46.53 1001 5583
invoice accept: apply 39.03 27227 4683
invoice accept: cancel 42.69 1247 5123
customer reserve: creation 3691.38 257 442966
customer reserve: removal 4213.61 106 505633
realization accept: apply 76.72 242 9207
realization accept: cancel 67.91 169 8149
payment from customer: creation 53.14 148 6377
payment from customer: removal 5.15 121 618
payment to supplier: creation 45.55 191 5466
payment to supplier: removal 2.94 107 353
service: total inventory turnovers 3.67 3795 440
service: total monetary turnovers 6.96 300 835
service: aggregate perf. data 0.98 13060 118
service: refresh index statistics 0.03 328852 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 16-05-2022 13:38:21 to 16-05-2022 13:38:23.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7731
TEST_TIME 2 6081
TEST_TIME 3 6093
TEST_TIME 4 6196
TEST_TIME 5 5909
TEST_TIME 6 6057
TEST_TIME 7 5785
TEST_TIME 8 5883
TEST_TIME 9 5838
TEST_TIME 10 5926
TEST_TIME 11 5957
TEST_TIME 12 6095
TEST_TIME 13 6219
TEST_TIME 14 6373
TEST_TIME 15 6519
TEST_TIME 16 6690
TEST_TIME 17 6722
TEST_TIME 18 7058
TEST_TIME 19 7202
TEST_TIME 20 7222
TEST_TIME 21 7378
TEST_TIME 22 7784
TEST_TIME 23 7929
TEST_TIME 24 8301
TEST_TIME 25 8624
TEST_TIME 26 9101
TEST_TIME 27 9628
TEST_TIME 28 10320
TEST_TIME 29 11057
TEST_TIME 30 10865
TEST_TIME 31 10554
TEST_TIME 32 10336
TEST_TIME 33 10288
TEST_TIME 34 10333
TEST_TIME 35 10211
TEST_TIME 36 10062
TEST_TIME 37 9939
TEST_TIME 38 9853
TEST_TIME 39 9803
TEST_TIME 40 9665
TEST_TIME 41 9484
TEST_TIME 42 9367
TEST_TIME 43 9317
TEST_TIME 44 9368
TEST_TIME 45 9419
TEST_TIME 46 9344
TEST_TIME 47 9286
TEST_TIME 48 9243
TEST_TIME 49 9191
TEST_TIME 50 9267
TEST_TIME 51 9192
TEST_TIME 52 9196
TEST_TIME 53 9175
TEST_TIME 54 9327
TEST_TIME 55 9225
TEST_TIME 56 9331
TEST_TIME 57 9264
TEST_TIME 58 9249
TEST_TIME 59 9174
TEST_TIME 60 9081
TEST_TIME 61 9031
TEST_TIME 62 9031
TEST_TIME 63 9009
TEST_TIME 64 8929
TEST_TIME 65 8848
TEST_TIME 66 8893
TEST_TIME 67 8890
TEST_TIME 68 8831
TEST_TIME 69 8839
TEST_TIME 70 8804
TEST_TIME 71 8823
TEST_TIME 72 8804
TEST_TIME 73 8785
TEST_TIME 74 8772
TEST_TIME 75 8861
TEST_TIME 76 8866
TEST_TIME 77 8857
TEST_TIME 78 8983
TEST_TIME 79 9089
TEST_TIME 80 9138
TEST_TIME 81 9093
TEST_TIME 82 9096
TEST_TIME 83 9035
TEST_TIME 84 9007
TEST_TIME 85 8964
TEST_TIME 86 9016
TEST_TIME 87 8966
TEST_TIME 88 8959
TEST_TIME 89 8924
TEST_TIME 90 8914
TEST_TIME 91 8872
TEST_TIME 92 8923
TEST_TIME 93 8946
TEST_TIME 94 8976
TEST_TIME 95 9046
TEST_TIME 96 9014
TEST_TIME 97 8932
TEST_TIME 98 8880
TEST_TIME 99 8843
TEST_TIME 100 8823
TEST_TIME 101 8779
TEST_TIME 102 8764
TEST_TIME 103 8757
TEST_TIME 104 8724
TEST_TIME 105 8691
TEST_TIME 106 8670
TEST_TIME 107 8636
TEST_TIME 108 8570
TEST_TIME 109 8572
TEST_TIME 110 8588
TEST_TIME 111 8567
TEST_TIME 112 8559
TEST_TIME 113 8616
TEST_TIME 114 8589
TEST_TIME 115 8577
TEST_TIME 116 8575
TEST_TIME 117 8577
TEST_TIME 118 8643
TEST_TIME 119 8647
TEST_TIME 120 8581

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 16-05-2022 13:38:25 to 16-05-2022 13:38:28.

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 1433412 1433412 0 0.00 0 46030 13 0 0
doc_list_biud 1433405 1433405 0 0.00 0 53319 42 0 0
sp_add_invoice_to_stock 4806 4683 123 2.55 57 201586 27227 0 123
sp_cancel_adding_invoice 5123 5123 0 0.00 6 74171 1248 0 0
sp_cancel_client_order 1628 1628 0 0.00 6 8494 352 0 0
sp_cancel_customer_reserve 505633 505633 0 0.00 1 53324 106 0 0
sp_cancel_pay_from_customer 618 618 0 0.00 4 6371 122 0 0
sp_cancel_pay_to_supplier 353 353 0 0.00 4 2761 107 0 0
sp_cancel_supplier_invoice 5591 5583 8 0.14 3 38600 1001 0 8
sp_cancel_supplier_order 395 395 0 0.00 12 1407922 170906 0 0
sp_cancel_write_off 8149 8149 0 0.00 2 9982 170 0 0
sp_client_order 18741 18741 0 0.00 6 29807 446 0 0
sp_customer_reserve 442966 442966 0 0.00 1 79799 258 0 0
sp_fill_shopping_cart 28792 28792 0 0.00 1 11993 77 0 0
sp_fill_shopping_cart_clo_res 442941 442941 0 0.00 0 18040 21 0 0
sp_get_clo_for_invoice 4647 4647 0 0.00 0 28134 376 0 0
sp_kill_cost_storno 14243 14243 0 0.00 0 12611 69 0 0
sp_kill_qstorno_ret_qs2qd 1025393 1025393 0 0.00 0 53309 46 0 0
sp_kill_qty_storno 540361 540361 0 0.00 0 53317 105 0 0
sp_lock_selected_doc 19055 19055 0 0.00 0 7872 7 0 0
sp_make_cost_storno 25696 25696 0 0.00 0 22777 73 0 0
sp_multiply_rows_for_pdistr 25694 25694 0 0.00 0 10835 35 0 0
sp_multiply_rows_for_qdistr 18741 18741 0 0.00 0 29413 173 0 0
sp_pay_from_customer 6377 6377 0 0.00 5 7847 148 0 0
sp_pay_to_supplier 5466 5466 0 0.00 7 13245 192 0 0
sp_payment_common 11843 11843 0 0.00 2 8360 42 0 0
sp_qd_handle_on_cancel_clo 1628 1628 0 0.00 0 8485 288 0 0
sp_qd_handle_on_invoice_upd_sts 9768 9768 0 0.00 0 37105 507 0 0
sp_qd_handle_on_reserve_upd_sts 9205 9205 0 0.00 0 14168 56 0 0
sp_reserve_write_off 9207 9207 0 0.00 8 17420 243 0 0
sp_supplier_invoice 5029 5029 0 0.00 10 108147 3043 0 0
sp_supplier_order 5031 5031 0 0.00 8 65209 1346 0 0
srv_aggregate_perf_data 119 118 1 0.84 1963 152483 13060 0 1
srv_fill_mon_cache_memory 69 69 0 0.00 722 156528 39752 0 0
srv_find_qd_qs_mism 980489 980489 0 0.00 0 46028 11 0 0
srv_make_invnt_saldo 440 440 0 0.00 61 51426 3795 0 0
srv_make_money_saldo 835 835 0 0.00 1 14934 300 0 0
srv_recalc_idx_stat 4 4 0 0.00 104121 418861 328853 0 0
t$perf-abend:sp_add_invoice_to_stock 123 123 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 4689 4689 0 0.00 1 11174 824 0 0
t$perf-norm:sp_cancel_adding_invoice 385 385 0 0.00 1 25810 496 0 0
t$perf-norm:sp_cancel_client_order 1628 1628 0 0.00 0 2327 25 0 0
t$perf-norm:sp_cancel_customer_reserve 632 632 0 0.00 0 6443 30 0 0
t$perf-norm:sp_cancel_pay_from_customer 618 618 0 0.00 0 3421 26 0 0
t$perf-norm:sp_cancel_pay_to_supplier 353 353 0 0.00 0 727 12 0 0
t$perf-norm:sp_cancel_supplier_invoice 323 323 0 0.00 0 860 29 0 0
t$perf-norm:sp_cancel_supplier_order 395 395 0 0.00 0 104205 6301 0 0
t$perf-norm:sp_cancel_write_off 881 881 0 0.00 0 1696 20 0 0
t$perf-norm:sp_client_order 18742 18742 0 0.00 0 6357 34 0 0
t$perf-norm:sp_customer_reserve 941 941 0 0.00 0 3054 17 0 0
t$perf-norm:sp_pay_from_customer 6377 6377 0 0.00 0 12191 17 0 0
t$perf-norm:sp_pay_to_supplier 5466 5466 0 0.00 0 12189 23 0 0
t$perf-norm:sp_reserve_write_off 9207 9207 0 0.00 0 3738 18 0 0
t$perf-norm:sp_supplier_invoice 5029 5029 0 0.00 0 3758 28 0 0
t$perf-norm:sp_supplier_order 5032 5032 0 0.00 0 6696 33 0 0
t$perf-norm:srv_aggregate_perf_data 118 118 0 0.00 0 298 14 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 230 11 0 0
t$perf-norm:srv_make_invnt_saldo 440 440 0 0.00 0 3841 16 0 0
t$perf-norm:srv_make_money_saldo 835 835 0 0.00 0 6830 13 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 25 171 71 0 0
v_add_invoice_to_stock 9520 9274 246 2.58 0 9888 24 0 246
v_all_customers 34102 34102 0 0.00 0 138 3 0 0
v_all_suppliers 28418 28418 0 0.00 0 184 4 0 0
v_all_wares 37479 37479 0 0.00 0 183 3 0 0
v_cancel_adding_invoice 770 770 0 0.00 0 6611 24 0 0
v_cancel_client_order 3256 3256 0 0.00 0 1044 9 0 0
v_cancel_customer_prepayment 1236 1236 0 0.00 0 680 9 0 0
v_cancel_customer_reserve 1264 1264 0 0.00 0 2105 11 0 0
v_cancel_payment_to_supplier 706 706 0 0.00 0 2726 16 0 0
v_cancel_supplier_invoice 662 646 16 2.41 0 908 21 0 16
v_cancel_supplier_order 790 790 0 0.00 0 906 10 0 0
v_cancel_write_off 1762 1762 0 0.00 0 1701 20 0 0
v_max_id_clo_ord 5027 5027 0 0.00 0 483 5 0 0
v_max_id_clo_res 941 941 0 0.00 0 2808 15 0 0
v_max_id_ord_sup 5023 5023 0 0.00 0 4082 6 0 0
v_max_non_paid_invoice 1305 1305 0 0.00 0 4359 10 0 0
v_max_non_paid_realizn 3402 3402 0 0.00 0 4172 9 0 0
v_min_id_clo_ord 5027 5027 0 0.00 0 2466 7 0 0
v_min_id_clo_res 941 941 0 0.00 0 4571 15 0 0
v_min_id_ord_sup 5023 5023 0 0.00 0 5258 9 0 0
v_min_non_paid_invoice 5464 5464 0 0.00 0 8356 16 0 0
v_min_non_paid_realizn 6377 6377 0 0.00 0 5138 16 0 0
v_our_firm 9326 9326 0 0.00 0 54 4 0 0
v_reserve_write_off 18404 18404 0 0.00 0 4349 10 0 0
x_lock_depdocs_on_canc_invoice 10383 10383 0 0.00 0 15410 131 0 0
x_lock_depdocs_on_canc_sup_ord 395 395 0 0.00 0 4771 368 0 0
x_make_qstorno_1000_1200 5031 5031 0 0.00 3 65183 1194 0 0
x_make_qstorno_1200_2000 5029 5029 0 0.00 4 107682 2823 0 0
x_make_qstorno_2100_3300 442965 442965 0 0.00 0 79791 226 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 16-05-2022 13:38:29 to 16-05-2022 13:38:33.

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
11:07:17 1 8192000000 8796669024 8807174144 3189120 0.038 1 1 2 0 3286736 61840 35776
11:08:18 23948 8192000000 9726050240 10027110400 802808160 8.925 100 87 173 1 831662816 7816128 21038528
11:09:46 39936 8192000000 9785458672 10098597888 855930960 9.459 100 90 180 1 890140192 13188928 21020304
11:11:35 10785 8192000000 9831649040 10157551616 889809056 9.797 100 85 166 4 937197904 28683744 18705104
11:12:47 9463 8192000000 9901155328 10241073152 936459552 10.258 100 88 175 0 1011133552 56020720 18653280
11:13:59 4958 8192000000 9945282304 10289442816 963968720 10.528 100 91 174 1 1055639728 73477632 18193376
11:15:06 2529 8192000000 9949509808 10307346432 997878464 10.858 100 85 168 0 1070864784 56082000 16904320
11:16:11 3851 8192000000 10004837344 10371891200 1019026112 11.063 100 88 172 0 1124168688 87992176 17150400
11:17:19 951 8192000000 10024561584 10390695936 1047110048 11.333 100 97 191 1 1140650288 74970240 18570000
11:18:21 1158 8192000000 10035235680 10411896832 1066991792 11.523 100 90 177 0 1155911664 70835888 18083984
11:19:23 1689 8192000000 10050286624 10425225216 1071186144 11.563 100 89 169 2 1168713824 80629776 16897904
11:20:26 1080 8192000000 10038966112 10420207616 1083121904 11.677 100 91 168 0 1163250736 62406480 17722352
11:21:28 1196 8192000000 10051887712 10440228864 1087426736 11.718 100 92 174 2 1171251136 65062320 18762080
11:22:30 1258 8192000000 10035500048 10418589696 1092579344 11.767 100 98 183 1 1154175296 43860448 17735504
11:23:32 1107 8192000000 10044800016 10431680512 1095895536 11.799 100 91 176 1 1164412320 50714240 17802544
11:24:34 5073 8192000000 10043981360 10430369792 1099449792 11.832 100 75 142 4 1157838576 43462720 14926064
11:25:42 1334 8192000000 10080071056 10466627584 1105136784 11.886 100 97 191 1 1200227344 75254576 19835984
11:26:45 1206 8192000000 10069591424 10458886144 1100703296 11.844 100 97 196 2 1193366816 73310720 19352800
11:27:47 2210 8192000000 10052485776 10438090752 1093747056 11.778 100 89 170 3 1166904320 56646112 16511152
11:28:49 1063 8192000000 10043080480 10429743104 1089096144 11.734 100 91 171 2 1163959152 57926352 16936656
11:29:51 8016 8192000000 10039608000 10444427264 1090801728 11.750 100 48 91 1 1178380688 78003184 9575776
11:31:00 1316 8192000000 10027181936 10415935488 1086036896 11.705 100 76 153 0 1151810384 50376960 15396528
11:32:02 4655 8192000000 10018531616 10404290560 1057873056 11.436 99 73 137 4 1133209024 60967440 14368528
11:33:07 1080 8192000000 10013676896 10388230144 1049775296 11.359 100 90 168 1 1131961968 64948992 17237680
11:34:09 5546 8192000000 10012436416 10402295808 1053281632 11.392 100 69 133 0 1142891376 76263648 13346096
11:35:18 1131 8192000000 9992297168 10363084800 1020659936 11.078 100 96 180 3 1103490944 63603952 19227056
11:36:21 1233 8192000000 9987057504 10359336960 1033078448 11.198 100 97 178 1 1108184368 57107728 17998192
11:37:24 22391 8192000000 9988621008 10371645440 1049309616 11.354 100 63 120 2 1132780624 71431264 12039744
11:39:02 38463 8192000000 10048086272 10438094848 1070881776 11.561 100 59 116 0 1155377504 72407280 12088448
11:40:44 1145 8192000000 10099147136 10479566848 1097566768 11.815 100 91 178 1 1215645904 100208912 17870224
11:41:48 1012 8192000000 10130994112 10518077440 1109129872 11.924 100 91 166 1 1246531024 119379696 18021456
11:42:54 1488 8192000000 10176189008 10571337728 1120164464 12.029 100 73 136 0 1286491152 152332064 13994624
11:44:07 2369 8192000000 10193460064 10591453184 1135865056 12.177 100 71 138 0 1306107376 155384960 14857360
11:45:15 3214 8192000000 10228438992 10627465216 1146954624 12.281 100 76 145 2 1345538736 183400544 15183568
11:46:22 2504 8192000000 10266206432 10667892736 1164841680 12.449 100 87 168 0 1393322576 208594352 19886544
11:47:27 952 8192000000 10319767984 10718470144 1171838336 12.514 100 92 180 1 1433128640 239906064 21384240
11:48:32 3206 8192000000 10367003120 10767654912 1186663888 12.652 100 82 160 1 1485940272 280477920 18798464
11:49:40 1371 8192000000 10435186816 10848804864 1197981632 12.758 100 95 185 0 1544184720 323578128 22624960
11:50:45 906 8192000000 10444330992 10847854592 1193573776 12.717 99 92 177 3 1554461136 339593680 21293680
11:51:49 1622 8192000000 10504756320 10913554432 1204112736 12.815 100 96 184 3 1617151648 391050624 21988288
11:52:53 1381 8192000000 10521483392 10951839744 1198232352 12.760 99 86 168 1 1631813104 413107728 20473024
11:53:58 1012 8192000000 10591360352 11017560064 1214398384 12.910 100 92 177 1 1696503968 460422960 21682624
11:55:04 782 8192000000 10601125968 11044794368 1214800720 12.914 100 98 193 1 1706270896 468392128 23078048
11:56:09 705 8192000000 10618690528 11048169472 1216449824 12.929 100 84 164 3 1722478176 487053408 18974944
11:57:15 1033 8192000000 10655397120 11076411392 1213690688 12.903 100 96 186 2 1762827136 526383600 22752848
11:58:21 920 8192000000 10616131152 11083390976 1216472832 12.929 100 95 183 0 1723502832 484118176 22911824
11:59:24 750 8192000000 10638103424 11075133440 1202382528 12.798 100 93 185 0 1745101600 519578720 23140352
12:00:27 4145 8192000000 10607433648 11049500672 1199886432 12.775 100 54 104 1 1713439312 499711696 13841184
12:01:35 4124 8192000000 10591034528 11050475520 1188873600 12.673 99 50 99 0 1699173840 497362464 12937776
12:02:40 18059 8192000000 10534658480 11053084672 1184425792 12.631 100 43 84 0 1652630544 456107136 12097616
12:04:25 15772 8192000000 10399481216 10905112576 1155809648 12.364 100 36 72 0 1505770464 340195280 9765536
12:05:54 40062 8192000000 10113766000 10583920640 1130305024 12.124 99 14 28 0 1250354048 116596784 3452240
12:07:35 28070 8192000000 10118835904 10550878208 1154434656 12.351 100 50 97 1 1210347888 45988960 9924272
12:09:07 41153 8192000000 10127915072 10567270400 1142193632 12.236 99 63 114 3 1214131648 60733376 11204640
12:10:49 17466 8192000000 10112118672 10576203776 1142850768 12.242 100 31 62 1 1219388288 70550240 5987280
12:12:09 22023 8192000000 10074080496 10527752192 1144185920 12.255 100 26 48 2 1183010560 33528704 5295936
12:13:32 31419 8192000000 10110827152 10564833280 1123837968 12.063 98 20 40 0 1180513216 52320768 4354480
12:15:04 72515 8192000000 10105148400 10582892544 1117492656 12.003 97 22 41 2 1199521472 77218192 4810624
12:17:26 156528 8192000000 10157404352 10624860160 1118145904 12.009 97 20 38 0 1232217168 109601008 4470256
12:21:20 53592 8192000000 10069404896 10579939328 1108203840 11.915 98 28 56 0 1178188432 63733024 6251568
12:23:19 41262 8192000000 10050130704 10523709440 1105355392 11.888 99 12 24 0 1140420800 32786336 2279072
12:25:09 66001 8192000000 10099757920 10554101760 1132028000 12.140 100 29 57 1 1211514432 73345200 6141232
12:27:19 72591 8192000000 10079241248 10511441920 1117011712 11.999 98 37 74 1 1161851504 37557696 7282096
12:29:36 61598 8192000000 10160312128 10608164864 1139326880 12.209 100 35 70 1 1220999520 74658512 7014128
12:31:53 51592 8192000000 10110510080 10540855296 1117505104 12.003 98 42 79 1 1168567248 42483168 8578976
12:33:47 68395 8192000000 10059715584 10495602688 1086085264 11.705 96 14 28 1 1108731456 19379120 3267072
12:35:56 31433 8192000000 10105630576 10538196992 1137425504 12.191 100 34 65 0 1202543232 59098496 6019232
12:37:29 95288 8192000000 10112746672 10558128128 1129693424 12.118 99 26 52 0 1203142944 68100816 5348704
12:40:09 77414 8192000000 10073432624 10554212352 1141874096 12.233 100 11 22 0 1192351904 47876096 2601712
12:42:27 70135 8192000000 10127688112 10585583616 1102159632 11.858 96 13 26 1 1187182400 81510000 3512768
12:44:37 34622 8192000000 10105370272 10546925568 1150609856 12.315 100 25 48 2 1205178752 48752816 5816080
12:46:12 41768 8192000000 10131991280 10595569664 1146931136 12.281 99 27 52 2 1207860480 55112528 5816816
12:48:00 35277 8192000000 10141129040 10583052288 1130301776 12.124 97 33 62 1 1235450304 97390272 7758256
12:49:36 26593 8192000000 10204413728 10635739136 1158432080 12.389 100 35 68 2 1288964272 123067568 7464624
12:51:03 36344 8192000000 10237574080 10676580352 1165764208 12.457 100 33 64 2 1338165888 165342496 7059184
12:52:39 74321 8192000000 10220324944 10696900608 1151580256 12.324 99 21 42 1 1338493408 181679200 5233952
12:55:21 45779 8192000000 10188140976 10674135040 1154367632 12.350 100 22 44 2 1286058416 126801968 4888816
12:57:10 129730 8192000000 10102490704 10599792640 1095449040 11.794 95 19 36 0 1163290656 63809152 4032464
13:00:20 100803 8192000000 10066671216 10516668416 1098181808 11.820 96 14 26 0 1156442848 55509472 2751568
13:03:02 63682 8192000000 10059116768 10535673856 1099339504 11.831 97 13 26 0 1150911840 48331344 3240992
13:05:08 40749 8192000000 10072343840 10510413824 1110771984 11.940 98 24 48 0 1152748640 36857376 5119280
13:07:03 84765 8192000000 10101912992 10540351488 1089279328 11.736 96 24 48 1 1147266032 53486720 4499984
13:09:34 43725 8192000000 10072497776 10529734656 1095173488 11.792 97 26 52 0 1143033264 42407408 5452368
13:11:18 50181 8192000000 10129077776 10574688256 1090797968 11.750 96 24 48 0 1147678256 52416560 4463728
13:13:14 115122 8192000000 10062740976 10484154368 1068684544 11.540 95 35 68 2 1104686208 28947616 7054048
13:16:11 35836 8192000000 10050276896 10483638272 1085279600 11.698 97 44 83 2 1127147600 33837232 8030768
13:17:50 66423 8192000000 10073806144 10520371200 1093964496 11.780 98 24 47 1 1157158384 58067280 5126608
13:20:19 134997 8192000000 10058526928 10547744768 1053375792 11.393 94 8 16 1 1114829136 59549984 1903360
13:23:55 81725 8192000000 10042358592 10489864192 1105412704 11.889 99 22 44 0 1141096096 31069936 4613456
13:26:26 77913 8192000000 10068374832 10578227200 1113579600 11.966 99 8 16 1 1177405984 62193216 1633168
13:28:44 44800 8192000000 10090918064 10544074752 1110876400 11.941 98 26 52 0 1161725664 45592832 5256432
13:30:40 21840 8192000000 10047767456 10495651840 1098730848 11.826 97 32 62 1 1129269936 24058912 6480176
13:32:03 27080 8192000000 10134949312 10573869056 1128790560 12.110 99 44 87 0 1219074176 81226080 9057536
13:33:35 32999 8192000000 10150599744 10593386496 1124493488 12.069 99 30 60 2 1257084240 126182832 6407920
13:35:14 37369 8192000000 10168537696 10639572992 1120267632 12.030 97 37 74 1 1270609632 142473648 7868352
13:36:57 30341 8192000000 9161852528 9466494976 278682048 3.289 25 8 14 1 341726400 61625072 1419280

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 16-05-2022 13:38:35 to 16-05-2022 13:38:51.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 123 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 16-05-2022 13:38:52 to 16-05-2022 13:38:54.

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          209731
MON$OLDEST_ACTIVE               211874
MON$OLDEST_SNAPSHOT             211874
MON$NEXT_TRANSACTION            211874
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                       2031968
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             762
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

16.05.22 13:38:55. 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-05-16 13:38:58 No severe PSQL-related problems occured
16.05.22 13:38:59. End of report.