Firebird 2.5 Performance Logs

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-10-04 2:26:53.14.
Common Performance Final Results
  1. Test configuration
  2. Test Finish details
  3. Test workload details
  4. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score
  2. Performance, DYNAMIC, 10 intervals
  3. Performance, per MINUTE, since launch
  4. Performance, TRACE data for ISQL #1
  5. Performance, DETAILS per units
  6. MON$-analysis, per business units
  7. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database Statistics, full
  3. Ratio "Versions / Records" for tables
  4. Database Validation Results
  5. New in firebird.log while test was run
  6. Final processing of ISQL logs

Server and database settings

Server version: WI-V2.5.7.27026 Firebird 2.5
Server implementation: Firebird/x86-64/Windows NT
FB_ARCHITECTURE DB_NAME FORCED_WRITES SWEEP_INT PAGE_BUFFERS PAGE_SIZE
Classic 2.5.7 D:\OLTP-EMUL\OLTP25-SMALL.FDB ON 0 384 8192

Test configuration settings

File: E:\OLTP-EMUL\src\oltp25_config.win
PARAM_NAME PARAM_VALUE
fbc E:\FB25.TMPINSTANCE\bin\
dbnm D:\OLTP-EMUL\oltp25-small.fdb
host localhost
port 3255
usr SYSDBA
pwd masterke
tmpdir e:\temp\logs.oltp25
working_mode small_03
warm_time 10
test_time 180
idle_time 0
use_mtee 0
is_embed 0
remove_isql_logs if_no_severe_errors
no_auto_undo 1
detailed_info 0
mon_unit_perf 0
trc_unit_perf 1
init_buff 32768
create_with_fw sync
create_with_sweep 0
wait_if_not_exists 0
wait_after_create 0
init_docs 0
wait_for_copy 0
create_with_debug_objects 1
create_with_split_heavy_tabs 1
create_with_separate_qdistr_idx 0
create_with_compound_columns_order most_selective_first
make_html 1
run_db_statistics 1
run_db_validation 1
file_name_with_test_params regular
file_name_this_host_info ak25
upload_report 1
max_snapshots_to_store 0

Test finish info

FINISH_STATE DTS_END FB_GDSCODE FB_MNEMONA STACK IP TRN_ID ATT_ID EXC_UNIT
NORMAL: TEST_TIME EXPIRED. 2016-10-04 02:26:21.1630 -1 <null> 127.0.0.1 90641 4278 2

Current test settings

CATEGORY SETTING VAL
COMMON TRACED_UNITS ,,
COMMON LOG_PK_VIOLATION 0
COMMON QMISM_VERIFY_BITSET 1
COMMON RECALC_IDX_MIN_INTERVAL 15
COMMON ENABLE_RESERVES_WHEN_ADD_INVOICE 1
COMMON ORDER_FOR_OUR_FIRM_PERCENT 25
COMMON ENABLE_FILL_PHRASES 0
COMMON RANDOM_SEEK_VIA_ROWS_LIMIT 0
COMMON C_INVOICE_MIN_PURCHASE 1000
COMMON C_INVOICE_MAX_PURCHASE 2000
COMMON C_INVOICE_MIN_PROFIT_PRC 35
COMMON C_INVOICE_MAX_PROFIT_PRC 80
COMMON C_MIN_COST_TO_BE_SPLITTED 1000
COMMON C_ROWS_TO_MULTIPLY 10
COMMON C_PAYMENT_FROM_CLIENT_MIN_TOTAL 1000
COMMON C_PAYMENT_FROM_CLIENT_MAX_TOTAL 5000
COMMON C_PAYMENT_TO_SUPPLIER_MIN_TOTAL 2000
COMMON C_PAYMENT_TO_SUPPLIER_MAX_TOTAL 15000
COMMON BUILD_WITH_SPLIT_HEAVY_TABS 1
COMMON BUILD_WITH_SEPAR_QDISTR_IDX 0
COMMON BUILD_WITH_QD_COMPOUND_ORDR MOST_SELECTIVE_FIRST
COMMON ENABLE_MON_QUERY 0
COMMON HALT_TEST_ON_ERRORS ,CK,
SMALL_03 C_WARES_MAX_ID 400
SMALL_03 C_CUSTOMER_DOC_MAX_ROWS 10
SMALL_03 C_SUPPLIER_DOC_MAX_ROWS 50
SMALL_03 C_CUSTOMER_DOC_MAX_QTY 15
SMALL_03 C_SUPPLIER_DOC_MAX_QTY 50
SMALL_03 C_NUMBER_OF_AGENTS 50

Index(es) for heavy-loaded table(s)

TAB_NAME IDX_NAME IDX_KEY
XQD_1000_1200 XQD_1000_1200_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_1000_3300 XQD_1000_3300_DOC DOC_ID
XQD_1000_3300 XQD_1000_3300_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_1200_2000 XQD_1200_2000_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_2000_3300 XQD_2000_3300_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_2100_3300 XQD_2100_3300_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_3300_3400 XQD_3300_3400_WARE_SOP_ROP_SND WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID

Performance reports

Performance in TOTAL:

ACTION AVG_TIMES_PER_MINUTE AVG_ELAPSED_MS SUCCESSFUL_TIMES_DONE JOB_BEG JOB_END
*** OVERALL *** for 180 minutes: 361.42 131068 65056 2016-10-03 23:26 2016-10-04 02:26
customer order: creation 27.88 124 5019 2016-10-03 23:26 2016-10-04 02:26
customer order: refuse 2.21 35 385 2016-10-03 23:26 2016-10-04 02:26
order to supplier: creation 7.37 5019 1326 2016-10-03 23:26 2016-10-04 02:26
order to supplier: removal 0.09 160395 16 2016-10-03 23:26 2016-10-04 02:26
invoice (draft): creation 7.34 3363 1313 2016-10-03 23:26 2016-10-04 02:26
invoice (draft): removal 0.83 150 144 2016-10-03 23:26 2016-10-04 02:26
invoice accept: apply 1.66 2084369 299 2016-10-03 23:26 2016-10-04 02:26
invoice accept: cancel 0.30 196282 51 2016-10-03 23:26 2016-10-04 02:26
customer reserve: creation 270.04 14840 48608 2016-10-03 23:26 2016-10-04 02:26
customer reserve: removal 6.53 14806 1150 2016-10-03 23:26 2016-10-04 02:26
realization accept: apply 13.15 59 2354 2016-10-03 23:26 2016-10-04 02:26
realization accept: cancel 2.24 45 401 2016-10-03 23:26 2016-10-04 02:26
payment from customer: creation 9.38 109 1688 2016-10-03 23:26 2016-10-04 02:26
payment from customer: removal 0.89 20 153 2016-10-03 23:26 2016-10-04 02:26
payment to supplier: creation 7.64 271 1375 2016-10-03 23:26 2016-10-04 02:26
payment to supplier: removal 0.57 20 99 2016-10-03 23:26 2016-10-04 02:26
service: total inventory turnovers 1.79 8319 323 2016-10-03 23:26 2016-10-04 02:26
service: total monetary turnovers 1.93 15 341 2016-10-03 23:26 2016-10-04 02:26
service: refresh index statistics 0.07 2054 11 2016-10-03 23:26 2016-10-04 02:26
Done for 7740 ms, from 2:27:10.70 to 2:27:18.44.

Performance in DYNAMIC:

ACTION ITRV_NO CNT_OK_PER_MINUTE CNT_ALL CNT_OK CNT_ERR ERR_PRC ITRV_BEG ITRV_END
interval # 1, overall 1 475 9296 8545 751 8.08 23:26:21 23:44:20
interval # 2, overall 2 308 5826 5541 285 4.89 23:44:21 00:02:20
interval # 3, overall 3 389 7323 7002 321 4.38 00:02:21 00:20:20
interval # 4, overall 4 399 7479 7180 299 4.00 00:20:21 00:38:20
interval # 5, overall 5 427 7946 7686 260 3.27 00:38:21 00:56:20
interval # 6, overall 6 436 8273 7843 430 5.20 00:56:21 01:14:20
interval # 7, overall 7 402 7446 7240 206 2.77 01:14:21 01:32:20
interval # 8, overall 8 389 7288 6998 290 3.98 01:32:21 01:50:20
interval # 9, overall 9 288 6091 5187 904 14.84 01:50:21 02:08:20
interval # 10, overall 10 102 2060 1834 226 10.97 02:08:21 02:26:20
Done for 11660 ms, from 2:27:26.63 to 2:27:38.29.

Performance for every MINUTE:

