Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 19.02.2023 07:47
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 15127196 kB
MemAvailable 30411376 kB
Buffers 0 kB
Cached 16549728 kB
SwapCached 3140 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-02-19 07:47:05
DTS_END                         2023-02-19 07:47:05.5250
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/40962
TRN_ID                          220018
ATT_ID                          580
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: 8849.50 24800 1061940
customer order: creation 167.59 478 20111
customer order: refuse 15.18 392 1822
order to supplier: creation 45.18 1316 5422
order to supplier: removal 3.30 159465 396
invoice (draft): creation 45.27 3487 5432
invoice (draft): removal 49.58 939 5949
invoice accept: apply 41.50 25926 4980
invoice accept: cancel 44.58 1083 5350
customer reserve: creation 3785.97 250 454316
customer reserve: removal 4360.35 95 523242
realization accept: apply 82.48 297 9897
realization accept: cancel 79.81 149 9577
payment from customer: creation 59.39 183 7127
payment from customer: removal 5.76 120 691
payment to supplier: creation 47.36 217 5683
payment to supplier: removal 3.48 114 417
service: total inventory turnovers 4.06 3537 487
service: total monetary turnovers 7.66 399 919
service: aggregate perf. data 0.98 12456 118
service: refresh index statistics 0.03 285087 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 19-02-2023 07:47:55 to 19-02-2023 07:47:57.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 9558
TEST_TIME 2 7448
TEST_TIME 3 6921
TEST_TIME 4 7242
TEST_TIME 5 6937
TEST_TIME 6 7283
TEST_TIME 7 7372
TEST_TIME 8 7547
TEST_TIME 9 7377
TEST_TIME 10 7264
TEST_TIME 11 7331
TEST_TIME 12 7382
TEST_TIME 13 7421
TEST_TIME 14 7322
TEST_TIME 15 7604
TEST_TIME 16 7571
TEST_TIME 17 7591
TEST_TIME 18 7612
TEST_TIME 19 7868
TEST_TIME 20 8126
TEST_TIME 21 8289
TEST_TIME 22 8335
TEST_TIME 23 8488
TEST_TIME 24 8729
TEST_TIME 25 8813
TEST_TIME 26 9195
TEST_TIME 27 9622
TEST_TIME 28 9968
TEST_TIME 29 10039
TEST_TIME 30 10432
TEST_TIME 31 10923
TEST_TIME 32 10839
TEST_TIME 33 10519
TEST_TIME 34 10249
TEST_TIME 35 10242
TEST_TIME 36 10172
TEST_TIME 37 10187
TEST_TIME 38 10024
TEST_TIME 39 9869
TEST_TIME 40 9748
TEST_TIME 41 9654
TEST_TIME 42 9575
TEST_TIME 43 9477
TEST_TIME 44 9544
TEST_TIME 45 9521
TEST_TIME 46 9358
TEST_TIME 47 9275
TEST_TIME 48 9197
TEST_TIME 49 9146
TEST_TIME 50 9153
TEST_TIME 51 9062
TEST_TIME 52 9030
TEST_TIME 53 8965
TEST_TIME 54 8993
TEST_TIME 55 8942
TEST_TIME 56 8880
TEST_TIME 57 8898
TEST_TIME 58 8860
TEST_TIME 59 8841
TEST_TIME 60 9003
TEST_TIME 61 9077
TEST_TIME 62 9006
TEST_TIME 63 9112
TEST_TIME 64 9125
TEST_TIME 65 9126
TEST_TIME 66 9131
TEST_TIME 67 9149
TEST_TIME 68 9181
TEST_TIME 69 9088
TEST_TIME 70 9021
TEST_TIME 71 8973
TEST_TIME 72 8957
TEST_TIME 73 8911
TEST_TIME 74 8841
TEST_TIME 75 8823
TEST_TIME 76 8862
TEST_TIME 77 8814
TEST_TIME 78 8810
TEST_TIME 79 8832
TEST_TIME 80 8793
TEST_TIME 81 8807
TEST_TIME 82 8880
TEST_TIME 83 8831
TEST_TIME 84 8867
TEST_TIME 85 8839
TEST_TIME 86 8884
TEST_TIME 87 8989
TEST_TIME 88 8946
TEST_TIME 89 8932
TEST_TIME 90 8850
TEST_TIME 91 8787
TEST_TIME 92 8805
TEST_TIME 93 8768
TEST_TIME 94 8752
TEST_TIME 95 8727
TEST_TIME 96 8699
TEST_TIME 97 8667
TEST_TIME 98 8658
TEST_TIME 99 8673
TEST_TIME 100 8653
TEST_TIME 101 8658
TEST_TIME 102 8649
TEST_TIME 103 8657
TEST_TIME 104 8646
TEST_TIME 105 8678
TEST_TIME 106 8924
TEST_TIME 107 8933
TEST_TIME 108 8925
TEST_TIME 109 8912
TEST_TIME 110 8954
TEST_TIME 111 8950
TEST_TIME 112 8917
TEST_TIME 113 8944
TEST_TIME 114 8904
TEST_TIME 115 8873
TEST_TIME 116 8879
TEST_TIME 117 8930
TEST_TIME 118 8913
TEST_TIME 119 8953
TEST_TIME 120 8882

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 19-02-2023 07:47:59 to 19-02-2023 07:48:02.

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 1480743 1480743 0 0.00 0 22203 13 0 0
doc_list_biud 1480724 1480724 0 0.00 0 37937 40 0 0
sp_add_invoice_to_stock 5123 4980 143 2.79 36 184566 25927 0 143
sp_cancel_adding_invoice 5350 5350 0 0.00 6 86601 1084 0 0
sp_cancel_client_order 1822 1822 0 0.00 5 7546 393 0 0
sp_cancel_customer_reserve 523242 523242 0 0.00 1 37153 96 0 0
sp_cancel_pay_from_customer 691 691 0 0.00 3 6471 121 0 0
sp_cancel_pay_to_supplier 417 417 0 0.00 3 4995 115 0 0
sp_cancel_supplier_invoice 5962 5949 13 0.21 3 37947 939 0 13
sp_cancel_supplier_order 396 396 0 0.00 18 1385812 159465 0 0
sp_cancel_write_off 9577 9577 0 0.00 2 8823 150 0 0
sp_client_order 20111 20111 0 0.00 5 53314 479 0 0
sp_customer_reserve 454316 454316 0 0.00 0 49896 251 0 0
sp_fill_shopping_cart 30957 30957 0 0.00 1 12097 86 0 0
sp_fill_shopping_cart_clo_res 454283 454283 0 0.00 0 14708 18 0 0
sp_get_clo_for_invoice 4935 4935 0 0.00 0 53941 347 0 0
sp_kill_cost_storno 16035 16035 0 0.00 0 8818 65 0 0
sp_kill_qstorno_ret_qs2qd 1062406 1062406 0 0.00 0 37933 42 0 0
sp_kill_qty_storno 561164 561164 0 0.00 0 37935 97 0 0
sp_lock_selected_doc 20508 20508 0 0.00 0 5816 6 0 0
sp_make_cost_storno 27641 27641 0 0.00 0 22163 88 0 0
sp_multiply_rows_for_pdistr 27637 27637 0 0.00 0 11650 41 0 0
sp_multiply_rows_for_qdistr 20109 20109 0 0.00 0 53303 180 0 0
sp_pay_from_customer 7127 7127 0 0.00 5 20005 183 0 0
sp_pay_to_supplier 5683 5683 0 0.00 7 17880 217 0 0
sp_payment_common 12808 12808 0 0.00 2 16554 52 0 0
sp_qd_handle_on_cancel_clo 1822 1822 0 0.00 0 7519 318 0 0
sp_qd_handle_on_invoice_upd_sts 10285 10285 0 0.00 0 18173 499 0 0
sp_qd_handle_on_reserve_upd_sts 9893 9893 0 0.00 0 17752 65 0 0
sp_reserve_write_off 9897 9897 0 0.00 8 22229 298 0 0
sp_supplier_invoice 5432 5432 0 0.00 8 121915 3488 0 0
sp_supplier_order 5422 5422 0 0.00 6 59282 1316 0 0
srv_aggregate_perf_data 118 118 0 0.00 2618 104539 12456 0 0
srv_fill_mon_cache_memory 71 71 0 0.00 848 131820 35694 0 0
srv_find_qd_qs_mism 1014001 1014001 0 0.00 0 17018 10 0 0
srv_make_invnt_saldo 487 487 0 0.00 46 61717 3537 0 0
srv_make_money_saldo 919 919 0 0.00 1 23021 400 0 0
srv_recalc_idx_stat 4 4 0 0.00 91349 360604 285088 0 0
t$perf-abend:sp_add_invoice_to_stock 143 143 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 13 13 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4984 4984 0 0.00 1 30567 885 0 0
t$perf-norm:sp_cancel_adding_invoice 373 373 0 0.00 0 8370 429 0 0
t$perf-norm:sp_cancel_client_order 1822 1822 0 0.00 0 10857 29 0 0
t$perf-norm:sp_cancel_customer_reserve 688 688 0 0.00 0 487 22 0 0
t$perf-norm:sp_cancel_pay_from_customer 691 691 0 0.00 0 490 12 0 0
t$perf-norm:sp_cancel_pay_to_supplier 417 417 0 0.00 0 1390 12 0 0
t$perf-norm:sp_cancel_supplier_invoice 392 392 0 0.00 0 4702 38 0 0
t$perf-norm:sp_cancel_supplier_order 396 396 0 0.00 0 107272 5807 0 0
t$perf-norm:sp_cancel_write_off 901 901 0 0.00 0 12115 34 0 0
t$perf-norm:sp_client_order 20111 20111 0 0.00 0 7075 36 0 0
t$perf-norm:sp_customer_reserve 984 984 0 0.00 0 1310 14 0 0
t$perf-norm:sp_pay_from_customer 7127 7127 0 0.00 0 4567 20 0 0
t$perf-norm:sp_pay_to_supplier 5683 5683 0 0.00 0 9333 20 0 0
t$perf-norm:sp_reserve_write_off 9897 9897 0 0.00 0 5840 22 0 0
t$perf-norm:sp_supplier_invoice 5432 5432 0 0.00 0 3171 29 0 0
t$perf-norm:sp_supplier_order 5422 5422 0 0.00 0 2601 28 0 0
t$perf-norm:srv_aggregate_perf_data 118 118 0 0.00 0 526 20 0 0
t$perf-norm:srv_fill_mon_cache_memory 71 71 0 0.00 0 276 7 0 0
t$perf-norm:srv_make_invnt_saldo 487 487 0 0.00 0 4286 20 0 0
t$perf-norm:srv_make_money_saldo 919 919 0 0.00 0 739 6 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 165 54 0 0
v_add_invoice_to_stock 10156 9870 286 2.81 0 7965 28 0 286
v_all_customers 36702 36702 0 0.00 0 92 4 0 0
v_all_suppliers 29828 29828 0 0.00 0 97 4 0 0
v_all_wares 40214 40214 0 0.00 0 129 4 0 0
v_cancel_adding_invoice 746 746 0 0.00 0 904 14 0 0
v_cancel_client_order 3644 3644 0 0.00 0 4818 13 0 0
v_cancel_customer_prepayment 1382 1382 0 0.00 0 6409 15 0 0
v_cancel_customer_reserve 1376 1376 0 0.00 1 5726 17 0 0
v_cancel_payment_to_supplier 834 834 0 0.00 0 491 11 0 0
v_cancel_supplier_invoice 810 784 26 3.20 0 1843 28 0 26
v_cancel_supplier_order 792 792 0 0.00 0 2254 18 0 0
v_cancel_write_off 1802 1802 0 0.00 0 4748 28 0 0
v_max_id_clo_ord 5422 5422 0 0.00 0 282 5 0 0
v_max_id_clo_res 984 984 0 0.00 0 2771 13 0 0
v_max_id_ord_sup 5425 5425 0 0.00 0 2748 7 0 0
v_max_non_paid_invoice 1616 1616 0 0.00 0 92 8 0 0
v_max_non_paid_realizn 3841 3841 0 0.00 0 9331 12 0 0
v_min_id_clo_ord 5422 5422 0 0.00 0 6829 11 0 0
v_min_id_clo_res 984 984 0 0.00 0 3518 13 0 0
v_min_id_ord_sup 5425 5425 0 0.00 0 6737 20 0 0
v_min_non_paid_invoice 5683 5683 0 0.00 0 11326 28 0 0
v_min_non_paid_realizn 7125 7125 0 0.00 0 9216 20 0 0
v_our_firm 10080 10080 0 0.00 0 61 5 0 0
v_reserve_write_off 19786 19786 0 0.00 0 6749 13 0 0
x_lock_depdocs_on_canc_invoice 10907 10907 0 0.00 0 16866 134 0 0
x_lock_depdocs_on_canc_sup_ord 396 396 0 0.00 0 4263 351 0 0
x_make_qstorno_1000_1200 5422 5422 0 0.00 2 57117 1148 0 0
x_make_qstorno_1200_2000 5432 5432 0 0.00 3 121219 3246 0 0
x_make_qstorno_2100_3300 454315 454315 0 0.00 0 49871 220 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 19-02-2023 07:48:03 to 19-02-2023 07:48:07.

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:17:09 19 8192000000 8821223776 8841392128 18537856 0.225 9 4 4 1 18816320 183504 94960
05:18:10 26359 8192000000 9707742880 10005458944 785238816 8.746 100 82 164 0 813053200 7502464 20311920
05:19:42 18189 8192000000 9750474784 10056736768 826828000 9.167 100 89 176 0 859428384 11523616 21076768
05:21:07 16036 8192000000 9794343328 10109902848 859657824 9.497 100 87 174 0 902568768 22973040 19937904
05:22:31 8516 8192000000 9846934912 10179891200 911109088 10.008 100 75 148 1 950909152 23748272 16051792
05:23:45 2814 8192000000 9908587456 10251948032 960780016 10.497 100 83 163 0 1025798928 47550432 17468480
05:24:49 2914 8192000000 9985869504 10338357248 998733696 10.866 100 91 176 1 1094029712 77122624 18173392
05:25:54 748 8192000000 10012607344 10376720384 1023068640 11.102 100 92 182 1 1129373328 87968416 18336272
05:26:56 1184 8192000000 9993008832 10363355136 1040839168 11.273 100 95 185 2 1116600432 56476864 19284400
05:27:58 1264 8192000000 10002741808 10378514432 1065354128 11.508 100 89 174 0 1125408784 43066112 16988544
05:29:02 4655 8192000000 10025257664 10407653376 1079367824 11.641 100 73 131 1 1147697984 56283904 12046256
05:30:07 1759 8192000000 10016890352 10405986304 1085870960 11.703 100 62 122 0 1138790736 40333696 12586080
05:31:10 1106 8192000000 10048249680 10437054464 1090383936 11.746 100 95 180 3 1169324928 60570784 18370208
05:32:12 1052 8192000000 10043356816 10429050880 1092744832 11.769 100 95 183 0 1163689776 51000960 19943984
05:33:14 1609 8192000000 10061906976 10449141760 1098820624 11.826 100 84 159 3 1181228592 65756512 16651456
05:34:17 1211 8192000000 10084822256 10480336896 1104511856 11.880 100 99 194 4 1208753744 85222512 19019376
05:35:19 1143 8192000000 10090842304 10486648832 1106376640 11.898 100 96 185 1 1208822976 82459616 19986720
05:36:21 6763 8192000000 10049081744 10447396864 1102770336 11.864 100 75 142 1 1171554400 54250816 14533248
05:37:28 2507 8192000000 10077896832 10480422912 1106865008 11.903 100 71 132 1 1204925200 84889392 13170800
05:38:33 1018 8192000000 10075364400 10467786752 1101922032 11.856 100 92 176 1 1195901008 75952352 18026624
05:39:34 1163 8192000000 10044372320 10428239872 1088808816 11.731 100 93 182 1 1164171184 56125312 19237056
05:40:36 1719 8192000000 10040649232 10425999360 1071264528 11.564 99 89 171 2 1159162752 70306432 17591792
05:41:39 1629 8192000000 10021592240 10406060032 1062009904 11.476 100 76 142 2 1147202848 70907632 14285312
05:42:41 1084 8192000000 9966459056 10338275328 1025232336 11.122 98 82 152 5 1086990736 44842976 16915424
05:43:43 2277 8192000000 9956161904 10330034176 1009701760 10.972 98 68 134 2 1081517616 58130336 13685520
05:44:47 1290 8192000000 10011418976 10385309696 1043993648 11.303 100 97 180 0 1128886208 66847440 18045120
05:45:49 2067 8192000000 9965154368 10340196352 1027211104 11.142 100 79 150 3 1087344688 44043600 16089984
05:46:52 1324 8192000000 10011591408 10390093824 1048161424 11.343 100 79 152 2 1131121168 68142848 14816896
05:48:01 27039 8192000000 10019109008 10408824832 1072805680 11.579 100 60 116 1 1144354416 59883248 11665488
05:49:33 5986 8192000000 10034401776 10416656384 1081686128 11.664 99 74 135 1 1160902976 66176352 13040496
05:50:41 1533 8192000000 10097516032 10485608448 1102593568 11.862 100 85 164 1 1217916352 97942736 17380048
05:51:47 9786 8192000000 10114102000 10510753792 1116686080 11.996 100 70 133 0 1241146336 110516384 13943872
05:53:00 1085 8192000000 10134222032 10526957568 1129522128 12.117 100 83 160 0 1255084336 109093344 16468864
05:54:05 2648 8192000000 10155966560 10552320000 1139111248 12.207 100 83 150 2 1273751488 118461024 16179216
05:55:11 4405 8192000000 10178915296 10589458432 1149068288 12.301 100 69 132 0 1295905104 133085968 13750848
05:56:19 3433 8192000000 10201119472 10612428800 1159689296 12.400 100 71 137 0 1318697872 142928272 16080304
05:57:31 2537 8192000000 10231597664 10630197248 1169498928 12.492 100 86 165 1 1344184576 156193152 18492496
05:58:36 1807 8192000000 10286972704 10692481024 1179921120 12.589 100 93 178 0 1398570928 199104528 19545280
05:59:43 2951 8192000000 10334654512 10749739008 1189082608 12.675 100 86 172 0 1451851600 243271456 19497536
06:00:51 837 8192000000 10362565264 10771193856 1186209200 12.648 100 95 180 2 1474625472 267692608 20723664
06:01:54 4220 8192000000 10366643600 10800390144 1193068576 12.712 100 85 166 1 1485166384 272700480 19397328
06:03:01 1443 8192000000 10396507808 10802630656 1193491520 12.716 100 98 191 1 1505803440 291246144 21065776
06:04:05 1202 8192000000 10459096496 10870247424 1196270816 12.742 100 93 182 0 1568379456 349987520 22121120
06:05:09 2292 8192000000 10451312208 10886307840 1184639008 12.633 100 90 173 1 1554011296 348957024 20415264
06:06:15 1235 8192000000 10441658048 10905235456 1184150816 12.629 100 88 165 0 1547798016 343079664 20567536
06:07:21 920 8192000000 10452353312 10868998144 1183431936 12.622 100 92 172 0 1557411728 354907376 19072416
06:08:27 6558 8192000000 10428859792 10890125312 1175815648 12.551 100 61 118 0 1531186832 340478960 14892224
06:09:40 3277 8192000000 10429348928 10891862016 1176302224 12.556 100 65 125 0 1534515216 342997488 15215504
06:10:47 1459 8192000000 10433281968 10885337088 1177419264 12.566 100 93 181 0 1535232640 336654864 21158512
06:11:50 3068 8192000000 10439425952 10872545280 1181059648 12.600 100 61 119 4 1548118224 351849776 15208800
06:12:58 2514 8192000000 10423382960 10906230784 1167231120 12.471 100 40 80 0 1530802448 352523264 11048064
06:14:17 23916 8192000000 10327296880 10844270592 1163563072 12.437 100 31 58 0 1478528992 307261008 7704912
06:15:49 24848 8192000000 10254598800 10762829824 1130392768 12.125 98 19 38 1 1381034304 245898528 4743008
06:17:15 42995 8192000000 10178073408 10644627456 1148694240 12.297 100 23 46 0 1303277344 148510064 6073040
06:19:00 81661 8192000000 10078126624 10520199168 1135178800 12.170 99 43 84 1 1167712912 22775504 9758608
06:21:35 5803 8192000000 10095787120 10524299264 1145157136 12.264 100 67 131 0 1193933312 35901648 12874528
06:22:59 59613 8192000000 10097277456 10568085504 1135534688 12.174 100 25 48 1 1216481616 75690704 5256224
06:25:05 18996 8192000000 10050770768 10485469184 1109862336 11.931 98 59 111 1 1137401056 15662544 11876176
06:27:41 54109 8192000000 10080381600 10542505984 1112117936 11.952 97 22 42 0 1170429328 53470928 4840464
06:29:35 54098 8192000000 10113092768 10566049792 1126592432 12.089 99 20 40 0 1189961968 59070640 4298896
06:31:30 96679 8192000000 10067987952 10572095488 1135520352 12.173 100 21 41 0 1180418480 40738544 4159584
06:34:10 24710 8192000000 10086520064 10541985792 1135568704 12.174 99 31 59 0 1186914256 45614464 5731088
06:35:36 15904 8192000000 10091197104 10530144256 1132966240 12.149 99 42 82 1 1186642864 44312784 9363840
06:37:02 39859 8192000000 10085405472 10574974976 1140223584 12.218 100 16 32 0 1187061312 43415248 3422480
06:38:43 64344 8192000000 10119701312 10578280448 1106280896 11.897 97 26 52 0 1193498112 81238912 5978304
06:41:31 68649 8192000000 10049222368 10540568576 1087976288 11.723 97 7 12 0 1125826848 36757104 1093456
06:43:43 55786 8192000000 10090353648 10535084032 1108567744 11.919 98 21 42 0 1170502256 57546944 4387568
06:46:08 43551 8192000000 10153918320 10589351936 1109555456 11.928 98 41 81 1 1211837984 93736720 8545808
06:47:58 62762 8192000000 10062476672 10551971840 1098816144 11.826 97 31 59 0 1155129280 49658352 6654784
06:50:04 71986 8192000000 10083879152 10540773376 1096710112 11.806 97 13 26 0 1153894912 54323536 2861264
06:52:16 51073 8192000000 10095007648 10529087488 1122200544 12.048 99 26 50 0 1179593632 52015168 5377920
06:54:07 29075 8192000000 10094753872 10518351872 1124706960 12.071 99 46 91 0 1174783168 40675648 9400560
06:55:37 80051 8192000000 10072647952 10512052224 1129900720 12.120 100 40 79 0 1192263008 54200784 8161504
06:58:01 28953 8192000000 10081264784 10523938816 1134731120 12.166 100 42 84 0 1184508144 41569520 8207504
06:59:30 37206 8192000000 10053087248 10526679040 1109944000 11.932 98 20 40 0 1157401968 42895792 4562176
07:01:08 62866 8192000000 10084146192 10532139008 1125809312 12.082 99 21 42 0 1181815184 51316272 4689600
07:03:26 52502 8192000000 10064636928 10555875328 1095943872 11.799 97 7 14 0 1145748080 48457984 1346224
07:05:19 61036 8192000000 10041248704 10520940544 1103994848 11.876 98 20 39 0 1171042080 62787824 4259408
07:07:20 22149 8192000000 10101927344 10527789056 1128797312 12.110 100 51 99 1 1187953264 48662176 10493776
07:08:55 52466 8192000000 10089409008 10530623488 1117027664 11.999 99 22 44 0 1193217456 71905760 4284032
07:10:48 23777 8192000000 10092733952 10542845952 1116008128 11.989 99 54 108 0 1191334880 64033952 11292800
07:12:19 47774 8192000000 10105101888 10557034496 1105737552 11.892 98 33 60 1 1195983392 83747392 6498448
07:14:07 131818 8192000000 10112547696 10586750976 1104748224 11.883 98 21 42 1 1188652400 79592800 4311376
07:17:22 82291 8192000000 10090847760 10525495296 1070547472 11.557 95 33 65 0 1129347776 52443520 6356784
07:19:46 51420 8192000000 10062597792 10503847936 1102678000 11.863 98 15 28 1 1141586784 35873440 3035344
07:21:37 79107 8192000000 10077748432 10527166464 1108857328 11.922 98 15 29 0 1166212976 54372368 2983280
07:23:57 25934 8192000000 10115345168 10545328128 1118048064 12.009 98 28 56 0 1194218112 69778032 6392016
07:25:27 25445 8192000000 10172372832 10607460352 1140951680 12.224 100 37 75 0 1264460112 115337616 8170816
07:26:54 45767 8192000000 10186478592 10616737792 1135020224 12.169 98 27 54 0 1252778000 111744032 6013744
07:28:46 19926 8192000000 10236877984 10666307584 1154380592 12.351 99 42 82 0 1323482800 160012560 9089648
07:30:10 40950 8192000000 10261931184 10696278016 1128278800 12.105 97 40 80 0 1335251744 198144544 8828400
07:31:52 27480 8192000000 10301883360 10740609024 1156217872 12.368 100 41 80 1 1395551904 230249248 9084784
07:33:23 46757 8192000000 10110883552 10640224256 1139826128 12.214 100 15 30 0 1315515008 172354400 3334480
07:35:16 117739 8192000000 10092725664 10589470720 1111678784 11.948 97 20 40 0 1203227248 86629072 4919392
07:38:14 114522 8192000000 10100375808 10568093696 1147669232 12.288 100 12 24 1 1193566560 43299744 2597584
07:41:22 34369 8192000000 10091435456 10515202048 1130810224 12.129 99 51 93 4 1167354976 26035680 10509072
07:42:57 21485 8192000000 10134243392 10584088576 1147302320 12.284 100 41 80 0 1241351456 85539936 8509200
07:44:20 82190 8192000000 10110324368 10560999424 1142986560 12.244 99 10 20 0 1217638704 72440416 2211728
07:46:43 35310 8192000000 8867043280 9109172224 14673168 0.178 2 1 2 0 14776688 68112 35408

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:17, from 19-02-2023 07:48:09 to 19-02-2023 07:48:26.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 143 v_add_invoice_to_stock 335544517
except 13 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 19-02-2023 07:48:27 to 19-02-2023 07:48:29.

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          220391
MON$OLDEST_ACTIVE               220392
MON$OLDEST_SNAPSHOT             220392
MON$NEXT_TRANSACTION            220392
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                       2053216
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             774
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


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

19.02.23 07:48:30. 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-02-19 07:48:33 No severe PSQL-related problems occured
19.02.23 07:48:34. End of report.