Firebird 2.5 Performance Logs

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-12-20 11:26:27.44.
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.27030 Firebird 2.5
Server implementation: Firebird/x86-64/Windows NT
FB_ARCHITECTURE DB_NAME FORCED_WRITES SWEEP_INT PAGE_BUFFERS PAGE_SIZE
SuperClassic 2.5.7 D:\OLTP-EMUL\OLTP25-SMALL.FDB ON 0 4096 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 0
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 fb257
upload_report 1
max_snapshots_to_store 180
replace_instance 1

Test finish info

FINISH_STATE DTS_END FB_GDSCODE FB_MNEMONA STACK IP TRN_ID ATT_ID EXC_UNIT
NORMAL: TEST_TIME EXPIRED. 2016-12-20 11:26:03.2620 -1 <null> 127.0.0.1 83807 4202 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 179 minutes: 593.97 91259 106320 2016-12-20 08:26 2016-12-20 11:25
customer order: creation 30.03 32 5376 2016-12-20 08:26 2016-12-20 11:25
customer order: refuse 2.49 16 443 2016-12-20 08:26 2016-12-20 11:25
order to supplier: creation 7.62 759 1364 2016-12-20 08:26 2016-12-20 11:25
order to supplier: removal 0.19 90237 33 2016-12-20 08:26 2016-12-20 11:25
invoice (draft): creation 7.58 692 1356 2016-12-20 08:26 2016-12-20 11:25
invoice (draft): removal 1.48 42 260 2016-12-20 08:26 2016-12-20 11:25
invoice accept: apply 2.43 1454452 435 2016-12-20 08:26 2016-12-20 11:25
invoice accept: cancel 0.42 166017 70 2016-12-20 08:26 2016-12-20 11:25
customer reserve: creation 490.42 10156 87786 2016-12-20 08:26 2016-12-20 11:25
customer reserve: removal 10.15 9484 1807 2016-12-20 08:26 2016-12-20 11:25
realization accept: apply 13.57 32 2429 2016-12-20 08:26 2016-12-20 11:25
realization accept: cancel 3.03 22 542 2016-12-20 08:26 2016-12-20 11:25
payment from customer: creation 9.80 71 1755 2016-12-20 08:26 2016-12-20 11:25
payment from customer: removal 0.89 9 159 2016-12-20 08:26 2016-12-20 11:25
payment to supplier: creation 8.60 257 1540 2016-12-20 08:26 2016-12-20 11:25
payment to supplier: removal 0.64 9 111 2016-12-20 08:26 2016-12-20 11:25
service: total inventory turnovers 2.89 411 517 2016-12-20 08:26 2016-12-20 11:25
service: total monetary turnovers 1.84 12 327 2016-12-20 08:26 2016-12-20 11:25
service: refresh index statistics 0.07 1202 10 2016-12-20 08:26 2016-12-20 11:25
Done for 10500 ms, from 11:26:46.64 to 11:26:57.14.

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 294 5687 5283 404 7.10 08:26:04 08:44:00
interval # 2, overall 2 302 5344 5135 209 3.91 08:44:01 09:01:57
interval # 3, overall 3 273 4973 4918 55 1.11 09:01:58 09:19:54
interval # 4, overall 4 348 6463 6260 203 3.14 09:19:55 09:37:51
interval # 5, overall 5 471 8769 8485 284 3.24 09:37:52 09:55:48
interval # 6, overall 6 484 8929 8709 220 2.46 09:55:49 10:13:45
interval # 7, overall 7 511 9343 9193 150 1.61 10:13:46 10:31:42
interval # 8, overall 8 800 14632 14395 237 1.62 10:31:43 10:49:39
interval # 9, overall 9 1226 22488 22065 423 1.88 10:49:40 11:07:36
interval # 10, overall 10 1215 23509 21877 1632 6.94 11:07:37 11:25:33
Done for 16120 ms, from 11:27:10.46 to 11:27:26.58.

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 2569.47 0.5759 1.3208 1396 94
WARM_TIME 2 1944.91 0.8727 1.1540 772 81
WARM_TIME 3 1642.95 0.9109 1.1028 793 82
WARM_TIME 4 1463.09 0.9290 1.0778 927 73
WARM_TIME 5 1335.58 0.9447 1.0551 816 55
WARM_TIME 6 1258.68 0.9331 1.0604 1006 49
WARM_TIME 7 1208.57 0.9468 1.0549 992 40
WARM_TIME 8 1161.76 0.9602 1.0410 787 27
WARM_TIME 9 1092.71 0.9840 1.0190 334 13
WARM_TIME 10 1015.28 0.9872 1.0090 86 4
TEST_TIME 11 936.76 0.9943 1.0068 70 2
TEST_TIME 12 865.12 0.9994 1.0005 12 1
TEST_TIME 13 802.34 0.9990 1.0009 24 1
TEST_TIME 14 751.87 0.9959 1.0043 75 3
TEST_TIME 15 705.07 0.9997 1.0003 9 1
TEST_TIME 16 669.45 0.9908 1.0061 110 4
TEST_TIME 17 636.18 0.9965 1.0036 56 3
TEST_TIME 18 607.76 0.9923 1.0084 148 3
TEST_TIME 19 583.80 0.9946 1.0036 64 4
TEST_TIME 20 561.67 0.9911 1.0057 134 3
TEST_TIME 21 549.53 0.9810 1.0049 110 3
TEST_TIME 22 533.33 0.9959 1.0074 88 3
TEST_TIME 23 516.62 0.9949 1.0072 81 4
TEST_TIME 24 500.46 0.9964 1.0034 95 2
TEST_TIME 25 485.77 0.9924 1.0060 135 2
TEST_TIME 26 476.68 0.9913 1.0117 187 3
TEST_TIME 27 471.36 0.9896 1.0122 143 5
TEST_TIME 28 462.69 0.9944 1.0052 144 4
TEST_TIME 29 449.51 0.9990 1.0009 29 1
TEST_TIME 30 437.02 0.9994 1.0004 15 2
TEST_TIME 31 423.85 0.9983 1.0017 54 1
TEST_TIME 32 412.97 0.9984 1.0015 44 1
TEST_TIME 33 401.67 0.9985 1.0014 41 1
TEST_TIME 34 390.82 0.9990 1.0010 29 1
TEST_TIME 35 384.15 0.9894 1.0060 167 4
TEST_TIME 36 382.45 0.9825 1.0089 238 4
TEST_TIME 37 376.18 0.9980 1.0040 17 2
TEST_TIME 38 368.16 0.9989 1.0046 6 2
TEST_TIME 39 364.59 0.9927 1.0086 59 3
TEST_TIME 40 358.93 0.9990 1.0008 26 2
TEST_TIME 41 358.10 0.9849 1.0050 132 3
TEST_TIME 42 351.46 0.9997 1.0002 8 1
TEST_TIME 43 348.04 0.9868 1.0062 101 4
TEST_TIME 44 345.98 0.9893 1.0125 208 6
TEST_TIME 45 347.71 0.9851 1.0099 98 6
TEST_TIME 46 343.89 0.9990 1.0009 33 2
TEST_TIME 48 332.39 0.9986 1.0014 49 1
TEST_TIME 49 326.15 0.9998 1.0001 6 1
TEST_TIME 50 323.52 0.9953 1.0016 33 2
TEST_TIME 52 313.60 0.9995 1.0004 16 1
TEST_TIME 53 310.44 0.9938 1.0060 220 2
TEST_TIME 57 292.81 0.9996 1.0002 6 1
TEST_TIME 59 285.22 0.9992 1.0008 28 1
TEST_TIME 60 282.90 0.9999 1.0001 4 1
TEST_TIME 61 280.75 0.9913 1.0042 48 3
TEST_TIME 62 286.20 0.9778 1.0108 146 5
TEST_TIME 63 284.94 0.9992 1.0011 30 2
TEST_TIME 64 285.25 0.9908 1.0024 37 3
TEST_TIME 65 282.88 0.9954 1.0044 33 2
TEST_TIME 66 281.85 0.9998 1.0001 8 1
TEST_TIME 67 280.09 0.9990 1.0018 35 2
TEST_TIME 68 278.94 0.9986 1.0012 56 1
TEST_TIME 69 277.47 0.9920 1.0104 99 5
TEST_TIME 70 278.19 0.9934 1.0021 23 2
TEST_TIME 71 275.77 0.9972 1.0032 116 4
TEST_TIME 72 273.79 0.9964 1.0151 32 3
TEST_TIME 73 278.71 0.9836 1.0164 122 5
TEST_TIME 74 280.15 0.9984 1.0016 52 2
TEST_TIME 75 278.43 0.9993 1.0006 32 1
TEST_TIME 76 278.30 0.9922 1.0026 40 2
TEST_TIME 77 277.01 0.9994 1.0005 24 1
TEST_TIME 78 274.26 0.9982 1.0011 50 2
TEST_TIME 79 272.64 0.9999 1.0001 6 2
TEST_TIME 80 272.27 0.9905 1.0107 145 4
TEST_TIME 81 278.31 0.9824 1.0037 82 3
TEST_TIME 82 278.68 0.9902 1.0080 70 4
TEST_TIME 83 278.75 0.9956 1.0106 93 3
TEST_TIME 84 278.36 1.0000 1.0000 1 1
TEST_TIME 85 277.34 0.9927 1.0058 109 5
TEST_TIME 86 276.64 0.9966 1.0026 105 4
TEST_TIME 87 277.92 0.9907 1.0054 110 5
TEST_TIME 88 282.21 0.9857 1.0037 74 3
TEST_TIME 89 282.68 0.9946 1.0047 41 2
TEST_TIME 90 287.03 0.9793 1.0069 159 5
TEST_TIME 91 288.36 0.9994 1.0004 28 1
TEST_TIME 92 287.00 0.9958 1.0042 224 2
TEST_TIME 93 289.41 0.9851 1.0070 170 5
TEST_TIME 94 290.07 0.9964 1.0029 43 2
TEST_TIME 95 287.98 0.9996 1.0003 22 1
TEST_TIME 96 288.38 0.9891 1.0106 136 4
TEST_TIME 97 293.07 0.9854 1.0150 226 6
TEST_TIME 98 294.96 0.9982 1.0019 107 2
TEST_TIME 103 283.44 0.9929 1.0033 92 4
TEST_TIME 104 285.70 0.9870 1.0042 171 3
TEST_TIME 105 285.74 0.9945 1.0031 15 3
TEST_TIME 106 286.87 0.9944 1.0048 57 2
TEST_TIME 107 288.37 0.9902 1.0085 40 3
TEST_TIME 108 290.74 0.9991 1.0022 46 3
TEST_TIME 109 289.06 0.9988 1.0100 58 3
TEST_TIME 110 292.12 0.9971 1.0016 85 4
TEST_TIME 111 291.74 0.9941 1.0047 13 3
TEST_TIME 112 295.02 0.9949 1.0059 87 4
TEST_TIME 113 295.61 0.9950 1.0029 173 4
TEST_TIME 114 297.65 0.9879 1.0105 160 3
TEST_TIME 115 303.30 0.9877 1.0088 103 5
TEST_TIME 116 308.19 0.9843 1.0122 333 6
TEST_TIME 117 312.93 0.9943 1.0082 87 4
TEST_TIME 118 314.19 0.9957 1.0085 54 3
TEST_TIME 119 315.03 0.9973 1.0048 43 3
TEST_TIME 120 321.18 0.9785 1.0157 325 8
TEST_TIME 121 330.37 0.9793 1.0139 190 6
TEST_TIME 122 336.63 0.9883 1.0042 157 5
TEST_TIME 123 340.81 0.9840 1.0050 58 4
TEST_TIME 124 341.73 0.9996 1.0003 32 1
TEST_TIME 125 344.75 0.9868 1.0020 100 4
TEST_TIME 126 343.96 0.9981 1.0015 43 3
TEST_TIME 127 344.20 0.9929 1.0119 75 5
TEST_TIME 128 346.74 0.9975 1.0055 69 3
TEST_TIME 129 354.35 0.9812 1.0093 192 8
TEST_TIME 130 357.43 0.9929 1.0070 137 7
TEST_TIME 131 359.11 0.9946 1.0037 30 2
TEST_TIME 132 361.60 0.9954 1.0032 29 2
TEST_TIME 134 358.01 0.9991 1.0018 37 2
TEST_TIME 135 359.74 0.9916 1.0077 94 4
TEST_TIME 136 362.05 0.9990 1.0074 33 4
TEST_TIME 137 363.87 0.9953 1.0043 140 5
TEST_TIME 138 365.27 0.9983 1.0015 89 3
TEST_TIME 139 363.87 0.9992 1.0003 33 2
TEST_TIME 140 365.59 0.9885 1.0076 126 5
TEST_TIME 141 371.87 0.9879 1.0066 212 6
TEST_TIME 142 373.10 0.9963 1.0059 111 4
TEST_TIME 143 377.53 0.9900 1.0124 196 8
TEST_TIME 144 381.73 0.9943 1.0007 66 3
TEST_TIME 146 378.14 0.9970 1.0020 148 4
TEST_TIME 147 376.44 0.9999 1.0000 5 1
TEST_TIME 148 379.76 0.9846 1.0060 77 8
TEST_TIME 149 380.86 0.9965 1.0035 72 4
TEST_TIME 150 380.23 0.9985 1.0013 64 5
TEST_TIME 151 380.53 0.9939 1.0027 73 3
TEST_TIME 152 380.11 0.9972 1.0042 55 3
TEST_TIME 153 382.87 0.9973 1.0053 199 5
TEST_TIME 154 386.29 0.9900 1.0131 193 9
TEST_TIME 155 395.20 0.9917 1.0048 234 5
TEST_TIME 156 396.58 0.9949 1.0107 182 7
TEST_TIME 157 400.59 0.9944 1.0075 76 5
TEST_TIME 158 410.36 0.9808 1.0042 198 6
TEST_TIME 159 413.44 0.9905 1.0112 138 8
TEST_TIME 160 419.83 0.9896 1.0067 64 6
TEST_TIME 161 425.75 0.9865 1.0069 332 11
TEST_TIME 162 426.53 0.9989 1.0031 43 4
TEST_TIME 163 427.30 0.9959 1.0023 42 4
TEST_TIME 164 428.09 0.9944 1.0019 78 5
TEST_TIME 165 428.88 0.9971 1.0018 48 5
TEST_TIME 166 434.79 0.9823 1.0138 319 11
TEST_TIME 167 446.01 0.9824 1.0156 267 16
TEST_TIME 168 458.09 0.9830 1.0053 290 13
TEST_TIME 169 460.36 0.9945 1.0120 455 11
TEST_TIME 170 466.34 0.9932 1.0102 260 9
TEST_TIME 171 479.93 0.9759 1.0217 330 11
TEST_TIME 172 493.45 0.9879 1.0106 298 9
TEST_TIME 173 502.22 0.9872 1.0114 320 11
TEST_TIME 174 507.76 0.9946 1.0087 70 9
TEST_TIME 175 511.74 0.9951 1.0076 177 9
TEST_TIME 176 517.36 0.9911 1.0078 165 7
TEST_TIME 177 520.78 0.9955 1.0081 227 9
TEST_TIME 178 524.42 0.9954 1.0055 106 6
TEST_TIME 179 527.92 0.9932 1.0061 117 6
TEST_TIME 180 532.82 0.9948 1.0101 59 5
TEST_TIME 181 542.56 0.9880 1.0126 130 8
TEST_TIME 182 549.59 0.9965 1.0096 151 8
TEST_TIME 183 554.16 0.9958 1.0056 124 4
TEST_TIME 184 565.09 0.9808 1.0172 307 12
TEST_TIME 185 583.73 0.9794 1.0204 348 17
TEST_TIME 186 599.36 0.9885 1.0101 188 12
TEST_TIME 187 606.90 0.9923 1.0177 114 10
TEST_TIME 188 622.68 0.9911 1.0085 130 7
TEST_TIME 189 625.52 0.9986 1.0004 40 4
TEST_TIME 190 622.49 1.0000 1.0000 100 100
Done for 10080 ms, from 11:27:26.87 to 11:27:36.95.