TEST_PHASE MINUTE_SINCE_TEST_START AVG_ESTIMATED MIN_TO_AVG_RATIO MAX_TO_AVG_RATIO ROWS_AGGREGATED DISTINCT_ATTACHMENTS
WARM_TIME 1 2130.01 0.4680 1.3920 1042 96
WARM_TIME 2 1676.15 0.8847 1.0953 461 71
WARM_TIME 3 1292.18 0.9474 1.0566 291 62
WARM_TIME 4 1115.44 0.9182 1.0531 463 65
WARM_TIME 5 967.33 0.9717 1.0290 307 52
WARM_TIME 6 846.64 0.9799 1.0303 202 44
WARM_TIME 7 773.47 0.9668 1.0239 273 51
WARM_TIME 8 725.03 0.9559 1.0318 327 51
WARM_TIME 9 694.54 0.9576 1.0526 563 53
WARM_TIME 10 716.39 0.9186 1.0550 762 52
TEST_TIME 11 734.06 0.9361 1.0488 794 42
TEST_TIME 12 732.40 0.9637 1.0368 706 33
TEST_TIME 13 735.88 0.9526 1.0572 962 29
TEST_TIME 14 745.78 0.9687 1.0252 520 17
TEST_TIME 15 722.94 0.9872 1.0099 183 6
TEST_TIME 16 692.31 0.9888 1.0112 258 7
TEST_TIME 17 663.71 0.9944 1.0174 94 6
TEST_TIME 18 645.19 0.9884 1.0084 184 5
TEST_TIME 19 619.98 0.9943 1.0069 130 4
TEST_TIME 20 596.21 0.9965 1.0017 41 3
TEST_TIME 21 573.59 0.9917 1.0057 119 4
TEST_TIME 22 552.51 0.9992 1.0007 22 1
TEST_TIME 24 507.91 0.9992 1.0007 20 1
TEST_TIME 25 492.25 0.9959 1.0033 58 2
TEST_TIME 26 476.56 0.9988 1.0012 33 2
TEST_TIME 27 468.59 0.9881 1.0048 113 4
TEST_TIME 28 459.05 0.9931 1.0063 59 6
TEST_TIME 29 449.86 0.9915 1.0065 151 4
TEST_TIME 31 426.47 0.9932 1.0104 92 4
TEST_TIME 32 417.69 0.9995 1.0004 14 1
TEST_TIME 34 400.56 0.9866 1.0217 125 6
TEST_TIME 35 400.00 0.9940 1.0065 103 4
TEST_TIME 36 391.67 0.9994 1.0006 19 1
TEST_TIME 37 384.65 0.9914 1.0054 22 4
TEST_TIME 38 377.08 0.9987 1.0012 40 3
TEST_TIME 39 370.49 0.9978 1.0021 60 2
TEST_TIME 40 367.51 0.9955 1.0035 16 2
TEST_TIME 41 360.79 0.9973 1.0021 59 3
TEST_TIME 42 357.66 0.9909 1.0104 77 4
TEST_TIME 43 355.65 0.9925 1.0056 180 5
TEST_TIME 44 358.20 0.9758 1.0081 176 4
TEST_TIME 45 355.62 0.9929 1.0065 94 4
TEST_TIME 46 355.29 0.9856 1.0124 160 8
TEST_TIME 47 354.28 0.9943 1.0065 179 6
TEST_TIME 48 349.95 0.9977 1.0021 80 4
TEST_TIME 49 345.40 0.9947 1.0027 74 3
TEST_TIME 50 340.40 0.9971 1.0060 28 3
TEST_TIME 51 339.58 0.9887 1.0171 68 4
TEST_TIME 52 339.18 0.9988 1.0012 47 2
TEST_TIME 53 336.04 0.9981 1.0019 78 2
TEST_TIME 54 336.47 0.9966 1.0035 132 3
TEST_TIME 55 338.47 0.9795 1.0115 199 5
TEST_TIME 56 337.10 0.9975 1.0063 42 2
TEST_TIME 57 338.32 0.9908 1.0024 78 3
TEST_TIME 58 336.32 0.9910 1.0080 89 3
TEST_TIME 59 333.58 0.9991 1.0067 11 2
TEST_TIME 60 334.09 0.9885 1.0055 39 3
TEST_TIME 61 334.17 0.9889 1.0025 83 4
TEST_TIME 62 331.22 0.9951 1.0051 134 6
TEST_TIME 63 330.63 0.9910 1.0145 186 6
TEST_TIME 64 333.07 0.9914 1.0043 96 5
TEST_TIME 65 333.99 0.9862 1.0136 213 9
TEST_TIME 66 335.02 0.9953 1.0056 58 4
TEST_TIME 67 336.49 0.9936 1.0054 157 6
TEST_TIME 68 341.37 0.9765 1.0167 266 9
TEST_TIME 69 342.48 0.9988 1.0031 49 3
TEST_TIME 70 342.11 0.9898 1.0055 138 6
TEST_TIME 71 339.83 0.9980 1.0022 88 3
TEST_TIME 72 340.34 0.9868 1.0069 74 6
TEST_TIME 73 339.78 0.9948 1.0153 92 5
TEST_TIME 74 345.17 0.9940 1.0074 83 5
TEST_TIME 75 344.24 0.9983 1.0017 75 5
TEST_TIME 77 337.31 0.9996 1.0004 26 1
TEST_TIME 78 335.33 0.9953 1.0033 68 5
TEST_TIME 80 329.44 0.9997 1.0001 5 2
TEST_TIME 81 326.18 0.9977 1.0019 11 2
TEST_TIME 82 325.76 0.9967 1.0069 57 3
TEST_TIME 83 326.64 0.9999 1.0000 6 1
TEST_TIME 84 324.44 0.9967 1.0007 38 3
TEST_TIME 85 329.45 0.9817 1.0035 143 5
TEST_TIME 86 326.89 0.9996 1.0004 25 2
TEST_TIME 87 323.37 0.9999 1.0000 3 1
TEST_TIME 88 322.74 0.9985 1.0052 51 4
TEST_TIME 89 324.21 0.9894 1.0066 111 5
TEST_TIME 91 319.21 0.9999 1.0000 4 1
TEST_TIME 92 320.11 0.9954 1.0031 105 3
TEST_TIME 93 318.87 0.9962 1.0036 169 3
TEST_TIME 94 316.91 0.9991 1.0017 55 3
TEST_TIME 95 316.92 0.9993 1.0006 46 1
TEST_TIME 96 319.73 0.9865 1.0078 42 3
TEST_TIME 97 320.57 0.9948 1.0070 56 3
TEST_TIME 98 319.90 0.9988 1.0011 78 2
TEST_TIME 99 320.10 0.9904 1.0046 52 4
TEST_TIME 100 319.08 0.9978 1.0010 53 3
TEST_TIME 101 318.54 0.9964 1.0053 31 4
TEST_TIME 102 317.87 0.9976 1.0020 145 4
TEST_TIME 103 315.57 0.9999 1.0000 4 1
TEST_TIME 104 315.25 0.9914 1.0050 61 3
TEST_TIME 105 315.61 0.9943 1.0055 49 5
TEST_TIME 106 316.02 0.9987 1.0060 54 3
TEST_TIME 107 316.24 0.9959 1.0036 61 2
TEST_TIME 108 316.39 0.9938 1.0043 34 3
TEST_TIME 109 316.36 0.9952 1.0058 67 4
TEST_TIME 110 317.08 0.9944 1.0005 28 3
TEST_TIME 111 316.13 0.9971 1.0016 69 4
TEST_TIME 112 320.68 0.9877 1.0106 54 5
TEST_TIME 113 322.10 0.9972 1.0081 55 5
TEST_TIME 114 324.50 0.9980 1.0025 16 2
TEST_TIME 115 323.88 0.9957 1.0054 81 4
TEST_TIME 116 325.38 0.9922 1.0051 98 5
TEST_TIME 117 333.66 0.9719 1.0138 150 7
TEST_TIME 118 336.82 0.9958 1.0021 47 3
TEST_TIME 119 338.09 0.9925 1.0057 33 5
TEST_TIME 120 342.62 0.9841 1.0050 158 7
TEST_TIME 121 344.07 0.9925 1.0040 92 6
TEST_TIME 122 346.59 0.9885 1.0136 88 6
TEST_TIME 123 353.99 0.9843 1.0171 137 10
TEST_TIME 124 362.32 0.9857 1.0071 142 7
TEST_TIME 125 362.25 0.9993 1.0006 69 3
TEST_TIME 127 359.20 0.9990 1.0004 27 3
TEST_TIME 128 361.05 0.9875 1.0031 44 4
TEST_TIME 129 360.17 0.9978 1.0007 47 3
TEST_TIME 130 360.42 0.9931 1.0014 97 5
TEST_TIME 131 358.27 0.9997 1.0002 26 2
TEST_TIME 134 353.42 0.9930 1.0016 38 2
TEST_TIME 135 356.87 0.9916 1.0043 42 4
TEST_TIME 136 356.47 0.9994 1.0005 57 4
TEST_TIME 137 355.52 0.9971 1.0037 36 5
TEST_TIME 138 358.56 0.9880 1.0112 109 9
TEST_TIME 139 370.08 0.9727 1.0068 319 11
TEST_TIME 140 372.33 0.9936 1.0082 117 6
TEST_TIME 142 371.24 0.9999 1.0001 12 1
TEST_TIME 143 369.38 0.9999 1.0000 11 2
TEST_TIME 144 372.66 0.9918 1.0093 119 5
TEST_TIME 145 375.54 0.9969 1.0038 210 7
TEST_TIME 146 376.35 0.9948 1.0052 76 5
TEST_TIME 147 378.15 0.9936 1.0077 80 6
TEST_TIME 148 381.49 0.9922 1.0033 95 6
TEST_TIME 149 380.55 0.9990 1.0004 16 3
TEST_TIME 150 379.93 0.9958 1.0010 17 2
TEST_TIME 151 379.75 0.9948 1.0009 24 2
TEST_TIME 152 378.38 0.9979 1.0011 41 3
TEST_TIME 153 378.96 0.9930 1.0050 102 6
TEST_TIME 154 378.75 0.9990 1.0010 111 5
TEST_TIME 155 380.47 0.9953 1.0021 93 5
TEST_TIME 156 380.24 0.9962 1.0010 114 4
TEST_TIME 157 380.36 0.9943 1.0064 83 7
TEST_TIME 158 384.59 0.9911 1.0114 195 10
TEST_TIME 159 390.20 0.9906 1.0110 147 7
TEST_TIME 160 392.57 0.9986 1.0075 33 4
TEST_TIME 161 393.45 0.9991 1.0009 114 4
TEST_TIME 162 393.02 0.9958 1.0027 77 4
TEST_TIME 163 391.92 0.9993 1.0017 35 3
TEST_TIME 164 391.90 0.9957 1.0040 25 3
TEST_TIME 165 392.63 0.9966 1.0022 74 6
TEST_TIME 166 393.37 0.9943 1.0115 72 7
TEST_TIME 167 395.97 0.9989 1.0009 136 6
TEST_TIME 168 396.99 0.9924 1.0093 141 6
TEST_TIME 169 400.46 0.9947 1.0035 202 10
TEST_TIME 170 400.68 0.9971 1.0032 189 7
TEST_TIME 171 401.77 0.9946 1.0041 178 7
TEST_TIME 172 402.29 0.9970 1.0013 53 5
TEST_TIME 173 400.90 0.9990 1.0006 92 3
TEST_TIME 174 398.91 0.9998 1.0001 17 2
TEST_TIME 175 398.39 0.9996 1.0003 56 2
TEST_TIME 176 396.79 0.9989 1.0038 21 4
TEST_TIME 177 396.37 0.9992 1.0007 74 3
TEST_TIME 178 395.27 0.9979 1.0012 61 4
TEST_TIME 179 396.98 0.9961 1.0020 72 4
TEST_TIME 180 396.18 0.9988 1.0006 48 5
TEST_TIME 181 395.67 0.9977 1.0015 48 5
TEST_TIME 182 397.45 0.9915 1.0061 140 6
TEST_TIME 183 398.67 0.9975 1.0011 99 4
TEST_TIME 184 397.05 0.9997 1.0002 36 1
TEST_TIME 185 395.37 0.9990 1.0006 15 2
TEST_TIME 186 395.40 0.9952 1.0007 42 2
TEST_TIME 187 395.09 0.9998 1.0002 31 2
TEST_TIME 189 392.54 0.9964 1.0011 32 3
TEST_TIME 190 391.12 0.9998 1.0000 110 100
Done for 8740 ms, from 2:27:38.69 to 2:27:47.43.

