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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15150708 kB
MemAvailable 30403652 kB
Buffers 0 kB
Cached 16546316 kB
SwapCached 4416 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 3.0.11
DB_NAME                         /home/bases/oltp30-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/oltp30-etalone.fdb
param=detailed_info, val=0
param=etalon_dbnm, val=/home/bases/oltp30-etalone.fd0
param=expected_workers, val=100
param=fbc, val=/opt/fb30/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=3333
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/oltp30-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-oltp30
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-10 16:38:39
DTS_END                         2023-01-10 16:38:39.4880
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SRV_AGGREGATE_PERF_DATA(83:5) ==> TMP_AGGREGATE_PERF_DATA_AUTOGEN(720:9) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(57:17)
IP                              ::1/39858
TRN_ID                          245132
ATT_ID                          734
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: 9608.33 19168 1153000
customer order: creation 177.60 346 21312
customer order: refuse 14.84 347 1781
order to supplier: creation 47.70 1243 5724
order to supplier: removal 3.45 108641 414
invoice (draft): creation 46.73 3416 5608
invoice (draft): removal 53.23 818 6387
invoice accept: apply 43.36 18845 5203
invoice accept: cancel 48.12 818 5774
customer reserve: creation 4070.47 184 488456
customer reserve: removal 4801.08 60 576129
realization accept: apply 85.03 183 10204
realization accept: cancel 82.41 104 9889
payment from customer: creation 61.69 118 7403
payment from customer: removal 5.87 90 704
payment to supplier: creation 50.31 141 6037
payment to supplier: removal 3.72 91 446
service: total inventory turnovers 4.83 1292 579
service: total monetary turnovers 7.03 38 843
service: aggregate perf. data 0.86 21727 103
service: refresh index statistics 0.03 224848 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 10-01-2023 16:39:26 to 10-01-2023 16:39:28.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4902
TEST_TIME 2 4101
TEST_TIME 3 4181
TEST_TIME 4 4511
TEST_TIME 5 4830
TEST_TIME 6 4762
TEST_TIME 7 4904
TEST_TIME 8 4804
TEST_TIME 9 4834
TEST_TIME 10 5469
TEST_TIME 11 5448
TEST_TIME 12 5749
TEST_TIME 13 5928
TEST_TIME 14 6200
TEST_TIME 15 6633
TEST_TIME 16 6933
TEST_TIME 17 7116
TEST_TIME 18 7503
TEST_TIME 19 7731
TEST_TIME 20 7681
TEST_TIME 21 7730
TEST_TIME 22 7920
TEST_TIME 23 7951
TEST_TIME 24 8054
TEST_TIME 25 8433
TEST_TIME 26 8581
TEST_TIME 27 8823
TEST_TIME 28 8843
TEST_TIME 29 9788
TEST_TIME 30 10058
TEST_TIME 31 10609
TEST_TIME 32 10518
TEST_TIME 33 10685
TEST_TIME 34 10604
TEST_TIME 35 10881
TEST_TIME 36 10721
TEST_TIME 37 10555
TEST_TIME 38 10496
TEST_TIME 39 10327
TEST_TIME 40 10426
TEST_TIME 41 10425
TEST_TIME 42 10226
TEST_TIME 43 10152
TEST_TIME 44 10089
TEST_TIME 45 9991
TEST_TIME 46 10147
TEST_TIME 47 10127
TEST_TIME 48 10120
TEST_TIME 49 10052
TEST_TIME 50 9997
TEST_TIME 51 9965
TEST_TIME 52 9896
TEST_TIME 53 9920
TEST_TIME 54 9904
TEST_TIME 55 9803
TEST_TIME 56 9756
TEST_TIME 57 9777
TEST_TIME 58 9734
TEST_TIME 59 9691
TEST_TIME 60 9556
TEST_TIME 61 9547
TEST_TIME 62 9596
TEST_TIME 63 9568
TEST_TIME 64 9601
TEST_TIME 65 9617
TEST_TIME 66 9713
TEST_TIME 67 9738
TEST_TIME 68 9745
TEST_TIME 69 9812
TEST_TIME 70 9796
TEST_TIME 71 9778
TEST_TIME 72 9810
TEST_TIME 73 9856
TEST_TIME 74 10062
TEST_TIME 75 9983
TEST_TIME 76 9898
TEST_TIME 77 9858
TEST_TIME 78 9792
TEST_TIME 79 9797
TEST_TIME 80 9773
TEST_TIME 81 9714
TEST_TIME 82 9673
TEST_TIME 83 9649
TEST_TIME 84 9567
TEST_TIME 85 9565
TEST_TIME 86 9751
TEST_TIME 87 9704
TEST_TIME 88 9667
TEST_TIME 89 9753
TEST_TIME 90 9761
TEST_TIME 91 9761
TEST_TIME 92 9769
TEST_TIME 93 9805
TEST_TIME 94 9807
TEST_TIME 95 9794
TEST_TIME 96 9834
TEST_TIME 97 9862
TEST_TIME 98 9868
TEST_TIME 99 9884
TEST_TIME 100 9880
TEST_TIME 101 9791
TEST_TIME 102 9801
TEST_TIME 103 9783
TEST_TIME 104 9743
TEST_TIME 105 9728
TEST_TIME 106 9689
TEST_TIME 107 9664
TEST_TIME 108 9623
TEST_TIME 109 9584
TEST_TIME 110 9589
TEST_TIME 111 9648
TEST_TIME 112 9617
TEST_TIME 113 9603
TEST_TIME 114 9606
TEST_TIME 115 9656
TEST_TIME 116 9658
TEST_TIME 117 9635
TEST_TIME 118 9608
TEST_TIME 119 9626
TEST_TIME 120 9610

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 10-01-2023 16:39:29 to 10-01-2023 16:39:33.

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 1605201 1605201 0 0.00 0 24935 6 0 0
doc_list_biud 1605199 1605199 0 0.00 0 35697 28 0 0
sp_add_invoice_to_stock 5356 5203 153 2.85 33 167685 18845 0 153
sp_cancel_adding_invoice 5774 5774 0 0.00 4 62076 819 0 0
sp_cancel_client_order 1781 1781 0 0.00 4 10485 347 0 0
sp_cancel_customer_reserve 576129 576129 0 0.00 0 25948 61 0 0
sp_cancel_pay_from_customer 704 704 0 0.00 3 4786 91 0 0
sp_cancel_pay_to_supplier 446 446 0 0.00 2 4825 91 0 0
sp_cancel_supplier_invoice 6397 6387 10 0.15 2 23551 819 0 10
sp_cancel_supplier_order 414 414 0 0.00 8 954785 108642 0 0
sp_cancel_write_off 9889 9889 0 0.00 1 9323 104 0 0
sp_client_order 21312 21312 0 0.00 3 16149 346 0 0
sp_customer_reserve 488456 488456 0 0.00 0 39942 185 0 0
sp_fill_shopping_cart 32642 32642 0 0.00 1 15951 38 0 0
sp_fill_shopping_cart_clo_res 488448 488448 0 0.00 0 29957 13 0 0
sp_get_clo_for_invoice 5195 5195 0 0.00 0 25313 264 0 0
sp_kill_cost_storno 16813 16813 0 0.00 0 14087 57 0 0
sp_kill_qstorno_ret_qs2qd 1168948 1168948 0 0.00 0 25876 33 0 0
sp_kill_qty_storno 615767 615767 0 0.00 0 35697 71 0 0
sp_lock_selected_doc 21381 21381 0 0.00 0 6112 4 0 0
sp_make_cost_storno 28833 28833 0 0.00 0 24933 61 0 0
sp_multiply_rows_for_pdistr 28832 28832 0 0.00 0 8478 27 0 0
sp_multiply_rows_for_qdistr 21312 21312 0 0.00 0 14922 145 0 0
sp_pay_from_customer 7403 7403 0 0.00 4 21043 118 0 0
sp_pay_to_supplier 6037 6037 0 0.00 5 24939 141 0 0
sp_payment_common 13439 13439 0 0.00 2 21039 29 0 0
sp_qd_handle_on_cancel_clo 1781 1781 0 0.00 0 10465 322 0 0
sp_qd_handle_on_invoice_upd_sts 10963 10963 0 0.00 0 35696 348 0 0
sp_qd_handle_on_reserve_upd_sts 10204 10204 0 0.00 0 18885 63 0 0
sp_reserve_write_off 10204 10204 0 0.00 6 21585 183 0 0
sp_supplier_invoice 5608 5608 0 0.00 7 86617 3417 0 0
sp_supplier_order 5724 5724 0 0.00 4 35438 1243 0 0
srv_aggregate_perf_data 104 103 1 0.96 3442 311585 21728 0 1
srv_fill_mon_cache_memory 67 67 0 0.00 1529 129993 40761 0 0
srv_find_qd_qs_mism 1103194 1103194 0 0.00 0 21213 5 0 0
srv_make_invnt_saldo 579 579 0 0.00 38 94012 1293 0 0
srv_make_money_saldo 843 843 0 0.00 1 5168 38 0 0
srv_recalc_idx_stat 4 4 0 0.00 108376 330374 224848 0 0
t$perf-abend:sp_add_invoice_to_stock 153 153 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-abend:srv_aggregate_perf_data 1 1 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 5203 5203 0 0.00 0 12606 178 0 0
t$perf-norm:sp_cancel_adding_invoice 406 406 0 0.00 0 7135 124 0 0
t$perf-norm:sp_cancel_client_order 1781 1781 0 0.00 0 2544 9 0 0
t$perf-norm:sp_cancel_customer_reserve 734 734 0 0.00 0 680 9 0 0
t$perf-norm:sp_cancel_pay_from_customer 704 704 0 0.00 0 4680 12 0 0
t$perf-norm:sp_cancel_pay_to_supplier 446 446 0 0.00 0 1850 9 0 0
t$perf-norm:sp_cancel_supplier_invoice 417 417 0 0.00 0 696 12 0 0
t$perf-norm:sp_cancel_supplier_order 414 414 0 0.00 0 29068 1762 0 0
t$perf-norm:sp_cancel_write_off 1086 1086 0 0.00 0 2003 7 0 0
t$perf-norm:sp_client_order 21312 21312 0 0.00 0 8721 16 0 0
t$perf-norm:sp_customer_reserve 1088 1088 0 0.00 0 1308 8 0 0
t$perf-norm:sp_pay_from_customer 7403 7403 0 0.00 0 6082 9 0 0
t$perf-norm:sp_pay_to_supplier 6037 6037 0 0.00 0 6699 11 0 0
t$perf-norm:sp_reserve_write_off 10204 10204 0 0.00 0 5158 10 0 0
t$perf-norm:sp_supplier_invoice 5608 5608 0 0.00 0 8449 19 0 0
t$perf-norm:sp_supplier_order 5724 5724 0 0.00 0 5500 18 0 0
t$perf-norm:srv_aggregate_perf_data 103 103 0 0.00 0 420 16 0 0
t$perf-norm:srv_fill_mon_cache_memory 67 67 0 0.00 0 180 5 0 0
t$perf-norm:srv_make_invnt_saldo 579 579 0 0.00 0 2537 32 0 0
t$perf-norm:srv_make_money_saldo 843 843 0 0.00 0 1336 17 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 1 3 2 0 0
v_add_invoice_to_stock 10682 10376 306 2.86 0 11424 24 0 306
v_all_customers 39154 39154 0 0.00 0 30 1 0 0
v_all_suppliers 31124 31124 0 0.00 0 23 1 0 0
v_all_wares 42622 42622 0 0.00 0 206 1 0 0
v_cancel_adding_invoice 812 812 0 0.00 0 466 8 0 0
v_cancel_client_order 3562 3562 0 0.00 0 2631 5 0 0
v_cancel_customer_prepayment 1408 1408 0 0.00 0 4451 12 0 0
v_cancel_customer_reserve 1468 1468 0 0.00 0 443 3 0 0
v_cancel_payment_to_supplier 892 892 0 0.00 0 4808 16 0 0
v_cancel_supplier_invoice 854 834 20 2.34 0 6196 28 0 20
v_cancel_supplier_order 828 828 0 0.00 0 4380 15 0 0
v_cancel_write_off 2172 2172 0 0.00 0 3075 14 0 0
v_max_id_clo_ord 5723 5723 0 0.00 0 2785 2 0 0
v_max_id_clo_res 1088 1088 0 0.00 0 2682 13 0 0
v_max_id_ord_sup 5608 5608 0 0.00 0 2882 4 0 0
v_max_non_paid_invoice 1805 1805 0 0.00 0 2280 5 0 0
v_max_non_paid_realizn 3881 3881 0 0.00 0 1324 4 0 0
v_min_id_clo_ord 5723 5723 0 0.00 0 3605 7 0 0
v_min_id_clo_res 1088 1088 0 0.00 0 6108 16 0 0
v_min_id_ord_sup 5608 5608 0 0.00 0 6670 15 0 0
v_min_non_paid_invoice 6036 6036 0 0.00 0 6008 22 0 0
v_min_non_paid_realizn 7403 7403 0 0.00 0 21035 21 0 0
v_our_firm 10512 10512 0 0.00 0 22 1 0 0
v_reserve_write_off 20408 20408 0 0.00 0 5208 7 0 0
x_lock_depdocs_on_canc_invoice 11744 11744 0 0.00 0 16419 130 0 0
x_lock_depdocs_on_canc_sup_ord 414 414 0 0.00 0 17002 434 0 0
x_make_qstorno_1000_1200 5724 5724 0 0.00 1 35431 1161 0 0
x_make_qstorno_1200_2000 5608 5608 0 0.00 2 86294 3284 0 0
x_make_qstorno_2100_3300 488456 488456 0 0.00 0 35644 169 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 10-01-2023 16:39:34 to 10-01-2023 16:39:38.

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
14:08:43 2 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
14:09:44 17325 8192000000 9894117888 10200244224 979759664 10.682 100 88 177 0 1009123536 5910544 23453328
14:11:06 18744 8192000000 9939789312 10260426752 1023443744 11.105 100 88 176 0 1054104224 8224432 22436048
14:12:27 13947 8192000000 9966020928 10294587392 1051433968 11.374 100 85 170 0 1082479472 9938064 21107440
14:13:51 10531 8192000000 10019776752 10363146240 1101924608 11.856 100 82 163 0 1132151456 10851568 19375280
14:15:05 6757 8192000000 10065237984 10418061312 1154973232 12.356 100 82 161 0 1186263248 12331616 18958400
14:16:14 3574 8192000000 10102382112 10467033088 1195003328 12.730 100 81 162 1 1227100304 13445280 18651696
14:17:21 1848 8192000000 10164074864 10536873984 1247450336 13.215 100 86 173 0 1282538368 16366784 18721248
14:18:25 3549 8192000000 10178636976 10559197184 1268490864 13.408 100 72 136 1 1295902832 12880960 14531008
14:19:30 1345 8192000000 10204644000 10589577216 1292523888 13.627 100 86 173 1 1325849136 13256096 20069152
14:20:34 30872 8192000000 10198752400 10603220992 1303235488 13.725 100 39 78 0 1320624672 8791104 8598080
14:22:06 5583 8192000000 10208046960 10619473920 1317256864 13.852 100 24 48 1 1328963376 6019312 5687200
14:23:14 9002 8192000000 10208688304 10626048000 1325910288 13.930 100 19 39 0 1335558864 5668512 3980064
14:24:25 14010 8192000000 10212876928 10633670656 1331221696 13.978 100 31 62 0 1344254592 5144672 7888224
14:25:41 21066 8192000000 10238080848 10647015424 1334225648 14.005 100 57 112 1 1354534832 6569968 13739216
14:27:03 7340 8192000000 10227257744 10651332608 1338036928 14.040 100 30 60 0 1351616256 6551024 7028304
14:28:11 7823 8192000000 10233722272 10646974464 1325744128 13.929 99 23 43 0 1336222976 5451920 5026928
14:29:19 54984 8192000000 10172454064 10568757248 1230166736 13.056 95 42 84 0 1245036688 5718448 9151504
14:31:18 5693 8192000000 10158931296 10560856064 1246219296 13.203 98 25 49 0 1257694304 6085632 5389376
14:32:26 6161 8192000000 10123117584 10518962176 1221360464 12.974 98 31 63 1 1234573088 5060352 8152272
14:33:32 13449 8192000000 10143315584 10546941952 1243455008 13.178 99 18 38 0 1253820224 5971472 4393744
14:34:47 32455 8192000000 10152245696 10554630144 1247494224 13.215 98 25 48 1 1258147248 5187008 5466016
14:36:22 6923 8192000000 10189340720 10591047680 1284769376 13.557 100 29 58 2 1296483408 5560128 6153904
14:37:31 9140 8192000000 10180706496 10600411136 1297119712 13.669 100 15 29 1 1305835744 5616880 3099152
14:38:42 12357 8192000000 10220299648 10635001856 1325312544 13.925 100 40 75 0 1339134784 4811424 9010816
14:39:57 43685 8192000000 10246529200 10660585472 1340503536 14.062 100 34 68 0 1356133728 8263376 7366816
14:41:45 22801 8192000000 10268633552 10685362176 1356719456 14.208 100 53 105 3 1385962704 17655248 11588000
14:43:14 36433 8192000000 10270441488 10699943936 1369679920 14.324 100 43 86 2 1395170240 15270096 10220224
14:45:00 22561 8192000000 10296150784 10721656832 1381126976 14.427 100 36 72 1 1409896880 20728992 8040912
14:46:26 20987 8192000000 10309122768 10731532288 1390571984 14.511 100 53 106 2 1421813376 18253616 12987776
14:47:54 4704 8192000000 10302344672 10726731776 1385874576 14.469 100 40 80 0 1416237792 20173424 10189792
14:49:02 6391 8192000000 10294363392 10711523328 1368572240 14.314 98 55 106 0 1403634848 22046240 13016368
14:50:13 16003 8192000000 10317448672 10744438784 1397949344 14.577 100 52 104 1 1435221536 24877616 12394576
14:51:39 1529 8192000000 10326157616 10736132096 1382625648 14.440 99 78 158 2 1430252704 28673120 18953936
14:52:44 2695 8192000000 10336754688 10745139200 1386272880 14.473 99 90 176 1 1438423680 31385776 20765024
14:53:53 4838 8192000000 10317546128 10725126144 1365310480 14.285 99 76 147 3 1416705904 33873952 17521472
14:55:04 3875 8192000000 10320407904 10722680832 1362969248 14.264 100 77 153 0 1423629664 42110464 18549952
14:56:15 3506 8192000000 10304820288 10712375296 1355816608 14.200 99 77 150 0 1408003968 34168320 18019040
14:57:27 2923 8192000000 10305510864 10709622784 1356603216 14.207 100 69 138 1 1402285600 29358288 16324096
14:58:39 6188 8192000000 10326658512 10730545152 1371724096 14.342 100 71 140 0 1424971984 36101824 17146064
14:59:50 3881 8192000000 10346130064 10752647168 1386224608 14.472 100 71 142 1 1444710512 40645552 17840352
15:01:00 10168 8192000000 10324971280 10741334016 1366657408 14.297 99 44 88 0 1422836256 43953440 12225408
15:02:22 3540 8192000000 10357891744 10763362304 1383813200 14.451 99 69 136 0 1448375200 46555120 18006880
15:03:30 6412 8192000000 10354415936 10774700032 1396962272 14.568 100 56 111 0 1458670496 46607904 15100320
15:04:43 11019 8192000000 10357486336 10781417472 1385306672 14.464 99 40 81 0 1451280880 54743072 11231136
15:05:56 9185 8192000000 10331158912 10761478144 1375838144 14.379 100 39 75 0 1434918544 47566944 11513456
15:07:08 9547 8192000000 10339865616 10771111936 1378943056 14.407 100 45 90 0 1444579856 52678288 12958512
15:08:23 64802 8192000000 10288741616 10743939072 1375125568 14.373 100 16 32 0 1417321584 38117568 4078448
15:10:37 53958 8192000000 10299344976 10749042688 1377644512 14.395 99 33 60 1 1393707264 9606672 6456080
15:14:00 72331 8192000000 10333228784 10770665472 1392913296 14.532 99 33 69 0 1419699120 19030144 7755680
15:16:18 94992 8192000000 10312383376 10759925760 1392934640 14.532 99 29 57 3 1417074352 17244048 6895664
15:19:08 62099 8192000000 10304283792 10761883648 1397984800 14.577 100 20 40 0 1411263120 8897520 4380800
15:21:16 24989 8192000000 10301028912 10758094848 1382855456 14.442 98 12 24 1 1394838592 9172784 2810352
15:22:41 31678 8192000000 10317904672 10771144704 1398045072 14.578 99 46 92 0 1423289632 14317872 10926688
15:24:19 14913 8192000000 10341825392 10788524032 1406484480 14.653 100 54 107 1 1444389856 25409424 12495952
15:25:41 26894 8192000000 10300346272 10758496256 1384405840 14.456 98 20 40 1 1400354464 11224416 4724208
15:27:17 43105 8192000000 10302810080 10767527936 1407148704 14.659 100 8 16 0 1417813408 8838272 1826432
15:29:02 53329 8192000000 10307925504 10779566080 1387547520 14.484 98 14 28 0 1399659104 8854912 3256672
15:30:57 66724 8192000000 10308926240 10784911360 1398421680 14.581 99 8 16 0 1418509664 18361664 1726320
15:33:21 82672 8192000000 10292015776 10762104832 1383836656 14.451 99 14 28 0 1402326912 15472848 3017408
15:35:49 27034 8192000000 10270738352 10728386560 1362847216 14.263 99 31 59 3 1375801968 5942768 7011984
15:37:20 61796 8192000000 10267516720 10736607232 1354539776 14.188 98 3 6 0 1363664112 8397120 727216
15:39:24 59748 8192000000 10260506944 10734538752 1346363344 14.115 98 11 22 0 1362647856 13718816 2565696
15:41:48 11305 8192000000 10269469424 10715926528 1357716592 14.217 100 32 64 0 1373658880 9126528 6815760
15:43:02 21173 8192000000 10273266992 10714963968 1347413072 14.124 99 37 74 0 1367774288 11615728 8745488
15:44:28 76902 8192000000 10239608672 10689138688 1279072704 13.505 94 14 28 0 1297434608 15556288 2805616
15:46:46 36325 8192000000 10264397712 10712485888 1322947552 13.903 97 28 54 0 1348246432 19135264 6163616
15:48:27 17831 8192000000 10256626352 10697900032 1337163360 14.032 99 35 72 1 1357354768 12019728 8171680
15:49:50 11775 8192000000 10254733072 10687492096 1329134624 13.959 99 48 95 0 1349231632 9609264 10487744
15:51:04 63067 8192000000 10266036960 10722111488 1335132560 14.014 98 15 30 0 1361748800 23077856 3538384
15:53:07 112349 8192000000 10257732640 10699857920 1335822256 14.020 99 20 40 0 1360369152 19791712 4755184
15:56:13 30758 8192000000 10252168320 10703237120 1353032688 14.175 100 11 22 0 1364142400 9064000 2045712
15:57:57 67632 8192000000 10254709232 10720903168 1352390064 14.169 99 12 23 0 1367204320 12304752 2509504
16:00:05 64079 8192000000 10268203280 10714845184 1338105872 14.040 98 16 32 0 1355136944 13177152 3853920
16:02:19 60121 8192000000 10289749376 10745118720 1380837584 14.424 100 16 32 0 1404184608 18986992 4360032
16:04:30 74057 8192000000 10284916288 10743275520 1363887344 14.272 99 16 32 0 1380438480 13045456 3505680
16:06:45 60697 8192000000 10288862304 10738307072 1373449936 14.358 99 21 42 0 1392856112 14506624 4899552
16:08:48 67836 8192000000 10304813856 10759778304 1395244112 14.553 100 13 26 0 1408160848 10158512 2758224
16:10:56 129993 8192000000 10312923936 10774044672 1352863424 14.173 96 16 32 0 1367794240 11995904 2934912
16:14:07 65005 8192000000 10312092912 10778664960 1357251136 14.213 96 25 49 0 1375622560 12295264 6076160
16:16:12 67180 8192000000 10310298480 10762342400 1390146640 14.507 99 12 24 0 1403917856 11435968 2335248
16:18:24 82001 8192000000 10305001936 10762776576 1402299040 14.615 100 22 44 0 1418246144 10892784 5054320
16:20:50 77303 8192000000 10306653744 10778230784 1392966208 14.532 99 19 37 0 1412909984 16107120 3836656
16:23:07 54832 8192000000 10297485808 10767650816 1381900496 14.434 98 5 10 0 1392928464 9834416 1193552
16:25:18 44467 8192000000 10291127968 10745040896 1354277312 14.186 96 16 33 0 1369011488 10718400 4015776
16:27:32 56346 8192000000 10297336640 10757607424 1366201392 14.293 98 19 38 0 1387761744 17240560 4319792
16:29:34 73712 8192000000 10259462848 10716356608 1305346688 13.744 95 7 14 0 1317086896 10258864 1481344
16:31:56 72877 8192000000 10256713632 10708541440 1274703584 13.465 93 18 36 0 1289921856 11082112 4136160
16:34:09 63833 8192000000 10225378112 10670673920 1251409552 13.251 93 13 26 0 1263415904 9404496 2601856
16:36:14 47068 8192000000 10262344528 10695110656 1295883392 13.658 96 36 72 0 1316766448 13406160 7476896
16:38:36 14072 8192000000 8985991488 9183096832 151762320 1.818 12 3 6 0 156197712 3959184 476208

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 10-01-2023 16:39:40 to 10-01-2023 16:39:55.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 153 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 10-01-2023 16:39:56 to 10-01-2023 16:39:58.

Content of mon$database and FB version

MON$DATABASE_NAME               /home/bases/oltp30-etalone.fdb
MON$PAGE_SIZE                   8192
MON$ODS_MAJOR                   12
MON$ODS_MINOR                   0
MON$OLDEST_TRANSACTION          245612
MON$OLDEST_ACTIVE               245613
MON$OLDEST_SNAPSHOT             245613
MON$NEXT_TRANSACTION            245613
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-03 16:41:55.3470
MON$PAGES                       2051808
MON$STAT_ID                     1
MON$BACKUP_STATE                0
MON$CRYPT_PAGE                  0
MON$OWNER                       SYSDBA                                                                                       
MON$SEC_DATABASE                Default


ISQL Version: LI-V3.0.11.33652 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33652 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33652 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33652 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
on disk structure version 12.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-oltp30 according to config parameter 'remove_isql_logs'

10.01.23 16:40:00. There are 3 logs in /var/tmp/logs-oltp30 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-10 16:40:02 No severe PSQL-related problems occured
10.01.23 16:40:03. End of report.