Config param. trc_unit_perf=0, trace for ISQL session #1 was not launched.

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 66953 64259 2694 4.02 0 5382 17 2694 2016-12-20 08:26 2016-12-20 11:26
doc_list_biud 66987 64251 2736 4.08 0 638837 972 2736 2016-12-20 08:26 2016-12-20 11:26
sp_add_invoice_to_stock 1216 435 781 64.22 3666 8610419 1454452 781 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_adding_invoice 124 70 54 43.54 78 1922469 166017 54 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_client_order 467 443 24 5.13 0 63 16 24 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_customer_reserve 3779 1807 1972 52.18 0 167154 9484 1972 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_pay_from_customer 161 159 2 1.24 0 63 9 2 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_pay_to_supplier 112 111 1 0.89 0 47 9 1 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_supplier_invoice 331 260 71 21.45 0 234 42 71 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_supplier_order 119 33 86 72.26 31 2049594 90237 86 2016-12-20 08:26 2016-12-20 11:26
sp_cancel_write_off 1251 542 709 56.67 0 171 22 709 2016-12-20 08:26 2016-12-20 11:26
sp_client_order 5376 5376 0 0.00 0 3760 32 0 2016-12-20 08:26 2016-12-20 11:26
sp_customer_reserve 87786 87786 0 0.00 15 76799 10156 0 2016-12-20 08:26 2016-12-20 11:26
sp_fill_shopping_cart 8096 8096 0 0.00 0 20530 168 0 2016-12-20 08:26 2016-12-20 11:26
sp_fill_shopping_cart_clo_res 87786 87786 0 0.00 0 390 1 0 2016-12-20 08:26 2016-12-20 11:26
sp_get_clo_for_invoice 440 440 0 0.00 0 546 56 0 2016-12-20 08:26 2016-12-20 11:26
sp_kill_cost_storno 1598 884 714 44.68 0 78 3 714 2016-12-20 08:26 2016-12-20 11:26
sp_kill_qstorno_ret_qs2qd 9086 4449 4637 51.03 0 167139 3853 4637 2016-12-20 08:26 2016-12-20 11:26
sp_kill_qty_storno 8744 6021 2723 31.14 0 638837 10372 2723 2016-12-20 08:26 2016-12-20 11:26
sp_lock_selected_doc 5216 4093 1123 21.52 0 31 0 1123 2016-12-20 08:26 2016-12-20 11:26
sp_make_cost_storno 6164 6164 0 0.00 0 3838 87 0 2016-12-20 08:26 2016-12-20 11:26
sp_multiply_rows_for_pdistr 6164 6164 0 0.00 0 359 5 0 2016-12-20 08:26 2016-12-20 11:26
sp_multiply_rows_for_qdistr 5376 5376 0 0.00 0 3728 13 0 2016-12-20 08:26 2016-12-20 11:26
sp_pay_from_customer 1755 1755 0 0.00 15 3916 71 0 2016-12-20 08:26 2016-12-20 11:26
sp_pay_to_supplier 1540 1540 0 0.00 0 2886 257 0 2016-12-20 08:26 2016-12-20 11:26
sp_payment_common 3295 3295 0 0.00 0 374 18 0 2016-12-20 08:26 2016-12-20 11:26
sp_qd_handle_on_cancel_clo 467 443 24 5.13 0 62 6 24 2016-12-20 08:26 2016-12-20 11:26
sp_qd_handle_on_invoice_upd_sts 534 507 27 5.05 0 638837 89303 27 2016-12-20 08:26 2016-12-20 11:26
sp_qd_handle_on_reserve_upd_sts 2429 2429 0 0.00 0 156 6 0 2016-12-20 08:26 2016-12-20 11:26
sp_reserve_write_off 2546 2429 117 4.59 0 936 32 117 2016-12-20 08:26 2016-12-20 11:26
sp_supplier_invoice 1356 1356 0 0.00 15 20888 692 0 2016-12-20 08:26 2016-12-20 11:26
sp_supplier_order 1364 1364 0 0.00 15 17581 759 0 2016-12-20 08:26 2016-12-20 11:26
srv_find_qd_qs_mism 36074 33390 2684 7.44 0 4587 16 2684 2016-12-20 08:26 2016-12-20 11:26
srv_make_invnt_saldo 517 517 0 0.00 62 1685 411 0 2016-12-20 08:26 2016-12-20 11:26
srv_make_money_saldo 327 327 0 0.00 0 187 12 0 2016-12-20 08:26 2016-12-20 11:26
srv_recalc_idx_stat 10 10 0 0.00 967 2293 1202 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_add_invoice_to_stock 781 781 0 0.00 0 78 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_adding_invoice 119 119 0 0.00 0 171 14 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_client_order 24 24 0 0.00 0 31 5 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_customer_reserve 8 8 0 0.00 0 16 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_pay_from_customer 2 2 0 0.00 0 0 0 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_pay_to_supplier 1 1 0 0.00 0 0 0 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_supplier_invoice 61 61 0 0.00 0 32 4 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_supplier_order 305 305 0 0.00 0 109 18 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_cancel_write_off 1 1 0 0.00 0 0 0 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-abend:sp_reserve_write_off 117 117 0 0.00 0 46 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_add_invoice_to_stock 525 525 0 0.00 0 1950 220 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_adding_invoice 60 60 0 0.00 0 453 76 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_client_order 443 443 0 0.00 0 124 4 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_customer_reserve 143 143 0 0.00 0 140 11 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_pay_from_customer 159 159 0 0.00 0 31 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_pay_to_supplier 111 111 0 0.00 0 93 3 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_supplier_invoice 45 45 0 0.00 0 188 8 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_supplier_order 33 33 0 0.00 0 624 50 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_cancel_write_off 238 238 0 0.00 0 63 4 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_client_order 5376 5376 0 0.00 0 686 5 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_customer_reserve 269 269 0 0.00 0 500 12 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_pay_from_customer 1755 1755 0 0.00 0 187 3 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_pay_to_supplier 1540 1540 0 0.00 0 140 4 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_reserve_write_off 2429 2429 0 0.00 0 203 4 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_supplier_invoice 1357 1357 0 0.00 0 234 6 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:sp_supplier_order 1364 1364 0 0.00 0 234 6 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:srv_make_invnt_saldo 517 517 0 0.00 0 62 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:srv_make_money_saldo 327 327 0 0.00 0 94 2 0 2016-12-20 08:26 2016-12-20 11:26
t$perf-norm:srv_recalc_idx_stat 10 10 0 0.00 0 94 25 0 2016-12-20 08:26 2016-12-20 11:26
v_add_invoice_to_stock 2432 870 1562 64.22 0 31 0 1562 2016-12-20 08:26 2016-12-20 11:26
v_all_customers 8048 8048 0 0.00 0 16 0 0 2016-12-20 08:26 2016-12-20 11:26
v_all_suppliers 5440 5440 0 0.00 0 16 0 0 2016-12-20 08:26 2016-12-20 11:26
v_all_wares 10752 10752 0 0.00 0 16 0 0 2016-12-20 08:26 2016-12-20 11:26
v_cancel_adding_invoice 200 116 84 42.00 0 16 3 84 2016-12-20 08:26 2016-12-20 11:26
v_cancel_client_order 934 886 48 5.13 0 16 0 48 2016-12-20 08:26 2016-12-20 11:26
v_cancel_customer_prepayment 322 318 4 1.24 0 16 0 4 2016-12-20 08:26 2016-12-20 11:26
v_cancel_customer_reserve 300 284 16 5.33 0 32 0 16 2016-12-20 08:26 2016-12-20 11:26
v_cancel_payment_to_supplier 224 222 2 0.89 0 31 0 2 2016-12-20 08:26 2016-12-20 11:26
v_cancel_supplier_invoice 212 90 122 57.54 0 16 1 122 2016-12-20 08:26 2016-12-20 11:26
v_cancel_supplier_order 238 66 172 72.26 0 16 0 172 2016-12-20 08:26 2016-12-20 11:26
v_cancel_write_off 478 476 2 0.41 0 16 1 2 2016-12-20 08:26 2016-12-20 11:26
v_max_id_clo_ord 1364 1364 0 0.00 0 764 7 0 2016-12-20 08:26 2016-12-20 11:26
v_max_id_clo_res 268 268 0 0.00 0 47 1 0 2016-12-20 08:26 2016-12-20 11:26
v_max_id_ord_sup 1356 1356 0 0.00 0 421 5 0 2016-12-20 08:26 2016-12-20 11:26
v_max_non_paid_invoice 1540 1540 0 0.00 0 31 1 0 2016-12-20 08:26 2016-12-20 11:26
v_max_non_paid_realizn 1755 1755 0 0.00 0 47 4 0 2016-12-20 08:26 2016-12-20 11:26
v_min_id_clo_ord 1364 1364 0 0.00 0 1825 39 0 2016-12-20 08:26 2016-12-20 11:26
v_min_id_clo_res 268 268 0 0.00 0 16 1 0 2016-12-20 08:26 2016-12-20 11:26
v_min_id_ord_sup 1356 1356 0 0.00 0 1544 35 0 2016-12-20 08:26 2016-12-20 11:26
v_min_non_paid_invoice 1540 1540 0 0.00 0 374 16 0 2016-12-20 08:26 2016-12-20 11:26
v_min_non_paid_realizn 1755 1755 0 0.00 0 203 7 0 2016-12-20 08:26 2016-12-20 11:26
v_our_firm 2704 2704 0 0.00 0 16 0 0 2016-12-20 08:26 2016-12-20 11:26
v_reserve_write_off 5092 4858 234 4.59 0 47 0 234 2016-12-20 08:26 2016-12-20 11:26
x_lock_depdocs_on_canc_invoice 474 285 189 39.87 0 31 1 189 2016-12-20 08:26 2016-12-20 11:26
x_lock_depdocs_on_canc_sup_ord 119 33 86 72.26 0 16 2 86 2016-12-20 08:26 2016-12-20 11:26
x_make_qstorno_1000_1200 1364 1364 0 0.00 0 8205 235 0 2016-12-20 08:26 2016-12-20 11:26
x_make_qstorno_1200_2000 1356 1356 0 0.00 0 6287 219 0 2016-12-20 08:26 2016-12-20 11:26
x_make_qstorno_2100_3300 87786 87786 0 0.00 15 76767 10142 0 2016-12-20 08:26 2016-12-20 11:26
Done for 27860 ms, from 11:27:56.75 to 11:28:24.61.

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 5 sp_kill_cost_storno 335544336 2016-12-20 08:51 2016-12-20 10:38
deadlock 3 sp_qd_handle_on_invoice_upd_sts 335544336 2016-12-20 08:40 2016-12-20 09:25
lock_conflict 3 sp_kill_cost_storno 335544345 2016-12-20 10:42 2016-12-20 11:16
lock_conflict 970 sp_lock_selected_doc 335544345 2016-12-20 08:26 2016-12-20 11:24
lock_conflict 24 sp_qd_handle_on_cancel_clo 335544345 2016-12-20 08:35 2016-12-20 11:18
lock_conflict 18 sp_qd_handle_on_invoice_upd_sts 335544345 2016-12-20 08:37 2016-12-20 11:22
lock_conflict 75 x_lock_depdocs_on_canc_invoice 335544345 2016-12-20 08:26 2016-12-20 11:21
lock_conflict 27 x_lock_depdocs_on_canc_sup_ord 335544345 2016-12-20 08:26 2016-12-20 11:21
Done for 2690 ms, from 11:28:25.16 to 11:28:27.85.

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 96200
MON$OLDEST_ACTIVE 96201
MON$OLDEST_SNAPSHOT 96201
MON$NEXT_TRANSACTION 96201
MON$PAGE_BUFFERS 4096
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 184643
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.7.27030 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.7.27030 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.7.27030 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.7.27030 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 100691
Page size 8192
ODS version 11.2
Oldest transaction 96202
Oldest active 96203
Oldest snapshot 96203
Next transaction 96204
Bumped transaction 1
Sequence number 0
Next attachment ID 4452
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.47, total records: 501488
Average version length: 46.40, total versions: 19047, max versions: 1
Data pages: 5346, data page slots: 5346, average fill: 73%
Fill distribution:
0 - 19% = 3
20 - 39% = 14
40 - 59% = 60
60 - 79% = 5162
80 - 99% = 107

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1707, nodes: 501488
Average data length: 11.84, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 184
20 - 39% = 34
40 - 59% = 710
60 - 79% = 118
80 - 99% = 661

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1465, nodes: 501488
Average data length: 5.92, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 22
40 - 59% = 1443
60 - 79% = 0
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 3, leaf buckets: 504, nodes: 501488
Average data length: 0.93, total dup: 427723, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 16
40 - 59% = 238
60 - 79% = 18
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.13, total records: 88774
Average version length: 49.40, total versions: 11052, max versions: 5
Data pages: 1114, data page slots: 1114, average fill: 82%
Fill distribution:
0 - 19% = 1
20 - 39% = 13
40 - 59% = 35
60 - 79% = 262
80 - 99% = 803

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 72, nodes: 88774
Average data length: 0.01, total dup: 88724, max dup: 19379
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 37
60 - 79% = 25
80 - 99% = 9

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 185, nodes: 88774
Average data length: 6.25, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 11
40 - 59% = 103
60 - 79% = 0
80 - 99% = 70

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: 61.65, total records: 400
Average version length: 13.26, total versions: 112043, max versions: 335
Data pages: 438, data page slots: 438, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 437

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.01, total records: 221058
Average version length: 68.71, total versions: 221043, max versions: 1
Data pages: 3086, data page slots: 3086, average fill: 90%
Fill distribution:
0 - 19% = 25
20 - 39% = 24
40 - 59% = 50
60 - 79% = 106
80 - 99% = 2881

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 536, nodes: 221058
Average data length: 7.99, total dup: 30111, max dup: 4
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 224
60 - 79% = 115
80 - 99% = 195

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

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.06, total records: 10268
Average version length: 44.07, total versions: 10256, max versions: 1
Data pages: 107, data page slots: 107, average fill: 92%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 2
60 - 79% = 0
80 - 99% = 104

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

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: 21.75, total records: 164394
Average version length: 32.20, total versions: 127655, max versions: 9
Data pages: 1749, data page slots: 1750, average fill: 89%
Fill distribution:
0 - 19% = 1
20 - 39% = 4
40 - 59% = 5
60 - 79% = 218
80 - 99% = 1521

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 159, nodes: 164394
Average data length: 0.01, total dup: 164345, max dup: 40596
Fill distribution:
0 - 19% = 2
20 - 39% = 2
40 - 59% = 120
60 - 79% = 18
80 - 99% = 17

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 183, nodes: 164394
Average data length: 0.90, total dup: 147912, max dup: 32
Fill distribution:
0 - 19% = 2
20 - 39% = 4
40 - 59% = 112
60 - 79% = 48
80 - 99% = 17

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 191, nodes: 164394
Average data length: 0.90, total dup: 147912, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 129
60 - 79% = 45
80 - 99% = 17

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 157, nodes: 164394
Average data length: 0.67, total dup: 147912, max dup: 32
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 52
60 - 79% = 77
80 - 99% = 27

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 20, nodes: 27016
Average data length: 0.01, total dup: 26837, max dup: 1395
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 7
60 - 79% = 9
80 - 99% = 4

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: 144.91, total records: 1407583
Average version length: 153.00, total versions: 1, max versions: 1
Data pages: 32246, data page slots: 32246, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 32245

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1705, nodes: 1407583
Average data length: 0.57, total dup: 831082, max dup: 38
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1201
60 - 79% = 341
80 - 99% = 163

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1726, nodes: 1407583
Average data length: 0.36, total dup: 1329427, max dup: 3722
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1447
60 - 79% = 168
80 - 99% = 111

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1523, nodes: 1407583
Average data length: 0.23, total dup: 1378639, max dup: 156507
Fill distribution:
0 - 19% = 2
20 - 39% = 2
40 - 59% = 1077
60 - 79% = 197
80 - 99% = 245

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.25, total records: 90007
Average version length: 54.53, total versions: 5812, max versions: 1
Data pages: 1050, data page slots: 1050, average fill: 76%
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 5
60 - 79% = 987
80 - 99% = 56

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 116, nodes: 90007
Average data length: 1.16, total dup: 74217, max dup: 172
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 110
60 - 79% = 4
80 - 99% = 0

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 81, nodes: 90007
Average data length: 0.60, total dup: 82173, max dup: 70
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 38
60 - 79% = 29
80 - 99% = 14

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: 1276, max versions: 770
Data pages: 5, data page slots: 5, average fill: 82%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 4

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: 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

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.11, total records: 356245
Average version length: 69.76, total versions: 355664, max versions: 1
Data pages: 4784, data page slots: 4784, average fill: 95%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 4783

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 401, nodes: 356245
Average data length: 1.23, total dup: 312361, max dup: 44
Fill distribution:
0 - 19% = 4
20 - 39% = 3
40 - 59% = 109
60 - 79% = 202
80 - 99% = 83

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 48.13, total records: 328760
Average version length: 69.21, total versions: 102176, max versions: 1
Data pages: 4451, data page slots: 4459, average fill: 83%
Fill distribution:
0 - 19% = 12
20 - 39% = 14
40 - 59% = 11
60 - 79% = 1916
80 - 99% = 2498

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 288, nodes: 328760
Average data length: 0.15, total dup: 321642, max dup: 212
Fill distribution:
0 - 19% = 3
20 - 39% = 6
40 - 59% = 140
60 - 79% = 28
80 - 99% = 111

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 385, nodes: 328760
Average data length: 1.24, total dup: 288549, max dup: 44
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 145
60 - 79% = 185
80 - 99% = 54

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.13, total records: 431944
Average version length: 69.76, total versions: 431165, max versions: 1
Data pages: 5805, data page slots: 5805, average fill: 94%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 2
80 - 99% = 5802

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 450, nodes: 431944
Average data length: 0.94, total dup: 391434, max dup: 150
Fill distribution:
0 - 19% = 7
20 - 39% = 2
40 - 59% = 117
60 - 79% = 190
80 - 99% = 134

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 19.31, total records: 1133515
Average version length: 68.40, total versions: 819623, max versions: 1
Data pages: 15274, data page slots: 15274, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 3810
80 - 99% = 11463

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1468, nodes: 1133515
Average data length: 1.12, total dup: 1003994, max dup: 91
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1190
60 - 79% = 131
80 - 99% = 147

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 3.24, total records: 279426
Average version length: 68.88, total versions: 266340, max versions: 1
Data pages: 4331, data page slots: 4452, average fill: 82%
Fill distribution:
0 - 19% = 64
20 - 39% = 138
40 - 59% = 116
60 - 79% = 925
80 - 99% = 3088

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 358, nodes: 279426
Average data length: 1.31, total dup: 242662, max dup: 107
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 189
60 - 79% = 116
80 - 99% = 47

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 36.49, total records: 782850
Average version length: 68.37, total versions: 368671, max versions: 1
Data pages: 10896, data page slots: 10938, average fill: 83%
Fill distribution:
0 - 19% = 58
20 - 39% = 133
40 - 59% = 242
60 - 79% = 3551
80 - 99% = 6912

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1101, nodes: 782850
Average data length: 1.34, total dup: 675695, max dup: 44
Fill distribution:
0 - 19% = 2
20 - 39% = 15
40 - 59% = 865
60 - 79% = 122
80 - 99% = 97

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.22, total records: 1060013
Average version length: 80.78, total versions: 33873, max versions: 1
Data pages: 15836, data page slots: 15836, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 6319
80 - 99% = 9516

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1180, nodes: 1060013
Average data length: 0.16, total dup: 1036082, max dup: 211
Fill distribution:
0 - 19% = 9
20 - 39% = 0
40 - 59% = 878
60 - 79% = 245
80 - 99% = 48

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 843, nodes: 1060013
Average data length: 0.72, total dup: 931472, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 1
40 - 59% = 146
60 - 79% = 15
80 - 99% = 679

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1345, nodes: 1060013
Average data length: 0.74, total dup: 928418, max dup: 44
Fill distribution:
0 - 19% = 12
20 - 39% = 0
40 - 59% = 1010
60 - 79% = 273
80 - 99% = 50

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 69.65, total records: 634111
Average version length: 80.16, total versions: 84133, max versions: 1
Data pages: 9625, data page slots: 9646, average fill: 80%
Fill distribution:
0 - 19% = 51
20 - 39% = 81
40 - 59% = 99
60 - 79% = 5134
80 - 99% = 4260

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 652, nodes: 634111
Average data length: 0.15, total dup: 620132, max dup: 309
Fill distribution:
0 - 19% = 2
20 - 39% = 4
40 - 59% = 359
60 - 79% = 232
80 - 99% = 55

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 524, nodes: 634111
Average data length: 0.84, total dup: 549244, max dup: 14
Fill distribution:
0 - 19% = 4
20 - 39% = 13
40 - 59% = 90
60 - 79% = 1
80 - 99% = 416

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 775, nodes: 634111
Average data length: 0.72, total dup: 560354, max dup: 52
Fill distribution:
0 - 19% = 32
20 - 39% = 2
40 - 59% = 434
60 - 79% = 262
80 - 99% = 45

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 75.45, total records: 1128268
Average version length: 82.21, total versions: 75049, max versions: 1
Data pages: 16863, data page slots: 16863, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7392
80 - 99% = 9471

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1168, nodes: 1128268
Average data length: 0.05, total dup: 1121738, max dup: 1630
Fill distribution:
0 - 19% = 1
20 - 39% = 2
40 - 59% = 768
60 - 79% = 299
80 - 99% = 98

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 844, nodes: 1128268
Average data length: 0.68, total dup: 998708, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 68
60 - 79% = 7
80 - 99% = 768

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1317, nodes: 1128268
Average data length: 0.68, total dup: 999809, max dup: 150
Fill distribution:
0 - 19% = 6
20 - 39% = 2
40 - 59% = 796
60 - 79% = 371
80 - 99% = 142

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: 72.60, total records: 806115
Average version length: 80.40, total versions: 79874, max versions: 1
Data pages: 12384, data page slots: 12429, average fill: 79%
Fill distribution:
0 - 19% = 90
20 - 39% = 180
40 - 59% = 186
60 - 79% = 5972
80 - 99% = 5956

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 744, nodes: 806115
Average data length: 0.05, total dup: 801533, max dup: 633
Fill distribution:
0 - 19% = 1
20 - 39% = 11
40 - 59% = 277
60 - 79% = 306
80 - 99% = 149

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 753, nodes: 806115
Average data length: 0.87, total dup: 694466, max dup: 14
Fill distribution:
0 - 19% = 9
20 - 39% = 14
40 - 59% = 266
60 - 79% = 4
80 - 99% = 460

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 845, nodes: 806115
Average data length: 0.69, total dup: 714364, max dup: 76
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 265
60 - 79% = 413
80 - 99% = 161

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 60.23, total records: 354580
Average version length: 68.33, total versions: 42518, max versions: 1
Data pages: 4774, data page slots: 4774, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 3672
80 - 99% = 1101

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 317, nodes: 354580
Average data length: 0.22, total dup: 343542, max dup: 217
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 102
60 - 79% = 127
80 - 99% = 88

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 375, nodes: 354580
Average data length: 0.82, total dup: 308870, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 144
60 - 79% = 158
80 - 99% = 73

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 19590 ms, from 11:28:28.51 to 11:28:48.10.

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 501488 19047 3.7980
DOC_LIST 88774 11052 12.4495
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 112043 28010.7500
INVNT_TURNOVER_LOG 221058 221043 99.9932
MONEY_SALDO 49 5165 10540.8163
MONEY_TURNOVER_LOG 10268 10256 99.8831
OPTYPES 9 0 0.0000
PDISTR 164394 127655 77.6518
PERF_ESTIMATED 27016 2 0.0074
PERF_LOG 1407583 1 0.0000
PSTORNED 90007 5812 6.4572
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 1276 31900.0000
SETTINGS 114 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 356245 355664 99.8369
XQD_1000_3300 328760 102176 31.0792
XQD_1200_2000 431944 431165 99.8196
XQD_2000_3300 1133515 819623 72.3080
XQD_2100_3300 279426 266340 95.3168
XQD_3300_3400 782850 368671 47.0934
XQS_1000_1200 1060013 33873 3.1955
XQS_1000_3300 634111 84133 13.2678
XQS_1200_2000 1128268 75049 6.6516
XQS_2100_3300 806115 79874 9.9085
XQS_3300_3400 354580 42518 11.9910
Z_USED_VIEWS 32 0 0.0000
Done for 4060 ms, from 11:28:58.29 to 11:29:02.35.