Performance from TRACE for ISQL instance #1:

TRACED_DATA ITRV_NO SP_CLIENT_ORDER SP_CANCEL_CLIENT_ORDER SP_SUPPLIER_ORDER SP_CANCEL_SUPPLIER_ORDER SP_SUPPLIER_INVOICE SP_CANCEL_SUPPLIER_INVOICE SP_ADD_INVOICE_TO_STOCK SP_CANCEL_ADDING_INVOICE SP_CUSTOMER_RESERVE SP_CANCEL_CUSTOMER_RESERVE SP_RESERVE_WRITE_OFF SP_CANCEL_WRITE_OFF SP_PAY_FROM_CUSTOMER SP_CANCEL_PAY_FROM_CUSTOMER SP_PAY_TO_SUPPLIER SP_CANCEL_PAY_TO_SUPPLIER SRV_MAKE_INVNT_SALDO SRV_MAKE_MONEY_SALDO SRV_RECALC_IDX_STAT ITRV_BEG ITRV_END
fetches per second 3 37099 <null> 20667 <null> 3410 <null> 1643 <null> <null> <null> 64965 35769 <null> <null> <null> <null> <null> 1677818 <null> 00:02:21 00:20:20
fetches per second 6 41393 86413 45131 <null> 55383 <null> 1592 <null> <null> 300 79896 <null> 138195 <null> 267357 <null> <null> <null> <null> 00:56:21 01:14:20
fetches per second 8 36929 50393 13480 <null> 53386 <null> 1249 <null> <null> <null> 63321 <null> 123998 <null> <null> <null> <null> <null> <null> 01:32:21 01:50:20
fetches per second 9 30786 <null> 7980 <null> 83956 <null> 1199 <null> <null> <null> 72040 <null> 82879 <null> 302699 <null> <null> <null> <null> 01:50:21 02:08:20
marks per second 3 7332 <null> 1112 <null> 221 <null> 226 <null> <null> <null> 8137 4653 <null> <null> <null> <null> <null> 8363 <null> 00:02:21 00:20:20
marks per second 6 7511 11347 2796 <null> 3055 <null> 101 <null> <null> 93 7065 <null> 2261 <null> 3058 <null> <null> <null> <null> 00:56:21 01:14:20
marks per second 8 6581 4653 501 <null> 2477 <null> 57 <null> <null> <null> 7318 <null> 1936 <null> <null> <null> <null> <null> <null> 01:32:21 01:50:20
marks per second 9 5944 <null> 319 <null> 3977 <null> 58 <null> <null> <null> 9920 <null> 1308 <null> 2114 <null> <null> <null> <null> 01:50:21 02:08:20
reads/fetches*100 3 6 <null> 9 <null> 6 <null> 14 <null> <null> <null> 7 6 <null> <null> <null> <null> <null> 0 <null> 00:02:21 00:20:20
reads/fetches*100 6 5 4 8 <null> 6 <null> 13 <null> <null> 46 6 <null> 5 <null> 3 <null> <null> <null> <null> 00:56:21 01:14:20
reads/fetches*100 8 4 5 9 <null> 6 <null> 15 <null> <null> <null> 7 <null> 5 <null> <null> <null> <null> <null> <null> 01:32:21 01:50:20
reads/fetches*100 9 5 <null> 9 <null> 6 <null> 18 <null> <null> <null> 5 <null> 6 <null> 3 <null> <null> <null> <null> 01:50:21 02:08:20
writes/marks*100 3 15 <null> 11 <null> 5 <null> 0 <null> <null> <null> 7 10 <null> <null> <null> <null> <null> 0 <null> 00:02:21 00:20:20
writes/marks*100 6 13 9 8 <null> 6 <null> 2 <null> <null> 2 8 <null> 8 <null> 4 <null> <null> <null> <null> 00:56:21 01:14:20
writes/marks*100 8 12 15 9 <null> 7 <null> 1 <null> <null> <null> 7 <null> 8 <null> <null> <null> <null> <null> <null> 01:32:21 01:50:20
writes/marks*100 9 14 <null> 7 <null> 9 <null> 4 <null> <null> <null> 8 <null> 7 <null> 6 <null> <null> <null> <null> 01:50:21 02:08:20
Done for 5740 ms, from 2:27:47.71 to 2:27:53.45.

Performance in DETAILS:

