Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 29.06.2022 13:39
Common Performance Final Results
  1. Hardware and OS info
  2. Test configuration
  3. Test Finish details
  4. Test workload details
  5. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score:    as table     as chart
  2. Performance per MINUTE, during test_time phase:    as table     as chart
  3. Performance, DETAILS per units
  4. Memory consumption, metadata cache, attachments activity    as table    as chart
  5. Monitoring data: STATEMENTS activity, as chart
  6. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database statistics was not gathered. Change config parameter 'run_db_statistics' to 1.
  3. Database validation was not performed. Change config parameter 'run_db_validation' to 1.
  4. New in firebird.log while test was run
  5. Final processing of ISQL logs

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15641472 kB
MemAvailable 31225392 kB
Buffers 0 kB
Cached 16091604 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-06-29 13:37:17
DTS_END                         2022-06-29 13:37:17.8640
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_SUPPLIER_ORDER(38:5) ==> X_MAKE_QSTORNO_1000_1200(279:25) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/41358
TRN_ID                          203738
ATT_ID                          573
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: 8519.62 27797 1022354
customer order: creation 152.83 523 18340
customer order: refuse 13.46 494 1615
order to supplier: creation 40.36 1460 4843
order to supplier: removal 3.23 190324 387
invoice (draft): creation 40.13 3832 4815
invoice (draft): removal 48.91 1114 5869
invoice accept: apply 37.64 29461 4517
invoice accept: cancel 44.17 1508 5300
customer reserve: creation 3534.53 270 424144
customer reserve: removal 4342.02 110 521043
realization accept: apply 72.77 363 8732
realization accept: cancel 75.20 193 9024
payment from customer: creation 51.78 218 6214
payment from customer: removal 4.63 166 556
payment to supplier: creation 43.03 258 5164
payment to supplier: removal 3.29 184 395
service: total inventory turnovers 3.55 5112 426
service: total monetary turnovers 7.15 431 858
service: aggregate perf. data 0.89 19969 107
service: refresh index statistics 0.04 299946 5

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 29-06-2022 13:39:40 to 29-06-2022 13:39:42.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 7881
TEST_TIME 2 6537
TEST_TIME 3 5918
TEST_TIME 4 6398
TEST_TIME 5 6740
TEST_TIME 6 6233
TEST_TIME 7 6550
TEST_TIME 8 6458
TEST_TIME 9 6650
TEST_TIME 10 6957
TEST_TIME 11 7072
TEST_TIME 12 7292
TEST_TIME 13 7428
TEST_TIME 14 7515
TEST_TIME 15 7458
TEST_TIME 16 7362
TEST_TIME 17 7344
TEST_TIME 18 7312
TEST_TIME 19 7565
TEST_TIME 20 7739
TEST_TIME 21 7921
TEST_TIME 22 8161
TEST_TIME 23 8211
TEST_TIME 24 8426
TEST_TIME 25 8401
TEST_TIME 26 8655
TEST_TIME 27 8633
TEST_TIME 28 8833
TEST_TIME 29 8955
TEST_TIME 30 8928
TEST_TIME 31 8999
TEST_TIME 32 8957
TEST_TIME 33 9132
TEST_TIME 34 9292
TEST_TIME 35 9606
TEST_TIME 36 9842
TEST_TIME 37 10125
TEST_TIME 38 10249
TEST_TIME 39 10238
TEST_TIME 40 10502
TEST_TIME 41 10541
TEST_TIME 42 10306
TEST_TIME 43 10105
TEST_TIME 44 9989
TEST_TIME 45 9961
TEST_TIME 46 9880
TEST_TIME 47 9706
TEST_TIME 48 9570
TEST_TIME 49 9820
TEST_TIME 50 9825
TEST_TIME 51 9828
TEST_TIME 52 9760
TEST_TIME 53 9652
TEST_TIME 54 9672
TEST_TIME 55 9623
TEST_TIME 56 9517
TEST_TIME 57 9438
TEST_TIME 58 9445
TEST_TIME 59 9322
TEST_TIME 60 9294
TEST_TIME 61 9253
TEST_TIME 62 9242
TEST_TIME 63 9197
TEST_TIME 64 9230
TEST_TIME 65 9146
TEST_TIME 66 9017
TEST_TIME 67 8977
TEST_TIME 68 8990
TEST_TIME 69 9035
TEST_TIME 70 9062
TEST_TIME 71 9088
TEST_TIME 72 9026
TEST_TIME 73 8961
TEST_TIME 74 8962
TEST_TIME 75 9004
TEST_TIME 76 8997
TEST_TIME 77 8993
TEST_TIME 78 9065
TEST_TIME 79 9014
TEST_TIME 80 9050
TEST_TIME 81 9082
TEST_TIME 82 8997
TEST_TIME 83 8934
TEST_TIME 84 8878
TEST_TIME 85 8931
TEST_TIME 86 8883
TEST_TIME 87 8877
TEST_TIME 88 8830
TEST_TIME 89 8826
TEST_TIME 90 8827
TEST_TIME 91 8778
TEST_TIME 92 8723
TEST_TIME 93 8705
TEST_TIME 94 8731
TEST_TIME 95 8709
TEST_TIME 96 8727
TEST_TIME 97 8709
TEST_TIME 98 8721
TEST_TIME 99 8695
TEST_TIME 100 8667
TEST_TIME 101 8721
TEST_TIME 102 8746
TEST_TIME 103 8795
TEST_TIME 104 8835
TEST_TIME 105 8863
TEST_TIME 106 8883
TEST_TIME 107 8882
TEST_TIME 108 8852
TEST_TIME 109 8851
TEST_TIME 110 8809
TEST_TIME 111 8758
TEST_TIME 112 8786
TEST_TIME 113 8772
TEST_TIME 114 8757
TEST_TIME 115 8724
TEST_TIME 116 8700
TEST_TIME 117 8656
TEST_TIME 118 8623
TEST_TIME 119 8597
TEST_TIME 120 8542

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 29-06-2022 13:39:44 to 29-06-2022 13:39:47.

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 1412454 1412454 0 0.00 0 29660 14 0 0
doc_list_biud 1412436 1412436 0 0.00 0 45550 48 0 0
sp_add_invoice_to_stock 4611 4517 94 2.03 72 252749 29461 0 94
sp_cancel_adding_invoice 5300 5300 0 0.00 5 105243 1508 0 0
sp_cancel_client_order 1615 1615 0 0.00 5 9017 494 0 0
sp_cancel_customer_reserve 521043 521043 0 0.00 1 42384 111 0 0
sp_cancel_pay_from_customer 556 556 0 0.00 3 4443 166 0 0
sp_cancel_pay_to_supplier 395 395 0 0.00 3 7284 185 0 0
sp_cancel_supplier_invoice 5875 5869 6 0.10 2 30203 1115 0 6
sp_cancel_supplier_order 387 387 0 0.00 18 1544684 190324 0 0
sp_cancel_write_off 9024 9024 0 0.00 2 30111 193 0 0
sp_client_order 18340 18340 0 0.00 5 42194 524 0 0
sp_customer_reserve 424144 424144 0 0.00 1 111396 271 0 0
sp_fill_shopping_cart 27987 27987 0 0.00 1 20671 106 0 0
sp_fill_shopping_cart_clo_res 424110 424110 0 0.00 0 19315 21 0 0
sp_get_clo_for_invoice 4477 4477 0 0.00 0 23897 385 0 0
sp_kill_cost_storno 15275 15275 0 0.00 0 10659 93 0 0
sp_kill_qstorno_ret_qs2qd 1057366 1057366 0 0.00 0 45548 48 0 0
sp_kill_qty_storno 556440 556440 0 0.00 0 45549 113 0 0
sp_lock_selected_doc 18373 18373 0 0.00 0 8751 9 0 0
sp_make_cost_storno 24585 24585 0 0.00 0 20230 102 0 0
sp_multiply_rows_for_pdistr 24583 24583 0 0.00 0 8620 46 0 0
sp_multiply_rows_for_qdistr 18340 18340 0 0.00 0 20634 171 0 0
sp_pay_from_customer 6214 6214 0 0.00 5 20240 218 0 0
sp_pay_to_supplier 5164 5164 0 0.00 6 20976 258 0 0
sp_payment_common 11377 11377 0 0.00 2 11322 59 0 0
sp_qd_handle_on_cancel_clo 1615 1615 0 0.00 0 9006 404 0 0
sp_qd_handle_on_invoice_upd_sts 9772 9772 0 0.00 0 33957 678 0 0
sp_qd_handle_on_reserve_upd_sts 8730 8730 0 0.00 0 41822 105 0 0
sp_reserve_write_off 8732 8732 0 0.00 7 42088 364 0 0
sp_supplier_invoice 4815 4815 0 0.00 10 74353 3832 0 0
sp_supplier_order 4843 4843 0 0.00 6 74784 1460 0 0
srv_aggregate_perf_data 107 107 0 0.00 2103 342507 19969 0 0
srv_fill_mon_cache_memory 70 70 0 0.00 673 125139 35028 0 0
srv_find_qd_qs_mism 978290 978290 0 0.00 0 29658 10 0 0
srv_make_invnt_saldo 426 426 0 0.00 83 181863 5113 0 0
srv_make_money_saldo 858 858 0 0.00 1 8230 431 0 0
srv_recalc_idx_stat 5 5 0 0.00 43227 589684 299947 0 0
t$perf-abend:sp_add_invoice_to_stock 94 94 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 6 6 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4522 4522 0 0.00 1 16496 1303 0 0
t$perf-norm:sp_cancel_adding_invoice 364 364 0 0.00 1 6716 677 0 0
t$perf-norm:sp_cancel_client_order 1615 1615 0 0.00 0 6472 39 0 0
t$perf-norm:sp_cancel_customer_reserve 628 628 0 0.00 0 2098 41 0 0
t$perf-norm:sp_cancel_pay_from_customer 556 556 0 0.00 0 2144 20 0 0
t$perf-norm:sp_cancel_pay_to_supplier 395 395 0 0.00 0 4340 26 0 0
t$perf-norm:sp_cancel_supplier_invoice 378 378 0 0.00 0 5405 82 0 0
t$perf-norm:sp_cancel_supplier_order 387 387 0 0.00 0 107537 8890 0 0
t$perf-norm:sp_cancel_write_off 860 860 0 0.00 0 4107 30 0 0
t$perf-norm:sp_client_order 18341 18341 0 0.00 0 35604 50 0 0
t$perf-norm:sp_customer_reserve 951 951 0 0.00 0 3765 18 0 0
t$perf-norm:sp_pay_from_customer 6214 6214 0 0.00 0 38040 33 0 0
t$perf-norm:sp_pay_to_supplier 5164 5164 0 0.00 0 38010 39 0 0
t$perf-norm:sp_reserve_write_off 8732 8732 0 0.00 0 8325 29 0 0
t$perf-norm:sp_supplier_invoice 4815 4815 0 0.00 0 9093 45 0 0
t$perf-norm:sp_supplier_order 4843 4843 0 0.00 0 5941 41 0 0
t$perf-norm:srv_aggregate_perf_data 107 107 0 0.00 0 944 45 0 0
t$perf-norm:srv_fill_mon_cache_memory 70 70 0 0.00 0 130 7 0 0
t$perf-norm:srv_make_invnt_saldo 426 426 0 0.00 0 1470 25 0 0
t$perf-norm:srv_make_money_saldo 858 858 0 0.00 0 1437 8 0 0
t$perf-norm:srv_recalc_idx_stat 5 5 0 0.00 3 273 110 0 0
v_add_invoice_to_stock 9108 8920 188 2.06 0 13659 34 0 188
v_all_customers 33606 33606 0 0.00 0 61 5 0 0
v_all_suppliers 26784 26784 0 0.00 0 101 5 0 0
v_all_wares 36678 36678 0 0.00 0 100 5 0 0
v_cancel_adding_invoice 728 728 0 0.00 0 980 18 0 0
v_cancel_client_order 3230 3230 0 0.00 0 4038 15 0 0
v_cancel_customer_prepayment 1112 1112 0 0.00 0 4415 23 0 0
v_cancel_customer_reserve 1256 1256 0 0.00 0 3514 17 0 0
v_cancel_payment_to_supplier 790 790 0 0.00 0 3662 22 0 0
v_cancel_supplier_invoice 768 756 12 1.56 0 1375 31 0 12
v_cancel_supplier_order 774 774 0 0.00 0 4030 22 0 0
v_cancel_write_off 1720 1720 0 0.00 0 3527 30 0 0
v_max_id_clo_ord 4843 4843 0 0.00 0 1172 7 0 0
v_max_id_clo_res 950 950 0 0.00 0 3533 14 0 0
v_max_id_ord_sup 4802 4802 0 0.00 0 7100 11 0 0
v_max_non_paid_invoice 1417 1417 0 0.00 0 74 9 0 0
v_max_non_paid_realizn 3161 3161 0 0.00 0 9758 12 0 0
v_min_id_clo_ord 4843 4843 0 0.00 0 5532 11 0 0
v_min_id_clo_res 950 950 0 0.00 0 1863 12 0 0
v_min_id_ord_sup 4802 4802 0 0.00 0 4382 11 0 0
v_min_non_paid_invoice 5164 5164 0 0.00 0 8424 23 0 0
v_min_non_paid_realizn 6213 6213 0 0.00 0 10426 21 0 0
v_our_firm 9176 9176 0 0.00 0 73 6 0 0
v_reserve_write_off 17458 17458 0 0.00 0 6175 14 0 0
x_lock_depdocs_on_canc_invoice 10791 10791 0 0.00 0 26341 152 0 0
x_lock_depdocs_on_canc_sup_ord 387 387 0 0.00 0 18883 541 0 0
x_make_qstorno_1000_1200 4843 4843 0 0.00 2 74768 1243 0 0
x_make_qstorno_1200_2000 4815 4815 0 0.00 5 73854 3535 0 0
x_make_qstorno_2100_3300 424143 424143 0 0.00 0 111368 233 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 29-06-2022 13:39:48 to 29-06-2022 13:39:52.

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:21 2 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
11:08:22 32525 8192000000 9733416352 10033168384 812224736 9.020 100 91 182 0 841549680 7920448 21404496
11:09:58 18591 8192000000 9766552336 10076254208 842910128 9.329 100 86 172 0 875225392 11998400 20316864
11:11:34 18511 8192000000 9797278272 10119532544 869440688 9.594 100 80 160 0 909668000 21632224 18595088
11:12:59 8243 8192000000 9883150480 10218991616 926428544 10.159 100 80 160 0 994859696 51266416 17164736
11:14:09 4522 8192000000 9925162528 10270756864 963969936 10.528 100 86 166 0 1038364864 57025264 17369664
11:15:16 2791 8192000000 9972614512 10325544960 991425664 10.795 100 90 176 2 1084963456 75826640 17711152
11:16:23 1772 8192000000 9987639360 10350145536 1016921504 11.042 100 88 176 1 1111428512 76321040 18185968
11:17:28 906 8192000000 10034563376 10401124352 1032914816 11.197 100 96 181 2 1154995808 103205616 18875376
11:18:30 1385 8192000000 10023277920 10393186304 1053673872 11.396 100 97 189 1 1149452704 76964544 18814288
11:19:34 2158 8192000000 10018254240 10398093312 1059489312 11.452 100 82 156 1 1146344848 71252160 15603376
11:20:38 1197 8192000000 10048174352 10425569280 1070530160 11.557 100 98 193 0 1174010960 83829792 19651008
11:21:44 809 8192000000 10047819216 10425462784 1075917376 11.609 100 93 181 1 1164458160 70168368 18372416
11:22:49 902 8192000000 10056511296 10437951488 1079460176 11.642 100 95 183 0 1173232864 75606000 18166688
11:23:53 1106 8192000000 10068614240 10458365952 1084538832 11.691 100 94 185 0 1194441632 90771648 19131152
11:24:55 1176 8192000000 10059546448 10445467648 1091384576 11.756 100 93 178 3 1179110768 68999648 18726544
11:25:57 998 8192000000 10073962304 10464010240 1097563872 11.815 100 91 175 0 1200268016 85255024 17449120
11:26:59 1045 8192000000 10065835648 10457657344 1098015296 11.819 100 90 171 0 1191209632 76634528 16559808
11:28:02 1141 8192000000 10068862192 10459574272 1095944496 11.799 100 93 174 0 1189130384 75071824 18114064
11:29:04 1034 8192000000 10035127120 10422669312 1088180144 11.725 100 94 181 1 1157865136 52464160 17220832
11:30:07 1143 8192000000 10042012752 10425180160 1066691488 11.520 99 96 191 0 1163068128 77546512 18830128
11:31:10 1293 8192000000 10065061936 10445090816 1078570608 11.634 100 95 186 1 1186268864 89918688 17779568
11:32:12 2557 8192000000 10025621936 10405470208 1065856992 11.512 99 83 150 2 1149418128 68131216 15429920
11:33:16 1306 8192000000 10016532832 10397245440 1054080128 11.400 99 96 180 2 1139248976 67004240 18164608
11:34:18 1071 8192000000 10011269328 10385977344 1047193232 11.334 100 94 178 0 1131207552 66182064 17832256
11:35:20 1083 8192000000 10017290832 10393649152 1045972160 11.322 99 93 181 1 1139898560 75907440 18018960
11:36:22 953 8192000000 9993031200 10367672320 1039185760 11.257 100 90 175 0 1115077792 57910048 17981984
11:37:24 816 8192000000 9994092784 10369880064 1056546720 11.423 100 86 163 0 1120666000 45771040 18348240
11:38:32 11333 8192000000 10024052784 10406719488 1055390592 11.412 99 77 149 1 1137756000 68983072 13382336
11:39:56 1416 8192000000 10058670224 10445799424 1091676384 11.759 100 80 146 1 1182832880 76084112 15072384
11:41:03 1304 8192000000 10074751648 10455121920 1091015280 11.752 100 95 176 3 1191301520 81088224 19198016
11:42:07 11949 8192000000 10115676672 10517594112 1108645088 11.920 100 64 128 0 1236400608 114282576 13472944
11:43:23 2496 8192000000 10119070656 10509377536 1123877408 12.064 100 74 141 0 1243355216 104805824 14671984
11:44:32 1160 8192000000 10176103408 10571231232 1131027728 12.131 100 97 187 4 1295275520 144747920 19499872
11:45:39 1242 8192000000 10188659040 10586456064 1136037008 12.178 100 93 173 2 1302144560 147020256 19087296
11:46:44 1198 8192000000 10202377936 10608664576 1132619616 12.146 99 90 172 1 1313724496 161863568 19241312
11:47:52 2002 8192000000 10215775296 10613964800 1153334688 12.341 100 87 156 0 1325185520 156975008 14875824
11:48:58 919 8192000000 10210663648 10630144000 1153432960 12.342 100 94 189 2 1322528944 147765536 21330448
11:50:04 1420 8192000000 10240017824 10645630976 1158678896 12.391 100 88 174 0 1353728608 175567392 19482320
11:51:08 1859 8192000000 10259202144 10660651008 1162997360 12.431 100 87 160 0 1369899472 187926432 18975680
11:52:13 937 8192000000 10302304000 10705559552 1171996720 12.515 100 91 169 0 1408690864 217634224 19059920
11:53:19 959 8192000000 10344310384 10747080704 1182543920 12.614 100 92 177 0 1452607488 249302704 20760864
11:54:26 745 8192000000 10400826560 10803204096 1185770640 12.644 100 95 182 0 1502595824 297491024 19334160
11:55:31 1727 8192000000 10414860272 10819694592 1171294160 12.509 99 94 185 5 1519976096 327108720 21573216
11:56:38 739 8192000000 10422833232 10858012672 1179608800 12.587 100 99 195 0 1530755408 328803664 22342944
11:57:43 1339 8192000000 10444475264 10884804608 1189435088 12.678 100 96 183 1 1550803664 339569616 21798960
11:58:48 758 8192000000 10431349840 10860339200 1180871088 12.598 100 91 180 0 1537293056 333964944 22457024
11:59:52 1557 8192000000 10424970624 10863374336 1180823552 12.598 100 93 177 0 1527052416 326369488 19859376
12:00:56 1248 8192000000 10423770640 10856239104 1171122560 12.507 100 96 184 0 1525846160 330617552 24106048
12:02:02 718 8192000000 10430411536 10845827072 1175286496 12.546 100 90 175 1 1529103536 333019216 20797824
12:03:05 966 8192000000 10476544560 10911707136 1182597472 12.614 100 96 178 2 1578958880 374508032 21853376
12:04:10 657 8192000000 10453736512 10896822272 1193393840 12.715 100 90 178 0 1561619152 345898400 22326912
12:05:15 4202 8192000000 10458276064 10949615616 1199536672 12.772 100 67 134 0 1574884144 358502352 16845120
12:06:26 4216 8192000000 10494070576 10935078912 1189311280 12.677 100 61 122 0 1607832576 403133248 15388048
12:07:43 9128 8192000000 10492969376 10938974208 1188611248 12.670 100 47 92 1 1601162640 400980224 11571168
12:08:57 11138 8192000000 10504002912 10946195456 1174240176 12.536 99 45 90 1 1593169952 407933088 10996688
12:10:13 9937 8192000000 10454076160 10922807296 1168830176 12.486 100 39 77 0 1561193424 382876016 9487232
12:11:34 25206 8192000000 10361052384 10889216000 1140211232 12.218 99 33 67 0 1496099488 347264528 8623728
12:13:21 20238 8192000000 10270378848 10706837504 1133312016 12.153 99 30 56 0 1370146864 230456784 6378064
12:14:43 19267 8192000000 10154302064 10630823936 1098990864 11.828 97 19 38 0 1282650544 179040784 4618896
12:16:05 2390 8192000000 10118506496 10598998016 1117253712 12.001 100 73 148 0 1218908880 84454880 17200288
12:17:10 692 8192000000 10155697152 10617540608 1131772304 12.138 100 83 158 0 1259433984 108308272 19353408
12:18:17 118430 8192000000 10176815088 10631831552 1136651424 12.184 100 35 69 0 1262201568 117649488 7900656
12:21:18 30380 8192000000 10244482064 10671087616 1152950544 12.337 100 51 97 2 1322176992 158493424 10733024
12:22:56 79609 8192000000 10213267888 10683711488 1134987760 12.168 99 17 32 1 1284738832 146158272 3592800
12:25:17 84187 8192000000 10246874272 10735886336 1138799136 12.204 100 34 67 0 1378388464 231322544 8266784
12:27:45 120282 8192000000 10102807328 10552041472 1116800592 11.997 98 19 33 0 1204220720 83432032 3988096
12:31:11 40794 8192000000 10118021488 10600943616 1124456448 12.069 99 23 47 0 1215012800 84992544 5563808
12:32:58 125138 8192000000 10144638880 10614677504 1143383392 12.247 100 38 77 1 1227866816 75356656 9126768
12:36:04 33525 8192000000 10119602336 10604535808 1141035600 12.225 99 25 48 2 1213754784 67635648 5083536
12:37:45 19985 8192000000 10136193056 10572861440 1148761664 12.298 99 50 101 2 1223556352 63561440 11233248
12:39:07 63742 8192000000 10144867248 10642313216 1158465824 12.389 100 14 28 0 1247758464 86593472 2699168
12:41:12 51330 8192000000 10086894560 10574557184 1156171680 12.367 100 19 30 0 1220364960 62400528 1792752
12:43:08 85448 8192000000 10139742192 10612486144 1146139728 12.273 98 28 50 1 1213139184 61816240 5183216
12:45:35 67604 8192000000 10087242592 10557308928 1126484544 12.088 97 9 18 0 1171611024 43501680 1624800
12:48:10 116057 8192000000 10080826016 10516754432 1050245552 11.363 90 32 64 0 1096885840 39808496 6831792
12:51:12 63273 8192000000 10170676368 10652962816 1153873840 12.346 100 40 80 0 1267318000 104982016 8462144
12:53:19 69838 8192000000 10094515936 10535067648 1133844176 12.158 98 22 43 0 1180906000 42654112 4407712
12:55:33 88937 8192000000 10123772160 10587738112 1135500656 12.173 99 21 42 0 1179330464 39875296 3954512
13:00:08 86161 8192000000 10121687664 10570493952 1140479104 12.220 99 18 35 0 1192458624 48488224 3491296
13:02:34 57003 8192000000 10120290816 10647977984 1135840816 12.176 100 19 38 1 1229609504 89980672 3788016
13:05:48 53060 8192000000 10068212496 10506936320 1125141264 12.076 100 18 35 0 1176473136 47791184 3540688
13:07:42 56941 8192000000 10061945312 10524934144 1124172416 12.066 99 13 26 0 1168813088 42084032 2556640
13:09:40 63891 8192000000 10078330944 10576142336 1137566144 12.193 100 10 18 0 1206418144 67245680 1606320
13:11:44 34604 8192000000 10054518464 10477113344 1095298576 11.793 96 26 49 0 1121683584 21163824 5221184
13:13:19 50987 8192000000 10062034352 10508537856 1084447472 11.690 96 15 30 0 1128364320 41100992 2815856
13:15:10 43657 8192000000 10135491616 10597007360 1136939248 12.187 99 26 50 0 1237846208 95314144 5592816
13:16:54 51387 8192000000 10174638288 10622877696 1104550896 11.881 96 29 58 0 1240658320 129228080 6879344
13:18:47 51615 8192000000 10142175392 10594217984 1127121888 12.094 99 32 64 2 1253252112 118556992 7573232
13:20:41 38438 8192000000 10117828496 10549686272 1112386288 11.955 98 27 54 0 1217180624 98962368 5831968
13:22:24 63696 8192000000 10104470912 10584797184 1113061808 11.961 98 36 72 0 1214786416 94015136 7709472
13:24:34 24626 8192000000 10102778608 10547937280 1125817520 12.082 99 39 78 0 1171366656 37249136 8300000
13:26:05 88785 8192000000 10156340464 10618503168 1124647584 12.071 99 35 70 0 1272252112 140130832 7473696
13:30:00 87180 8192000000 10067992128 10531786752 1101199296 11.849 97 20 39 0 1150907120 45751040 3956784
13:32:27 120837 8192000000 10057951344 10525388800 1107630048 11.910 98 8 16 0 1150557776 41340800 1586928
13:35:29 39403 8192000000 10070769712 10533888000 1138073472 12.197 100 18 34 0 1173085824 31626304 3386048
13:37:08 22831 8192000000 9239293984 9566367744 376816416 4.397 33 3 6 0 407580320 30416736 347168

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 29-06-2022 13:39:54 to 29-06-2022 13:40:10.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 94 v_add_invoice_to_stock 335544517
except 6 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 29-06-2022 13:40:11 to 29-06-2022 13:40:13.

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          203457
MON$OLDEST_ACTIVE               203993
MON$OLDEST_SNAPSHOT             203993
MON$NEXT_TRANSACTION            203993
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                       2108864
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             749
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

29.06.22 13:40:14. 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-06-29 13:40:16 No severe PSQL-related problems occured
29.06.22 13:40:18. End of report.