Database validation

11:29:02.66 Validation started

11:29:02.67 Relation 140 (DOC_LIST)
11:29:02.67 process pointer page 0 of 1
11:29:02.74 Index 1 (PK_DOC_LIST)
11:29:02.77 Index 2 (DOC_LIST_ID_DESC)
11:29:02.80 Index 3 (FK_DOC_LIST_AGENTS)
11:29:02.83 Relation 140 (DOC_LIST) is ok

11:29:02.83 Relation 141 (DOC_DATA)
11:29:02.83 process pointer page 0 of 3
11:29:02.94 process pointer page 1 of 3
11:29:03.05 process pointer page 2 of 3
11:29:03.14 Index 2 (DOC_DATA_DOC_WARE_UNQ)
11:29:03.28 Index 3 (DOC_DATA_ID_DESC)
11:29:03.34 Index 4 (FK_DOC_DATA_DOC_LIST)
11:29:03.38 Relation 141 (DOC_DATA) is ok

11:29:03.38 Relation 147 (INVNT_SALDO)
11:29:03.38 process pointer page 0 of 1
11:29:03.45 Index 1 (PK_INVNT_SALDO)
11:29:03.45 Relation 147 (INVNT_SALDO) is ok

11:29:03.45 Relation 150 (PDISTR)
11:29:03.45 process pointer page 0 of 1
11:29:03.52 Index 2 (PDISTR_SND_ID)
11:29:03.53 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
11:29:03.55 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
11:29:03.56 Index 5 (PDISTR_AGENT_ID)
11:29:03.56 Relation 150 (PDISTR) is ok

