Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 07.01.2023 13: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 15045056 kB
MemAvailable 30404988 kB
Buffers 0 kB
Cached 16690148 kB
SwapCached 4428 kB
Command: fdisk -l
WARNING: fdisk GPT support is currently new, and therefore in an experimental phase. Use at your own discretion.
Disk /dev/sda: 599.9 GB, 599932581888 bytes, 1171743324 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk label type: gpt
Disk identifier: 919DACA4-2F35-4CBB-BAA7-2A8CD8F7168C
# Start End Size Type Name
1 2048 411647 200M EFI System EFI System Partition
2 411648 2508799 1G Microsoft basic
3 2508800 1171742719 557.5G Linux LVM
Disk /dev/mapper/centos_mscs--test--161-root: 53.7 GB, 53687091200 bytes, 104857600 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/mapper/centos_mscs--test--161-swap: 16.8 GB, 16844324864 bytes, 32899072 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes
Disk /dev/sdb: 536 MB, 536870912 bytes, 1048576 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk label type: dos
Disk identifier: 0x00000046
Device Boot Start End Blocks Id System
/dev/sdb1 63 514079 257008+ c W95 FAT32 (LBA)
Disk /dev/mapper/centos_mscs--test--161-home: 528.1 GB, 528109010944 bytes, 1031462912 sectors
Units = sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 262144 bytes / 524288 bytes

Server and database settinfs

SERVER_MODE                     SuperServer 4.0.3
DB_NAME                         /home/bases/oltp40-etalone.fdb
FORCED_WRITES                   ON
SWEEP_INT                       0
PAGE_BUFFERS                    1000000
PAGE_SIZE                       8192


Test configuration settings

param=actions_todo_before_reconnect, val=300
param=create_with_compound_columns_order, val=most_selective_first
param=create_with_debug_objects, val=1
param=create_with_fw, val=sync
param=create_with_separate_qdistr_idx, val=0
param=create_with_split_heavy_tabs, val=1
param=create_with_sweep, val=0
param=dbnm, val=/home/bases/oltp40-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp40-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb40/bin
param=file_name_this_host_info, val=bz_cpu24_ram32
param=file_name_with_test_params, val=regular
param=gather_hardware_info, val=1
param=halt_test_on_errors, val=/CK/
param=host, val=localhost
param=init_buff, val=10000
param=init_docs, val=0
param=is_embed, val=0
param=make_html, val=1
param=max_cps, val=25
param=mon_query_interval, val=60
param=mon_query_role, val=tmp$oemul$worker
param=mon_unit_list, val=//
param=mon_unit_perf, val=2
param=mon_usr_prefix, val=tmp$oemul$user_
param=no_auto_undo, val=1
param=port, val=3400
param=pwd, val=masterkey
param=qmism_verify_bitset, val=1
param=recalc_idx_min_interval, val=30
param=remove_isql_logs, val=if_no_severe_errors
param=replace_instance, val=1
param=report_compress_cmd, val=/usr/bin/7za
param=results_storage_fbk, val=/home/bases/oltp40-results-storage.fbk
param=run_db_statistics, val=0
param=run_db_validation, val=0
param=separate_workers, val=1
param=sleep_ddl, val=./oltp_sleepUDF_nix.sql
param=sleep_max, val=0
param=test_intervals, val=60
param=test_time, val=120
param=tmpdir, val=/var/tmp/logs-oltp40
param=unit_selection_method, val=random
param=update_conflict_percent, val=0
param=used_in_replication, val=0
param=use_mtee, val=0
param=usr, val=SYSDBA
param=wait_after_create, val=0
param=wait_for_copy, val=1
param=wait_if_not_exists, val=0
param=warm_time, val=30
param=working_mode, val=small_03
Custom name of interactive SQL utility: parameter: 'clu', value: |isql|

Test finish info