UNIT CNT_ALL CNT_OK CNT_ERR ERR_PRC OK_MIN_MS OK_MAX_MS OK_AVG_MS CNT_LK_CONFL JOB_BEG JOB_END
doc_list_aiud 49516 46677 2839 5.73 0 8174 26 2839 2016-10-03 23:26 2016-10-04 02:26
doc_list_biud 49573 46666 2907 5.86 0 519964 935 2907 2016-10-03 23:26 2016-10-04 02:26
sp_add_invoice_to_stock 1112 299 813 73.11 24242 8765203 2084369 813 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_adding_invoice 130 51 79 60.76 94 1246177 196282 79 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_client_order 409 385 24 5.86 0 374 35 24 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_customer_reserve 3090 1150 1940 62.78 0 162116 14806 1940 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_pay_from_customer 155 153 2 1.29 0 141 20 2 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_pay_to_supplier 100 99 1 1.00 0 94 20 1 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_supplier_invoice 211 144 67 31.75 0 1232 150 67 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_supplier_order 98 16 82 83.67 31 1310839 160395 82 2016-10-03 23:26 2016-10-04 02:26
sp_cancel_write_off 1301 401 900 69.17 0 421 45 900 2016-10-03 23:26 2016-10-04 02:26
sp_client_order 5019 5019 0 0.00 0 3120 124 0 2016-10-03 23:26 2016-10-04 02:26
sp_customer_reserve 48608 48608 0 0.00 109 70731 14840 0 2016-10-03 23:26 2016-10-04 02:26
sp_fill_shopping_cart 7658 7658 0 0.00 0 62697 902 0 2016-10-03 23:26 2016-10-04 02:26
sp_fill_shopping_cart_clo_res 48608 48608 0 0.00 0 125 3 0 2016-10-03 23:26 2016-10-04 02:26
sp_get_clo_for_invoice 303 303 0 0.00 0 421 65 0 2016-10-03 23:26 2016-10-04 02:26
sp_kill_cost_storno 1609 705 904 56.18 0 296 5 904 2016-10-03 23:26 2016-10-04 02:26
sp_kill_qstorno_ret_qs2qd 7616 2861 4755 62.43 0 162084 5957 4755 2016-10-03 23:26 2016-10-04 02:26
sp_kill_qty_storno 7683 4801 2882 37.51 0 519964 9081 2882 2016-10-03 23:26 2016-10-04 02:26
sp_lock_selected_doc 4937 3812 1125 22.78 0 16 0 1125 2016-10-03 23:26 2016-10-04 02:26
sp_make_cost_storno 5720 5720 0 0.00 0 1965 81 0 2016-10-03 23:26 2016-10-04 02:26
sp_multiply_rows_for_pdistr 5720 5720 0 0.00 0 343 10 0 2016-10-03 23:26 2016-10-04 02:26
sp_multiply_rows_for_qdistr 5020 5020 0 0.00 0 2855 84 0 2016-10-03 23:26 2016-10-04 02:26
sp_pay_from_customer 1688 1688 0 0.00 31 671 109 0 2016-10-03 23:26 2016-10-04 02:26
sp_pay_to_supplier 1375 1375 0 0.00 31 2262 271 0 2016-10-03 23:26 2016-10-04 02:26
sp_payment_common 3063 3063 0 0.00 0 250 31 0 2016-10-03 23:26 2016-10-04 02:26
sp_qd_handle_on_cancel_clo 409 385 24 5.86 0 359 16 24 2016-10-03 23:26 2016-10-04 02:26
sp_qd_handle_on_invoice_upd_sts 389 351 38 9.76 15 519964 75367 38 2016-10-03 23:26 2016-10-04 02:26
sp_qd_handle_on_reserve_upd_sts 2355 2354 1 0.04 0 218 16 1 2016-10-03 23:26 2016-10-04 02:26
sp_reserve_write_off 2418 2354 64 2.64 0 702 59 64 2016-10-03 23:26 2016-10-04 02:26
sp_supplier_invoice 1313 1313 0 0.00 31 62743 3363 0 2016-10-03 23:26 2016-10-04 02:26
sp_supplier_order 1326 1326 0 0.00 31 60216 5019 0 2016-10-03 23:26 2016-10-04 02:26
srv_find_qd_qs_mism 26958 24112 2846 10.55 0 8128 27 2846 2016-10-03 23:26 2016-10-04 02:26
srv_make_invnt_saldo 323 323 0 0.00 2137 26240 8319 0 2016-10-03 23:26 2016-10-04 02:26
srv_make_money_saldo 341 341 0 0.00 0 62 15 0 2016-10-03 23:26 2016-10-04 02:26
srv_recalc_idx_stat 11 11 0 0.00 1202 4383 2054 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_add_invoice_to_stock 813 813 0 0.00 0 93 6 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_adding_invoice 202 202 0 0.00 0 171 35 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_client_order 24 24 0 0.00 0 47 10 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_customer_reserve 4 4 0 0.00 0 15 3 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_pay_from_customer 2 2 0 0.00 0 15 7 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_pay_to_supplier 1 1 0 0.00 47 47 47 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_supplier_invoice 62 62 0 0.00 0 63 7 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_supplier_order 257 257 0 0.00 0 265 45 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_cancel_write_off 4 4 0 0.00 0 15 7 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-abend:sp_reserve_write_off 64 64 0 0.00 0 32 6 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_add_invoice_to_stock 345 345 0 0.00 0 3869 367 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_adding_invoice 40 40 0 0.00 0 343 91 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_client_order 385 385 0 0.00 0 109 12 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_customer_reserve 196 196 0 0.00 0 156 16 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_pay_from_customer 153 153 0 0.00 0 78 10 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_pay_to_supplier 99 99 0 0.00 0 62 8 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_supplier_invoice 42 42 0 0.00 0 125 16 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_supplier_order 16 16 0 0.00 0 1076 157 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_cancel_write_off 234 234 0 0.00 0 187 11 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_client_order 5021 5021 0 0.00 0 234 14 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_customer_reserve 262 262 0 0.00 0 78 10 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_pay_from_customer 1688 1688 0 0.00 0 140 10 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_pay_to_supplier 1377 1377 0 0.00 0 140 10 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_reserve_write_off 2355 2355 0 0.00 0 219 13 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_supplier_invoice 1314 1314 0 0.00 0 266 17 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:sp_supplier_order 1358 1358 0 0.00 0 219 16 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:srv_make_invnt_saldo 324 324 0 0.00 0 31 3 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:srv_make_money_saldo 342 342 0 0.00 0 62 3 0 2016-10-03 23:26 2016-10-04 02:26
t$perf-norm:srv_recalc_idx_stat 11 11 0 0.00 0 109 31 0 2016-10-03 23:26 2016-10-04 02:26
v_add_invoice_to_stock 2224 598 1626 73.11 0 16 2 1626 2016-10-03 23:26 2016-10-04 02:26
v_all_customers 7580 7580 0 0.00 0 16 0 0 2016-10-03 23:26 2016-10-04 02:26
v_all_suppliers 5278 5278 0 0.00 0 16 0 0 2016-10-03 23:26 2016-10-04 02:26
v_all_wares 10038 10038 0 0.00 0 16 0 0 2016-10-03 23:26 2016-10-04 02:26
v_cancel_adding_invoice 216 78 138 63.88 0 47 7 138 2016-10-03 23:26 2016-10-04 02:26
v_cancel_client_order 818 770 48 5.86 0 16 0 48 2016-10-03 23:26 2016-10-04 02:26
v_cancel_customer_prepayment 310 306 4 1.29 0 16 1 4 2016-10-03 23:26 2016-10-04 02:26
v_cancel_customer_reserve 390 382 8 2.05 0 16 1 8 2016-10-03 23:26 2016-10-04 02:26
v_cancel_payment_to_supplier 200 198 2 1.00 0 16 1 2 2016-10-03 23:26 2016-10-04 02:26
v_cancel_supplier_invoice 208 84 124 59.61 0 16 2 124 2016-10-03 23:26 2016-10-04 02:26
v_cancel_supplier_order 196 32 164 83.67 0 16 0 164 2016-10-03 23:26 2016-10-04 02:26
v_cancel_write_off 476 468 8 1.68 0 16 2 8 2016-10-03 23:26 2016-10-04 02:26
v_max_id_clo_ord 1326 1326 0 0.00 0 998 24 0 2016-10-03 23:26 2016-10-04 02:26
v_max_id_clo_res 261 261 0 0.00 0 16 1 0 2016-10-03 23:26 2016-10-04 02:26
v_max_id_ord_sup 1313 1313 0 0.00 0 905 17 0 2016-10-03 23:26 2016-10-04 02:26
v_max_non_paid_invoice 1375 1375 0 0.00 0 62 4 0 2016-10-03 23:26 2016-10-04 02:26
v_max_non_paid_realizn 1688 1688 0 0.00 0 63 5 0 2016-10-03 23:26 2016-10-04 02:26
v_min_id_clo_ord 1326 1326 0 0.00 0 1544 73 0 2016-10-03 23:26 2016-10-04 02:26
v_min_id_clo_res 261 261 0 0.00 0 16 1 0 2016-10-03 23:26 2016-10-04 02:26
v_min_id_ord_sup 1313 1313 0 0.00 0 2262 71 0 2016-10-03 23:26 2016-10-04 02:26
v_min_non_paid_invoice 1375 1375 0 0.00 0 203 32 0 2016-10-03 23:26 2016-10-04 02:26
v_min_non_paid_realizn 1688 1688 0 0.00 0 78 12 0 2016-10-03 23:26 2016-10-04 02:26
v_our_firm 2458 2458 0 0.00 0 16 0 0 2016-10-03 23:26 2016-10-04 02:26
v_reserve_write_off 4836 4708 128 2.64 0 32 1 128 2016-10-03 23:26 2016-10-04 02:26
x_lock_depdocs_on_canc_invoice 379 153 226 59.63 0 16 2 226 2016-10-03 23:26 2016-10-04 02:26
x_lock_depdocs_on_canc_sup_ord 98 16 82 83.67 0 16 4 82 2016-10-03 23:26 2016-10-04 02:26
x_make_qstorno_1000_1200 1333 1333 0 0.00 15 41855 1995 0 2016-10-03 23:26 2016-10-04 02:26
x_make_qstorno_1200_2000 1313 1313 0 0.00 0 25880 1234 0 2016-10-03 23:26 2016-10-04 02:26
x_make_qstorno_2100_3300 48608 48608 0 0.00 109 70715 14821 0 2016-10-03 23:26 2016-10-04 02:26
Done for 21820 ms, from 2:28:07.49 to 2:28:29.31.

Config param. mon_unit_perf=0, data from MON$ tables were NOT gathered.

Exceptions occured during test work:

FB_MNEMONA CNT UNIT FB_GDSCODE DTS_BEG DTS_END
deadlock 11 sp_kill_cost_storno 335544336 2016-10-03 23:28 2016-10-04 02:06
deadlock 9 sp_qd_handle_on_invoice_upd_sts 335544336 2016-10-03 23:33 2016-10-04 02:16
lock_conflict 3 sp_kill_cost_storno 335544345 2016-10-03 23:26 2016-10-04 01:53
lock_conflict 946 sp_lock_selected_doc 335544345 2016-10-03 23:26 2016-10-04 02:26
lock_conflict 24 sp_qd_handle_on_cancel_clo 335544345 2016-10-03 23:26 2016-10-04 02:19
lock_conflict 26 sp_qd_handle_on_invoice_upd_sts 335544345 2016-10-03 23:26 2016-10-04 02:16
lock_conflict 1 sp_qd_handle_on_reserve_upd_sts 335544345 2016-10-04 00:26 2016-10-04 00:26
lock_conflict 81 x_lock_depdocs_on_canc_invoice 335544345 2016-10-03 23:26 2016-10-04 02:16
lock_conflict 27 x_lock_depdocs_on_canc_sup_ord 335544345 2016-10-03 23:27 2016-10-04 02:18
Done for 2440 ms, from 2:28:29.81 to 2:28:32.25.