11:29:03.56 Relation 151 (PSTORNED)
11:29:03.56 process pointer page 0 of 1
11:29:03.59 Index 2 (PSTORNED_SND_ID)
11:29:03.59 Index 3 (PSTORNED_RCV_ID)
11:29:03.59 Relation 151 (PSTORNED) is ok

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

11:29:03.59 Relation 157 (INVNT_TURNOVER_LOG)
11:29:03.59 process pointer page 0 of 2
11:29:03.78 process pointer page 1 of 2
11:29:03.89 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
11:29:04.03 Relation 157 (INVNT_TURNOVER_LOG) is ok

11:29:04.03 Relation 160 (PERF_ESTIMATED)
11:29:04.03 process pointer page 0 of 1
11:29:04.05 Index 1 (PERF_EST_MINUTE_SINCE_START)
11:29:04.05 Relation 160 (PERF_ESTIMATED) is ok

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

11:29:04.05 Relation 162 (PERF_LOG)
11:29:04.05 process pointer page 0 of 17
11:29:04.12 process pointer page 1 of 17
11:29:04.20 process pointer page 2 of 17
11:29:04.28 process pointer page 3 of 17
11:29:04.34 process pointer page 4 of 17
11:29:04.42 process pointer page 5 of 17
11:29:04.51 process pointer page 6 of 17
11:29:04.59 process pointer page 7 of 17
11:29:04.67 process pointer page 8 of 17
11:29:04.75 process pointer page 9 of 17
11:29:04.83 process pointer page 10 of 17
11:29:04.90 process pointer page 11 of 17
11:29:04.97 process pointer page 12 of 17
11:29:05.04 process pointer page 13 of 17
11:29:05.11 process pointer page 14 of 17
11:29:05.18 process pointer page 15 of 17
11:29:05.25 process pointer page 16 of 17
11:29:05.31 Index 1 (PERF_LOG_DTS_BEG_DESC)
11:29:05.70 Index 2 (PERF_LOG_UNIT)
11:29:06.21 Index 3 (PERF_LOG_TRN_DESC)
11:29:06.42 Index 4 (PERF_LOG_GDSCODE)
11:29:06.73 Relation 162 (PERF_LOG) is ok

