Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 26.06.2022 07: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 16127512 kB
MemAvailable 31234188 kB
Buffers 0 kB
Cached 15612272 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-26 07:37:15
DTS_END                         2022-06-26 07:37:15.5310
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_ADD_INVOICE_TO_STOCK(190:30) ==> SP_CUSTOMER_RESERVE(47:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/48100
TRN_ID                          209448
ATT_ID                          654
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: 8610.99 26539 1033319
customer order: creation 162.12 489 19454
customer order: refuse 13.35 461 1602
order to supplier: creation 43.46 1459 5215
order to supplier: removal 3.11 190306 373
invoice (draft): creation 43.99 3505 5279
invoice (draft): removal 49.00 1009 5880
invoice accept: apply 39.03 27896 4684
invoice accept: cancel 44.53 1419 5343
customer reserve: creation 3605.18 265 432622
customer reserve: removal 4322.27 108 518673
realization accept: apply 77.18 292 9262
realization accept: cancel 86.88 171 10426
payment from customer: creation 55.00 189 6600
payment from customer: removal 5.44 135 653
payment to supplier: creation 45.63 220 5475
payment to supplier: removal 2.93 136 351
service: total inventory turnovers 3.79 4647 455
service: total monetary turnovers 7.22 425 866
service: aggregate perf. data 0.85 16589 102
service: refresh index statistics 0.03 281068 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 26-06-2022 07:38:52 to 26-06-2022 07:38:54.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5872
TEST_TIME 2 5779
TEST_TIME 3 6280
TEST_TIME 4 6467
TEST_TIME 5 5961
TEST_TIME 6 5594
TEST_TIME 7 5596
TEST_TIME 8 5523
TEST_TIME 9 5871
TEST_TIME 10 6148
TEST_TIME 11 6279
TEST_TIME 12 6482
TEST_TIME 13 6647
TEST_TIME 14 6875
TEST_TIME 15 7011
TEST_TIME 16 7135
TEST_TIME 17 7265
TEST_TIME 18 7247
TEST_TIME 19 7462
TEST_TIME 20 7708
TEST_TIME 21 7673
TEST_TIME 22 7925
TEST_TIME 23 8035
TEST_TIME 24 8022
TEST_TIME 25 8050
TEST_TIME 26 8080
TEST_TIME 27 8449
TEST_TIME 28 8832
TEST_TIME 29 8852
TEST_TIME 30 8947
TEST_TIME 31 9255
TEST_TIME 32 9740
TEST_TIME 33 10080
TEST_TIME 34 10295
TEST_TIME 35 10742
TEST_TIME 36 10698
TEST_TIME 37 10510
TEST_TIME 38 10380
TEST_TIME 39 10140
TEST_TIME 40 10122
TEST_TIME 41 10016
TEST_TIME 42 9861
TEST_TIME 43 9881
TEST_TIME 44 9753
TEST_TIME 45 9705
TEST_TIME 46 9599
TEST_TIME 47 9484
TEST_TIME 48 9459
TEST_TIME 49 9361
TEST_TIME 50 9237
TEST_TIME 51 9091
TEST_TIME 52 9059
TEST_TIME 53 9004
TEST_TIME 54 9060
TEST_TIME 55 9043
TEST_TIME 56 9019
TEST_TIME 57 8921
TEST_TIME 58 8890
TEST_TIME 59 8996
TEST_TIME 60 8956
TEST_TIME 61 8949
TEST_TIME 62 8963
TEST_TIME 63 9033
TEST_TIME 64 9004
TEST_TIME 65 9048
TEST_TIME 66 9037
TEST_TIME 67 9136
TEST_TIME 68 9081
TEST_TIME 69 8991
TEST_TIME 70 8984
TEST_TIME 71 8952
TEST_TIME 72 8940
TEST_TIME 73 8871
TEST_TIME 74 8812
TEST_TIME 75 8741
TEST_TIME 76 8712
TEST_TIME 77 8806
TEST_TIME 78 8738
TEST_TIME 79 8728
TEST_TIME 80 8702
TEST_TIME 81 8680
TEST_TIME 82 8659
TEST_TIME 83 8647
TEST_TIME 84 8626
TEST_TIME 85 8644
TEST_TIME 86 8738
TEST_TIME 87 8681
TEST_TIME 88 8911
TEST_TIME 89 8998
TEST_TIME 90 9033
TEST_TIME 91 8983
TEST_TIME 92 8952
TEST_TIME 93 8878
TEST_TIME 94 8870
TEST_TIME 95 8803
TEST_TIME 96 8814
TEST_TIME 97 8762
TEST_TIME 98 8759
TEST_TIME 99 8724
TEST_TIME 100 8739
TEST_TIME 101 8730
TEST_TIME 102 8745
TEST_TIME 103 8696
TEST_TIME 104 8777
TEST_TIME 105 8750
TEST_TIME 106 8733
TEST_TIME 107 8896
TEST_TIME 108 8883
TEST_TIME 109 8863
TEST_TIME 110 8859
TEST_TIME 111 8820
TEST_TIME 112 8783
TEST_TIME 113 8766
TEST_TIME 114 8753
TEST_TIME 115 8725
TEST_TIME 116 8707
TEST_TIME 117 8687
TEST_TIME 118 8635
TEST_TIME 119 8671
TEST_TIME 120 8634

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 26-06-2022 07:38:56 to 26-06-2022 07:38:59.

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 1431434 1431434 0 0.00 0 28427 15 0 0
doc_list_biud 1431416 1431416 0 0.00 0 38452 45 0 0
sp_add_invoice_to_stock 4749 4684 65 1.36 87 210035 27897 0 65
sp_cancel_adding_invoice 5343 5343 0 0.00 6 75423 1420 0 0
sp_cancel_client_order 1602 1602 0 0.00 5 8826 461 0 0
sp_cancel_customer_reserve 518673 518673 0 0.00 1 38465 108 0 0
sp_cancel_pay_from_customer 653 653 0 0.00 4 6591 135 0 0
sp_cancel_pay_to_supplier 351 351 0 0.00 4 3854 136 0 0
sp_cancel_supplier_invoice 5890 5880 10 0.16 3 21916 1009 0 10
sp_cancel_supplier_order 373 373 0 0.00 32 1587016 190307 0 0
sp_cancel_write_off 10426 10426 0 0.00 2 28429 171 0 0
sp_client_order 19454 19454 0 0.00 5 23436 489 0 0
sp_customer_reserve 432622 432622 0 0.00 0 57345 266 0 0
sp_fill_shopping_cart 29926 29926 0 0.00 1 16490 94 0 0
sp_fill_shopping_cart_clo_res 432583 432583 0 0.00 0 16225 20 0 0
sp_get_clo_for_invoice 4636 4636 0 0.00 0 17108 279 0 0
sp_kill_cost_storno 16773 16773 0 0.00 0 28427 78 0 0
sp_kill_qstorno_ret_qs2qd 1054025 1054025 0 0.00 0 31680 47 0 0
sp_kill_qty_storno 556194 556194 0 0.00 0 38451 108 0 0
sp_lock_selected_doc 19208 19208 0 0.00 0 8433 8 0 0
sp_make_cost_storno 25973 25973 0 0.00 0 13510 89 0 0
sp_multiply_rows_for_pdistr 25972 25972 0 0.00 0 9751 39 0 0
sp_multiply_rows_for_qdistr 19452 19452 0 0.00 0 14051 185 0 0
sp_pay_from_customer 6600 6600 0 0.00 5 17059 189 0 0
sp_pay_to_supplier 5475 5475 0 0.00 6 17177 221 0 0
sp_payment_common 12074 12074 0 0.00 2 17002 47 0 0
sp_qd_handle_on_cancel_clo 1602 1602 0 0.00 0 7454 377 0 0
sp_qd_handle_on_invoice_upd_sts 9978 9978 0 0.00 0 37729 597 0 0
sp_qd_handle_on_reserve_upd_sts 9262 9262 0 0.00 0 19641 67 0 0
sp_reserve_write_off 9262 9262 0 0.00 8 19703 292 0 0
sp_supplier_invoice 5279 5279 0 0.00 10 114257 3506 0 0
sp_supplier_order 5215 5215 0 0.00 7 61983 1460 0 0
srv_aggregate_perf_data 102 102 0 0.00 2569 238759 16589 0 0
srv_fill_mon_cache_memory 71 71 0 0.00 793 139673 32565 0 0
srv_find_qd_qs_mism 987292 987292 0 0.00 0 25226 12 0 0
srv_make_invnt_saldo 455 455 0 0.00 51 109994 4647 0 0
srv_make_money_saldo 866 866 0 0.00 1 13219 426 0 0
srv_recalc_idx_stat 4 4 0 0.00 107998 497256 281068 0 0
t$perf-abend:sp_add_invoice_to_stock 65 65 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 10 10 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4684 4684 0 0.00 1 18367 1080 0 0
t$perf-norm:sp_cancel_adding_invoice 408 408 0 0.00 1 8276 528 0 0
t$perf-norm:sp_cancel_client_order 1602 1602 0 0.00 0 2723 26 0 0
t$perf-norm:sp_cancel_customer_reserve 640 640 0 0.00 0 2422 34 0 0
t$perf-norm:sp_cancel_pay_from_customer 653 653 0 0.00 0 1863 21 0 0
t$perf-norm:sp_cancel_pay_to_supplier 351 351 0 0.00 0 214 10 0 0
t$perf-norm:sp_cancel_supplier_invoice 369 369 0 0.00 0 2049 37 0 0
t$perf-norm:sp_cancel_supplier_order 373 373 0 0.00 0 113941 7865 0 0
t$perf-norm:sp_cancel_write_off 918 918 0 0.00 0 6328 30 0 0
t$perf-norm:sp_client_order 19454 19454 0 0.00 0 13593 42 0 0
t$perf-norm:sp_customer_reserve 907 907 0 0.00 0 1244 15 0 0
t$perf-norm:sp_pay_from_customer 6600 6600 0 0.00 0 9668 23 0 0
t$perf-norm:sp_pay_to_supplier 5475 5475 0 0.00 0 9606 26 0 0
t$perf-norm:sp_reserve_write_off 9262 9262 0 0.00 0 9420 27 0 0
t$perf-norm:sp_supplier_invoice 5279 5279 0 0.00 0 7637 36 0 0
t$perf-norm:sp_supplier_order 5215 5215 0 0.00 0 3698 33 0 0
t$perf-norm:srv_aggregate_perf_data 102 102 0 0.00 0 519 21 0 0
t$perf-norm:srv_fill_mon_cache_memory 71 71 0 0.00 0 471 20 0 0
t$perf-norm:srv_make_invnt_saldo 455 455 0 0.00 0 1224 18 0 0
t$perf-norm:srv_make_money_saldo 866 866 0 0.00 0 8630 20 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 4 51 23 0 0
v_add_invoice_to_stock 9396 9266 130 1.38 0 6686 26 0 130
v_all_customers 35352 35352 0 0.00 0 82 4 0 0
v_all_suppliers 28942 28942 0 0.00 0 91 5 0 0
v_all_wares 38894 38894 0 0.00 0 59 4 0 0
v_cancel_adding_invoice 816 816 0 0.00 0 1571 17 0 0
v_cancel_client_order 3204 3204 0 0.00 0 3846 12 0 0
v_cancel_customer_prepayment 1306 1306 0 0.00 0 6521 17 0 0
v_cancel_customer_reserve 1280 1280 0 0.00 1 1355 12 0 0
v_cancel_payment_to_supplier 702 702 0 0.00 0 3783 21 0 0
v_cancel_supplier_invoice 758 738 20 2.63 0 337 22 0 20
v_cancel_supplier_order 746 746 0 0.00 0 588 14 0 0
v_cancel_write_off 1836 1836 0 0.00 0 2508 28 0 0
v_max_id_clo_ord 5209 5209 0 0.00 0 1798 6 0 0
v_max_id_clo_res 907 907 0 0.00 0 2153 21 0 0
v_max_id_ord_sup 5267 5267 0 0.00 0 1819 6 0 0
v_max_non_paid_invoice 1479 1479 0 0.00 0 543 8 0 0
v_max_non_paid_realizn 3515 3515 0 0.00 0 855 8 0 0
v_min_id_clo_ord 5208 5208 0 0.00 0 3272 10 0 0
v_min_id_clo_res 907 907 0 0.00 0 2753 14 0 0
v_min_id_ord_sup 5267 5267 0 0.00 0 5578 10 0 0
v_min_non_paid_invoice 5475 5475 0 0.00 0 5338 15 0 0
v_min_non_paid_realizn 6599 6599 0 0.00 0 16995 18 0 0
v_our_firm 9710 9710 0 0.00 0 77 5 0 0
v_reserve_write_off 18522 18522 0 0.00 0 8903 14 0 0
x_lock_depdocs_on_canc_invoice 10854 10854 0 0.00 0 18083 147 0 0
x_lock_depdocs_on_canc_sup_ord 373 373 0 0.00 0 18730 472 0 0
x_make_qstorno_1000_1200 5215 5215 0 0.00 2 61956 1277 0 0
x_make_qstorno_1200_2000 5279 5279 0 0.00 5 114215 3243 0 0
x_make_qstorno_2100_3300 432620 432620 0 0.00 0 57342 232 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 26-06-2022 07:39:00 to 26-06-2022 07:39:04.

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
05:07:19 1 8192000000 8796669104 8807108608 3189120 0.038 1 1 2 0 3286736 61840 35776
05:08:20 25143 8192000000 9723447840 10021834752 800447056 8.901 100 80 160 0 827115488 7374752 19293680
05:09:52 24204 8192000000 9755912048 10062479360 827463936 9.174 100 82 164 0 860009376 12334448 20210992
05:11:23 17998 8192000000 9785794752 10104672256 859259488 9.493 100 87 173 0 899669152 20100256 20309408
05:12:46 12783 8192000000 9854242464 10185785344 903389328 9.932 100 81 162 0 959443952 38266544 17788080
05:14:04 6432 8192000000 9901895872 10239549440 946627984 10.358 100 85 168 0 1015802720 51097824 18076912
05:15:13 2776 8192000000 9957505904 10305998848 979723968 10.682 100 89 178 0 1066463248 68560336 18178944
05:16:19 2073 8192000000 9966313216 10318979072 1006886800 10.945 100 93 171 0 1080325120 56226784 17211536
05:17:23 692 8192000000 10017140848 10380079104 1021545472 11.087 100 92 181 1 1137020624 97771952 17703200
05:18:26 1128 8192000000 10013607968 10379329536 1031557888 11.183 100 93 178 3 1131344384 81683088 18103408
05:19:28 1018 8192000000 10020433536 10399518720 1049530864 11.356 100 96 190 1 1144869456 76481536 18857056
05:20:31 1285 8192000000 10030936576 10411798528 1062612784 11.481 100 93 176 0 1151972688 71715872 17644032
05:21:33 1082 8192000000 10041173168 10420228096 1068075808 11.534 100 94 177 2 1164266912 78639344 17551760
05:22:35 989 8192000000 10055705136 10439565312 1074235856 11.593 100 94 184 1 1176735984 85438016 17062112
05:23:37 4185 8192000000 10020203280 10406137856 1076842208 11.617 100 75 138 2 1139502304 47154192 15505904
05:24:43 1049 8192000000 10052475840 10442498048 1085415392 11.699 100 95 185 3 1179828048 74508224 19904432
05:25:44 1022 8192000000 10066412512 10456788992 1090437664 11.747 100 92 182 0 1185986208 77063504 18485040
05:26:48 1032 8192000000 10075536816 10463617024 1092665088 11.768 100 89 174 2 1194736704 85748208 16323408
05:27:50 1030 8192000000 10069423744 10457804800 1090911600 11.751 100 92 179 1 1194094864 84203328 18979936
05:28:52 1448 8192000000 10068415872 10460622848 1094431520 11.785 100 78 149 1 1189311424 80101008 14778896
05:29:54 1579 8192000000 10034847024 10429407232 1089199120 11.735 100 78 151 0 1158743904 54786240 14758544
05:30:59 1046 8192000000 10078542928 10469703680 1103086592 11.867 100 94 181 0 1199308960 76783008 19439360
05:32:02 999 8192000000 10044437024 10427432960 1072067312 11.572 100 90 170 3 1166110320 75741376 18301632
05:33:04 994 8192000000 9977989984 10352074752 1034440912 11.211 100 92 169 4 1102085856 48788240 18856704
05:34:06 2553 8192000000 10002213728 10376683520 1037703824 11.243 99 79 145 1 1128336592 77051584 13581184
05:35:10 1498 8192000000 10010629856 10389864448 1052627504 11.386 100 76 145 1 1130474672 62511808 15335360
05:36:13 1103 8192000000 9989507216 10362540032 1033996480 11.207 100 91 173 0 1108343456 56906928 17440048
05:37:15 1305 8192000000 9993131840 10362732544 1043233904 11.296 100 95 179 2 1114724064 52457152 19033008
05:38:25 20704 8192000000 10016499648 10394550272 1066692448 11.520 100 77 133 2 1134405440 52768608 14944384
05:39:50 3120 8192000000 10057704992 10439864320 1088817312 11.731 100 77 148 0 1185471136 81560016 15093808
05:40:56 4850 8192000000 10088383904 10467516416 1100366128 11.841 100 87 158 2 1206025600 90323568 15335904
05:42:07 20858 8192000000 10121555136 10523021312 1116387056 11.993 100 72 139 0 1248475456 116530288 15558112
05:43:43 5766 8192000000 10179183056 10585219072 1128919296 12.111 100 66 130 0 1301756112 157340368 15496448
05:44:55 5622 8192000000 10207835200 10607140864 1132549392 12.145 100 70 133 1 1328203872 181547456 14107024
05:46:08 2801 8192000000 10246425744 10653491200 1143227888 12.246 100 83 164 0 1365174272 202729584 19216800
05:47:17 4187 8192000000 10262839824 10676027392 1145941184 12.271 100 72 144 1 1383729824 221561840 16226800
05:48:25 873 8192000000 10280127424 10684948480 1151843584 12.327 100 97 183 0 1398073600 224316864 21913152
05:49:28 972 8192000000 10316797200 10724298752 1157882176 12.383 100 89 171 1 1428206368 250772320 19551872
05:50:33 1034 8192000000 10359880080 10762670080 1165151408 12.451 100 96 188 1 1470627456 284233552 21242496
05:51:41 1615 8192000000 10356064576 10778255360 1167789488 12.476 100 92 184 1 1467335072 278737248 20808336
05:52:45 878 8192000000 10382104928 10785042432 1170878304 12.505 100 98 192 3 1491000496 297978656 22143536
05:53:49 2876 8192000000 10384323856 10813497344 1174356656 12.538 100 79 154 0 1489320832 297595760 17368416
05:54:55 921 8192000000 10417726960 10823225344 1187420912 12.659 100 99 190 1 1526253440 316794848 22037680
05:55:59 826 8192000000 10463055904 10882736128 1180170560 12.592 100 92 177 0 1564563536 363321040 21071936
05:57:03 987 8192000000 10444818240 10879619072 1180319840 12.593 100 88 168 2 1549779424 348515104 20944480
05:58:14 1101 8192000000 10503992272 10912559104 1194329264 12.724 100 90 176 0 1605527056 389614256 21583536
05:59:17 1013 8192000000 10517403008 10950250496 1196876080 12.747 100 98 188 1 1622928432 403283296 22769056
06:00:21 933 8192000000 10532808160 10952773632 1191770208 12.700 100 94 181 0 1638478336 423626704 23081424
06:01:25 908 8192000000 10553157728 10972672000 1199637072 12.773 100 96 188 2 1658920368 435118416 24164880
06:02:29 1493 8192000000 10578204336 11007008768 1189796208 12.681 100 84 165 2 1678142720 468199936 20146576
06:03:36 787 8192000000 10582097136 11024572416 1188281888 12.667 100 96 189 1 1684858432 472247040 24329504
06:04:39 1212 8192000000 10539630000 11062439936 1184126896 12.629 100 62 124 0 1647434080 447434080 15873104
06:05:46 26585 8192000000 10495773184 10944770048 1176008848 12.553 99 39 78 0 1594831776 408480976 10341952
06:07:24 15301 8192000000 10506833952 10975244288 1162898816 12.430 99 35 70 0 1591094352 419260848 8934688
06:09:00 30308 8192000000 10359172064 10861338624 1161016528 12.413 100 20 40 0 1548094848 381836304 5242016
06:10:33 31459 8192000000 10250643184 10740371456 1151311792 12.322 100 31 61 0 1340269440 182410624 6547024
06:12:07 23804 8192000000 10128738608 10659622912 1136107264 12.179 99 23 46 0 1253494704 111819968 5567472
06:13:42 6008 8192000000 10077994576 10514710528 1141562672 12.230 100 42 72 0 1188312144 36306288 10443184
06:14:56 124997 8192000000 10140620720 10609336320 1142140496 12.236 100 32 62 0 1247133328 98303536 6689296
06:18:07 36269 8192000000 10104841328 10546683904 1125378176 12.078 99 35 69 0 1196020656 63687456 6955024
06:20:32 83823 8192000000 10075138336 10530328576 1117659168 12.005 99 15 30 0 1156773152 36015552 3098432
06:23:04 64029 8192000000 10065343664 10528104448 1119588848 12.023 98 13 26 0 1140664224 18209280 2866096
06:25:42 20913 8192000000 10072113968 10513760256 1135820496 12.176 100 24 46 2 1170247952 29408688 5018768
06:27:14 87457 8192000000 10078386592 10549305344 1138003296 12.197 100 26 52 0 1176325712 32893920 5428496
06:29:47 31388 8192000000 10096826880 10555191296 1120986432 12.036 98 39 76 1 1181719760 52741408 7991920
06:31:36 70069 8192000000 10081464176 10588762112 1111689136 11.948 98 15 30 0 1155948320 41209648 3049536
06:34:13 30210 8192000000 10083709360 10526978048 1121079952 12.037 99 30 58 0 1175404272 47981984 6342336
06:35:47 29311 8192000000 10104702368 10586038272 1119208688 12.020 99 35 70 0 1218167824 91807072 7152064
06:37:20 25949 8192000000 10097122800 10527518720 1105317968 11.888 98 47 92 0 1174086944 59887440 8881536
06:38:54 45116 8192000000 10122376880 10570559488 1129518016 12.117 99 28 56 0 1220506272 85253456 5734800
06:40:43 29578 8192000000 10100868848 10553094144 1097743408 11.816 97 38 75 1 1155069232 49882832 7442992
06:42:13 22745 8192000000 10137798608 10564775936 1125212064 12.076 99 59 117 0 1204121024 66728032 12180928
06:43:38 71524 8192000000 10135514192 10585731072 1121261424 12.039 98 36 72 0 1220225008 91718496 7245088
06:46:57 113991 8192000000 10100891856 10594439168 1139989328 12.215 100 18 35 0 1212886896 69680736 3216832
06:50:11 54122 8192000000 10063868160 10519855104 1117948128 12.008 98 8 16 0 1153089136 33481264 1659744
06:52:06 42660 8192000000 10114517840 10580807680 1142747664 12.241 100 16 32 0 1226422080 79840416 3834000
06:54:01 62134 8192000000 10063311088 10603270144 1130023088 12.122 100 11 20 0 1174759248 42900800 1835360
06:56:04 35965 8192000000 10053733280 10497556480 1085034000 11.695 97 31 60 1 1133271744 41990704 6247040
06:57:41 20052 8192000000 10112523888 10553425920 1106149040 11.896 98 34 68 0 1192163232 78654240 7359952
06:59:05 11501 8192000000 10168103584 10604167168 1141942864 12.234 100 49 97 3 1262783488 111087008 9753616
07:00:23 10128 8192000000 10152276096 10584678400 1116472736 11.994 99 44 80 0 1255738448 129914672 9351040
07:01:36 23351 8192000000 10218090576 10679767040 1118174528 12.010 99 47 93 0 1319324320 191096304 10053488
07:03:05 22854 8192000000 10202505808 10671292416 1113370096 11.964 99 34 64 0 1301603792 181083408 7150288
07:04:38 79248 8192000000 10144888512 10688446464 1104607680 11.881 99 21 40 0 1299809840 190107280 5094880
07:06:57 43121 8192000000 10072752736 10533916672 1100760368 11.845 99 16 28 0 1163121680 59638384 2722928
07:08:41 97149 8192000000 10050418816 10517209088 1122872480 12.054 100 22 42 0 1195650656 68080240 4697936
07:11:18 42455 8192000000 10065917648 10543362048 1097812448 11.817 98 13 26 0 1158386224 58338064 2235712
07:14:24 56041 8192000000 10060597984 10530279424 1116395936 11.993 99 20 40 0 1151761040 31631856 3733248
07:16:25 63888 8192000000 10113009600 10564763648 1103156224 11.868 97 20 38 1 1179320272 71868480 4295568
07:18:39 36076 8192000000 10116096144 10582999040 1131225040 12.133 99 28 56 0 1203454000 66238048 5990912
07:20:24 15202 8192000000 10182667344 10613633024 1141592576 12.231 99 58 115 2 1260597840 106447936 12557328
07:21:43 68026 8192000000 10159003616 10625667072 1149922208 12.309 100 19 38 0 1254631440 100288224 4421008
07:24:27 43068 8192000000 10106901296 10650152960 1123749968 12.062 99 16 32 0 1267688368 140128848 3809552
07:26:11 25411 8192000000 10113107424 10555514880 1119547104 12.023 99 51 98 0 1179083616 49490256 10046256
07:27:40 139673 8192000000 10099793552 10573877248 1141100976 12.226 100 28 53 3 1189689136 43639232 4948928
07:31:06 87294 8192000000 10085267392 10571993088 1139133904 12.207 100 12 24 0 1203278912 61452912 2692096
07:33:35 61669 8192000000 10091155888 10567356416 1120762240 12.034 99 18 36 0 1190105056 65494384 3848432
07:36:25 62251 8192000000 9375629088 9766989824 496109392 5.710 44 5 10 0 538083424 40988512 985520

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 26-06-2022 07:39:06 to 26-06-2022 07:39:21.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 65 v_add_invoice_to_stock 335544517
except 10 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 26-06-2022 07:39:22 to 26-06-2022 07:39:24.

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          209251
MON$OLDEST_ACTIVE               209736
MON$OLDEST_SNAPSHOT             209736
MON$NEXT_TRANSACTION            209736
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                       2050016
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             755
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

26.06.22 07:39:25. 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-26 07:39:27 No severe PSQL-related problems occured
26.06.22 07:39:29. End of report.