MON$DATABASE and FB VERSION info

MON$DATABASE_NAME D:\OLTP-EMUL\OLTP25-SMALL.FDB
MON$PAGE_SIZE 8192
MON$ODS_MAJOR 11
MON$ODS_MINOR 2
MON$OLDEST_TRANSACTION 91035
MON$OLDEST_ACTIVE 91036
MON$OLDEST_SNAPSHOT 91036
MON$NEXT_TRANSACTION 91036
MON$PAGE_BUFFERS 384
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 2015-12-11 10:02:47.3010
MON$PAGES 163560
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.7.27026 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.7.27026 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.7.27026 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.7.27026 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
on disk structure version 11.2

Database statistics, full


Database "D:\OLTP-EMUL\oltp25-small.fdb"
Database header page information:
Flags 0
Checksum 12345
Generation 95512
Page size 8192
ODS version 11.2
Oldest transaction 91037
Oldest active 91038
Oldest snapshot 91038
Next transaction 91039
Bumped transaction 1
Sequence number 0
Next attachment ID 4434
Implementation ID 24
Shadow count 0
Page buffers 0
Next header page 0
Database dialect 3
Creation date Dec 11, 2015 10:02:47
Attributes force write

Variable header data:
Sweep interval: 0
*END*


Database file sequence:
File D:\OLTP-EMUL\oltp25-small.fdb is the only file

Analyzing database pages ...
AGENTS (154)
Primary pointer page: 259, Index root page: 260
Average record length: 34.62, total records: 50
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 32%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index AGENTS_ID_DESC (2)
Depth: 1, leaf buckets: 1, nodes: 50
Average data length: 7.10, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index AGENTS_IS_OUR_FIRM (4)
Depth: 1, leaf buckets: 1, nodes: 50
Average data length: 0.06, total dup: 48, max dup: 48
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index AGENTS_IS_SUPPLIER (3)
Depth: 1, leaf buckets: 1, nodes: 50
Average data length: 0.06, total dup: 48, max dup: 47
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index AGENTS_NAME_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 50
Average data length: 13.88, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_AGENTS (0)
Depth: 1, leaf buckets: 1, nodes: 50
Average data length: 7.10, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

BUSINESS_OPS (158)
Primary pointer page: 280, Index root page: 281
Average record length: 103.00, total records: 19
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 28%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index BO_UNIT_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 19
Average data length: 14.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index BUSINESS_OPS_RND_WGTH (2)
Depth: 1, leaf buckets: 1, nodes: 19
Average data length: 0.84, total dup: 7, max dup: 3
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index RDB$1 (0)
Depth: 1, leaf buckets: 1, nodes: 19
Average data length: 1.63, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

DOC_DATA (141)
Primary pointer page: 199, Index root page: 200
Average record length: 44.81, total records: 467427
Average version length: 46.22, total versions: 13899, max versions: 1
Data pages: 4993, data page slots: 4993, average fill: 73%
Fill distribution:
0 - 19% = 0
20 - 39% = 8
40 - 59% = 91
60 - 79% = 4850
80 - 99% = 44

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1532, nodes: 467427
Average data length: 11.73, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 148
20 - 39% = 50
40 - 59% = 595
60 - 79% = 90
80 - 99% = 649

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1371, nodes: 467427
Average data length: 5.95, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 23
40 - 59% = 1348
60 - 79% = 0
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 453, nodes: 467427
Average data length: 0.88, total dup: 402889, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 27
40 - 59% = 190
60 - 79% = 5
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.60, total records: 78334
Average version length: 50.34, total versions: 7921, max versions: 5
Data pages: 1007, data page slots: 1007, average fill: 79%
Fill distribution:
0 - 19% = 5
20 - 39% = 20
40 - 59% = 58
60 - 79% = 301
80 - 99% = 623

Index DOC_LIST_ID_DESC (1)
Depth: 2, leaf buckets: 229, nodes: 78334
Average data length: 6.27, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 16
40 - 59% = 213
60 - 79% = 0
80 - 99% = 0

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 68, nodes: 78334
Average data length: 0.01, total dup: 78284, max dup: 18152
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 49
60 - 79% = 16
80 - 99% = 3

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 162, nodes: 78334
Average data length: 6.27, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 5
20 - 39% = 12
40 - 59% = 76
60 - 79% = 0
80 - 99% = 69

DOC_STATES (153)
Primary pointer page: 257, Index root page: 258
Average record length: 67.50, total records: 4
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 4%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index DOC_STATES_MCODE_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 13.75, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index DOC_STATES_NAME_UNQ (2)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 29.75, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_DOC_STATES (0)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 1.50, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

FB_ERRORS (159)
Primary pointer page: 287, Index root page: 288
Average record length: 79.56, total records: 758
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 12, data page slots: 12, average fill: 75%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 4
80 - 99% = 7

Index FB_ERRORS_GDS_CODE (0)
Depth: 1, leaf buckets: 1, nodes: 758
Average data length: 1.03, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

INVNT_SALDO (147)
Primary pointer page: 216, Index root page: 217
Average record length: 62.31, total records: 400
Average version length: 13.69, total versions: 81452, max versions: 241
Data pages: 324, data page slots: 324, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 323

Index PK_INVNT_SALDO (0)
Depth: 1, leaf buckets: 1, nodes: 400
Average data length: 7.22, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 0

INVNT_TURNOVER_LOG (157)
Primary pointer page: 278, Index root page: 279
Average record length: 0.02, total records: 171733
Average version length: 68.64, total versions: 171681, max versions: 1
Data pages: 2453, data page slots: 2453, average fill: 88%
Fill distribution:
0 - 19% = 1
20 - 39% = 22
40 - 59% = 83
60 - 79% = 204
80 - 99% = 2143

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 417, nodes: 171733
Average data length: 8.32, total dup: 18533, max dup: 4
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 74
60 - 79% = 243
80 - 99% = 97

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.41, total records: 49
Average version length: 9.00, total versions: 4487, max versions: 384
Data pages: 16, data page slots: 16, average fill: 91%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 15

Index PK_MONEY_SALDO (0)
Depth: 1, leaf buckets: 1, nodes: 49
Average data length: 7.10, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

MONEY_TURNOVER_LOG (142)
Primary pointer page: 206, Index root page: 207
Average record length: 0.18, total records: 8099
Average version length: 44.08, total versions: 8067, max versions: 1
Data pages: 84, data page slots: 84, average fill: 92%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 83

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 6, nodes: 8099
Average data length: 0.12, total dup: 8004, max dup: 1794
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 2
60 - 79% = 3
80 - 99% = 1

