Generated by /opt/oltp-emul/oltp_isql_run_worker.sh, ISQL session No. 1 of total launched 100. 20.01.2023 13:37
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 15543636 kB
MemAvailable 30408552 kB
Buffers 0 kB
Cached 16150488 kB
SwapCached 1780 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-01-20 13:37:26
DTS_END                         2023-01-20 13:37:26.2280
FB_GDSCODE                      -1
FB_MNEMONA                      
STACK                           SP_PAY_TO_SUPPLIER(26:5) ==> SP_CHECK_TO_STOP_WORK(32:12) ==> SP_HALT_ON_ERROR(68:17)
IP                              ::1/35958
TRN_ID                          215313
ATT_ID                          572
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: 8666.90 28201 1040028
customer order: creation 161.82 466 19418
customer order: refuse 13.63 380 1636
order to supplier: creation 43.68 1221 5241
order to supplier: removal 3.29 152966 395
invoice (draft): creation 43.03 2789 5164
invoice (draft): removal 48.91 915 5869
invoice accept: apply 40.22 28306 4826
invoice accept: cancel 44.23 1075 5308
customer reserve: creation 3686.10 279 442332
customer reserve: removal 4297.19 92 515663
realization accept: apply 78.65 250 9438
realization accept: cancel 83.86 139 10063
payment from customer: creation 55.28 180 6633
payment from customer: removal 5.48 110 658
payment to supplier: creation 46.35 189 5562
payment to supplier: removal 3.18 104 381
service: total inventory turnovers 4.12 3695 494
service: total monetary turnovers 6.96 392 835
service: aggregate perf. data 0.90 13921 108
service: refresh index statistics 0.03 356558 4

Performance in TOTAL, chart


Completed "Performance in TOTAL". Done for 00:00:02, from 20-01-2023 13:38:05 to 20-01-2023 13:38:07.

Performance for every MINUTE

TEST_PHASE_NAME MINUTES_PASSED PERF_SCORE
TEST_TIME 1 5592
TEST_TIME 2 5240
TEST_TIME 3 4964
TEST_TIME 4 5031
TEST_TIME 5 5079
TEST_TIME 6 5370
TEST_TIME 7 5465
TEST_TIME 8 5447
TEST_TIME 9 5375
TEST_TIME 10 5708
TEST_TIME 11 5677
TEST_TIME 12 5872
TEST_TIME 13 6104
TEST_TIME 14 6039
TEST_TIME 15 6041
TEST_TIME 16 6158
TEST_TIME 17 6358
TEST_TIME 18 6772
TEST_TIME 19 7521
TEST_TIME 20 8000
TEST_TIME 21 7896
TEST_TIME 22 8028
TEST_TIME 23 8020
TEST_TIME 24 8437
TEST_TIME 25 8853
TEST_TIME 26 9527
TEST_TIME 27 10030
TEST_TIME 28 10480
TEST_TIME 29 10703
TEST_TIME 30 10475
TEST_TIME 31 10323
TEST_TIME 32 10102
TEST_TIME 33 9982
TEST_TIME 34 10002
TEST_TIME 35 9858
TEST_TIME 36 9793
TEST_TIME 37 9670
TEST_TIME 38 9540
TEST_TIME 39 9587
TEST_TIME 40 9507
TEST_TIME 41 9371
TEST_TIME 42 9174
TEST_TIME 43 9027
TEST_TIME 44 9028
TEST_TIME 45 9106
TEST_TIME 46 9274
TEST_TIME 47 9168
TEST_TIME 48 9080
TEST_TIME 49 9017
TEST_TIME 50 9019
TEST_TIME 51 9095
TEST_TIME 52 9037
TEST_TIME 53 9018
TEST_TIME 54 9004
TEST_TIME 55 8993
TEST_TIME 56 9025
TEST_TIME 57 8966
TEST_TIME 58 8945
TEST_TIME 59 8895
TEST_TIME 60 8941
TEST_TIME 61 9267
TEST_TIME 62 9232
TEST_TIME 63 9140
TEST_TIME 64 9091
TEST_TIME 65 9006
TEST_TIME 66 9028
TEST_TIME 67 8970
TEST_TIME 68 8903
TEST_TIME 69 8929
TEST_TIME 70 8855
TEST_TIME 71 8813
TEST_TIME 72 8846
TEST_TIME 73 8813
TEST_TIME 74 8881
TEST_TIME 75 8853
TEST_TIME 76 8879
TEST_TIME 77 8928
TEST_TIME 78 8953
TEST_TIME 79 8955
TEST_TIME 80 8912
TEST_TIME 81 8981
TEST_TIME 82 8976
TEST_TIME 83 8970
TEST_TIME 84 8978
TEST_TIME 85 8990
TEST_TIME 86 8908
TEST_TIME 87 8871
TEST_TIME 88 8842
TEST_TIME 89 8799
TEST_TIME 90 8751
TEST_TIME 91 8708
TEST_TIME 92 8717
TEST_TIME 93 8699
TEST_TIME 94 8705
TEST_TIME 95 8691
TEST_TIME 96 8680
TEST_TIME 97 8737
TEST_TIME 98 8705
TEST_TIME 99 8688
TEST_TIME 100 8666
TEST_TIME 101 8682
TEST_TIME 102 8774
TEST_TIME 103 8796
TEST_TIME 104 8825
TEST_TIME 105 8808
TEST_TIME 106 8734
TEST_TIME 107 8715
TEST_TIME 108 8743
TEST_TIME 109 8717
TEST_TIME 110 8684
TEST_TIME 111 8691
TEST_TIME 112 8652
TEST_TIME 113 8644
TEST_TIME 114 8641
TEST_TIME 115 8652
TEST_TIME 116 8683
TEST_TIME 117 8671
TEST_TIME 118 8654
TEST_TIME 119 8717
TEST_TIME 120 8694