FINISH_STATE                    NORMAL: TEST_TIME EXPIRED AT 2023-01-07 13:37:24
DTS_END                         2023-01-07 13:37:24.2690
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_INVOICE(39:5) ==> X_MAKE_QSTORNO_1200_2000(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/34726
TRN_ID                          220771
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: 8926.07 29902 1071128
customer order: creation 166.33 495 19960
customer order: refuse 14.76 463 1771
order to supplier: creation 45.06 1460 5407
order to supplier: removal 3.34 179836 401
invoice (draft): creation 44.89 3144 5387
invoice (draft): removal 50.12 981 6014
invoice accept: apply 41.13 28695 4936
invoice accept: cancel 45.49 1414 5459
customer reserve: creation 3800.78 274 456094
customer reserve: removal 4421.97 107 530636
realization accept: apply 80.47 288 9657
realization accept: cancel 84.28 176 10114
payment from customer: creation 58.99 195 7079
payment from customer: removal 5.36 146 643
payment to supplier: creation 47.41 217 5689
payment to supplier: removal 3.23 130 387
service: total inventory turnovers 3.89 4535 467
service: total monetary turnovers 7.54 413 905
service: aggregate perf. data 0.98 16064 118
service: refresh index statistics 0.03 358999 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 07-01-2023 13:39:14 to 07-01-2023 13:39:17.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 9612
TEST_TIME 2 7571
TEST_TIME 3 7147
TEST_TIME 4 6698
TEST_TIME 5 6443
TEST_TIME 6 6481
TEST_TIME 7 6398
TEST_TIME 8 6802
TEST_TIME 9 6761
TEST_TIME 10 6702
TEST_TIME 11 6997
TEST_TIME 12 7082
TEST_TIME 13 7167
TEST_TIME 14 7107
TEST_TIME 15 7074
TEST_TIME 16 7156
TEST_TIME 17 7135
TEST_TIME 18 7109
TEST_TIME 19 7169
TEST_TIME 20 7180
TEST_TIME 21 7535
TEST_TIME 22 7456
TEST_TIME 23 7634
TEST_TIME 24 7727
TEST_TIME 25 7807
TEST_TIME 26 7991
TEST_TIME 27 8177
TEST_TIME 28 8284
TEST_TIME 29 8618
TEST_TIME 30 8688
TEST_TIME 31 9236
TEST_TIME 32 9402
TEST_TIME 33 9359
TEST_TIME 34 9530
TEST_TIME 35 10147
TEST_TIME 36 10203
TEST_TIME 37 10692
TEST_TIME 38 10614
TEST_TIME 39 10759
TEST_TIME 40 10545
TEST_TIME 41 10542
TEST_TIME 42 10462
TEST_TIME 43 10386
TEST_TIME 44 10232
TEST_TIME 45 10063
TEST_TIME 46 10010
TEST_TIME 47 9895
TEST_TIME 48 9765
TEST_TIME 49 9734
TEST_TIME 50 9733
TEST_TIME 51 9783
TEST_TIME 52 9723
TEST_TIME 53 9682
TEST_TIME 54 9678
TEST_TIME 55 9663
TEST_TIME 56 9572
TEST_TIME 57 9588
TEST_TIME 58 9613
TEST_TIME 59 9555
TEST_TIME 60 9529
TEST_TIME 61 9581
TEST_TIME 62 9574
TEST_TIME 63 9569
TEST_TIME 64 9548
TEST_TIME 65 9472
TEST_TIME 66 9608
TEST_TIME 67 9604
TEST_TIME 68 9611
TEST_TIME 69 9682
TEST_TIME 70 9559
TEST_TIME 71 9495
TEST_TIME 72 9416
TEST_TIME 73 9371
TEST_TIME 74 9397
TEST_TIME 75 9354
TEST_TIME 76 9313
TEST_TIME 77 9231
TEST_TIME 78 9186
TEST_TIME 79 9182
TEST_TIME 80 9171
TEST_TIME 81 9162
TEST_TIME 82 9125
TEST_TIME 83 9113
TEST_TIME 84 9122
TEST_TIME 85 9350
TEST_TIME 86 9366
TEST_TIME 87 9349
TEST_TIME 88 9367
TEST_TIME 89 9374
TEST_TIME 90 9301
TEST_TIME 91 9290
TEST_TIME 92 9302
TEST_TIME 93 9292
TEST_TIME 94 9259
TEST_TIME 95 9245
TEST_TIME 96 9220
TEST_TIME 97 9189
TEST_TIME 98 9128
TEST_TIME 99 9116
TEST_TIME 100 9117
TEST_TIME 101 9105
TEST_TIME 102 9101
TEST_TIME 103 9094
TEST_TIME 104 9094
TEST_TIME 105 9114
TEST_TIME 106 9118
TEST_TIME 107 9140
TEST_TIME 108 9115
TEST_TIME 109 9101
TEST_TIME 110 9124
TEST_TIME 111 9112
TEST_TIME 112 9177
TEST_TIME 113 9138
TEST_TIME 114 9166
TEST_TIME 115 9101
TEST_TIME 116 9069
TEST_TIME 117 9043
TEST_TIME 118 9038
TEST_TIME 119 9005
TEST_TIME 120 8953

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 07-01-2023 13:39:18 to 07-01-2023 13:39:21.

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 1491809 1491809 0 0.00 0 28385 15 0 0
doc_list_biud 1491794 1491794 0 0.00 0 62439 44 0 0
sp_add_invoice_to_stock 5097 4936 161 3.15 40 210819 28696 0 161
sp_cancel_adding_invoice 5459 5459 0 0.00 6 85882 1414 0 0
sp_cancel_client_order 1771 1771 0 0.00 6 20005 464 0 0
sp_cancel_customer_reserve 530636 530636 0 0.00 1 62441 108 0 0
sp_cancel_pay_from_customer 643 643 0 0.00 3 4721 147 0 0
sp_cancel_pay_to_supplier 387 387 0 0.00 4 1751 131 0 0
sp_cancel_supplier_invoice 6026 6014 12 0.19 3 23371 982 0 12
sp_cancel_supplier_order 401 401 0 0.00 8 1520119 179836 0 0
sp_cancel_write_off 10114 10114 0 0.00 2 11662 176 0 0
sp_client_order 19960 19960 0 0.00 6 27816 496 0 0
sp_customer_reserve 456094 456094 0 0.00 0 151235 275 0 0
sp_fill_shopping_cart 30739 30739 0 0.00 1 16229 88 0 0
sp_fill_shopping_cart_clo_res 456067 456067 0 0.00 0 12763 18 0 0
sp_get_clo_for_invoice 4899 4899 0 0.00 0 32816 281 0 0
sp_kill_cost_storno 16603 16603 0 0.00 0 12046 78 0 0
sp_kill_qstorno_ret_qs2qd 1077801 1077801 0 0.00 0 62424 46 0 0
sp_kill_qty_storno 568946 568946 0 0.00 0 62437 106 0 0
sp_lock_selected_doc 20285 20285 0 0.00 0 10030 9 0 0
sp_make_cost_storno 27324 27324 0 0.00 0 15053 86 0 0
sp_multiply_rows_for_pdistr 27322 27322 0 0.00 0 7405 41 0 0
sp_multiply_rows_for_qdistr 19958 19958 0 0.00 0 14935 178 0 0
sp_pay_from_customer 7079 7079 0 0.00 5 15137 195 0 0
sp_pay_to_supplier 5689 5689 0 0.00 6 19386 217 0 0
sp_payment_common 12767 12767 0 0.00 2 10710 51 0 0
sp_qd_handle_on_cancel_clo 1771 1771 0 0.00 0 17110 383 0 0
sp_qd_handle_on_invoice_upd_sts 10357 10357 0 0.00 0 15966 552 0 0
sp_qd_handle_on_reserve_upd_sts 9653 9653 0 0.00 0 17875 60 0 0
sp_reserve_write_off 9657 9657 0 0.00 9 19666 289 0 0
sp_supplier_invoice 5387 5387 0 0.00 8 87602 3145 0 0
sp_supplier_order 5407 5407 0 0.00 7 37953 1460 0 0
srv_aggregate_perf_data 118 118 0 0.00 2092 134836 16065 0 0
srv_fill_mon_cache_memory 70 70 0 0.00 798 210380 37714 0 0
srv_find_qd_qs_mism 1023489 1023489 0 0.00 0 28153 11 0 0
srv_make_invnt_saldo 467 467 0 0.00 73 83816 4535 0 0
srv_make_money_saldo 905 905 0 0.00 1 10468 414 0 0
srv_recalc_idx_stat 4 4 0 0.00 244722 433995 359000 0 0
t$perf-abend:sp_add_invoice_to_stock 161 161 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 12 12 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4944 4944 0 0.00 1 11351 1062 0 0
t$perf-norm:sp_cancel_adding_invoice 428 428 0 0.00 1 8233 520 0 0
t$perf-norm:sp_cancel_client_order 1771 1771 0 0.00 0 2780 31 0 0
t$perf-norm:sp_cancel_customer_reserve 714 714 0 0.00 0 2521 24 0 0
t$perf-norm:sp_cancel_pay_from_customer 643 643 0 0.00 0 2288 19 0 0
t$perf-norm:sp_cancel_pay_to_supplier 387 387 0 0.00 0 4433 34 0 0
t$perf-norm:sp_cancel_supplier_invoice 388 388 0 0.00 0 969 38 0 0
t$perf-norm:sp_cancel_supplier_order 401 401 0 0.00 0 116559 7586 0 0
t$perf-norm:sp_cancel_write_off 1005 1005 0 0.00 0 655 18 0 0
t$perf-norm:sp_client_order 19961 19961 0 0.00 0 6360 38 0 0
t$perf-norm:sp_customer_reserve 1029 1029 0 0.00 0 1654 17 0 0
t$perf-norm:sp_pay_from_customer 7079 7079 0 0.00 0 4881 20 0 0
t$perf-norm:sp_pay_to_supplier 5689 5689 0 0.00 0 4030 24 0 0
t$perf-norm:sp_reserve_write_off 9658 9658 0 0.00 0 6502 25 0 0
t$perf-norm:sp_supplier_invoice 5387 5387 0 0.00 0 2950 34 0 0
t$perf-norm:sp_supplier_order 5408 5408 0 0.00 0 2517 34 0 0
t$perf-norm:srv_aggregate_perf_data 118 118 0 0.00 0 448 32 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 481 16 0 0
t$perf-norm:srv_make_invnt_saldo 467 467 0 0.00 0 3001 22 0 0
t$perf-norm:srv_make_money_saldo 905 905 0 0.00 0 2627 8 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 37 210 88 0 0
v_add_invoice_to_stock 10114 9792 322 3.18 0 9610 27 0 322
v_all_customers 37052 37052 0 0.00 0 108 4 0 0
v_all_suppliers 29779 29779 0 0.00 0 143 5 0 0
v_all_wares 39902 39902 0 0.00 0 113 4 0 0
v_cancel_adding_invoice 856 856 0 0.00 0 174 14 0 0
v_cancel_client_order 3542 3542 0 0.00 0 4826 12 0 0
v_cancel_customer_prepayment 1286 1286 0 0.00 0 1890 14 0 0
v_cancel_customer_reserve 1428 1428 0 0.00 0 1406 13 0 0
v_cancel_payment_to_supplier 774 774 0 0.00 0 1553 16 0 0
v_cancel_supplier_invoice 800 776 24 3.00 0 2743 29 0 24
v_cancel_supplier_order 802 802 0 0.00 0 1357 15 0 0
v_cancel_write_off 2010 2010 0 0.00 0 3789 26 0 0
v_max_id_clo_ord 5403 5403 0 0.00 0 274 5 0 0
v_max_id_clo_res 1029 1029 0 0.00 0 1969 18 0 0
v_max_id_ord_sup 5383 5383 0 0.00 0 3958 7 0 0
v_max_non_paid_invoice 1583 1583 0 0.00 0 62 7 0 0
v_max_non_paid_realizn 3508 3508 0 0.00 0 7245 11 0 0
v_min_id_clo_ord 5403 5403 0 0.00 0 1938 9 0 0
v_min_id_clo_res 1029 1029 0 0.00 0 4542 16 0 0
v_min_id_ord_sup 5383 5383 0 0.00 0 6220 10 0 0
v_min_non_paid_invoice 5689 5689 0 0.00 0 8370 20 0 0
v_min_non_paid_realizn 7078 7078 0 0.00 0 10703 22 0 0
v_our_firm 9982 9982 0 0.00 0 71 5 0 0
v_reserve_write_off 19304 19304 0 0.00 0 3516 11 0 0
x_lock_depdocs_on_canc_invoice 11085 11085 0 0.00 0 23388 139 0 0
x_lock_depdocs_on_canc_sup_ord 401 401 0 0.00 0 5023 404 0 0
x_make_qstorno_1000_1200 5407 5407 0 0.00 2 37889 1274 0 0
x_make_qstorno_1200_2000 5387 5387 0 0.00 4 81918 2903 0 0
x_make_qstorno_2100_3300 456091 456091 0 0.00 0 151232 242 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 07-01-2023 13:39:22 to 07-01-2023 13:39:27.

Memory consumption, metadata cache, attachments activity

Fields:
  page cache memo used            = page cache total size, bytes:
  memo used, total                = total of mon$memory_usage.mon$memory_used for database level (mon$stat_group = 0);
  memo allocated, total           = the same of mon$memory_usage.mon$memory_allocated;
  metadata cache memo used        = metadata cache, bytes;
  metadata cache percent of total = ratio: metadata cache / (metadata cache + page cache);
  total attachments cnt           = total number of attachments, regardless of state;
  active attachments cnt          = number of attachments with mon$state = 1;
  running statements cnt          = number of statements that are operating with data from page cache (mon$state = 1);
  stalled statements cnt          = number of statements that are waiting for client request for fetching ( mon$state = 2);
  memo used by attachments        = total of mon$memory_usage.mon$memory_used for attachment level (mon$stat_group = 1);
  memo used by transactions       = the same of transaction level (mon$stat_group = 2);
  memo used by statements         = the same of statement level (mon$stat_group = 3);


Page cache type: shared, buffers: 1000000 for all connections, with total size: 8192000000                                                                                                                                                                     

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
11:07:28 1 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
11:08:29 19744 8192000000 9724792432 10024067072 806433696 8.961 100 89 178 0 835537808 7607552 21496560
11:09:52 15705 8192000000 9766057248 10075471872 843172304 9.332 100 87 174 0 875053840 11126368 20755168
11:11:17 15949 8192000000 9806584800 10124410880 876185872 9.662 100 83 164 0 912193376 17200256 18807248
11:12:41 9280 8192000000 9861650560 10191949824 917072880 10.067 100 80 160 1 970716432 36344736 17298816
11:13:53 4992 8192000000 9923978336 10264375296 958704880 10.476 100 91 178 0 1032387984 55383824 18299280
11:15:01 4687 8192000000 9957103792 10313924608 984966992 10.733 100 84 163 1 1079826016 78104704 16754320
11:16:10 991 8192000000 9986565920 10344615936 1009315184 10.969 100 88 172 1 1100645248 74989488 16340576
11:17:13 2953 8192000000 9999870384 10368057344 1026776512 11.137 100 80 156 0 1126945040 85264480 14904048
11:18:18 1008 8192000000 10040925888 10410569728 1050854304 11.369 100 96 182 0 1156805760 88263312 17688144
11:19:20 1046 8192000000 10021209024 10395590656 1058307968 11.440 100 95 182 2 1139165904 62457312 18400624
11:20:22 793 8192000000 10040663824 10421141504 1065476368 11.509 100 91 173 1 1166408512 83716928 17215216
11:21:25 1029 8192000000 10041446832 10421260288 1072936752 11.580 100 97 188 1 1163405600 71949424 18519424
11:22:27 1272 8192000000 10042140976 10427498496 1078940576 11.637 100 92 171 3 1169846944 72572352 18334016
11:23:29 1410 8192000000 10038610096 10424815616 1079735952 11.645 100 80 148 3 1160618048 66661776 14220320
11:24:32 1496 8192000000 10060095104 10448875520 1085679552 11.702 100 88 168 2 1188339792 84545376 18114864
11:25:35 901 8192000000 10065976032 10452512768 1096669296 11.806 100 91 172 0 1184488960 70578208 17241456
11:26:37 1239 8192000000 10055220720 10448699392 1095765680 11.797 100 87 166 2 1181762784 68152192 17844912
11:27:40 1167 8192000000 10056685888 10444537856 1091641920 11.758 100 93 174 0 1179284864 68796032 18846912
11:28:43 1319 8192000000 10029267168 10412457984 1077695952 11.626 100 95 178 1 1153144560 57543920 17904688
11:29:45 1023 8192000000 10056423984 10442760192 1086282640 11.707 100 89 164 0 1178823792 77581360 14959792
11:30:48 1064 8192000000 10015999072 10395107328 1054212320 11.401 100 91 174 4 1139767552 66621264 18933968
11:31:51 1308 8192000000 10043018384 10420084736 1062354592 11.479 100 94 182 1 1160054400 79144960 18554848
11:32:54 1162 8192000000 10020221184 10397843456 1063060896 11.486 100 91 167 1 1142247120 61611680 17574544
11:33:56 1057 8192000000 10005158464 10383171584 1054875360 11.407 100 84 147 0 1122989328 53110608 15003360
11:34:58 1528 8192000000 9955138848 10326573056 1021910720 11.090 98 84 159 2 1083683216 45056096 16716400
11:36:00 938 8192000000 9966026912 10340524032 1021888448 11.090 100 82 158 0 1088436800 49740736 16807616
11:37:02 891 8192000000 9978477408 10351439872 1033594464 11.203 100 94 179 3 1101313168 48971376 18747328
11:38:10 9100 8192000000 10001043424 10379689984 1054007328 11.399 100 71 137 0 1121413168 53918256 13487584
11:39:31 15843 8192000000 10049412464 10441703424 1070462720 11.556 100 62 121 0 1157398784 74884064 12052000
11:40:53 1554 8192000000 10060475008 10448855040 1088165344 11.725 100 88 161 3 1175293648 69547648 17580656
11:42:00 2173 8192000000 10086004976 10476875776 1099032448 11.828 100 75 136 2 1206463856 93139248 14292160
11:43:13 937 8192000000 10112967904 10509115392 1108257744 11.916 100 95 190 0 1232967280 104048912 20660624
11:44:19 7354 8192000000 10144634032 10551578624 1120585632 12.033 100 66 124 0 1261826304 127917168 13323504
11:45:30 8909 8192000000 10150451280 10557673472 1132285280 12.143 100 67 130 0 1278544096 132492944 13765872
11:46:43 7731 8192000000 10198901728 10602762240 1145323936 12.266 100 67 134 1 1319562080 159791440 14446704
11:47:54 1376 8192000000 10233835248 10640977920 1167117536 12.470 100 90 167 0 1349143264 163485984 18539744
11:48:58 1836 8192000000 10281741216 10688905216 1182494240 12.613 100 94 183 1 1397612096 193976144 21141712
11:50:05 1571 8192000000 10301062880 10702630912 1189605632 12.680 100 84 162 0 1412273344 204450928 18216784
11:51:10 1304 8192000000 10322986816 10726703104 1186474368 12.651 100 92 175 1 1430791568 225735104 18582096
11:52:15 1049 8192000000 10374058656 10787409920 1199699936 12.774 100 94 186 1 1489758528 268569904 21488688
11:53:21 1027 8192000000 10407925008 10819772416 1203615744 12.810 100 92 175 3 1518685184 293718496 21350944
11:54:26 1124 8192000000 10434659056 10848145408 1202763360 12.802 100 85 167 0 1545221248 324245776 18212112
11:55:33 1576 8192000000 10468741792 10881773568 1198362944 12.761 100 94 180 0 1569661408 350475792 20822672
11:56:39 1220 8192000000 10474015872 10901856256 1197331152 12.752 100 97 188 1 1576359248 357309952 21718144
11:57:46 2001 8192000000 10517345648 10960990208 1204925616 12.822 100 96 189 1 1623808896 395985312 22897968
11:58:50 1173 8192000000 10499098736 10918330368 1192651792 12.708 99 96 189 0 1605473664 390342576 22479296
11:59:55 832 8192000000 10531467664 10967969792 1202583904 12.800 100 97 190 1 1630892240 405241760 23066576
12:00:59 782 8192000000 10536265584 10963922944 1189713680 12.681 100 97 190 1 1638568640 426048640 22806320
12:02:03 888 8192000000 10557272832 11000246272 1188674928 12.671 100 94 187 0 1663976320 452461120 22840272
12:03:08 966 8192000000 10585365200 11022282752 1175526352 12.548 99 92 182 1 1690709872 491699184 23484336
12:04:13 1582 8192000000 10544177456 11009753088 1181272208 12.602 100 75 133 2 1653404576 454736944 17395424
12:05:19 4488 8192000000 10579582848 11011129344 1176432464 12.557 100 68 132 0 1686730352 493388896 16908992
12:06:40 1575 8192000000 10540401184 10970042368 1175445952 12.548 100 61 124 0 1644246624 454034992 14765680
12:07:50 2927 8192000000 10498339392 10979540992 1169961696 12.496 100 64 126 0 1602445680 417353008 15130976
12:09:14 39164 8192000000 10397128208 10844610560 1135910480 12.177 98 33 66 0 1522135872 377573504 8651888
12:11:25 26357 8192000000 10363159360 10848235520 1121585120 12.042 100 21 42 0 1463826704 336736592 5504992
12:13:11 48649 8192000000 10207097072 10650783744 1114960096 11.979 99 30 61 2 1286272416 163827536 7484784
12:15:00 58084 8192000000 10110492448 10566684672 1127939008 12.102 100 22 41 1 1195431968 63085264 4407696
12:17:01 34070 8192000000 10101461776 10527330304 1142806768 12.242 100 50 93 1 1186354512 34681024 8866720
12:18:37 69166 8192000000 10082707632 10540146688 1099839536 11.836 96 20 39 1 1182483472 78383248 4260688
12:21:00 77218 8192000000 10122861760 10567589888 1136103344 12.179 100 43 71 2 1219187056 74693056 8390656
12:23:18 119410 8192000000 10117505072 10555805696 1118386832 12.012 97 34 68 0 1185796064 60487056 6922176
12:26:24 13498 8192000000 10144069648 10577653760 1142282384 12.237 99 43 73 0 1242213072 91860800 8069888
12:27:40 28103 8192000000 10180358240 10647543808 1159480144 12.398 100 45 90 0 1271693264 102804560 9408560
12:29:12 37946 8192000000 10147551264 10613534720 1136239184 12.180 98 38 73 1 1231630192 87554576 7836432
12:30:51 210380 8192000000 10106830656 10581467136 1080415312 11.651 94 11 22 1 1180275360 97257472 2602576
12:35:22 53719 8192000000 10059200560 10509033472 1100192176 11.839 96 15 28 1 1135469600 32438320 2839104
12:37:17 30931 8192000000 10085560976 10530512896 1122430272 12.050 99 29 58 0 1176976656 48830016 5716368
12:38:48 81163 8192000000 10085592096 10530263040 1116920784 11.998 98 30 60 0 1198340240 75648336 5771120
12:41:11 16994 8192000000 10141289568 10582196224 1141351776 12.228 99 38 76 0 1224406432 75352640 7702016
12:42:31 89771 8192000000 10132259104 10631659520 1116986912 11.999 97 22 44 1 1225594656 103824608 4783136
12:45:38 160973 8192000000 10067614336 10511015936 1096737552 11.807 96 24 46 1 1137878704 36030768 5110384
12:49:23 44606 8192000000 10064173136 10493620224 1118171520 12.010 99 46 81 2 1183922896 57087744 8663632
12:51:08 41352 8192000000 10072984800 10544349184 1101878432 11.855 98 36 72 0 1199761280 90727760 7155088
12:52:51 47292 8192000000 10055995264 10501238784 1101765008 11.854 98 14 26 0 1135488448 30781664 2941776
12:54:41 53322 8192000000 10083766160 10529460224 1106194368 11.896 97 22 44 2 1166649088 55393360 5061360
12:56:40 25919 8192000000 10120501712 10557538304 1128024864 12.103 99 24 47 0 1202923344 69464368 5434112
12:58:13 16316 8192000000 10155678112 10588868608 1152623232 12.334 100 38 76 0 1248674432 87249664 8801536
12:59:32 5473 8192000000 10188553440 10611339264 1163994992 12.441 100 73 139 1 1287099904 107737744 15367168
13:00:40 36789 8192000000 10237823408 10685603840 1163326288 12.434 100 37 66 1 1342635952 171539264 7770400
13:02:18 85347 8192000000 10104916864 10580930560 1106918272 11.903 97 13 25 0 1227552912 117869488 2765152
13:04:45 3801 8192000000 10092371760 10519683072 1140120544 12.217 100 84 164 3 1185626480 27782832 17723104
13:05:51 67526 8192000000 10139134496 10622271488 1111219024 11.944 97 26 52 0 1182559056 66236480 5103552
13:08:04 112285 8192000000 10104123328 10579873792 1126129568 12.085 99 19 38 0 1202462752 71754896 4578288
13:11:20 48855 8192000000 10113920208 10574147584 1150353200 12.313 100 40 78 1 1227945920 69480848 8111872
13:13:18 72927 8192000000 10085367632 10612768768 1134683680 12.165 99 7 14 0 1196168352 59953792 1530880
13:15:31 56858 8192000000 10065605136 10555432960 1114366176 11.974 98 6 12 0 1147067760 31756320 945264
13:17:28 72503 8192000000 10072001536 10516111360 1135553184 12.174 99 16 32 0 1177324976 38599344 3172448
13:19:40 52324 8192000000 10071579504 10543280128 1095193568 11.792 95 20 36 0 1137921008 39233296 3494144
13:21:33 50959 8192000000 10130165600 10580774912 1146585040 12.277 100 27 54 0 1214792304 62873520 5333744
13:23:29 62734 8192000000 10087518048 10536574976 1100999040 11.847 96 24 46 0 1158154496 52289472 4865984
13:25:32 42500 8192000000 10096358960 10557083648 1127201280 12.095 99 60 108 4 1183339280 44574032 11563968
13:27:18 30501 8192000000 10105667888 10555232256 1088662240 11.730 96 41 82 0 1171524720 74652480 8210000
13:28:53 113989 8192000000 10111295360 10560262144 1111253136 11.944 98 31 62 0 1208217520 90717040 6247344
13:31:53 134632 8192000000 10055365264 10506338304 1112678384 11.958 98 36 68 2 1149821248 30447584 6695280
13:35:09 59121 8192000000 10039284560 10501615616 1097821536 11.817 97 15 29 0 1133446624 32514016 3111072
13:37:16 23186 8192000000 9192188816 9488932864 338808112 3.971 31 2 4 0 356263728 17152240 303376

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:17, from 07-01-2023 13:39:28 to 07-01-2023 13:39:45.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 161 v_add_invoice_to_stock 335544517
except 12 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 07-01-2023 13:39:46 to 07-01-2023 13:39:48.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp40-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   13
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          221127
MON$OLDEST_ACTIVE               221128
MON$OLDEST_SNAPSHOT             221128
MON$NEXT_TRANSACTION            221128
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                       2062880
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             780
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

07.01.23 13:39:49. There are 3 logs in /var/tmp/logs-oltp40 that can be removed if no severe errors occured, see config setting 'remove_isql_logs' Following values of gdscode are considered as SEVERE: 0 Unidentified error in PSQL code: gdscode=0 within WHEN block when exception raised. 335544321 'string truncation'. Attempt to assign too long text into string variable. 335544347 'not_valid'. Validation error for column. 335544349 'no_dup'. Attempt to store duplicate value visible to active transactions. 335544558 'check_constraint'. Operation violates CHECK constraint on view or table. 335544665 'unique_key_violation'. Violation of PRIMARY or UNIQUE KEY constraint. 335544838 'foreign_key_target_doesnt_exist'. Foreign key reference target does not exist. 335544839 'foreign_key_references_present'. Foreign key references are present for the record.
FINISHED_AT ERRORS_RESULT
2023-01-07 13:39:51 No severe PSQL-related problems occured
07.01.23 13:39:52. End of report.