MON_LOG (164)
Primary pointer page: 303, Index root page: 304
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_DTS (4)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_GDSCODE (2)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_ROWSET_DESC (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_UNIT (3)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_MON_LOG (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

MON_LOG_TABLE_STATS (165)
Primary pointer page: 316, Index root page: 317
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_TABLE_STATS_DTS (4)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_TABLE_STATS_GDSCODE (2)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_TABLE_STATS_ROWSET (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_TABLE_STATS_TN_UNIT (3)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_MON_LOG_TABLE_STATS (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

OPTYPES (138)
Primary pointer page: 186, Index root page: 187
Average record length: 67.89, total records: 9
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 9%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index OPTYPES_MCODE_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 9
Average data length: 4.56, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_OPTYPES (0)
Depth: 1, leaf buckets: 1, nodes: 9
Average data length: 2.11, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

PDISTR (150)
Primary pointer page: 241, Index root page: 242
Average record length: 23.13, total records: 144368
Average version length: 31.32, total versions: 108630, max versions: 11
Data pages: 1541, data page slots: 1541, average fill: 88%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 5
60 - 79% = 265
80 - 99% = 1270

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 128, nodes: 144368
Average data length: 0.01, total dup: 144319, max dup: 32852
Fill distribution:
0 - 19% = 0
20 - 39% = 5
40 - 59% = 81
60 - 79% = 19
80 - 99% = 23

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 156, nodes: 144368
Average data length: 0.89, total dup: 130020, max dup: 29
Fill distribution:
0 - 19% = 2
20 - 39% = 1
40 - 59% = 100
60 - 79% = 31
80 - 99% = 22

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 162, nodes: 144368
Average data length: 0.89, total dup: 130020, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 103
60 - 79% = 34
80 - 99% = 23

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 142, nodes: 144368
Average data length: 0.66, total dup: 130020, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 69
60 - 79% = 51
80 - 99% = 22

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 26.97, total records: 22121
Average version length: 18.00, total versions: 2, max versions: 1
Data pages: 182, data page slots: 182, average fill: 65%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 182
80 - 99% = 0

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 16, nodes: 22121
Average data length: 0.01, total dup: 21941, max dup: 1041
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 7
60 - 79% = 6
80 - 99% = 3

PERF_ISQL_STAT (161)
Primary pointer page: 296, Index root page: 297
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PERF_ISQL_STAT_TRN (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

PERF_LOG (162)
Primary pointer page: 299, Index root page: 300
Average record length: 143.97, total records: 1205560
Average version length: 153.00, total versions: 1, max versions: 1
Data pages: 27470, data page slots: 27470, average fill: 86%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 27469

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1509, nodes: 1205560
Average data length: 0.62, total dup: 661023, max dup: 36
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1159
60 - 79% = 228
80 - 99% = 122

Index PERF_LOG_GDSCODE (3)
Depth: 3, leaf buckets: 1191, nodes: 1205560
Average data length: 0.00, total dup: 1205555, max dup: 1168488
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1190
60 - 79% = 0
80 - 99% = 1

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1506, nodes: 1205560
Average data length: 0.39, total dup: 1132442, max dup: 2901
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1307
60 - 79% = 117
80 - 99% = 82

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1327, nodes: 1205560
Average data length: 0.26, total dup: 1177391, max dup: 134316
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 951
60 - 79% = 183
80 - 99% = 191

PHRASES (145)
Primary pointer page: 212, Index root page: 213
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PHRASES_ID_DESC (3)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PHRASES_NAME (2)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PHRASES_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_PHRASES (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

PSTORNED (151)
Primary pointer page: 248, Index root page: 249
Average record length: 51.82, total records: 86922
Average version length: 54.75, total versions: 4645, max versions: 1
Data pages: 1011, data page slots: 1011, average fill: 76%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 960
80 - 99% = 51

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 109, nodes: 86922
Average data length: 1.13, total dup: 72178, max dup: 144
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 106
60 - 79% = 1
80 - 99% = 2

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 79, nodes: 86922
Average data length: 0.60, total dup: 79443, max dup: 77
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 40
60 - 79% = 32
80 - 99% = 7

RULES_FOR_PDISTR (152)
Primary pointer page: 250, Index root page: 251
Average record length: 18.00, total records: 4
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 2%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index RULES_FOR_PDISTR_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 7.50, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

RULES_FOR_QDISTR (139)
Primary pointer page: 190, Index root page: 191
Average record length: 32.71, total records: 7
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 4%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index RULES_FOR_QDISTR_RCVOP (1)
Depth: 1, leaf buckets: 1, nodes: 7
Average data length: 1.57, total dup: 2, max dup: 2
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index RULES_FOR_QDISTR_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 7
Average data length: 6.14, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

SEMAPHORES (156)
Primary pointer page: 263, Index root page: 264
Average record length: 34.25, total records: 4
Average version length: 9.00, total versions: 915, max versions: 453
Data pages: 4, data page slots: 4, average fill: 73%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 3

Index PK_SEMAPHORES (0)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 8.50, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index SEMAPHORES_TASK_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 18.50, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

SETTINGS (137)
Primary pointer page: 183, Index root page: 184
Average record length: 98.32, total records: 114
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 2, data page slots: 2, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 1

Index SETTINGS_MODE_CODE (0)
Depth: 1, leaf buckets: 1, nodes: 114
Average data length: 23.07, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$AUTOGEN$RAND$CALLS (136)
Primary pointer page: 180, Index root page: 181
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$AUTOGEN$SOURCE (135)
Primary pointer page: 178, Index root page: 179
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$DEP_DOCS (129)
Primary pointer page: 159, Index root page: 160
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP_DEP_DOCS_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$IDX_RECALC (132)
Primary pointer page: 169, Index root page: 170
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP_IDX_RECALC_IDX_NAME_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$MON_LOG (133)
Primary pointer page: 174, Index root page: 175
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$MON_LOG_TABLE_STATS (134)
Primary pointer page: 176, Index root page: 177
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$PERF_LOG (163)
Primary pointer page: 301, Index root page: 302
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP$PERF_LOG_UNIT_TRN_DTS_END (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$PERF_MON (131)
Primary pointer page: 167, Index root page: 168
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$RESULT_SET (130)
Primary pointer page: 162, Index root page: 163
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP_RESULT_SET_DOC (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP_RESULT_SET_WARE_DOC (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$SHOPPING_CART (128)
Primary pointer page: 155, Index root page: 156
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index TMP_SHOPCART_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TRACE_STAT (276)
Primary pointer page: 513, Index root page: 95177
Average record length: 59.32, total records: 233
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 3, data page slots: 3, average fill: 73%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3
80 - 99% = 0

WARES (144)
Primary pointer page: 210, Index root page: 211
Average record length: 78.00, total records: 400
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 6, data page slots: 6, average fill: 78%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 4
80 - 99% = 2

Index FK_WARES_WARE_GROUPS (3)
Depth: 1, leaf buckets: 1, nodes: 400
Average data length: 0.14, total dup: 392, max dup: 62
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_WARES (0)
Depth: 1, leaf buckets: 1, nodes: 400
Average data length: 7.22, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 0

Index WARES_ID_DESC (2)
Depth: 1, leaf buckets: 1, nodes: 400
Average data length: 7.22, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 0

Index WARES_NUMB_UNQ (1)
Depth: 2, leaf buckets: 2, nodes: 400
Average data length: 19.40, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 2
60 - 79% = 0
80 - 99% = 0

WARE_GROUPS (155)
Primary pointer page: 261, Index root page: 262
Average record length: 32.13, total records: 8
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 5%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_WARE_GROUPS (0)
Depth: 1, leaf buckets: 1, nodes: 8
Average data length: 7.25, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index WARE_GROUPS_NAME_UNQ (1)
Depth: 1, leaf buckets: 1, nodes: 8
Average data length: 15.88, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

XQD_1000_1200 (258)
Primary pointer page: 645, Index root page: 646
Average record length: 0.24, total records: 280426
Average version length: 69.72, total versions: 279460, max versions: 1
Data pages: 3756, data page slots: 3756, average fill: 95%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 3755

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 332, nodes: 280426
Average data length: 1.25, total dup: 245572, max dup: 29
Fill distribution:
0 - 19% = 6
20 - 39% = 5
40 - 59% = 139
60 - 79% = 119
80 - 99% = 63

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 49.84, total records: 267497
Average version length: 69.19, total versions: 76400, max versions: 1
Data pages: 3614, data page slots: 3618, average fill: 83%
Fill distribution:
0 - 19% = 3
20 - 39% = 5
40 - 59% = 7
60 - 79% = 1709
80 - 99% = 1890

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 236, nodes: 267497
Average data length: 0.15, total dup: 261619, max dup: 179
Fill distribution:
0 - 19% = 0
20 - 39% = 22
40 - 59% = 107
60 - 79% = 16
80 - 99% = 91

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 316, nodes: 267497
Average data length: 1.26, total dup: 234501, max dup: 36
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 155
60 - 79% = 98
80 - 99% = 61

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.14, total records: 324081
Average version length: 69.67, total versions: 323435, max versions: 1
Data pages: 4348, data page slots: 4348, average fill: 95%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 6
80 - 99% = 4342

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 364, nodes: 324081
Average data length: 1.01, total dup: 291903, max dup: 125
Fill distribution:
0 - 19% = 2
20 - 39% = 2
40 - 59% = 152
60 - 79% = 140
80 - 99% = 68

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 18.69, total records: 1025550
Average version length: 68.25, total versions: 750374, max versions: 1
Data pages: 13815, data page slots: 13815, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 3386
80 - 99% = 10428

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1297, nodes: 1025550
Average data length: 1.15, total dup: 905216, max dup: 93
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 978
60 - 79% = 137
80 - 99% = 182

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 2.20, total records: 220739
Average version length: 68.76, total versions: 213717, max versions: 1
Data pages: 3862, data page slots: 3913, average fill: 73%
Fill distribution:
0 - 19% = 73
20 - 39% = 193
40 - 59% = 328
60 - 79% = 1851
80 - 99% = 1417

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 297, nodes: 220739
Average data length: 1.42, total dup: 189327, max dup: 93
Fill distribution:
0 - 19% = 2
20 - 39% = 16
40 - 59% = 149
60 - 79% = 112
80 - 99% = 18

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 37.69, total records: 730037
Average version length: 68.31, total versions: 330335, max versions: 1
Data pages: 10299, data page slots: 10312, average fill: 81%
Fill distribution:
0 - 19% = 144
20 - 39% = 191
40 - 59% = 248
60 - 79% = 3688
80 - 99% = 6028

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1020, nodes: 730037
Average data length: 1.32, total dup: 632063, max dup: 44
Fill distribution:
0 - 19% = 3
20 - 39% = 17
40 - 59% = 769
60 - 79% = 116
80 - 99% = 115

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.64, total records: 984815
Average version length: 80.65, total versions: 24784, max versions: 1
Data pages: 14704, data page slots: 14704, average fill: 80%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 6501
80 - 99% = 8202

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1096, nodes: 984815
Average data length: 0.16, total dup: 962490, max dup: 159
Fill distribution:
0 - 19% = 7
20 - 39% = 0
40 - 59% = 825
60 - 79% = 211
80 - 99% = 53

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 779, nodes: 984815
Average data length: 0.73, total dup: 864705, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 125
60 - 79% = 20
80 - 99% = 632

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1245, nodes: 984815
Average data length: 0.75, total dup: 862153, max dup: 38
Fill distribution:
0 - 19% = 9
20 - 39% = 0
40 - 59% = 934
60 - 79% = 249
80 - 99% = 53

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 70.28, total records: 612236
Average version length: 80.17, total versions: 75954, max versions: 1
Data pages: 9327, data page slots: 9340, average fill: 80%
Fill distribution:
0 - 19% = 78
20 - 39% = 88
40 - 59% = 115
60 - 79% = 5117
80 - 99% = 3929

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 631, nodes: 612236
Average data length: 0.15, total dup: 598886, max dup: 272
Fill distribution:
0 - 19% = 1
20 - 39% = 9
40 - 59% = 353
60 - 79% = 218
80 - 99% = 50

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 494, nodes: 612236
Average data length: 0.83, total dup: 531447, max dup: 14
Fill distribution:
0 - 19% = 6
20 - 39% = 8
40 - 59% = 67
60 - 79% = 5
80 - 99% = 408

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 756, nodes: 612236
Average data length: 0.72, total dup: 541312, max dup: 45
Fill distribution:
0 - 19% = 32
20 - 39% = 8
40 - 59% = 442
60 - 79% = 242
80 - 99% = 32

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 77.40, total records: 1022919
Average version length: 81.38, total versions: 41724, max versions: 1
Data pages: 15274, data page slots: 15274, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7380
80 - 99% = 7894

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1062, nodes: 1022919
Average data length: 0.05, total dup: 1016732, max dup: 893
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 722
60 - 79% = 249
80 - 99% = 91

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 774, nodes: 1022919
Average data length: 0.70, total dup: 902495, max dup: 49
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 79
60 - 79% = 6
80 - 99% = 689

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1216, nodes: 1022919
Average data length: 0.70, total dup: 902868, max dup: 125
Fill distribution:
0 - 19% = 5
20 - 39% = 1
40 - 59% = 768
60 - 79% = 333
80 - 99% = 109

XQS_2000_3300 (267)
Primary pointer page: 683, Index root page: 684
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index XQS_2000_3300_DOC_ID (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index XQS_2000_3300_RCV_ID (2)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index XQS_2000_3300_SND_ID (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

XQS_2100_3300 (268)
Primary pointer page: 691, Index root page: 692
Average record length: 73.06, total records: 769907
Average version length: 80.28, total versions: 70910, max versions: 1
Data pages: 11898, data page slots: 11924, average fill: 79%
Fill distribution:
0 - 19% = 158
20 - 39% = 198
40 - 59% = 216
60 - 79% = 5798
80 - 99% = 5528

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 713, nodes: 769907
Average data length: 0.05, total dup: 765490, max dup: 1193
Fill distribution:
0 - 19% = 2
20 - 39% = 10
40 - 59% = 251
60 - 79% = 316
80 - 99% = 134

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 713, nodes: 769907
Average data length: 0.85, total dup: 665851, max dup: 14
Fill distribution:
0 - 19% = 11
20 - 39% = 21
40 - 59% = 233
60 - 79% = 7
80 - 99% = 441

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 810, nodes: 769907
Average data length: 0.70, total dup: 682011, max dup: 67
Fill distribution:
0 - 19% = 1
20 - 39% = 6
40 - 59% = 270
60 - 79% = 371
80 - 99% = 162

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 61.14, total records: 334732
Average version length: 68.31, total versions: 35437, max versions: 1
Data pages: 4506, data page slots: 4506, average fill: 79%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3626
80 - 99% = 879

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 297, nodes: 334732
Average data length: 0.22, total dup: 324242, max dup: 233
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 101
60 - 79% = 109
80 - 99% = 87

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 349, nodes: 334732
Average data length: 0.82, total dup: 291445, max dup: 44
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 133
60 - 79% = 137
80 - 99% = 78

ZDOC_DATA (228)
Primary pointer page: 564, Index root page: 565
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZDOC_LIST (227)
Primary pointer page: 560, Index root page: 561
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZINVNT_TURNOVER_LOG (229)
Primary pointer page: 567, Index root page: 568
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZPDISTR (232)
Primary pointer page: 573, Index root page: 574
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZPDISTR_ID (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZPSTORNED (233)
Primary pointer page: 575, Index root page: 576
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZPSTORNED_ID (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZQDISTR (230)
Primary pointer page: 569, Index root page: 570
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQDISTR_ID (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQDISTR_WARE_SNDOP_RCVOP (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZQSTORNED (231)
Primary pointer page: 571, Index root page: 572
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQSTORNED_DOC_ID (1)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQSTORNED_ID (0)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQSTORNED_RCV_ID (3)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index ZQSTORNED_SND_ID (2)
Depth: 1, leaf buckets: 1, nodes: 0
Average data length: 0.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZTMP_DEP_DOCS (226)
Primary pointer page: 558, Index root page: 559
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

ZTMP_SHOPPING_CART (225)
Primary pointer page: 556, Index root page: 557
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Z_USED_VIEWS (146)
Primary pointer page: 214, Index root page: 215
Average record length: 29.19, total records: 32
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 18%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index Z_USED_VIEWS_UNQ (0)
Depth: 1, leaf buckets: 1, nodes: 32
Average data length: 10.78, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Done for 18930 ms, from 2:28:32.85 to 2:28:51.78.

Analyzing DB stat log: obtaining values of total records and versions

TABLE_NAME TOTAL_RECS TOTAL_VERS VERS_PERCENT
AGENTS 50 0 0.0000
BUSINESS_OPS 19 0 0.0000
DOC_DATA 467427 13899 2.9735
DOC_LIST 78334 7921 10.1118
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 81452 20363.0000
INVNT_TURNOVER_LOG 171733 171681 99.9697
MONEY_SALDO 49 4487 9157.1428
MONEY_TURNOVER_LOG 8099 8067 99.6048
OPTYPES 9 0 0.0000
PDISTR 144368 108630 75.2452
PERF_ESTIMATED 22121 2 0.0090
PERF_LOG 1205560 1 0.0000
PSTORNED 86922 4645 5.3438
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 915 22875.0000
SETTINGS 114 0 0.0000
TRACE_STAT 233 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 280426 279460 99.6555
XQD_1000_3300 267497 76400 28.5610
XQD_1200_2000 324081 323435 99.8006
XQD_2000_3300 1025550 750374 73.1679
XQD_2100_3300 220739 213717 96.8188
XQD_3300_3400 730037 330335 45.2490
XQS_1000_1200 984815 24784 2.5166
XQS_1000_3300 612236 75954 12.4060
XQS_1200_2000 1022919 41724 4.0789
XQS_2100_3300 769907 70910 9.2102
XQS_3300_3400 334732 35437 10.5866
Z_USED_VIEWS 32 0 0.0000
Done for 2750 ms, from 2:29:00.54 to 2:29:03.29.

Database validation

02:29:03.41 Validation started

02:29:03.41 Relation 140 (DOC_LIST)
02:29:03.41 process pointer page 0 of 1
02:29:03.48 Index 1 (PK_DOC_LIST)
02:29:03.51 Index 2 (DOC_LIST_ID_DESC)
02:29:03.52 Index 3 (FK_DOC_LIST_AGENTS)
02:29:03.56 Relation 140 (DOC_LIST) is ok

02:29:03.56 Relation 141 (DOC_DATA)
02:29:03.56 process pointer page 0 of 3
02:29:03.65 process pointer page 1 of 3
02:29:03.76 process pointer page 2 of 3
02:29:03.80 Index 2 (DOC_DATA_DOC_WARE_UNQ)
02:29:04.01 Index 3 (DOC_DATA_ID_DESC)
02:29:04.15 Index 4 (FK_DOC_DATA_DOC_LIST)
02:29:04.19 Relation 141 (DOC_DATA) is ok

02:29:04.19 Relation 147 (INVNT_SALDO)
02:29:04.19 process pointer page 0 of 1
02:29:04.26 Index 1 (PK_INVNT_SALDO)
02:29:04.26 Relation 147 (INVNT_SALDO) is ok

02:29:04.26 Relation 150 (PDISTR)
02:29:04.26 process pointer page 0 of 1
02:29:04.44 Index 2 (PDISTR_SND_ID)
02:29:04.48 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
02:29:04.52 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
02:29:04.55 Index 5 (PDISTR_AGENT_ID)
02:29:04.60 Relation 150 (PDISTR) is ok

02:29:04.60 Relation 151 (PSTORNED)
02:29:04.60 process pointer page 0 of 1
02:29:04.65 Index 2 (PSTORNED_SND_ID)
02:29:04.68 Index 3 (PSTORNED_RCV_ID)
02:29:04.69 Relation 151 (PSTORNED) is ok

02:29:04.69 Relation 156 (SEMAPHORES)
02:29:04.69 process pointer page 0 of 1
02:29:04.69 Index 1 (PK_SEMAPHORES)
02:29:04.69 Index 2 (SEMAPHORES_TASK_UNQ)
02:29:04.69 Relation 156 (SEMAPHORES) is ok

02:29:04.69 Relation 157 (INVNT_TURNOVER_LOG)
02:29:04.69 process pointer page 0 of 2
02:29:04.88 process pointer page 1 of 2
02:29:04.93 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
02:29:05.04 Relation 157 (INVNT_TURNOVER_LOG) is ok

02:29:05.04 Relation 160 (PERF_ESTIMATED)
02:29:05.04 process pointer page 0 of 1
02:29:05.04 Index 1 (PERF_EST_MINUTE_SINCE_START)
02:29:05.04 Relation 160 (PERF_ESTIMATED) is ok

02:29:05.04 Relation 161 (PERF_ISQL_STAT)
02:29:05.04 process pointer page 0 of 1
02:29:05.04 Index 1 (PERF_ISQL_STAT_TRN)
02:29:05.04 Relation 161 (PERF_ISQL_STAT) is ok

02:29:05.04 Relation 162 (PERF_LOG)
02:29:05.04 process pointer page 0 of 15
02:29:05.08 process pointer page 1 of 15
02:29:05.12 process pointer page 2 of 15
02:29:05.15 process pointer page 3 of 15
02:29:05.18 process pointer page 4 of 15
02:29:05.21 process pointer page 5 of 15
02:29:05.24 process pointer page 6 of 15
02:29:05.30 process pointer page 7 of 15
02:29:05.38 process pointer page 8 of 15
02:29:05.46 process pointer page 9 of 15
02:29:05.54 process pointer page 10 of 15
02:29:05.60 process pointer page 11 of 15
02:29:05.68 process pointer page 12 of 15
02:29:05.74 process pointer page 13 of 15
02:29:05.82 process pointer page 14 of 15
02:29:05.83 Index 1 (PERF_LOG_DTS_BEG_DESC)
02:29:06.24 Index 2 (PERF_LOG_UNIT)
02:29:06.86 Index 3 (PERF_LOG_TRN_DESC)
02:29:07.22 Index 4 (PERF_LOG_GDSCODE)
02:29:07.50 Relation 162 (PERF_LOG) is ok

02:29:07.50 Relation 166 (V_STOPTEST)
02:29:07.50 Relation 166 (V_STOPTEST) is ok

02:29:07.50 Relation 183 (V_QDISTR_SOURCE)
02:29:07.50 Relation 183 (V_QDISTR_SOURCE) is ok

02:29:07.50 Relation 184 (V_QSTORNED_SOURCE)
02:29:07.50 Relation 184 (V_QSTORNED_SOURCE) is ok

02:29:07.50 Relation 258 (XQD_1000_1200)
02:29:07.50 process pointer page 0 of 2
02:29:07.69 process pointer page 1 of 2
02:29:07.86 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
02:29:07.95 Relation 258 (XQD_1000_1200) is ok

02:29:07.95 Relation 259 (XQD_1200_2000)
02:29:07.95 process pointer page 0 of 3
02:29:08.14 process pointer page 1 of 3
02:29:08.31 process pointer page 2 of 3
02:29:08.36 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
02:29:08.44 Relation 259 (XQD_1200_2000) is ok

02:29:08.44 Relation 260 (XQD_1000_3300)
02:29:08.44 process pointer page 0 of 2
02:29:08.50 process pointer page 1 of 2
02:29:08.53 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
02:29:08.59 Index 2 (XQD_1000_3300_DOC)
02:29:08.66 Relation 260 (XQD_1000_3300) is ok

02:29:08.66 Relation 261 (XQD_2000_3300)
02:29:08.66 process pointer page 0 of 8
02:29:08.83 process pointer page 1 of 8
02:29:09.02 process pointer page 2 of 8
02:29:09.19 process pointer page 3 of 8
02:29:09.37 process pointer page 4 of 8
02:29:09.47 process pointer page 5 of 8
02:29:09.59 process pointer page 6 of 8
02:29:09.62 process pointer page 7 of 8
02:29:09.62 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
02:29:09.80 Relation 261 (XQD_2000_3300) is ok

02:29:09.80 Relation 262 (XQD_2100_3300)
02:29:09.80 process pointer page 0 of 3
02:29:09.95 process pointer page 1 of 3
02:29:10.09 process pointer page 2 of 3
02:29:10.09 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
02:29:10.19 Relation 262 (XQD_2100_3300) is ok

02:29:10.19 Relation 263 (XQD_3300_3400)
02:29:10.19 process pointer page 0 of 6
02:29:10.31 process pointer page 1 of 6
02:29:10.37 process pointer page 2 of 6
02:29:10.47 process pointer page 3 of 6
02:29:10.59 process pointer page 4 of 6
02:29:10.70 process pointer page 5 of 6
02:29:10.73 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
02:29:10.98 Relation 263 (XQD_3300_3400) is ok

02:29:10.98 Relation 264 (XQS_1000_1200)
02:29:10.98 process pointer page 0 of 8
02:29:11.06 process pointer page 1 of 8
02:29:11.15 process pointer page 2 of 8
02:29:11.25 process pointer page 3 of 8
02:29:11.34 process pointer page 4 of 8
02:29:11.42 process pointer page 5 of 8
02:29:11.53 process pointer page 6 of 8
02:29:11.60 process pointer page 7 of 8
02:29:11.67 Index 1 (XQS_1000_1200_DOC_ID)
02:29:11.96 Index 2 (XQS_1000_1200_SND_ID)
02:29:12.26 Index 3 (XQS_1000_1200_RCV_ID)
02:29:12.37 Relation 264 (XQS_1000_1200) is ok

02:29:12.37 Relation 265 (XQS_1200_2000)
02:29:12.37 process pointer page 0 of 8
02:29:12.43 process pointer page 1 of 8
02:29:12.53 process pointer page 2 of 8
02:29:12.62 process pointer page 3 of 8
02:29:12.71 process pointer page 4 of 8
02:29:12.79 process pointer page 5 of 8
02:29:12.90 process pointer page 6 of 8
02:29:12.99 process pointer page 7 of 8
02:29:13.07 Index 1 (XQS_1200_2000_DOC_ID)
02:29:13.35 Index 2 (XQS_1200_2000_SND_ID)
02:29:13.66 Index 3 (XQS_1200_2000_RCV_ID)
02:29:13.91 Relation 265 (XQS_1200_2000) is ok

02:29:13.91 Relation 266 (XQS_1000_3300)
02:29:13.91 process pointer page 0 of 5
02:29:14.01 process pointer page 1 of 5
02:29:14.10 process pointer page 2 of 5
02:29:14.21 process pointer page 3 of 5
02:29:14.30 process pointer page 4 of 5
02:29:14.40 Index 1 (XQS_1000_3300_DOC_ID)
02:29:14.55 Index 2 (XQS_1000_3300_SND_ID)
02:29:14.63 Index 3 (XQS_1000_3300_RCV_ID)
02:29:14.77 Relation 266 (XQS_1000_3300) is ok

02:29:14.77 Relation 267 (XQS_2000_3300)
02:29:14.77 process pointer page 0 of 1
02:29:14.77 Index 1 (XQS_2000_3300_DOC_ID)
02:29:14.77 Index 2 (XQS_2000_3300_SND_ID)
02:29:14.77 Index 3 (XQS_2000_3300_RCV_ID)
02:29:14.77 Relation 267 (XQS_2000_3300) is ok

02:29:14.77 Relation 268 (XQS_2100_3300)
02:29:14.77 process pointer page 0 of 7
02:29:14.87 process pointer page 1 of 7
02:29:14.97 process pointer page 2 of 7
02:29:15.07 process pointer page 3 of 7
02:29:15.18 process pointer page 4 of 7
02:29:15.26 process pointer page 5 of 7
02:29:15.35 process pointer page 6 of 7
02:29:15.36 Index 1 (XQS_2100_3300_DOC_ID)
02:29:15.63 Index 2 (XQS_2100_3300_SND_ID)
02:29:15.82 Index 3 (XQS_2100_3300_RCV_ID)
02:29:16.02 Relation 268 (XQS_2100_3300) is ok

02:29:16.02 Relation 269 (XQS_3300_3400)
02:29:16.02 process pointer page 0 of 3
02:29:16.13 process pointer page 1 of 3
02:29:16.22 process pointer page 2 of 3
02:29:16.25 Index 1 (XQS_3300_3400_DOC_ID)
02:29:16.35 Index 2 (XQS_3300_3400_SND_ID)
02:29:16.43 Relation 269 (XQS_3300_3400) is ok

02:29:16.43 Relation 276 (TRACE_STAT)
02:29:16.43 process pointer page 0 of 1
02:29:16.43 Relation 276 (TRACE_STAT) is ok

02:29:16.43 Validation finished
Done for 13120 ms, from 2:29:03.32 to 2:29:16.44.

Differences between old and current firebird.log

2:29:17.17. Got:
STDOUT: ---------- E:\TEMP\LOGS.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 5 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-10-04 02:29 309 oltp25_fb_log_when_test_finished.log

End of gathering firebird.log AFTER test finish.

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

+++ Start of comparison +++
result: files match. No new messages appeared in firebird.log during test ran.
+++ End of comparison +++

Final processing ISQL logs in e:\temp\logs.oltp25


Remove 401 logs of every ISQL session if there were no serious errors.

Remove logs of every ISQL session if there were no serious errors, pattern: e:\temp\logs.oltp25\oltp25_*.*:

ERRORS_CHECKING_RESULT
NO_SEVERE_ERRORS_FOUND
ISQL logs are removed because no severe errors occured during test.
2016-10-04 2:29:19.39 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html