Performance per minute, chart


Completed "Performance for every MINUTE". Done for 00:00:03, from 20-01-2023 13:38:09 to 20-01-2023 13:38:12.

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 1447736 1447736 0 0.00 0 27120 14 0 0
doc_list_biud 1447722 1447722 0 0.00 0 37717 38 0 0
sp_add_invoice_to_stock 4953 4826 127 2.56 49 310502 28307 0 127
sp_cancel_adding_invoice 5308 5308 0 0.00 7 74905 1075 0 0
sp_cancel_client_order 1636 1636 0 0.00 6 13219 381 0 0
sp_cancel_customer_reserve 515663 515663 0 0.00 1 37722 93 0 0
sp_cancel_pay_from_customer 658 658 0 0.00 3 2687 110 0 0
sp_cancel_pay_to_supplier 381 381 0 0.00 4 3590 104 0 0
sp_cancel_supplier_invoice 5876 5869 7 0.11 2 28073 915 0 7
sp_cancel_supplier_order 395 395 0 0.00 9 1354634 152967 0 0
sp_cancel_write_off 10063 10063 0 0.00 1 9587 140 0 0
sp_client_order 19418 19418 0 0.00 5 25363 467 0 0
sp_customer_reserve 442332 442332 0 0.00 0 60579 280 0 0
sp_fill_shopping_cart 29812 29812 0 0.00 1 17091 71 0 0
sp_fill_shopping_cart_clo_res 442300 442300 0 0.00 0 14043 22 0 0
sp_get_clo_for_invoice 4782 4782 0 0.00 0 25326 321 0 0
sp_kill_cost_storno 16410 16410 0 0.00 0 5815 63 0 0
sp_kill_qstorno_ret_qs2qd 1047653 1047653 0 0.00 0 37691 41 0 0
sp_kill_qty_storno 553152 553152 0 0.00 0 37717 93 0 0
sp_lock_selected_doc 19676 19676 0 0.00 0 5396 7 0 0
sp_make_cost_storno 26415 26415 0 0.00 0 27094 79 0 0
sp_multiply_rows_for_pdistr 26413 26413 0 0.00 0 8318 39 0 0
sp_multiply_rows_for_qdistr 19418 19418 0 0.00 0 12053 192 0 0
sp_pay_from_customer 6633 6633 0 0.00 5 14951 181 0 0
sp_pay_to_supplier 5562 5562 0 0.00 7 17201 190 0 0
sp_payment_common 12195 12195 0 0.00 2 9194 45 0 0
sp_qd_handle_on_cancel_clo 1636 1636 0 0.00 0 13185 310 0 0
sp_qd_handle_on_invoice_upd_sts 10089 10089 0 0.00 0 21562 440 0 0
sp_qd_handle_on_reserve_upd_sts 9436 9436 0 0.00 0 12883 56 0 0
sp_reserve_write_off 9438 9438 0 0.00 8 16877 250 0 0
sp_supplier_invoice 5164 5164 0 0.00 8 66619 2789 0 0
sp_supplier_order 5241 5241 0 0.00 7 27071 1222 0 0
srv_aggregate_perf_data 109 108 1 0.91 2282 131954 13921 0 1
srv_fill_mon_cache_memory 68 68 0 0.00 770 188679 38653 0 0
srv_find_qd_qs_mism 993837 993837 0 0.00 0 16890 12 0 0
srv_make_invnt_saldo 494 494 0 0.00 51 97645 3695 0 0
srv_make_money_saldo 835 835 0 0.00 1 13287 393 0 0
srv_recalc_idx_stat 4 4 0 0.00 204685 492476 356559 0 0
t$perf-abend:sp_add_invoice_to_stock 127 127 0 0.00 0 0 0 0 0
t$perf-abend:sp_cancel_supplier_invoice 7 7 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 4834 4834 0 0.00 0 16337 745 0 0
t$perf-norm:sp_cancel_adding_invoice 392 392 0 0.00 1 5804 357 0 0
t$perf-norm:sp_cancel_client_order 1636 1636 0 0.00 0 8164 32 0 0
t$perf-norm:sp_cancel_customer_reserve 640 640 0 0.00 0 691 17 0 0
t$perf-norm:sp_cancel_pay_from_customer 658 658 0 0.00 0 2101 20 0 0
t$perf-norm:sp_cancel_pay_to_supplier 381 381 0 0.00 0 645 14 0 0
t$perf-norm:sp_cancel_supplier_invoice 401 401 0 0.00 0 2214 39 0 0
t$perf-norm:sp_cancel_supplier_order 395 395 0 0.00 0 96566 6065 0 0
t$perf-norm:sp_cancel_write_off 957 957 0 0.00 0 907 15 0 0
t$perf-norm:sp_client_order 19418 19418 0 0.00 0 9913 30 0 0
t$perf-norm:sp_customer_reserve 941 941 0 0.00 0 1957 17 0 0
t$perf-norm:sp_pay_from_customer 6633 6633 0 0.00 0 9486 18 0 0
t$perf-norm:sp_pay_to_supplier 5562 5562 0 0.00 0 4653 18 0 0
t$perf-norm:sp_reserve_write_off 9438 9438 0 0.00 0 13789 23 0 0
t$perf-norm:sp_supplier_invoice 5164 5164 0 0.00 0 13291 31 0 0
t$perf-norm:sp_supplier_order 5241 5241 0 0.00 0 3826 28 0 0
t$perf-norm:srv_aggregate_perf_data 108 108 0 0.00 0 530 17 0 0
t$perf-norm:srv_fill_mon_cache_memory 68 68 0 0.00 0 25 3 0 0
t$perf-norm:srv_make_invnt_saldo 494 494 0 0.00 0 1939 19 0 0
t$perf-norm:srv_make_money_saldo 835 835 0 0.00 0 235 4 0 0
t$perf-norm:srv_recalc_idx_stat 4 4 0 0.00 3 194 69 0 0
v_add_invoice_to_stock 9812 9558 254 2.58 0 7387 25 0 254
v_all_customers 35698 35698 0 0.00 0 157 3 0 0
v_all_suppliers 29100 29100 0 0.00 0 93 4 0 0
v_all_wares 38824 38824 0 0.00 0 89 3 0 0
v_cancel_adding_invoice 784 784 0 0.00 0 2113 19 0 0
v_cancel_client_order 3272 3272 0 0.00 0 1631 10 0 0
v_cancel_customer_prepayment 1316 1316 0 0.00 0 365 9 0 0
v_cancel_customer_reserve 1280 1280 0 0.00 0 454 9 0 0
v_cancel_payment_to_supplier 762 762 0 0.00 0 3509 17 0 0
v_cancel_supplier_invoice 816 802 14 1.71 0 1748 24 0 14
v_cancel_supplier_order 790 790 0 0.00 0 820 10 0 0
v_cancel_write_off 1914 1914 0 0.00 0 1225 20 0 0
v_max_id_clo_ord 5237 5237 0 0.00 0 4839 5 0 0
v_max_id_clo_res 940 940 0 0.00 0 761 8 0 0
v_max_id_ord_sup 5157 5157 0 0.00 0 3050 7 0 0
v_max_non_paid_invoice 1406 1406 0 0.00 0 888 7 0 0
v_max_non_paid_realizn 3245 3245 0 0.00 0 4920 9 0 0
v_min_id_clo_ord 5237 5237 0 0.00 0 2110 7 0 0
v_min_id_clo_res 940 940 0 0.00 0 9028 23 0 0
v_min_id_ord_sup 5157 5157 0 0.00 0 4949 9 0 0
v_min_non_paid_invoice 5561 5561 0 0.00 0 6065 17 0 0
v_min_non_paid_realizn 6633 6633 0 0.00 0 4858 22 0 0
v_our_firm 9902 9902 0 0.00 0 157 4 0 0
v_reserve_write_off 18872 18872 0 0.00 0 4890 11 0 0
x_lock_depdocs_on_canc_invoice 10776 10776 0 0.00 0 20774 140 0 0
x_lock_depdocs_on_canc_sup_ord 395 395 0 0.00 0 5455 325 0 0
x_make_qstorno_1000_1200 5241 5241 0 0.00 2 27054 1077 0 0
x_make_qstorno_1200_2000 5164 5164 0 0.00 3 62180 2586 0 0
x_make_qstorno_2100_3300 442331 442331 0 0.00 0 60578 248 0 0

