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

Hardware and OS info

Command: hostnamectl
Static hostname mscs-test-161.budzdorov.ru
Icon name computer-server
Chassis server
Machine ID aeee285d2cca40bf84c40a748f599e77
Boot ID 2a7b53d1c5ed44b9bb2712fffac5d8c6
Operating System CentOS Linux 7 (Core)
CPE OS Name cpe:/o:centos:centos:7
Kernel Linux 3.10.0-1127.10.1.el7.x86_64
Architecture x86-64
Command: who -b
bootup_info system boot 2021-11-11 18:28
Command: dmidecode -t system|grep -i -e 'manufacturer\|product\|hypervisor'
Manufacturer HP
Product Name ProLiant DL380 Gen9
Command: dmesg | grep DMI
[ 0.000000] DMI HP ProLiant DL380 Gen9/ProLiant DL380 Gen9, BIOS P89 05/21/2018
Command: lscpu | grep -i -v flags
Architecture x86_64
CPU op-mode(s) 32-bit, 64-bit
Byte Order Little Endian
CPU(s) 24
On-line CPU(s) list 0-23
Thread(s) per core 2
Core(s) per socket 6
Socket(s) 2
NUMA node(s) 2
Vendor ID GenuineIntel
CPU family 6
Model 63
Model name Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Stepping 2
CPU MHz 1200.000
CPU max MHz 2400.0000
CPU min MHz 1200.0000
BogoMIPS 4794.33
Virtualization VT-x
L1d cache 32K
L1i cache 32K
L2 cache 256K
L3 cache 15360K
NUMA node0 CPU(s) 0-5,12-17
NUMA node1 CPU(s) 6-11,18-23
Command: cat /proc/meminfo | grep -i -e 'memtotal\|memfree\|memavail\|buffers\|cached\|swapcached'
MemTotal 32643792 kB
MemFree 15238964 kB
MemAvailable 30435896 kB
Buffers 0 kB
Cached 16455192 kB
SwapCached 3308 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-17 10:37:25
DTS_END                         2023-02-17 10:37:25.4030
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/40728
TRN_ID                          218612
ATT_ID                          602
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: 9157.08 19810 1098850
customer order: creation 172.92 463 20750
customer order: refuse 14.63 362 1755
order to supplier: creation 46.20 1281 5544
order to supplier: removal 3.46 138940 415
invoice (draft): creation 45.03 3066 5403
invoice (draft): removal 50.28 885 6034
invoice accept: apply 41.84 25612 5021
invoice accept: cancel 45.86 1073 5503
customer reserve: creation 3933.53 243 472023
customer reserve: removal 4514.35 83 541722
realization accept: apply 83.03 263 9963
realization accept: cancel 77.94 154 9353
payment from customer: creation 58.65 176 7038
payment from customer: removal 5.55 119 666
payment to supplier: creation 47.83 192 5740
payment to supplier: removal 3.50 138 420
service: total inventory turnovers 4.14 3485 497
service: total monetary turnovers 7.34 356 881
service: aggregate perf. data 0.98 14359 118
service: refresh index statistics 0.03 204956 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 17-02-2023 10:38:47 to 17-02-2023 10:38:49.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5667
TEST_TIME 2 5532
TEST_TIME 3 5553
TEST_TIME 4 5538
TEST_TIME 5 5802
TEST_TIME 6 6069
TEST_TIME 7 5989
TEST_TIME 8 6267
TEST_TIME 9 6300
TEST_TIME 10 6237
TEST_TIME 11 6559
TEST_TIME 12 6958
TEST_TIME 13 6944
TEST_TIME 14 7102
TEST_TIME 15 7318
TEST_TIME 16 7322
TEST_TIME 17 7434
TEST_TIME 18 7590
TEST_TIME 19 7636
TEST_TIME 20 8027
TEST_TIME 21 8347
TEST_TIME 22 8637
TEST_TIME 23 8884
TEST_TIME 24 8855
TEST_TIME 25 8958
TEST_TIME 26 9307
TEST_TIME 27 9944
TEST_TIME 28 10246
TEST_TIME 29 10530
TEST_TIME 30 10995
TEST_TIME 31 11028
TEST_TIME 32 10820
TEST_TIME 33 10939
TEST_TIME 34 10851
TEST_TIME 35 10638
TEST_TIME 36 10425
TEST_TIME 37 10634
TEST_TIME 38 10404
TEST_TIME 39 10251
TEST_TIME 40 10262
TEST_TIME 41 10296
TEST_TIME 42 10193
TEST_TIME 43 10263
TEST_TIME 44 10113
TEST_TIME 45 10067
TEST_TIME 46 9994
TEST_TIME 47 9890
TEST_TIME 48 9958
TEST_TIME 49 9945
TEST_TIME 50 9922
TEST_TIME 51 9814
TEST_TIME 52 9762
TEST_TIME 53 9669
TEST_TIME 54 9684
TEST_TIME 55 9664
TEST_TIME 56 9653
TEST_TIME 57 9756
TEST_TIME 58 9757
TEST_TIME 59 9703
TEST_TIME 60 9720
TEST_TIME 61 9871
TEST_TIME 62 9864
TEST_TIME 63 9928
TEST_TIME 64 10094
TEST_TIME 65 9988
TEST_TIME 66 9934
TEST_TIME 67 9922
TEST_TIME 68 9943
TEST_TIME 69 9876
TEST_TIME 70 9853
TEST_TIME 71 9781
TEST_TIME 72 9773
TEST_TIME 73 9680
TEST_TIME 74 9594
TEST_TIME 75 9582
TEST_TIME 76 9557
TEST_TIME 77 9540
TEST_TIME 78 9534
TEST_TIME 79 9493
TEST_TIME 80 9477
TEST_TIME 81 9467
TEST_TIME 82 9539
TEST_TIME 83 9504
TEST_TIME 84 9539
TEST_TIME 85 9535
TEST_TIME 86 9559
TEST_TIME 87 9577
TEST_TIME 88 9661
TEST_TIME 89 9657
TEST_TIME 90 9560
TEST_TIME 91 9477
TEST_TIME 92 9468
TEST_TIME 93 9470
TEST_TIME 94 9441
TEST_TIME 95 9396
TEST_TIME 96 9401
TEST_TIME 97 9382
TEST_TIME 98 9351
TEST_TIME 99 9382
TEST_TIME 100 9378
TEST_TIME 101 9355
TEST_TIME 102 9330
TEST_TIME 103 9323
TEST_TIME 104 9340
TEST_TIME 105 9422
TEST_TIME 106 9445
TEST_TIME 107 9416
TEST_TIME 108 9412
TEST_TIME 109 9465
TEST_TIME 110 9425
TEST_TIME 111 9372
TEST_TIME 112 9341
TEST_TIME 113 9305
TEST_TIME 114 9287
TEST_TIME 115 9248
TEST_TIME 116 9231
TEST_TIME 117 9223
TEST_TIME 118 9222
TEST_TIME 119 9238
TEST_TIME 120 9180

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 17-02-2023 10:38:51 to 17-02-2023 10:38:54.

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 1532714 1532714 0 0.00 0 23013 13 0 0
doc_list_biud 1532697 1532697 0 0.00 0 75706 35 0 0
sp_add_invoice_to_stock 5150 5021 129 2.50 63 218650 25613 0 129
sp_cancel_adding_invoice 5503 5503 0 0.00 6 67716 1074 0 0
sp_cancel_client_order 1755 1755 0 0.00 5 10036 363 0 0
sp_cancel_customer_reserve 541722 541722 0 0.00 1 57428 84 0 0
sp_cancel_pay_from_customer 666 666 0 0.00 4 6737 120 0 0
sp_cancel_pay_to_supplier 420 420 0 0.00 4 5090 138 0 0
sp_cancel_supplier_invoice 6045 6034 11 0.18 2 75721 886 0 11
sp_cancel_supplier_order 415 415 0 0.00 8 1355827 138941 0 0
sp_cancel_write_off 9353 9353 0 0.00 2 14570 155 0 0
sp_client_order 20750 20750 0 0.00 5 29640 464 0 0
sp_customer_reserve 472023 472023 0 0.00 0 71126 244 0 0
sp_fill_shopping_cart 31679 31679 0 0.00 1 15680 81 0 0
sp_fill_shopping_cart_clo_res 471989 471989 0 0.00 0 36068 18 0 0
sp_get_clo_for_invoice 4984 4984 0 0.00 0 23420 299 0 0
sp_kill_cost_storno 15942 15942 0 0.00 0 9372 67 0 0
sp_kill_qstorno_ret_qs2qd 1099246 1099246 0 0.00 0 75701 37 0 0
sp_kill_qty_storno 579724 579724 0 0.00 0 75704 85 0 0
sp_lock_selected_doc 20716 20716 0 0.00 0 5820 7 0 0
sp_make_cost_storno 27724 27724 0 0.00 0 19860 79 0 0
sp_multiply_rows_for_pdistr 27718 27718 0 0.00 0 11324 38 0 0
sp_multiply_rows_for_qdistr 20750 20750 0 0.00 0 15254 183 0 0
sp_pay_from_customer 7038 7038 0 0.00 5 22812 176 0 0
sp_pay_to_supplier 5740 5740 0 0.00 6 24293 193 0 0
sp_payment_common 12775 12775 0 0.00 2 7991 41 0 0
sp_qd_handle_on_cancel_clo 1755 1755 0 0.00 0 9891 289 0 0
sp_qd_handle_on_invoice_upd_sts 10485 10485 0 0.00 0 35220 452 0 0
sp_qd_handle_on_reserve_upd_sts 9960 9960 0 0.00 0 17144 59 0 0
sp_reserve_write_off 9963 9963 0 0.00 7 21623 264 0 0
sp_supplier_invoice 5403 5403 0 0.00 10 96685 3067 0 0
sp_supplier_order 5544 5544 0 0.00 7 22578 1282 0 0
srv_aggregate_perf_data 119 118 1 0.84 2691 120787 14360 0 1
srv_fill_mon_cache_memory 67 67 0 0.00 801 144115 37971 0 0
srv_find_qd_qs_mism 1049300 1049300 0 0.00 0 17352 10 0 0
srv_make_invnt_saldo 497 497 0 0.00 56 58806 3486 0 0
srv_make_money_saldo 881 881 0 0.00 1 16632 356 0 0
srv_recalc_idx_stat 4 4 0 0.00 30087 389853 204957 0 0
t$perf-abend:sp_add_invoice_to_stock 129 129 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 11 11 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 5025 5025 0 0.00 0 16370 861 0 0
t$perf-norm:sp_cancel_adding_invoice 435 435 0 0.00 1 6675 448 0 0
t$perf-norm:sp_cancel_client_order 1755 1755 0 0.00 0 4044 31 0 0
t$perf-norm:sp_cancel_customer_reserve 728 728 0 0.00 0 10709 41 0 0
t$perf-norm:sp_cancel_pay_from_customer 666 666 0 0.00 0 4631 20 0 0
t$perf-norm:sp_cancel_pay_to_supplier 420 420 0 0.00 0 10598 46 0 0
t$perf-norm:sp_cancel_supplier_invoice 382 382 0 0.00 0 986 29 0 0
t$perf-norm:sp_cancel_supplier_order 415 415 0 0.00 0 101065 5608 0 0
t$perf-norm:sp_cancel_write_off 974 974 0 0.00 0 10763 30 0 0
t$perf-norm:sp_client_order 20750 20750 0 0.00 0 16511 35 0 0
t$perf-norm:sp_customer_reserve 1004 1004 0 0.00 0 2621 20 0 0
t$perf-norm:sp_pay_from_customer 7038 7038 0 0.00 0 7209 23 0 0
t$perf-norm:sp_pay_to_supplier 5740 5740 0 0.00 0 10648 25 0 0
t$perf-norm:sp_reserve_write_off 9963 9963 0 0.00 0 16139 25 0 0
t$perf-norm:sp_supplier_invoice 5403 5403 0 0.00 0 8175 29 0 0
t$perf-norm:sp_supplier_order 5544 5544 0 0.00 0 16395 33 0 0
t$perf-norm:srv_aggregate_perf_data 118 118 0 0.00 0 477 19 0 0
t$perf-norm:srv_fill_mon_cache_memory 67 67 0 0.00 0 251 13 0 0
t$perf-norm:srv_make_invnt_saldo 497 497 0 0.00 0 656 10 0 0
t$perf-norm:srv_make_money_saldo 881 881 0 0.00 0 15387 22 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 19 176 74 0 0
v_add_invoice_to_stock 10218 9960 258 2.52 0 8851 27 0 258
v_all_customers 37790 37790 0 0.00 0 70 4 0 0
v_all_suppliers 30426 30426 0 0.00 0 90 4 0 0
v_all_wares 41490 41490 0 0.00 0 73 4 0 0
v_cancel_adding_invoice 870 870 0 0.00 0 657 14 0 0
v_cancel_client_order 3510 3510 0 0.00 0 2931 11 0 0
v_cancel_customer_prepayment 1332 1332 0 0.00 0 4650 14 0 0
v_cancel_customer_reserve 1456 1456 0 0.00 1 2057 12 0 0
v_cancel_payment_to_supplier 840 840 0 0.00 0 2010 13 0 0
v_cancel_supplier_invoice 786 764 22 2.79 0 358 19 0 22
v_cancel_supplier_order 830 830 0 0.00 0 539 9 0 0
v_cancel_write_off 1948 1948 0 0.00 0 6301 26 0 0
v_max_id_clo_ord 5539 5539 0 0.00 0 482 5 0 0
v_max_id_clo_res 1004 1004 0 0.00 0 3198 13 0 0
v_max_id_ord_sup 5394 5394 0 0.00 0 7426 11 0 0
v_max_non_paid_invoice 1458 1458 0 0.00 0 338 8 0 0
v_max_non_paid_realizn 3670 3670 0 0.00 0 846 7 0 0
v_min_id_clo_ord 5539 5539 0 0.00 0 4920 9 0 0
v_min_id_clo_res 1004 1004 0 0.00 0 1132 9 0 0
v_min_id_ord_sup 5394 5394 0 0.00 0 9024 13 0 0
v_min_non_paid_invoice 5737 5737 0 0.00 0 6725 15 0 0
v_min_non_paid_realizn 7037 7037 0 0.00 0 1554 13 0 0
v_our_firm 10432 10432 0 0.00 0 58 4 0 0
v_reserve_write_off 19920 19920 0 0.00 0 5030 12 0 0
x_lock_depdocs_on_canc_invoice 11155 11155 0 0.00 0 12285 101 0 0
x_lock_depdocs_on_canc_sup_ord 415 415 0 0.00 0 3868 279 0 0
x_make_qstorno_1000_1200 5544 5544 0 0.00 2 22537 1132 0 0
x_make_qstorno_1200_2000 5403 5403 0 0.00 4 96617 2836 0 0
x_make_qstorno_2100_3300 472022 472022 0 0.00 0 71120 214 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 17-02-2023 10:38:55 to 17-02-2023 10:38:59.