11:29:06.73 Relation 166 (V_STOPTEST)
11:29:06.73 Relation 166 (V_STOPTEST) is ok

11:29:06.73 Relation 183 (V_QDISTR_SOURCE)
11:29:06.73 Relation 183 (V_QDISTR_SOURCE) is ok

11:29:06.73 Relation 184 (V_QSTORNED_SOURCE)
11:29:06.73 Relation 184 (V_QSTORNED_SOURCE) is ok

11:29:06.73 Relation 258 (XQD_1000_1200)
11:29:06.73 process pointer page 0 of 3
11:29:06.92 process pointer page 1 of 3
11:29:07.07 process pointer page 2 of 3
11:29:07.12 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
11:29:07.21 Relation 258 (XQD_1000_1200) is ok

11:29:07.21 Relation 259 (XQD_1200_2000)
11:29:07.21 process pointer page 0 of 4
11:29:07.34 process pointer page 1 of 4
11:29:07.51 process pointer page 2 of 4
11:29:07.67 process pointer page 3 of 4
11:29:07.68 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
11:29:07.74 Relation 259 (XQD_1200_2000) is ok

11:29:07.74 Relation 260 (XQD_1000_3300)
11:29:07.74 process pointer page 0 of 3
11:29:07.90 process pointer page 1 of 3
11:29:07.99 process pointer page 2 of 3
11:29:08.02 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
11:29:08.12 Index 2 (XQD_1000_3300_DOC)
11:29:08.20 Relation 260 (XQD_1000_3300) is ok