Completed "Performance in DETAILS". Done for 00:00:04, from 20-01-2023 13:38:13 to 20-01-2023 13:38:17.

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
11:07:30 2 8192000000 8796669344 8807108608 3189136 0.038 1 1 2 0 3286752 61840 35776
11:08:31 31468 8192000000 9708685600 10006659072 787574400 8.770 100 88 176 0 817613296 7751360 22287536
11:10:12 17042 8192000000 9755628704 10060513280 826113712 9.160 100 84 166 0 858917168 12813952 19989504
11:11:41 11512 8192000000 9797850304 10114658304 870582160 9.606 100 81 160 0 908784288 20214432 17987696
11:12:55 6377 8192000000 9860364224 10193756160 917742864 10.074 100 85 164 2 965938768 30610320 17585584
11:14:05 6034 8192000000 9919571856 10259877888 956750304 10.457 100 90 179 0 1037507584 62163984 18593296
11:15:15 1987 8192000000 9965533712 10315296768 986614528 10.749 100 92 178 1 1085792128 81615568 17562032
11:16:21 1848 8192000000 9973168000 10336538624 1008190528 10.958 100 90 179 0 1093314880 66353072 18771280
11:17:24 1109 8192000000 10008609072 10376347648 1037224288 11.238 100 95 188 0 1132320944 77041296 18055360
11:18:28 981 8192000000 10035381008 10408357888 1052944096 11.389 100 95 188 1 1153352896 81831808 18576992
11:19:31 704 8192000000 10025312528 10399232000 1063122144 11.486 100 94 177 1 1145053856 63387120 18544592
11:20:34 1750 8192000000 10035515584 10415771648 1070670400 11.558 100 90 174 4 1156325024 67816128 17838496
11:21:38 899 8192000000 10044092768 10430922752 1077056352 11.619 100 96 185 0 1167622944 71454416 19112176
11:22:40 1335 8192000000 10050997328 10436714496 1081824352 11.665 100 97 178 1 1170989856 70972624 18192880
11:23:42 1154 8192000000 10050577952 10439958528 1087482032 11.719 100 95 184 2 1170947072 64561840 18903200
11:24:45 1070 8192000000 10064555536 10455277568 1092868496 11.770 100 93 180 1 1190014656 78691200 18454960
11:25:48 1290 8192000000 10065871872 10452729856 1099409872 11.832 100 95 189 1 1183829344 64949360 19470112
11:26:50 1125 8192000000 10071110720 10460192768 1101781568 11.855 100 98 178 1 1198749952 77337424 19630960
11:27:52 904 8192000000 10072241392 10463780864 1094613712 11.787 100 93 176 1 1191875888 79224160 18038016
11:28:54 8388 8192000000 10023881952 10411286528 1090058752 11.743 100 76 131 0 1149917152 48019552 11838848
11:30:04 2950 8192000000 10027872960 10415755264 1073106784 11.582 100 69 129 1 1145007744 58536416 13364544
11:31:08 1139 8192000000 10049360384 10430742528 1079416720 11.642 100 91 171 1 1175402544 78679376 17306448
11:32:10 1115 8192000000 10023024448 10400985088 1054147408 11.400 99 93 175 3 1149938464 79027088 16763968
11:33:12 992 8192000000 10023490208 10402123776 1064700608 11.501 100 95 181 1 1143221920 60799072 17722240
11:34:14 7465 8192000000 9981928048 10365566976 1028979696 11.159 99 53 94 2 1103013552 65231712 8802144
11:35:22 4964 8192000000 9982348752 10355310592 1028983408 11.159 100 72 141 0 1108530176 64210400 15336368
11:36:28 2410 8192000000 9996071696 10380238848 1045149264 11.314 100 79 156 0 1121155520 59625616 16380640
11:37:40 9581 8192000000 10008535904 10398068736 1067874688 11.532 100 61 119 1 1134279808 54382224 12022896
11:39:02 899 8192000000 10024250560 10402242560 1073148544 11.582 100 92 182 1 1143845136 51677600 19018992
11:40:06 7234 8192000000 10022712320 10411511808 1069580176 11.548 99 65 119 2 1139587760 57732992 12274592
11:41:19 2269 8192000000 10096068368 10484023296 1091849408 11.760 100 78 145 3 1215887360 109338784 14699168
11:42:27 3254 8192000000 10130373920 10522767360 1105702656 11.892 100 83 157 1 1250345872 127491344 17151872
11:43:33 6198 8192000000 10154866256 10551255040 1120902416 12.036 100 73 135 1 1270425088 135364192 14158480
11:44:42 2077 8192000000 10195604816 10588377088 1133006016 12.150 100 85 166 1 1317688560 166580064 18102480
11:45:49 2819 8192000000 10223419152 10622574592 1139005696 12.206 100 74 141 2 1335476848 181276848 15194304
11:46:59 2545 8192000000 10244482240 10661040128 1150531648 12.314 100 85 160 1 1364402080 194565648 19304784
11:48:05 4461 8192000000 10282374752 10679676928 1162465056 12.426 99 75 144 0 1387777408 208502880 16809472
11:49:16 1375 8192000000 10356423616 10750693376 1180942320 12.599 99 92 183 1 1471821776 270002176 20877280
11:50:19 808 8192000000 10378893392 10776326144 1183179072 12.620 100 95 183 0 1487809808 284036880 20593856
11:51:22 1507 8192000000 10425523504 10825711616 1187007360 12.656 100 83 157 1 1529383088 324476544 17899184
11:52:27 1184 8192000000 10504765072 10912460800 1202873040 12.803 100 97 191 4 1615001312 388868096 23260176
11:53:32 990 8192000000 10548003920 10960977920 1208835680 12.858 100 96 186 1 1659302208 426946800 23519728
11:54:35 1103 8192000000 10554369040 11029295104 1209659920 12.866 100 96 188 0 1664775104 430280608 24834576
11:55:41 763 8192000000 10549110464 11037278208 1202539216 12.800 100 98 187 0 1654961504 429444368 22977920
11:56:46 2218 8192000000 10447018256 10925625344 1175925024 12.552 99 66 128 0 1552876144 360312096 16639024
11:57:50 20312 8192000000 10464316656 10902597632 1185849584 12.645 100 49 89 1 1579740624 382608160 11282880
11:59:24 2682 8192000000 10477129248 10929430528 1172629024 12.521 100 72 133 2 1584337472 394776688 16931760
12:00:30 10924 8192000000 10475374512 10919477248 1160944256 12.412 99 46 86 1 1565760608 393361952 11454400
12:01:44 13241 8192000000 10429052560 10897211392 1163715440 12.438 100 43 86 0 1555399472 380406464 11277568
12:03:08 74865 8192000000 10283090880 10818564096 1139985344 12.215 99 22 44 1 1475373616 329401792 5986480
12:05:25 20802 8192000000 10098044384 10600452096 1146832560 12.280 100 32 59 0 1229037696 75017392 7187744
12:06:55 39856 8192000000 10094299968 10527301632 1145349024 12.266 100 35 61 1 1197366272 45369840 6647408
12:08:36 49351 8192000000 10134330416 10609168384 1141817568 12.233 99 48 93 1 1226435568 74687744 9930256
12:10:53 78169 8192000000 10088371456 10569969664 1125710352 12.081 99 20 40 0 1196943472 67378528 3854592
12:13:12 61528 8192000000 10119979376 10567127040 1134392848 12.163 99 21 43 0 1225875888 86852160 4630880
12:15:17 43034 8192000000 10139145168 10610327552 1141887648 12.233 100 45 82 2 1269537968 117512608 10137712
12:17:13 188679 8192000000 10193921440 10654691328 1121403472 12.040 97 15 30 0 1208783616 84299968 3080176
12:22:39 54710 8192000000 10111585696 10649817088 1147002704 12.281 100 22 44 0 1232386704 80406192 4977808
12:24:35 6315 8192000000 10067874464 10510430208 1139812112 12.214 100 54 100 1 1170458304 20427568 10218624
12:25:42 36723 8192000000 10093954240 10540109824 1123113408 12.056 98 24 48 0 1178095136 49631728 5350000
12:27:31 72666 8192000000 10048213168 10541125632 1075298128 11.603 95 12 24 0 1137079616 59353840 2427648
12:29:44 5942 8192000000 10090207344 10521198592 1132031136 12.141 100 52 104 0 1194645072 52085152 10528784
12:30:52 24748 8192000000 10056025616 10498584576 1076910512 11.618 95 40 80 0 1130487728 45320432 8256784
12:32:21 18851 8192000000 10100858608 10532720640 1123529872 12.060 100 45 90 0 1201576512 69184512 8862128
12:33:40 40633 8192000000 10095229568 10520694784 1131384800 12.134 100 43 86 0 1193492144 53879936 8227408
12:35:28 50435 8192000000 10185862928 10627702784 1134986720 12.168 99 45 88 0 1275266768 131426560 8853488
12:37:22 78979 8192000000 10129503600 10688012288 1115105184 11.981 98 13 25 0 1269619648 151661792 2852672
12:39:51 65167 8192000000 10086281040 10528186368 1097123488 11.810 97 26 52 0 1165496336 62807568 5565280
12:42:33 56336 8192000000 10106721536 10536677376 1093312688 11.774 97 41 81 1 1180370592 78640432 8417472
12:44:31 61748 8192000000 10098380096 10560040960 1112930512 11.960 99 20 40 0 1219859872 102395392 4533968
12:48:07 64243 8192000000 10096424224 10551156736 1123850016 12.063 99 13 27 0 1202850416 76198720 2801680
12:50:11 25819 8192000000 10102717312 10549334016 1129157712 12.113 99 36 72 0 1196896016 59157728 8580576
12:51:42 65002 8192000000 10121212080 10551197696 1118068176 12.009 98 23 46 0 1199255584 76462976 4724432
12:53:59 28168 8192000000 10136498304 10588291072 1152036656 12.329 100 47 94 1 1247149952 85500464 9612832
12:55:30 70087 8192000000 10092618784 10527113216 1122568352 12.051 98 30 57 1 1176021808 46866304 6587152
12:57:40 100801 8192000000 10080621248 10543898624 1076652544 11.616 95 23 46 0 1154483776 73067584 4763648
13:00:22 65444 8192000000 10131718672 10575618048 1137510816 12.192 100 42 82 0 1223329040 77127504 8690720
13:02:28 31419 8192000000 10057163712 10476924928 1084117648 11.687 97 41 82 0 1128385152 36384048 7883456
13:04:04 59275 8192000000 10057758208 10500542464 1104663072 11.882 99 42 84 0 1158972272 45958160 8351040
13:06:12 33357 8192000000 10052147232 10507321344 1119253728 12.020 100 9 19 0 1159675696 38158688 2263280
13:07:46 91054 8192000000 10103229584 10550079488 1100156896 11.839 98 15 30 0 1172628752 69319488 3152368
13:10:17 62324 8192000000 10045105200 10548854784 1102353136 11.860 98 13 24 1 1181174304 75912096 2909072
13:12:20 63680 8192000000 10075541424 10523222016 1088334096 11.727 96 16 32 1 1136693600 44925520 3433984
13:14:26 50628 8192000000 10062713936 10502647808 1100167648 11.839 98 30 58 1 1167930976 61608080 6155248
13:16:23 15953 8192000000 10118291264 10545229824 1092056096 11.762 98 53 100 1 1200720880 97451088 11213696
13:17:40 41488 8192000000 10191949424 10619879424 1127497328 12.098 100 40 79 0 1268723104 133273792 7951984
13:19:47 15519 8192000000 10105234896 10536755200 1136022384 12.178 100 52 99 0 1207099536 61221280 9855872
13:21:04 55208 8192000000 10099486176 10527002624 1095298080 11.793 96 42 84 0 1172765568 69478288 7989200
13:23:01 90732 8192000000 10127210416 10574897152 1114040800 11.971 99 55 110 1 1224703056 100016960 10645296
13:25:34 54736 8192000000 10061247232 10563420160 1094591168 11.786 98 7 14 0 1143393648 47472096 1330384
13:27:29 117915 8192000000 10070292560 10542780416 1108194416 11.915 98 20 38 0 1169521904 57149264 4178224
13:30:27 41833 8192000000 10105721600 10543738880 1124007936 12.065 99 27 52 1 1187156944 57761312 5387696
13:32:17 68706 8192000000 10061940352 10527895552 1135582080 12.174 100 18 34 0 1211984880 72873392 3529408
13:34:29 20678 8192000000 10090550784 10517680128 1122275264 12.048 99 52 95 1 1173108624 41498400 9334960
13:35:55 66139 8192000000 10092890896 10570702848 1107763072 11.911 98 26 52 0 1170353408 58029168 4561168

