Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 18.01.2023 10: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 15094732 kB
MemAvailable 30380340 kB
Buffers 0 kB
Cached 16599384 kB
SwapCached 2524 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-18 10:37:24
DTS_END                         2023-01-18 10:37:24.0770
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_CANCEL_SUPPLIER_ORDER(116:18) ==> SP_CANCEL_CUSTOMER_RESERVE(36:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/59838
TRN_ID                          213270
ATT_ID                          597
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: 9016.52 25149 1081982
customer order: creation 161.56 496 19387
customer order: refuse 13.75 381 1650
order to supplier: creation 42.63 1354 5116
order to supplier: removal 3.13 186908 375
invoice (draft): creation 44.44 3419 5333
invoice (draft): removal 50.88 1010 6105
invoice accept: apply 39.74 25613 4769
invoice accept: cancel 45.83 1208 5500
customer reserve: creation 3770.69 239 452483
customer reserve: removal 4552.83 101 546340
realization accept: apply 79.72 256 9567
realization accept: cancel 88.22 168 10586
payment from customer: creation 56.11 173 6733
payment from customer: removal 4.96 106 595
payment to supplier: creation 46.46 209 5575
payment to supplier: removal 3.45 103 414
service: total inventory turnovers 3.73 4084 448
service: total monetary turnovers 7.39 322 887
service: aggregate perf. data 0.96 15030 115
service: refresh index statistics 0.03 261799 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 18-01-2023 10:38:06 to 18-01-2023 10:38:09.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4811
TEST_TIME 2 5116
TEST_TIME 3 4200
TEST_TIME 4 4787
TEST_TIME 5 4949
TEST_TIME 6 4771
TEST_TIME 7 5046
TEST_TIME 8 5354
TEST_TIME 9 6042
TEST_TIME 10 5900
TEST_TIME 11 6359
TEST_TIME 12 6556
TEST_TIME 13 6549
TEST_TIME 14 6876
TEST_TIME 15 6919
TEST_TIME 16 6934
TEST_TIME 17 7181
TEST_TIME 18 7333
TEST_TIME 19 7599
TEST_TIME 20 7858
TEST_TIME 21 7939
TEST_TIME 22 8508
TEST_TIME 23 8578
TEST_TIME 24 8677
TEST_TIME 25 8491
TEST_TIME 26 8646
TEST_TIME 27 8989
TEST_TIME 28 9300
TEST_TIME 29 10041
TEST_TIME 30 10838
TEST_TIME 31 11070
TEST_TIME 32 11627
TEST_TIME 33 11425
TEST_TIME 34 11126
TEST_TIME 35 11059
TEST_TIME 36 11027
TEST_TIME 37 10929
TEST_TIME 38 10839
TEST_TIME 39 10737
TEST_TIME 40 10703
TEST_TIME 41 10559
TEST_TIME 42 10400
TEST_TIME 43 10260
TEST_TIME 44 10217
TEST_TIME 45 10098
TEST_TIME 46 9929
TEST_TIME 47 9862
TEST_TIME 48 9799
TEST_TIME 49 9695
TEST_TIME 50 9566
TEST_TIME 51 9514
TEST_TIME 52 9494
TEST_TIME 53 9494
TEST_TIME 54 9546
TEST_TIME 55 9480
TEST_TIME 56 9401
TEST_TIME 57 9308
TEST_TIME 58 9228
TEST_TIME 59 9128
TEST_TIME 60 9152
TEST_TIME 61 9103
TEST_TIME 62 9080
TEST_TIME 63 9091
TEST_TIME 64 9121
TEST_TIME 65 9155
TEST_TIME 66 9127
TEST_TIME 67 9230
TEST_TIME 68 9230
TEST_TIME 69 9218
TEST_TIME 70 9308
TEST_TIME 71 9251
TEST_TIME 72 9336
TEST_TIME 73 9393
TEST_TIME 74 9339
TEST_TIME 75 9348
TEST_TIME 76 9262
TEST_TIME 77 9260
TEST_TIME 78 9182
TEST_TIME 79 9165
TEST_TIME 80 9160
TEST_TIME 81 9103
TEST_TIME 82 9088
TEST_TIME 83 8999
TEST_TIME 84 8930
TEST_TIME 85 8961
TEST_TIME 86 8946
TEST_TIME 87 8966
TEST_TIME 88 8946
TEST_TIME 89 8940
TEST_TIME 90 8925
TEST_TIME 91 8952
TEST_TIME 92 8941
TEST_TIME 93 8992
TEST_TIME 94 9205
TEST_TIME 95 9186
TEST_TIME 96 9201
TEST_TIME 97 9175
TEST_TIME 98 9181
TEST_TIME 99 9207
TEST_TIME 100 9124
TEST_TIME 101 9097
TEST_TIME 102 9101
TEST_TIME 103 9040
TEST_TIME 104 8998
TEST_TIME 105 8976
TEST_TIME 106 8916
TEST_TIME 107 8906
TEST_TIME 108 8868
TEST_TIME 109 8911
TEST_TIME 110 8945
TEST_TIME 111 8908
TEST_TIME 112 8894
TEST_TIME 113 8894
TEST_TIME 114 8880
TEST_TIME 115 8867
TEST_TIME 116 8873
TEST_TIME 117 8872
TEST_TIME 118 8898
TEST_TIME 119 9018
TEST_TIME 120 9040

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 18-01-2023 10:38:10 to 18-01-2023 10:38:13.

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 1497206 1497206 0 0.00 0 22848 13 0 0
doc_list_biud 1497203 1497203 0 0.00 0 71555 42 0 0
sp_add_invoice_to_stock 4916 4769 147 2.99 65 224033 25613 0 147
sp_cancel_adding_invoice 5500 5500 0 0.00 5 91707 1208 0 0
sp_cancel_client_order 1650 1650 0 0.00 5 10331 381 0 0
sp_cancel_customer_reserve 546340 546340 0 0.00 1 24916 102 0 0
sp_cancel_pay_from_customer 595 595 0 0.00 4 2514 107 0 0
sp_cancel_pay_to_supplier 414 414 0 0.00 4 1241 104 0 0
sp_cancel_supplier_invoice 6109 6105 4 0.06 3 71697 1011 0 4
sp_cancel_supplier_order 375 375 0 0.00 10 1239516 186908 0 0
sp_cancel_write_off 10586 10586 0 0.00 2 13626 169 0 0
sp_client_order 19387 19387 0 0.00 5 67977 497 0 0
sp_customer_reserve 452483 452483 0 0.00 0 67888 239 0 0
sp_fill_shopping_cart 29822 29822 0 0.00 1 41861 88 0 0
sp_fill_shopping_cart_clo_res 452456 452456 0 0.00 0 18733 20 0 0
sp_get_clo_for_invoice 4734 4734 0 0.00 0 31483 366 0 0
sp_kill_cost_storno 17095 17095 0 0.00 0 18142 68 0 0
sp_kill_qstorno_ret_qs2qd 1109746 1109746 0 0.00 0 71530 44 0 0
sp_kill_qty_storno 584856 584856 0 0.00 0 71547 100 0 0
sp_lock_selected_doc 19752 19752 0 0.00 0 6154 6 0 0
sp_make_cost_storno 26608 26608 0 0.00 0 17013 84 0 0
sp_multiply_rows_for_pdistr 26608 26608 0 0.00 0 12175 36 0 0
sp_multiply_rows_for_qdistr 19387 19387 0 0.00 0 37773 187 0 0
sp_pay_from_customer 6733 6733 0 0.00 5 14492 173 0 0
sp_pay_to_supplier 5575 5575 0 0.00 6 20468 210 0 0
sp_payment_common 12308 12308 0 0.00 2 14091 49 0 0
sp_qd_handle_on_cancel_clo 1650 1650 0 0.00 0 8682 304 0 0
sp_qd_handle_on_invoice_upd_sts 10233 10233 0 0.00 0 13240 509 0 0
sp_qd_handle_on_reserve_upd_sts 9567 9567 0 0.00 0 9124 57 0 0
sp_reserve_write_off 9567 9567 0 0.00 8 14083 256 0 0
sp_supplier_invoice 5333 5333 0 0.00 9 97747 3419 0 0
sp_supplier_order 5116 5116 0 0.00 7 44906 1355 0 0
srv_aggregate_perf_data 115 115 0 0.00 2259 165732 15031 0 0
srv_fill_mon_cache_memory 69 69 0 0.00 734 109395 36471 0 0
srv_find_qd_qs_mism 1034381 1034381 0 0.00 0 22841 10 0 0
srv_make_invnt_saldo 448 448 0 0.00 50 84738 4085 0 0
srv_make_money_saldo 887 887 0 0.00 1 19571 323 0 0
srv_recalc_idx_stat 4 4 0 0.00 119725 352311 261800 0 0
t$perf-abend:sp_add_invoice_to_stock 147 147 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 4 4 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4775 4775 0 0.00 1 13253 929 0 0
t$perf-norm:sp_cancel_adding_invoice 388 388 0 0.00 1 14680 497 0 0
t$perf-norm:sp_cancel_client_order 1650 1650 0 0.00 0 3871 24 0 0
t$perf-norm:sp_cancel_customer_reserve 677 677 0 0.00 0 4070 41 0 0
t$perf-norm:sp_cancel_pay_from_customer 595 595 0 0.00 0 575 13 0 0
t$perf-norm:sp_cancel_pay_to_supplier 414 414 0 0.00 0 1665 26 0 0
t$perf-norm:sp_cancel_supplier_invoice 403 403 0 0.00 0 1668 36 0 0
t$perf-norm:sp_cancel_supplier_order 375 375 0 0.00 0 101200 7446 0 0
t$perf-norm:sp_cancel_write_off 956 956 0 0.00 0 1523 18 0 0
t$perf-norm:sp_client_order 19387 19387 0 0.00 0 6470 36 0 0
t$perf-norm:sp_customer_reserve 948 948 0 0.00 0 4563 31 0 0
t$perf-norm:sp_pay_from_customer 6733 6733 0 0.00 0 13882 26 0 0
t$perf-norm:sp_pay_to_supplier 5575 5575 0 0.00 0 2178 17 0 0
t$perf-norm:sp_reserve_write_off 9567 9567 0 0.00 0 5093 23 0 0
t$perf-norm:sp_supplier_invoice 5333 5333 0 0.00 0 4751 30 0 0
t$perf-norm:sp_supplier_order 5116 5116 0 0.00 0 4127 30 0 0
t$perf-norm:srv_aggregate_perf_data 115 115 0 0.00 0 676 19 0 0
t$perf-norm:srv_fill_mon_cache_memory 69 69 0 0.00 0 555 11 0 0
t$perf-norm:srv_make_invnt_saldo 448 448 0 0.00 0 6090 24 0 0
t$perf-norm:srv_make_money_saldo 887 887 0 0.00 0 3886 9 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 249 86 0 0
v_add_invoice_to_stock 9748 9454 294 3.01 0 5554 27 0 294
v_all_customers 35512 35512 0 0.00 0 95 4 0 0
v_all_suppliers 29186 29186 0 0.00 0 74 4 0 0
v_all_wares 38774 38774 0 0.00 0 56 4 0 0
v_cancel_adding_invoice 776 776 0 0.00 0 1248 16 0 0
v_cancel_client_order 3300 3300 0 0.00 0 1287 10 0 0
v_cancel_customer_prepayment 1190 1190 0 0.00 0 1255 11 0 0
v_cancel_customer_reserve 1354 1354 0 0.00 0 771 10 0 0
v_cancel_payment_to_supplier 828 828 0 0.00 0 959 12 0 0
v_cancel_supplier_invoice 814 806 8 0.98 0 1048 25 0 8
v_cancel_supplier_order 750 750 0 0.00 0 897 11 0 0
v_cancel_write_off 1912 1912 0 0.00 0 950 22 0 0
v_max_id_clo_ord 5111 5111 0 0.00 0 2149 5 0 0
v_max_id_clo_res 948 948 0 0.00 0 3721 18 0 0
v_max_id_ord_sup 5323 5323 0 0.00 0 5313 7 0 0
v_max_non_paid_invoice 1416 1416 0 0.00 0 60 7 0 0
v_max_non_paid_realizn 3397 3397 0 0.00 0 1694 7 0 0
v_min_id_clo_ord 5111 5111 0 0.00 0 5164 10 0 0
v_min_id_clo_res 948 948 0 0.00 0 2461 10 0 0
v_min_id_ord_sup 5323 5323 0 0.00 0 6349 12 0 0
v_min_non_paid_invoice 5575 5575 0 0.00 0 10943 21 0 0
v_min_non_paid_realizn 6733 6733 0 0.00 0 11755 21 0 0
v_our_firm 9934 9934 0 0.00 0 181 4 0 0
v_reserve_write_off 19134 19134 0 0.00 0 6939 10 0 0
x_lock_depdocs_on_canc_invoice 11202 11202 0 0.00 0 10836 117 0 0
x_lock_depdocs_on_canc_sup_ord 375 375 0 0.00 0 5464 368 0 0
x_make_qstorno_1000_1200 5116 5116 0 0.00 2 44490 1198 0 0
x_make_qstorno_1200_2000 5333 5333 0 0.00 4 97618 3157 0 0
x_make_qstorno_2100_3300 452482 452482 0 0.00 0 67884 208 0 0

Completed "Performance in DETAILS". Done for 00:00:05, from 18-01-2023 10:38:14 to 18-01-2023 10:38:19.

Memory consumption, metadata cache, attachments activity

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


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

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
08:07:28 927 8192000000 8926168944 8981557248 12042672 0.146 4 2 4 0 12473728 141840 289216
08:08:29 23301 8192000000 9719126576 10017972224 798084176 8.877 100 88 176 0 826951856 7564208 21303472
08:09:55 16331 8192000000 9767732688 10074595328 840354896 9.303 100 91 180 0 873243552 11192432 21696224
08:11:16 14432 8192000000 9793687888 10112745472 864143104 9.542 100 83 166 0 901012912 17472608 19397200
08:12:33 10050 8192000000 9856438224 10183852032 911384272 10.011 100 82 162 0 954662112 25813392 17464448
08:13:47 9032 8192000000 9904322736 10249424896 951256768 10.403 100 78 157 0 1018491376 50951600 16283008
08:15:00 3053 8192000000 9968074368 10320105472 984160928 10.725 100 91 178 0 1085065968 82866944 18038096
08:16:05 1006 8192000000 9975043968 10332663808 1012915520 11.004 100 92 174 1 1094861008 64623280 17322208
08:17:08 1182 8192000000 10010099008 10377162752 1039630256 11.261 100 93 174 1 1128793600 70699248 18464096
08:18:11 1018 8192000000 10022743136 10402652160 1052554832 11.385 100 93 179 2 1142665552 71912064 18198656
08:19:13 14449 8192000000 10024864672 10401091584 1068826448 11.541 100 92 165 0 1151755104 66623696 16304960
08:20:29 1067 8192000000 10070596096 10452185088 1077720432 11.626 100 96 181 2 1191389280 95420960 18247888
08:21:31 1161 8192000000 10049197728 10429997056 1082082352 11.667 100 88 173 0 1163474912 65398800 15993760
08:22:33 1035 8192000000 10056561552 10441752576 1088539824 11.729 100 95 181 1 1175340992 68512016 18289152
08:23:35 1069 8192000000 10069582416 10462593024 1087980640 11.723 100 95 174 0 1194231056 88641744 17608672
08:24:37 1122 8192000000 10053751568 10446045184 1099878224 11.836 100 82 152 1 1180791424 65536976 15376224
08:25:39 1088 8192000000 10082049392 10476199936 1099009648 11.828 100 88 173 1 1205016816 88839840 17167328
08:26:41 816 8192000000 10043288560 10434891776 1100646032 11.844 100 87 161 2 1162454208 45905600 15902576
08:27:43 1402 8192000000 10068152848 10459398144 1099251808 11.831 100 88 160 1 1197557968 80187904 18118256
08:28:45 6678 8192000000 10065324320 10453536768 1099024208 11.828 100 74 141 1 1167825024 54239360 14561456
08:29:52 914 8192000000 10020573568 10408173568 1066831872 11.522 100 91 168 1 1144465936 58432000 19202064
08:30:54 4427 8192000000 10015898384 10414174208 1085897856 11.704 100 50 100 0 1145221504 49512768 9810880
08:32:06 3517 8192000000 10021342768 10405625856 1073651760 11.587 100 68 135 1 1147766432 61484528 12630144
08:33:10 1005 8192000000 10032666640 10404696064 1052442384 11.384 100 93 184 0 1154506208 83294864 18768960
08:34:13 7771 8192000000 9998967024 10376249344 1040912528 11.273 99 52 97 0 1113644848 63325024 9407296
08:35:22 11186 8192000000 9942893424 10323537920 1014224480 11.016 97 45 87 0 1056062336 32368240 9469616
08:36:34 8302 8192000000 9967706560 10355707904 1026541072 11.135 98 45 89 0 1103193424 68291104 8361248
08:37:49 40025 8192000000 10008502656 10393858048 1054639520 11.405 100 63 126 2 1130402320 62898304 12864496
08:39:39 2100 8192000000 10027390560 10413023232 1077295696 11.622 100 63 119 2 1146473312 56732544 12445072
08:40:45 19422 8192000000 10118822672 10513551360 1102163184 11.858 100 69 129 0 1231237040 115080144 13993712
08:42:18 1744 8192000000 10119943104 10511192064 1112465520 11.956 100 63 118 2 1238697136 113060208 13171408
08:43:27 2773 8192000000 10161092176 10553307136 1122795744 12.053 100 79 155 0 1279119648 138953616 17370288
08:44:33 2758 8192000000 10205154576 10605510656 1137785888 12.195 100 89 171 2 1324222128 167888320 18547920
08:45:39 1562 8192000000 10266040352 10663366656 1151201536 12.321 100 91 176 2 1380848800 209654672 19992592
08:46:44 1873 8192000000 10246882272 10648215552 1154027280 12.347 100 87 168 1 1359379680 186292640 19059760
08:47:49 2590 8192000000 10315483088 10712219648 1173610240 12.531 100 89 171 3 1419264864 227479888 18174736
08:48:54 890 8192000000 10338644704 10740228096 1186519280 12.651 100 92 181 0 1452965088 245963184 20482624
08:49:59 1395 8192000000 10370965920 10776936448 1193025168 12.712 100 89 167 0 1484965152 273290240 18649744
08:51:03 1671 8192000000 10423373872 10845712384 1206875888 12.840 100 95 184 1 1531972848 304254736 20842224
08:52:07 897 8192000000 10438542400 10842210304 1208722640 12.857 100 100 194 2 1546995728 315421680 22851408
08:53:11 1443 8192000000 10511473680 10919440384 1213725584 12.904 100 95 186 2 1620674880 385153168 21796128
08:54:15 1120 8192000000 10547150304 10970779648 1215113968 12.916 100 98 192 1 1654984704 416521440 23349296
08:55:18 886 8192000000 10585561360 11019501568 1222111168 12.981 100 96 188 2 1693831792 449333840 22386784
08:56:21 895 8192000000 10555687024 11016065024 1217832736 12.942 100 95 187 0 1660463216 420685328 21945152
08:57:24 980 8192000000 10594981600 11051593728 1223199408 12.991 100 99 197 0 1701294496 453767408 24327680
08:58:27 1353 8192000000 10581518000 11044446208 1207335856 12.844 99 96 190 0 1681167696 450297728 23534112
08:59:29 4606 8192000000 10587978496 11050913792 1190554128 12.689 99 63 126 0 1691170032 484538144 16077760
09:00:37 6779 8192000000 10619506432 11075067904 1200668880 12.783 100 54 102 0 1727668384 513359776 13639728
09:02:05 6839 8192000000 10659893792 11114954752 1200778528 12.784 100 41 82 0 1763217840 551458864 10980448
09:03:14 12064 8192000000 10708165360 11181309952 1180900416 12.599 99 41 83 0 1804047456 611839648 11307392
09:05:06 11968 8192000000 10613174304 11119075328 1173836480 12.533 100 32 64 0 1740346880 557485664 9024736
09:06:46 25344 8192000000 10400992992 10939068416 1151488992 12.323 99 26 52 0 1547509856 389608976 6411888
09:08:24 12931 8192000000 10200761296 10727993344 1157936128 12.384 100 33 62 1 1353259184 188059440 7263616
09:09:39 60046 8192000000 10122582832 10567639040 1119930016 12.026 97 20 40 0 1213108464 88852848 4325600
09:11:56 21762 8192000000 10161535440 10619371520 1146927984 12.281 100 51 96 1 1259484320 102793344 9762992
09:14:33 63050 8192000000 10119768128 10599694336 1133035952 12.150 98 13 25 0 1230525312 94622048 2867312
09:16:50 101555 8192000000 10047030752 10513739776 1066477088 11.518 93 14 24 0 1105374320 36653776 2243456
09:20:22 93067 8192000000 10100190064 10560458752 1120955648 12.036 99 23 46 0 1177650864 52037184 4658032
09:23:32 32821 8192000000 10054460064 10486300672 1109628896 11.929 98 55 110 0 1143952896 22595456 11728544
09:25:08 61289 8192000000 10094496880 10550263808 1145774832 12.270 100 22 42 0 1196004480 45667392 4562256
09:27:10 30935 8192000000 10126647552 10582827008 1156106672 12.367 100 23 46 0 1226145376 65121584 4917120
09:28:45 48128 8192000000 10145893568 10607132672 1124046688 12.065 98 40 80 0 1224199648 91285168 8867792
09:30:43 11808 8192000000 10123101104 10592968704 1135457856 12.173 100 44 85 0 1231894384 86608848 9827680
09:31:58 86913 8192000000 10050242448 10507685888 1064429408 11.499 93 24 48 1 1116614368 46951360 5233600
09:34:25 74656 8192000000 10052272672 10525302784 1126842768 12.092 100 19 38 0 1153499168 22847312 3809088
09:36:46 725 8192000000 10066070768 10497548288 1135614848 12.174 100 91 174 1 1177070528 22257488 19198192
09:37:48 78155 8192000000 10061963744 10524524544 1119468976 12.022 98 15 30 0 1160657664 38164736 3023952
09:40:08 73427 8192000000 10134898128 10596229120 1135442032 12.173 98 23 46 0 1216694800 76689152 4563616
09:42:23 50540 8192000000 10132895520 10585296896 1148161936 12.292 99 20 40 1 1202048752 49589472 4297344
09:44:13 63483 8192000000 10124277856 10586075136 1136823840 12.186 99 19 38 1 1230438880 89195216 4419824
09:46:19 37100 8192000000 10125961680 10560339968 1099976608 11.837 97 38 70 1 1181420000 74513024 6930368
09:48:00 33751 8192000000 10111997920 10550140928 1117234704 12.001 98 35 71 0 1197843536 73381536 7227296
09:49:34 44085 8192000000 10117282000 10582605824 1099698640 11.835 97 39 78 0 1175084080 67736512 7648928
09:51:20 42280 8192000000 10108514384 10547474432 1106987984 11.904 98 31 62 0 1144380896 31093440 6299472
09:53:04 107002 8192000000 10041780576 10464174080 1061834848 11.474 94 27 48 1 1100931248 32234400 6862000
09:55:52 15154 8192000000 10080637712 10509484032 1113673088 11.967 100 47 91 1 1177187504 54181648 9332768
09:57:08 58248 8192000000 10029385520 10491908096 1097689184 11.816 98 13 26 1 1146152784 45376432 3087168
09:59:19 86950 8192000000 10057768320 10509844480 1091663856 11.758 97 21 43 0 1137873184 41562288 4647040
10:01:53 47455 8192000000 10076003152 10570039296 1115401488 11.984 99 14 28 0 1217515968 98827184 3287296
10:03:41 52096 8192000000 10063391808 10500808704 1113390096 11.965 99 35 69 1 1182841504 61933008 7518400
10:05:33 17460 8192000000 10129833312 10556694528 1119092144 12.018 99 46 92 0 1199430336 70808816 9529376
10:06:53 16662 8192000000 10174209856 10600157184 1135657184 12.175 99 46 92 0 1257107376 112005408 9444784
10:08:10 55315 8192000000 10209939456 10665754624 1151667216 12.325 100 23 46 0 1318877072 161902304 5307552
10:10:06 65253 8192000000 10179679536 10649018368 1115439056 11.984 97 13 26 0 1268368960 149716464 3213440
10:12:20 49102 8192000000 10091744848 10530476032 1105194896 11.887 97 26 52 0 1160872304 50550736 5126672
10:14:09 37143 8192000000 10091382800 10524999680 1107369152 11.908 97 38 73 2 1169223024 54116496 7737376
10:16:41 109393 8192000000 10091628384 10528878592 1120167216 12.029 99 31 61 1 1186829984 59670128 6992640
10:19:31 73111 8192000000 10083211952 10570182656 1133668864 12.156 100 12 24 0 1182231216 46005584 2556768
10:22:14 74391 8192000000 10085483792 10537213952 1137553376 12.193 100 18 34 1 1192261168 50660976 4046816
10:24:42 78853 8192000000 10145325104 10618875904 1140071952 12.216 99 14 28 0 1231640848 88507392 3061504
10:27:06 100764 8192000000 10087925056 10562777088 1117519776 12.004 97 11 22 0 1188197600 68498608 2179216
10:29:55 51507 8192000000 10122096768 10583207936 1113320928 11.964 97 31 62 0 1202065728 82244480 6500320
10:31:54 48861 8192000000 10195761952 10637455360 1113145504 11.962 97 35 70 0 1246457632 125930048 7382080
10:33:50 21497 8192000000 10217754848 10664968192 1155095840 12.357 100 43 85 0 1315635008 150837632 9701536
10:35:16 38606 8192000000 10242457408 10736349184 1151258800 12.321 100 19 38 0 1328009808 172460816 4290192
10:36:56 34977 8192000000 8934827952 9133625344 97786864 1.179 9 2 4 0 104201776 6101248 313664

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 18-01-2023 10:38:21 to 18-01-2023 10:38:37.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 147 v_add_invoice_to_stock 335544517
except 4 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 18-01-2023 10:38:38 to 18-01-2023 10:38:40.

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          213856
MON$OLDEST_ACTIVE               213857
MON$OLDEST_SNAPSHOT             213857
MON$NEXT_TRANSACTION            213857
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                       2058400
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                                                                                                                                                                                      
MON$SEC_DATABASE                Default
MON$CRYPT_STATE                 0
MON$GUID                        {58978C10-B735-40F5-8B7D-F7A1956E782B}
MON$FILE_ID                     02fd0000000000002e02000000000000
MON$NEXT_ATTACHMENT             763
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

18.01.23 10:38:41. 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-18 10:38:43 No severe PSQL-related problems occured
18.01.23 10:38:45. End of report.