11:29:08.20 Relation 261 (XQD_2000_3300)
11:29:08.20 process pointer page 0 of 8
11:29:08.38 process pointer page 1 of 8
11:29:08.57 process pointer page 2 of 8
11:29:08.66 process pointer page 3 of 8
11:29:08.73 process pointer page 4 of 8
11:29:08.79 process pointer page 5 of 8
11:29:08.84 process pointer page 6 of 8
11:29:08.87 process pointer page 7 of 8
11:29:08.91 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
11:29:09.23 Relation 261 (XQD_2000_3300) is ok

11:29:09.23 Relation 262 (XQD_2100_3300)
11:29:09.23 process pointer page 0 of 3
11:29:09.35 process pointer page 1 of 3
11:29:09.49 process pointer page 2 of 3
11:29:09.52 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
11:29:09.63 Relation 262 (XQD_2100_3300) is ok

11:29:09.63 Relation 263 (XQD_3300_3400)
11:29:09.63 process pointer page 0 of 6
11:29:09.80 process pointer page 1 of 6
11:29:09.96 process pointer page 2 of 6
11:29:10.08 process pointer page 3 of 6
11:29:10.21 process pointer page 4 of 6
11:29:10.32 process pointer page 5 of 6
11:29:10.38 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
11:29:10.54 Relation 263 (XQD_3300_3400) is ok