Memory consumption, total, chart

Metadata cache size, chart

Statements activity, chart


Completed "Memory consumption, metadata cache, attachments activity". Done for 00:00:16, from 20-01-2023 13:38:20 to 20-01-2023 13:38:36.

Exceptions occured during test was in run

FB_MNEMONA CNT UNIT FB_GDSCODE
except 1 srv_aggregate_perf_data 335544517
except 127 v_add_invoice_to_stock 335544517
except 7 v_cancel_supplier_invoice 335544517

Completed "Exceptions occured during test was in run". Done for 00:00:02, from 20-01-2023 13:38:37 to 20-01-2023 13:38:39.

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          215621
MON$OLDEST_ACTIVE               215622
MON$OLDEST_SNAPSHOT             215622
MON$NEXT_TRANSACTION            215622
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                       2008128
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             771
MON$NEXT_STATEMENT              53
MON$REPLICA_MODE                0


ISQL Version: LI-V4.0.3.2890 Firebird 4.0
Server version:
Firebird/Linux/AMD/Intel/x64 (access method), version "LI-V4.0.3.2890 Firebird 4.0"
Firebird/Linux/AMD/Intel/x64 (remote server), version "LI-V4.0.3.2890 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
Firebird/Linux/AMD/Intel/x64 (remote interface), version "LI-V4.0.3.2890 Firebird 4.0/tcp (mscs-test-161.budzdorov.ru)/P17:C"
on disk structure version 13.0

Database statistics

Database statistics was not gathered, see config parameter 'run_db_statistics'.
===============================================================================

Database validation

Database validation was not performed, see config parameter 'run_db_validation'
===============================================================================

Comparison of old and new firebird.log: get messages that appeared during test

--- start of diff output ---
--- end of diff output ---

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

20.01.23 13:38:40. 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-01-20 13:38:43 No severe PSQL-related problems occured
20.01.23 13:38:44. End of report.