Memory consumption, metadata cache, attachments activity

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


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

measurement_dts measurement duration ms page cache memo used memo used, total memo allocated, total metadata cache metadata cache percent of total total attachments cnt active attachments cnt running statements cnt stalled statements cnt memo used by attachments memo used by transactions memo used by statements
08:07:29 28 8192000000 8810210256 8825991168 13260832 0.161 5 4 5 0 13549360 175984 112544
08:08:30 31791 8192000000 9714660000 10013794304 791604192 8.811 100 86 172 0 820414576 7457296 21353088
08:10:07 20455 8192000000 9761651296 10067255296 835608368 9.256 100 94 188 0 871475984 12887520 22980096
08:11:28 17410 8192000000 9801313568 10115731456 857146592 9.472 100 88 176 0 901107392 23120496 20840304
08:12:47 9058 8192000000 9849024480 10184400896 907347392 9.971 100 81 162 0 967560928 42234512 17979024
08:13:59 5356 8192000000 9884542592 10228391936 952581248 10.416 100 78 150 2 1006944512 38827104 15536160
08:15:08 1950 8192000000 9966601664 10315849728 990576864 10.787 100 91 170 1 1085302816 77967424 16758528
08:16:14 2275 8192000000 10009728368 10369908736 1010782720 10.983 100 92 173 3 1124176032 96958144 16435168
08:17:19 1547 8192000000 9984451888 10349142016 1032548576 11.193 100 96 178 0 1103280352 53245216 17486560
08:18:22 1061 8192000000 10020514960 10391945216 1053589744 11.395 100 93 182 0 1143273024 70215040 19468240
08:19:24 861 8192000000 10016108160 10391683072 1059159520 11.448 100 94 186 1 1147461712 68069136 20233056
08:20:26 1144 8192000000 10034203824 10417229824 1064290592 11.498 100 81 160 1 1156824208 75887120 16646496
08:21:28 2359 8192000000 10015234048 10394021888 1071763216 11.569 100 65 122 1 1135160592 52160336 11237040
08:22:31 1125 8192000000 10030869568 10417983488 1078591312 11.634 100 82 163 1 1155557248 60373312 16592624
08:23:34 927 8192000000 10049518848 10435706880 1081727024 11.664 100 92 177 0 1172404384 70687232 19990128
08:24:36 1415 8192000000 10052869856 10443366400 1084491808 11.690 100 84 155 1 1175719840 75241616 15986416
08:25:38 1333 8192000000 10062836480 10455080960 1088698672 11.730 100 94 178 1 1189324976 82051248 18575056
08:26:40 1244 8192000000 10054799280 10438692864 1092327936 11.765 100 92 179 1 1174348720 63438112 18582672
08:27:42 4850 8192000000 10040549664 10433769472 1104021872 11.876 100 58 111 1 1163466128 48539152 10905104
08:28:48 3274 8192000000 10037519328 10434166784 1091103280 11.753 100 62 110 4 1160107424 57702912 11301232
08:29:51 2179 8192000000 10032173632 10421411840 1081903936 11.666 99 78 144 3 1153006224 56534720 14567568
08:30:54 1253 8192000000 10015541600 10404397056 1081886272 11.665 100 81 154 3 1138055440 39940864 16228304
08:31:57 1132 8192000000 10017032736 10394574848 1055684560 11.415 99 91 176 2 1137288288 63689008 17914720
08:33:00 2006 8192000000 9994983440 10379616256 1052962768 11.389 100 70 135 2 1120523408 54036560 13524080
08:34:03 1090 8192000000 9995567824 10371092480 1045539952 11.318 100 89 177 1 1119571888 55093808 18938128
08:35:05 982 8192000000 9971658144 10342993920 1031328512 11.181 100 95 182 1 1100313728 48793072 20192144
08:36:07 1082 8192000000 9990018880 10359812096 1022012944 11.091 100 93 170 2 1111993776 72159584 17821248
08:37:10 1480 8192000000 9981300272 10355712000 1026925120 11.139 99 93 174 5 1103268160 57587408 18755632
08:38:20 24840 8192000000 9999400576 10373742592 1056216496 11.420 100 76 137 2 1118668816 48696272 13756048
08:39:49 6716 8192000000 10025824672 10404966400 1064948752 11.504 99 68 120 1 1150053872 72273776 12831344
08:41:02 6825 8192000000 10075689344 10463313920 1092162944 11.763 100 63 124 0 1183470240 78606336 12700960
08:42:14 1981 8192000000 10091029328 10487226368 1105454208 11.889 100 76 146 3 1213686384 92912880 15319296
08:43:25 2620 8192000000 10153173408 10545213440 1122648448 12.052 100 80 152 2 1270850816 132261632 15940736
08:44:31 1840 8192000000 10167166560 10562699264 1122530624 12.051 99 79 152 2 1283003216 143980784 16491808
08:45:38 8730 8192000000 10214954928 10609053696 1140706304 12.222 100 84 156 3 1333965120 176946672 16312144
08:46:50 1475 8192000000 10202470240 10599317504 1149592784 12.306 100 80 142 1 1309601424 144354784 15653856
08:47:57 1247 8192000000 10267847168 10666733568 1163513520 12.436 100 93 182 0 1384169504 200011568 20644416
08:49:03 838 8192000000 10304700064 10702716928 1169669584 12.494 100 97 195 0 1419105184 228357088 21078512
08:50:07 1010 8192000000 10332583264 10733735936 1182280720 12.611 100 88 170 1 1440095488 240255872 17558896
08:51:11 854 8192000000 10354314496 10769379328 1188332976 12.668 100 94 184 0 1468141312 257751664 22056672
08:52:15 1414 8192000000 10372216848 10797363200 1187705344 12.662 100 96 187 1 1484383632 275215920 21462368
08:53:21 868 8192000000 10414894640 10818416640 1175173904 12.545 99 98 190 2 1519674064 322140432 22359728
08:54:24 791 8192000000 10421028064 10838409216 1174075904 12.535 100 96 188 0 1533222544 337756240 21390400
08:55:26 1439 8192000000 10462383696 10864861184 1167023440 12.469 100 95 184 0 1568292112 378562608 22706064
08:56:32 835 8192000000 10509880432 10938638336 1192899520 12.710 100 97 190 0 1616649488 401504464 22245504
08:57:35 1049 8192000000 10481873376 10941247488 1187407232 12.659 100 97 191 0 1587371392 378043744 21920416
08:58:39 2117 8192000000 10513183296 10948898816 1179775952 12.588 100 74 144 1 1620122416 422887312 17459152
08:59:44 2680 8192000000 10472531936 10915041280 1180472352 12.595 100 54 104 1 1579410464 385481472 13456640
09:00:51 15315 8192000000 10476341312 10934288384 1176251168 12.555 100 38 76 1 1579123424 393111472 9760784
09:02:33 21456 8192000000 10470207872 10918641664 1165922768 12.459 100 46 90 0 1584021472 406273168 11825536
09:03:56 12410 8192000000 10376539296 10863935488 1155270544 12.359 100 35 69 0 1518429968 354226752 8932672
09:05:13 28787 8192000000 10272972496 10749415424 1130724288 12.128 98 30 60 0 1373193840 234990544 7479008
09:06:46 24168 8192000000 10189540192 10675204096 1133508240 12.154 99 21 39 0 1310085024 171784544 4792240
09:08:11 41689 8192000000 10103768704 10546122752 1123061888 12.056 98 12 24 0 1173653616 47788432 2803296
09:09:55 9640 8192000000 10144827152 10570317824 1134855056 12.167 100 52 101 1 1233623376 87971568 10796752
09:11:06 144114 8192000000 10119792080 10569531392 1103762896 11.873 97 29 47 1 1201903232 92616192 5524144
09:14:35 63852 8192000000 10082270000 10532646912 1104551360 11.881 98 38 66 1 1155534640 44627440 6355840
09:16:39 19738 8192000000 10092096192 10521006080 1097807584 11.817 97 42 81 0 1168210464 61781232 8621648
09:18:00 91399 8192000000 10112189856 10555609088 1122672736 12.052 99 33 64 0 1203857616 73903344 7281536
09:20:44 69032 8192000000 10107341184 10553962496 1109732784 11.930 97 17 34 0 1175875824 62630480 3512560
09:22:55 50839 8192000000 10114563216 10590359552 1133042144 12.150 100 13 25 0 1224567488 88478160 3047184
09:24:51 51891 8192000000 10081156240 10561740800 1121019888 12.037 99 29 59 0 1201454272 73801488 6632896
09:27:14 66446 8192000000 10059880000 10531282944 1082103056 11.668 96 28 56 1 1148552576 60919024 5530496
09:30:53 18634 8192000000 10103171680 10544193536 1126370992 12.087 100 44 81 2 1189599728 54017584 9211152
09:32:46 24608 8192000000 10125461360 10565042176 1106690304 11.901 98 31 62 0 1195335408 82489344 6155760
09:35:01 71027 8192000000 10139039344 10578014208 1106666528 11.901 98 22 44 0 1217826368 106437392 4722448
09:37:21 29712 8192000000 10183878160 10619297792 1135270816 12.171 99 22 38 0 1262339680 122813328 4255536
09:38:51 17259 8192000000 10154858960 10596859904 1139062432 12.207 99 47 82 2 1259788480 110788528 9937520
09:40:13 44859 8192000000 10171215648 10659704832 1134106672 12.160 99 34 68 1 1286935072 145711168 7117232
09:42:37 141154 8192000000 10153191536 10639687680 1127855504 12.101 99 33 66 0 1252463184 117456096 7151584
09:45:59 67231 8192000000 10111525184 10552639488 1131253584 12.133 99 30 60 0 1194264080 56435232 6575264
09:48:07 75035 8192000000 10086546288 10546790400 1133717024 12.156 99 8 16 0 1194817184 59669424 1430736
09:50:38 74089 8192000000 10071256752 10548068352 1123686208 12.062 99 10 20 0 1182643328 57084944 1872176
09:52:56 67611 8192000000 10067694336 10540933120 1123238032 12.058 99 21 42 0 1181891680 54148256 4505392
09:55:19 20316 8192000000 10083232368 10517557248 1121285392 12.039 98 41 80 1 1163042672 32521552 9235728
09:56:40 50343 8192000000 10130258944 10567974912 1125194352 12.076 99 37 74 0 1204884992 72127472 7563168
09:58:46 36357 8192000000 10093582192 10549342208 1112647456 11.957 98 35 70 0 1201322208 81781360 6893392
10:00:26 30986 8192000000 10136817872 10584498176 1131390640 12.134 99 41 82 1 1221013344 81470320 8152384
10:01:59 25356 8192000000 10110011424 10567606272 1134244640 12.161 100 49 97 0 1214699424 70328112 10126672
10:03:27 41044 8192000000 10144289312 10635841536 1133442000 12.154 99 34 68 0 1247378752 106771040 7165712
10:05:14 83273 8192000000 10123473024 10585047040 1096423232 11.804 96 28 56 0 1170815408 68706560 5685616
10:09:05 83429 8192000000 10124619072 10611011584 1120265344 12.029 98 12 22 1 1183399440 60784256 2349840
10:11:28 81323 8192000000 10072385920 10515456000 1093203024 11.773 96 11 22 0 1148634656 53102928 2328704
10:13:52 64239 8192000000 10070588320 10513494016 1118806864 12.016 98 18 34 0 1139985136 17720912 3457360
10:16:03 61579 8192000000 10077222112 10541678592 1102775664 11.864 96 20 40 0 1150708416 44342560 3590192
10:18:05 21572 8192000000 10102049984 10526720000 1094157808 11.782 96 44 87 0 1145278368 41965376 9155184
10:19:27 46533 8192000000 10139254336 10583977984 1114794544 11.978 98 39 77 0 1214376112 91643504 7938064
10:21:14 39747 8192000000 10115796080 10577747968 1084611200 11.691 95 28 56 0 1217684176 126897040 6175936
10:22:54 38198 8192000000 10103151616 10531885056 1078964672 11.638 96 44 81 0 1141805728 54759872 8081184
10:24:41 57365 8192000000 10171046800 10609340416 1139512496 12.211 100 40 80 0 1213740816 66029184 8199136
10:26:42 103226 8192000000 10082904784 10526789632 1108882928 11.922 98 19 40 1 1169951408 57258576 3809904
10:29:32 74241 8192000000 10062420624 10526195712 1112778256 11.959 98 12 24 1 1157545392 41951104 2816032
10:31:46 40874 8192000000 10060598672 10540871680 1132374560 12.144 100 7 14 0 1157858368 24311552 1172256
10:33:28 64801 8192000000 10129294608 10572775424 1130550624 12.127 98 25 50 0 1203954976 67802656 5601696
10:35:35 66887 8192000000 10149732448 10609352704 1154626432 12.353 100 28 56 0 1256660912 96007888 6026592

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


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

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 129 v_add_invoice_to_stock 335544517
except 11 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 17-02-2023 10:39:18 to 17-02-2023 10:39:20.

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          212981
MON$OLDEST_ACTIVE               219204
MON$OLDEST_SNAPSHOT             219204
MON$NEXT_TRANSACTION            219204
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                       2041824
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             772
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2902 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2902 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2902 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2902 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 ---
:139: 
:140: mscs-test-161.budzdorov.ru    Fri Feb 17 10:37:33 2023
:141:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:142: 
:143: 
:144: mscs-test-161.budzdorov.ru    Fri Feb 17 10:37:34 2023
:145:     INET/inet_error: send errno = 32, server host = localhost, address = ::1/3400
:146: 
--- end of diff output ---

Final processing ISQL logs in /var/tmp/logs-oltp40 according to config parameter 'remove_isql_logs'

17.02.23 10:39:22. 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-17 10:39:24 No severe PSQL-related problems occured
17.02.23 10:39:26. End of report.