11:29:10.54 Relation 264 (XQS_1000_1200)
11:29:10.54 process pointer page 0 of 9
11:29:10.63 process pointer page 1 of 9
11:29:10.72 process pointer page 2 of 9
11:29:10.82 process pointer page 3 of 9
11:29:10.91 process pointer page 4 of 9
11:29:11.00 process pointer page 5 of 9
11:29:11.10 process pointer page 6 of 9
11:29:11.18 process pointer page 7 of 9
11:29:11.27 process pointer page 8 of 9
11:29:11.30 Index 1 (XQS_1000_1200_DOC_ID)
11:29:11.41 Index 2 (XQS_1000_1200_SND_ID)
11:29:11.50 Index 3 (XQS_1000_1200_RCV_ID)
11:29:11.74 Relation 264 (XQS_1000_1200) is ok

11:29:11.74 Relation 265 (XQS_1200_2000)
11:29:11.74 process pointer page 0 of 9
11:29:11.83 process pointer page 1 of 9
11:29:11.92 process pointer page 2 of 9
11:29:12.00 process pointer page 3 of 9
11:29:12.10 process pointer page 4 of 9
11:29:12.19 process pointer page 5 of 9
11:29:12.28 process pointer page 6 of 9
11:29:12.38 process pointer page 7 of 9
11:29:12.49 process pointer page 8 of 9
11:29:12.55 Index 1 (XQS_1200_2000_DOC_ID)
11:29:12.83 Index 2 (XQS_1200_2000_SND_ID)
11:29:13.13 Index 3 (XQS_1200_2000_RCV_ID)
11:29:13.23 Relation 265 (XQS_1200_2000) is ok

