Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 25.12.2022 19: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 15119276 kB
MemAvailable 30099888 kB
Buffers 0 kB
Cached 16605908 kB
SwapCached 3220 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 2022-12-25 19:38:36
DTS_END                         2022-12-25 19:38:36.3800
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(57:17)
IP                              ::1/49702
TRN_ID                          231599
ATT_ID                          581
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: 9120.56 19578 1094467
customer order: creation 160.63 390 19276
customer order: refuse 14.11 374 1693
order to supplier: creation 42.76 1281 5131
order to supplier: removal 3.41 115568 409
invoice (draft): creation 44.21 3371 5305
invoice (draft): removal 54.08 824 6489
invoice accept: apply 39.47 19418 4736
invoice accept: cancel 48.83 744 5860
customer reserve: creation 3621.92 194 434630
customer reserve: removal 4810.40 64 577248
realization accept: apply 78.53 206 9423
realization accept: cancel 82.43 114 9891
payment from customer: creation 54.68 134 6561
payment from customer: removal 5.42 81 650
payment to supplier: creation 45.56 139 5467
payment to supplier: removal 3.11 117 373
service: total inventory turnovers 4.51 1044 541
service: total monetary turnovers 5.71 25 685
service: aggregate perf. data 0.79 21992 95
service: refresh index statistics 0.03 225489 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:03, from 25-12-2022 19:40:03 to 25-12-2022 19:40:06.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 4499
TEST_TIME 2 4246
TEST_TIME 3 3979
TEST_TIME 4 4108
TEST_TIME 5 4260
TEST_TIME 6 4190
TEST_TIME 7 4182
TEST_TIME 8 4644
TEST_TIME 9 4972
TEST_TIME 10 5090
TEST_TIME 11 5358
TEST_TIME 12 5402
TEST_TIME 13 5444
TEST_TIME 14 5530
TEST_TIME 15 5688
TEST_TIME 16 6340
TEST_TIME 17 6318
TEST_TIME 18 6647
TEST_TIME 19 6865
TEST_TIME 20 7335
TEST_TIME 21 7414
TEST_TIME 22 7538
TEST_TIME 23 8174
TEST_TIME 24 8614
TEST_TIME 25 9308
TEST_TIME 26 9391
TEST_TIME 27 10002
TEST_TIME 28 10642
TEST_TIME 29 10444
TEST_TIME 30 10330
TEST_TIME 31 10107
TEST_TIME 32 10174
TEST_TIME 33 9927
TEST_TIME 34 10053
TEST_TIME 35 9914
TEST_TIME 36 9948
TEST_TIME 37 9785
TEST_TIME 38 9757
TEST_TIME 39 9642
TEST_TIME 40 9512
TEST_TIME 41 9564
TEST_TIME 42 9565
TEST_TIME 43 9428
TEST_TIME 44 9338
TEST_TIME 45 9356
TEST_TIME 46 9260
TEST_TIME 47 9160
TEST_TIME 48 9162
TEST_TIME 49 9366
TEST_TIME 50 9419
TEST_TIME 51 9377
TEST_TIME 52 9372
TEST_TIME 53 9270
TEST_TIME 54 9401
TEST_TIME 55 9451
TEST_TIME 56 9505
TEST_TIME 57 9598
TEST_TIME 58 9574
TEST_TIME 59 9485
TEST_TIME 60 9620
TEST_TIME 61 9637
TEST_TIME 62 9585
TEST_TIME 63 9449
TEST_TIME 64 9395
TEST_TIME 65 9362
TEST_TIME 66 9360
TEST_TIME 67 9421
TEST_TIME 68 9388
TEST_TIME 69 9352
TEST_TIME 70 9282
TEST_TIME 71 9273
TEST_TIME 72 9206
TEST_TIME 73 9187
TEST_TIME 74 9247
TEST_TIME 75 9215
TEST_TIME 76 9161
TEST_TIME 77 9108
TEST_TIME 78 9176
TEST_TIME 79 9127
TEST_TIME 80 9158
TEST_TIME 81 9191
TEST_TIME 82 9217
TEST_TIME 83 9287
TEST_TIME 84 9334
TEST_TIME 85 9357
TEST_TIME 86 9334
TEST_TIME 87 9335
TEST_TIME 88 9378
TEST_TIME 89 9408
TEST_TIME 90 9438
TEST_TIME 91 9415
TEST_TIME 92 9321
TEST_TIME 93 9321
TEST_TIME 94 9267
TEST_TIME 95 9259
TEST_TIME 96 9281
TEST_TIME 97 9239
TEST_TIME 98 9218
TEST_TIME 99 9221
TEST_TIME 100 9208
TEST_TIME 101 9220
TEST_TIME 102 9200
TEST_TIME 103 9185
TEST_TIME 104 9162
TEST_TIME 105 9175
TEST_TIME 106 9275
TEST_TIME 107 9288
TEST_TIME 108 9273
TEST_TIME 109 9296
TEST_TIME 110 9306
TEST_TIME 111 9270
TEST_TIME 112 9364
TEST_TIME 113 9288
TEST_TIME 114 9213
TEST_TIME 115 9200
TEST_TIME 116 9152
TEST_TIME 117 9113
TEST_TIME 118 9115
TEST_TIME 119 9145
TEST_TIME 120 9121

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:04, from 25-12-2022 19:40:07 to 25-12-2022 19:40:11.

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 1498398 1498398 0 0.00 0 49255 6 0 0
doc_list_biud 1498398 1498398 0 0.00 0 19166 31 0 0
sp_add_invoice_to_stock 4835 4736 99 2.04 24 215064 19418 0 99
sp_cancel_adding_invoice 5860 5860 0 0.00 3 93641 744 0 0
sp_cancel_client_order 1693 1693 0 0.00 4 14796 374 0 0
sp_cancel_customer_reserve 577248 577248 0 0.00 0 18665 65 0 0
sp_cancel_pay_from_customer 650 650 0 0.00 3 6930 81 0 0
sp_cancel_pay_to_supplier 373 373 0 0.00 3 9745 118 0 0
sp_cancel_supplier_invoice 6497 6489 8 0.12 1 15209 825 0 8
sp_cancel_supplier_order 409 409 0 0.00 7 1116927 115569 0 0
sp_cancel_write_off 9891 9891 0 0.00 1 12495 115 0 0
sp_client_order 19276 19276 0 0.00 3 25493 391 0 0
sp_customer_reserve 434630 434630 0 0.00 0 119992 194 0 0
sp_fill_shopping_cart 29708 29708 0 0.00 1 15429 37 0 0
sp_fill_shopping_cart_clo_res 434629 434629 0 0.00 0 16862 15 0 0
sp_get_clo_for_invoice 4734 4734 0 0.00 0 34199 347 0 0
sp_kill_cost_storno 16774 16774 0 0.00 0 14622 56 0 0
sp_kill_qstorno_ret_qs2qd 1171285 1171285 0 0.00 0 18662 35 0 0
sp_kill_qty_storno 615747 615747 0 0.00 0 19156 74 0 0
sp_lock_selected_doc 19678 19678 0 0.00 0 6511 6 0 0
sp_make_cost_storno 26185 26185 0 0.00 0 30460 69 0 0
sp_multiply_rows_for_pdistr 26185 26185 0 0.00 0 20432 35 0 0
sp_multiply_rows_for_qdistr 19276 19276 0 0.00 0 11866 163 0 0
sp_pay_from_customer 6561 6561 0 0.00 4 20458 135 0 0
sp_pay_to_supplier 5467 5467 0 0.00 4 13414 140 0 0
sp_payment_common 12028 12028 0 0.00 1 18057 35 0 0
sp_qd_handle_on_cancel_clo 1693 1693 0 0.00 0 14789 330 0 0
sp_qd_handle_on_invoice_upd_sts 10594 10594 0 0.00 0 19148 321 0 0
sp_qd_handle_on_reserve_upd_sts 9423 9423 0 0.00 0 12859 59 0 0
sp_reserve_write_off 9423 9423 0 0.00 6 20458 206 0 0
sp_supplier_invoice 5305 5305 0 0.00 7 73968 3372 0 0
sp_supplier_order 5131 5131 0 0.00 5 36160 1281 0 0
srv_aggregate_perf_data 95 95 0 0.00 2325 421062 21992 0 0
srv_fill_mon_cache_memory 64 64 0 0.00 1337 177553 45935 0 0
srv_find_qd_qs_mism 1050549 1050549 0 0.00 0 14050 5 0 0
srv_make_invnt_saldo 541 541 0 0.00 37 36428 1045 0 0
srv_make_money_saldo 685 685 0 0.00 1 938 25 0 0
srv_recalc_idx_stat 4 4 0 0.00 158936 266096 225489 0 0
t$perf-abend:sp_add_invoice_to_stock 99 99 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 8 8 0 0.00 0 0 0 0 0
t$perf-norm:sp_add_invoice_to_stock 4736 4736 0 0.00 0 12320 164 0 0
t$perf-norm:sp_cancel_adding_invoice 386 386 0 0.00 1 11402 109 0 0
t$perf-norm:sp_cancel_client_order 1693 1693 0 0.00 0 2503 12 0 0
t$perf-norm:sp_cancel_customer_reserve 706 706 0 0.00 0 981 7 0 0
t$perf-norm:sp_cancel_pay_from_customer 650 650 0 0.00 0 3581 11 0 0
t$perf-norm:sp_cancel_pay_to_supplier 373 373 0 0.00 0 929 4 0 0
t$perf-norm:sp_cancel_supplier_invoice 362 362 0 0.00 0 479 11 0 0
t$perf-norm:sp_cancel_supplier_order 409 409 0 0.00 0 31030 1699 0 0
t$perf-norm:sp_cancel_write_off 943 943 0 0.00 0 6524 14 0 0
t$perf-norm:sp_client_order 19276 19276 0 0.00 0 10526 17 0 0
t$perf-norm:sp_customer_reserve 905 905 0 0.00 0 6349 16 0 0
t$perf-norm:sp_pay_from_customer 6561 6561 0 0.00 0 5256 9 0 0
t$perf-norm:sp_pay_to_supplier 5467 5467 0 0.00 0 7739 11 0 0
t$perf-norm:sp_reserve_write_off 9423 9423 0 0.00 0 8146 19 0 0
t$perf-norm:sp_supplier_invoice 5305 5305 0 0.00 0 5220 15 0 0
t$perf-norm:sp_supplier_order 5131 5131 0 0.00 0 3673 15 0 0
t$perf-norm:srv_aggregate_perf_data 95 95 0 0.00 0 317 5 0 0
t$perf-norm:srv_fill_mon_cache_memory 64 64 0 0.00 0 428 7 0 0
t$perf-norm:srv_make_invnt_saldo 541 541 0 0.00 0 574 13 0 0
t$perf-norm:srv_make_money_saldo 685 685 0 0.00 0 2501 23 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 2 3 3 0 0
v_add_invoice_to_stock 9666 9468 198 2.04 0 9048 23 0 198
v_all_customers 34966 34966 0 0.00 0 15 0 0 0
v_all_suppliers 28772 28772 0 0.00 0 30 1 0 0
v_all_wares 38550 38550 0 0.00 0 56 1 0 0
v_cancel_adding_invoice 772 772 0 0.00 0 2976 10 0 0
v_cancel_client_order 3386 3386 0 0.00 0 7220 16 0 0
v_cancel_customer_prepayment 1300 1300 0 0.00 0 6671 13 0 0
v_cancel_customer_reserve 1412 1412 0 0.00 0 4590 20 0 0
v_cancel_payment_to_supplier 746 746 0 0.00 0 9461 19 0 0
v_cancel_supplier_invoice 740 724 16 2.16 0 2835 21 0 16
v_cancel_supplier_order 818 818 0 0.00 0 6543 23 0 0
v_cancel_write_off 1886 1886 0 0.00 0 5933 28 0 0
v_max_id_clo_ord 5130 5130 0 0.00 0 1066 2 0 0
v_max_id_clo_res 905 905 0 0.00 0 3142 13 0 0
v_max_id_ord_sup 5303 5303 0 0.00 0 6879 7 0 0
v_max_non_paid_invoice 1514 1514 0 0.00 0 3574 6 0 0
v_max_non_paid_realizn 3499 3499 0 0.00 0 3362 6 0 0
v_min_id_clo_ord 5130 5130 0 0.00 0 2855 6 0 0
v_min_id_clo_res 905 905 0 0.00 0 4362 10 0 0
v_min_id_ord_sup 5303 5303 0 0.00 0 4839 7 0 0
v_min_non_paid_invoice 5467 5467 0 0.00 0 5849 22 0 0
v_min_non_paid_realizn 6561 6561 0 0.00 0 18051 30 0 0
v_our_firm 9708 9708 0 0.00 0 16 1 0 0
v_reserve_write_off 18844 18844 0 0.00 0 6731 8 0 0
x_lock_depdocs_on_canc_invoice 11987 11987 0 0.00 0 20049 125 0 0
x_lock_depdocs_on_canc_sup_ord 409 409 0 0.00 0 23622 509 0 0
x_make_qstorno_1000_1200 5131 5131 0 0.00 1 36131 1212 0 0
x_make_qstorno_1200_2000 5305 5305 0 0.00 3 72691 3234 0 0
x_make_qstorno_2100_3300 434630 434630 0 0.00 0 119992 177 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 25-12-2022 19:40:12 to 25-12-2022 19:40:16.

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
17:08:40 1 8192000000 8797116400 8807743488 3955424 0.048 1 1 2 0 4053696 55488 42784
17:09:42 35139 8192000000 9908237072 10220818432 994233136 10.823 100 91 182 0 1024850336 6307296 24309904
17:11:29 18965 8192000000 9956072864 10277740544 1038029792 11.246 100 88 176 0 1069329344 9021552 22278000
17:12:54 6889 8192000000 9976015120 10305826816 1060139360 11.458 100 81 162 0 1090254288 9977952 20136976
17:14:04 8963 8192000000 10031468816 10377682944 1110323968 11.935 100 88 175 1 1142706496 11443824 20938704
17:15:20 5385 8192000000 10076675216 10433867776 1163667008 12.438 100 84 168 0 1195243184 11690432 19885744
17:16:28 2467 8192000000 10124114032 10494992384 1213382160 12.900 100 80 160 1 1244274368 13041392 17850816
17:17:33 2584 8192000000 10157624944 10534219776 1247104608 13.212 100 80 158 0 1277518000 13743792 16669600
17:18:38 1839 8192000000 10195056096 10576199680 1278606448 13.500 100 88 171 2 1310389344 12609312 19173584
17:19:43 1203 8192000000 10214870736 10603233280 1301590976 13.710 100 89 176 0 1333646704 13097328 18958400
17:20:45 972 8192000000 10214660608 10610302976 1305687600 13.747 100 76 152 1 1332457760 9487328 17282832
17:21:47 4724 8192000000 10209706368 10620248064 1318186432 13.860 100 37 73 2 1333944848 6840160 8918256
17:22:52 9720 8192000000 10218933232 10634436608 1327500240 13.945 100 24 48 0 1338971568 5922272 5549056
17:24:02 20472 8192000000 10221562880 10635104256 1330726656 13.974 100 22 42 2 1341221936 5419696 5075584
17:25:27 29087 8192000000 10223047584 10641555456 1320054080 13.877 99 18 36 0 1329238768 5360688 3824000
17:26:58 4181 8192000000 10232318192 10649866240 1333930512 14.003 100 32 64 0 1347411632 6563952 6917168
17:28:03 7102 8192000000 10199087584 10616283136 1286751312 13.575 97 19 38 0 1296042128 4956048 4334768
17:29:13 60777 8192000000 10192318176 10606100480 1251719472 13.254 95 22 44 0 1262020096 5608032 4692592
17:31:18 6206 8192000000 10142101968 10548228096 1241683056 13.162 98 33 66 0 1255894704 6180496 8031152
17:32:25 5154 8192000000 10152634128 10547957760 1241167216 13.157 98 25 48 2 1252262240 5615376 5479648
17:33:37 27249 8192000000 10162125536 10570997760 1271027088 13.431 100 37 74 1 1285252416 4484944 9740384
17:35:42 6855 8192000000 10184807408 10593558528 1290616320 13.610 100 26 53 0 1302270336 5521104 6132912
17:36:49 8936 8192000000 10189727792 10606710784 1298478896 13.681 100 19 39 1 1311938112 9111984 4347232
17:37:59 10604 8192000000 10211921408 10628112384 1314298112 13.825 100 16 32 1 1327146352 9311264 3536976
17:39:14 36951 8192000000 10247314880 10656354304 1324241104 13.915 99 36 73 1 1337768016 5693152 7833760
17:40:57 25285 8192000000 10256566752 10676711424 1354375008 14.187 100 43 84 1 1374367120 10303152 9688960
17:42:28 16394 8192000000 10271868192 10693877760 1367531760 14.305 100 39 78 0 1388668208 11633056 9503392
17:43:52 13332 8192000000 10290385936 10713604096 1377531344 14.394 100 44 87 1 1404437408 16893408 10012656
17:45:10 8899 8192000000 10305607536 10728718336 1391921872 14.523 100 36 69 1 1418559088 17304720 9332496
17:46:23 5420 8192000000 10323071968 10748137472 1400584672 14.600 100 51 102 0 1436275536 22272944 13417920
17:47:34 11346 8192000000 10344376992 10769072128 1419516624 14.768 100 54 105 0 1458740576 27239392 11984560
17:48:50 2417 8192000000 10355163984 10770141184 1412471296 14.706 100 72 142 0 1460041792 30989312 16581184
17:49:56 1332 8192000000 10347567248 10760011776 1404211104 14.632 99 79 157 2 1457495408 33899504 19384800
17:51:02 5553 8192000000 10365498160 10783137792 1414278176 14.722 100 64 126 0 1473552192 43544896 15729120
17:52:19 3963 8192000000 10377898976 10790842368 1399110384 14.587 98 85 164 0 1470877296 51116880 20650032
17:53:27 4101 8192000000 10368612368 10781749248 1403722112 14.628 100 63 126 1 1476794832 56484896 16587824
17:54:35 9661 8192000000 10368273296 10787909632 1415438128 14.732 100 58 116 2 1479780944 48664800 15678016
17:55:53 3644 8192000000 10358856352 10777423872 1396154320 14.561 100 62 120 0 1465542864 53489472 15899072
17:57:06 5316 8192000000 10381654896 10792808448 1407895488 14.665 100 70 138 0 1484760352 58570224 18294640
17:58:22 4297 8192000000 10363815664 10779947008 1387402944 14.483 99 66 131 1 1457386064 52129760 17853360
17:59:29 18147 8192000000 10362912672 10781999104 1390932384 14.514 99 44 87 2 1459748784 56645392 12171008
18:01:00 11495 8192000000 10374505424 10804301824 1402939200 14.621 100 46 93 0 1481415424 65871968 12604256
18:02:16 17545 8192000000 10348842160 10775539712 1358278608 14.222 97 42 82 0 1430119424 59700736 12140080
18:03:44 33251 8192000000 10299606192 10735648768 1347017008 14.121 98 25 50 0 1396001792 42171728 6813056
18:05:21 32471 8192000000 10298429328 10738479104 1350240992 14.150 99 17 34 0 1405138992 49570016 5327984
18:07:03 51595 8192000000 10252367760 10671808512 1292304160 13.625 96 64 120 0 1315060240 9276608 13479472
18:08:58 40194 8192000000 10281727072 10715406336 1347835536 14.128 99 34 68 2 1370926048 15186928 7903584
18:10:38 42449 8192000000 10285255024 10731966464 1358873712 14.227 99 9 18 0 1378070352 17217792 1978848
18:12:30 83747 8192000000 10266716736 10712248320 1358118384 14.220 99 27 52 0 1381045408 16689664 6237360
18:14:55 177552 8192000000 10290458752 10753347584 1378511520 14.403 99 10 20 1 1396154992 15026160 2617312
18:18:52 77974 8192000000 10300068432 10741157888 1365212752 14.284 98 30 60 1 1385139408 12654832 7271824
18:21:13 48195 8192000000 10282744528 10736730112 1386791040 14.477 100 29 55 0 1403212560 9818288 6603232
18:23:06 27974 8192000000 10305429056 10757271552 1397852208 14.576 100 44 88 0 1426414720 17113456 11449056
18:24:46 46067 8192000000 10303313456 10759680000 1387733104 14.486 99 15 30 0 1408335632 17190016 3412512
18:26:35 46364 8192000000 10309191504 10764800000 1387916448 14.487 99 19 39 0 1405950064 13433856 4599760
18:28:26 76457 8192000000 10312554144 10768490496 1402817792 14.620 100 18 38 0 1419386240 12493584 4074864
18:30:52 64039 8192000000 10331937616 10778136576 1401124416 14.605 99 24 48 1 1420467472 13834912 5508144
18:33:00 64280 8192000000 10328330016 10782806016 1418393264 14.758 100 12 25 0 1435118768 14105104 2620400
18:35:07 79667 8192000000 10323445760 10787172352 1405681408 14.646 99 4 8 0 1421474016 14892160 900448
18:37:37 31123 8192000000 10317138288 10763038720 1384426640 14.456 98 28 56 0 1405112112 14257392 6428080
18:39:19 57087 8192000000 10304089216 10746499072 1356673488 14.207 97 21 42 0 1373214816 12369744 4171584
18:41:16 61928 8192000000 10281963072 10719608832 1357240688 14.213 98 39 78 0 1378241456 12344416 8656352
18:43:53 35743 8192000000 10301047616 10748268544 1379712976 14.414 99 33 66 0 1401193920 14100240 7380704
18:45:30 66463 8192000000 10292880544 10752208896 1381961936 14.434 99 12 24 0 1398887264 14166896 2758432
18:47:37 87128 8192000000 10272766976 10724233216 1310135280 13.787 94 9 18 0 1323998112 11912928 1949904
18:50:12 93136 8192000000 10256272608 10712973312 1339259632 14.051 98 16 32 0 1357085808 13996512 3829664
18:52:51 30769 8192000000 10245599344 10700476416 1332124864 13.986 98 23 46 1 1347198432 9839120 5234448
18:54:22 71110 8192000000 10264109392 10716942336 1342112544 14.076 98 11 22 0 1360789632 15448128 3228960
18:56:36 74789 8192000000 10273256992 10722689024 1340215184 14.059 98 11 22 0 1354493920 12026912 2251824
18:59:05 59282 8192000000 10251224320 10709532672 1298214976 13.679 95 16 32 0 1318189984 16314224 3660784
19:01:09 64920 8192000000 10258216288 10702471168 1304124464 13.733 97 12 24 0 1325169568 18509712 2535392
19:03:16 90037 8192000000 10264939920 10696478720 1286486592 13.572 95 25 50 0 1302001600 10002240 5512768
19:05:56 15496 8192000000 10269917984 10704228352 1345907600 14.111 100 34 68 0 1363674448 10457360 7309488
19:07:14 52835 8192000000 10274513520 10713890816 1327906832 13.948 98 21 40 0 1343263584 11031120 4325632
19:09:11 95000 8192000000 10272397936 10705137664 1340679792 14.064 98 28 56 1 1355537856 8736176 6121888
19:11:55 23389 8192000000 10272363776 10716999680 1369615888 14.324 100 40 73 1 1385998256 7929008 8453360
19:13:24 76591 8192000000 10273698096 10746793984 1365356400 14.285 99 15 30 0 1386742448 17768656 3617392
19:15:42 49577 8192000000 10276114144 10728116224 1358595008 14.225 98 10 21 0 1370759408 10094640 2069760
19:17:32 71788 8192000000 10291511936 10763124736 1385324400 14.464 100 13 25 0 1402878288 14806656 2747232
19:19:44 76053 8192000000 10314409648 10763653120 1389849008 14.505 99 19 39 0 1401326416 7106000 4371408
19:22:08 27639 8192000000 10325246608 10770604032 1405980384 14.648 100 44 88 0 1427403792 11136640 10286768
19:23:39 83802 8192000000 10314651088 10792980480 1393960400 14.541 99 15 30 0 1415345472 17881312 3503760
19:26:35 60594 8192000000 10317468816 10769256448 1375437120 14.376 98 19 38 0 1397202672 17594576 4170976
19:28:38 53913 8192000000 10301254128 10740822016 1341521808 14.071 96 34 68 1 1362342864 13452048 7369008
19:30:32 90994 8192000000 10290621568 10753482752 1376462848 14.385 100 8 16 0 1398297280 20270336 1564096
19:33:12 11750 8192000000 10273691296 10711736320 1349340144 14.142 98 43 87 3 1368426016 9468912 9616960
19:34:42 62530 8192000000 10285198096 10743840768 1380818464 14.424 100 11 22 0 1400771600 17450400 2502736
19:36:46 66878 8192000000 10277821200 10735796224 1328120480 13.950 96 8 16 1 1346918240 16815536 1982224

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:15, from 25-12-2022 19:40:18 to 25-12-2022 19:40:33.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 99 v_add_invoice_to_stock 335544517
except 8 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 25-12-2022 19:40:34 to 25-12-2022 19:40:36.

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          230842
MON$OLDEST_ACTIVE               231739
MON$OLDEST_SNAPSHOT             231739
MON$NEXT_TRANSACTION            231739
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                       2019904
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.33650 Firebird 3.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V3.0.11.33650 Firebird 3.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V3.0.11.33650 Firebird 3.0/tcp (mscs-test-161.budzdorov.ru)/P15:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V3.0.11.33650 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'

25.12.22 19:40:37. 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
2022-12-25 19:40:39 No severe PSQL-related problems occured
25.12.22 19:40:41. End of report.