11:29:13.23 Relation 266 (XQS_1000_3300)
11:29:13.23 process pointer page 0 of 6
11:29:13.30 process pointer page 1 of 6
11:29:13.41 process pointer page 2 of 6
11:29:13.50 process pointer page 3 of 6
11:29:13.61 process pointer page 4 of 6
11:29:13.70 process pointer page 5 of 6
11:29:13.70 Index 1 (XQS_1000_3300_DOC_ID)
11:29:13.86 Index 2 (XQS_1000_3300_SND_ID)
11:29:14.01 Index 3 (XQS_1000_3300_RCV_ID)
11:29:14.06 Relation 266 (XQS_1000_3300) is ok

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

11:29:14.06 Relation 268 (XQS_2100_3300)
11:29:14.06 process pointer page 0 of 7
11:29:14.11 process pointer page 1 of 7
11:29:14.19 process pointer page 2 of 7
11:29:14.23 process pointer page 3 of 7
11:29:14.28 process pointer page 4 of 7
11:29:14.31 process pointer page 5 of 7
11:29:14.36 process pointer page 6 of 7
11:29:14.36 Index 1 (XQS_2100_3300_DOC_ID)
11:29:14.53 Index 2 (XQS_2100_3300_SND_ID)
11:29:14.78 Index 3 (XQS_2100_3300_RCV_ID)
11:29:14.86 Relation 268 (XQS_2100_3300) is ok

11:29:14.86 Relation 269 (XQS_3300_3400)
11:29:14.86 process pointer page 0 of 3
11:29:14.97 process pointer page 1 of 3
11:29:15.08 process pointer page 2 of 3
11:29:15.12 Index 1 (XQS_3300_3400_DOC_ID)
11:29:15.20 Index 2 (XQS_3300_3400_SND_ID)
11:29:15.28 Relation 269 (XQS_3300_3400) is ok

11:29:15.28 Relation 276 (TRACE_STAT)
11:29:15.28 process pointer page 0 of 1
11:29:15.28 Relation 276 (TRACE_STAT) is ok

11:29:15.28 Validation finished
Done for 12890 ms, from 11:29:02.42 to 11:29:15.31.

Differences between old and current firebird.log

11:29:15.89. Got:
STDOUT: ---------- E:\TEMP\LOGS.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 4 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-12-20 11:29 264 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-12-20 11:29:18.18 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html