Tests

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-09-15 2:26:50.36.
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.27025 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

Test finish info

FINISH_STATE DTS_END FB_GDSCODE FB_MNEMONA STACK IP TRN_ID ATT_ID EXC_UNIT
NORMAL: TEST_TIME EXPIRED. 2016-09-15 02:26:09.8830 -1 <null> 127.0.0.1 90157 4194 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: 504.09 114180 90737 2016-09-14 23:26 2016-09-15 02:26
customer order: creation 29.33 614 5279 2016-09-14 23:26 2016-09-15 02:26
customer order: refuse 2.17 39 388 2016-09-14 23:26 2016-09-15 02:26
order to supplier: creation 7.26 7396 1300 2016-09-14 23:26 2016-09-15 02:26
order to supplier: removal 0.17 106428 27 2016-09-14 23:26 2016-09-15 02:26
invoice (draft): creation 7.70 3200 1386 2016-09-14 23:26 2016-09-15 02:26
invoice (draft): removal 1.51 170 243 2016-09-14 23:26 2016-09-15 02:26
invoice accept: apply 2.23 1898353 402 2016-09-14 23:26 2016-09-15 02:26
invoice accept: cancel 0.51 124810 84 2016-09-14 23:26 2016-09-15 02:26
customer reserve: creation 397.26 10990 71506 2016-09-14 23:26 2016-09-15 02:26
customer reserve: removal 13.64 6536 2442 2016-09-14 23:26 2016-09-15 02:26
realization accept: apply 13.46 62 2409 2016-09-14 23:26 2016-09-15 02:26
realization accept: cancel 6.40 45 1139 2016-09-14 23:26 2016-09-15 02:26
payment from customer: creation 9.75 114 1745 2016-09-14 23:26 2016-09-15 02:26
payment from customer: removal 0.83 22 148 2016-09-14 23:26 2016-09-15 02:26
payment to supplier: creation 8.04 265 1439 2016-09-14 23:26 2016-09-15 02:26
payment to supplier: removal 0.55 20 84 2016-09-14 23:26 2016-09-15 02:26
service: total inventory turnovers 2.02 8284 363 2016-09-14 23:26 2016-09-15 02:26
service: total monetary turnovers 1.94 16 342 2016-09-14 23:26 2016-09-15 02:26
service: refresh index statistics 0.07 2056 11 2016-09-14 23:26 2016-09-15 02:26
Done for 6740 ms, from 2:27:04.70 to 2:27:11.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 605 11727 10891 836 7.13 23:26:09 23:44:08
interval # 2, overall 2 498 9207 8961 246 2.67 23:44:09 00:02:08
interval # 3, overall 3 481 8830 8662 168 1.90 00:02:09 00:20:08
interval # 4, overall 4 502 9297 9035 262 2.82 00:20:09 00:38:08
interval # 5, overall 5 549 10221 9876 345 3.38 00:38:09 00:56:08
interval # 6, overall 6 583 10813 10495 318 2.94 00:56:09 01:14:08
interval # 7, overall 7 788 15485 14188 1297 8.38 01:14:09 01:32:08
interval # 8, overall 8 586 11144 10549 595 5.34 01:32:09 01:50:08
interval # 9, overall 9 339 6775 6098 677 9.99 01:50:09 02:08:08
interval # 10, overall 10 110 3272 1982 1290 39.43 02:08:09 02:26:08
Done for 9340 ms, from 2:27:18.85 to 2:27:28.19.

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 2040.31 0.6881 1.4635 856 87
WARM_TIME 2 1817.18 0.8218 1.1638 525 88
WARM_TIME 3 1566.23 0.9004 1.0762 465 71
WARM_TIME 4 1366.29 0.9254 1.1092 468 71
WARM_TIME 5 1295.67 0.9358 1.0643 368 64
WARM_TIME 6 1180.66 0.9734 1.0261 401 61
WARM_TIME 7 1082.07 0.9597 1.0280 372 56
WARM_TIME 8 1005.61 0.9680 1.0289 472 62
WARM_TIME 9 956.29 0.9618 1.0708 652 64
WARM_TIME 10 936.26 0.9844 1.0165 298 43
TEST_TIME 11 880.87 0.9823 1.0169 369 49
TEST_TIME 12 852.88 0.9629 1.0295 406 45
TEST_TIME 13 834.53 0.9713 1.0283 530 47
TEST_TIME 14 828.89 0.9614 1.0324 795 34
TEST_TIME 15 816.82 0.9779 1.0255 536 16
TEST_TIME 16 789.90 0.9942 1.0073 87 5
TEST_TIME 17 751.71 0.9963 1.0129 34 5
TEST_TIME 18 724.43 0.9928 1.0126 160 5
TEST_TIME 19 701.47 0.9908 1.0095 225 5
TEST_TIME 20 677.22 0.9934 1.0125 95 4
TEST_TIME 21 667.30 0.9787 1.0154 304 5
TEST_TIME 22 657.17 0.9843 1.0112 179 6
TEST_TIME 23 641.92 0.9940 1.0054 106 3
TEST_TIME 24 623.93 0.9946 1.0061 37 4
TEST_TIME 25 609.60 0.9921 1.0118 83 6
TEST_TIME 26 603.17 0.9981 1.0076 41 4
TEST_TIME 27 588.75 0.9941 1.0067 143 4
TEST_TIME 28 576.04 0.9921 1.0048 155 3
TEST_TIME 29 565.67 0.9880 1.0097 185 7
TEST_TIME 30 557.35 0.9907 1.0099 138 7
TEST_TIME 31 552.03 0.9868 1.0253 323 7
TEST_TIME 32 551.59 0.9941 1.0081 192 5
TEST_TIME 33 544.75 0.9898 1.0064 150 4
TEST_TIME 34 535.81 0.9984 1.0015 52 4
TEST_TIME 35 527.32 0.9886 1.0037 87 3
TEST_TIME 36 521.19 0.9874 1.0076 56 4
TEST_TIME 37 517.62 0.9926 1.0080 67 5
TEST_TIME 38 512.20 0.9919 1.0014 49 4
TEST_TIME 39 508.05 0.9902 1.0076 151 5
TEST_TIME 41 493.11 0.9935 1.0043 118 5
TEST_TIME 42 485.28 0.9963 1.0103 44 4
TEST_TIME 43 479.53 0.9987 1.0012 58 3
TEST_TIME 44 474.23 0.9894 1.0129 60 5
TEST_TIME 45 474.27 0.9903 1.0096 94 7
TEST_TIME 46 472.63 0.9911 1.0095 218 6
TEST_TIME 47 472.21 0.9936 1.0131 98 4
TEST_TIME 48 473.63 0.9891 1.0100 111 5
TEST_TIME 49 475.68 0.9910 1.0100 161 6
TEST_TIME 50 470.94 0.9998 1.0001 7 1
TEST_TIME 51 462.50 0.9986 1.0086 30 4
TEST_TIME 52 458.33 0.9982 1.0072 60 5
TEST_TIME 53 460.22 0.9913 1.0036 158 4
TEST_TIME 55 447.86 0.9989 1.0016 5 2
TEST_TIME 56 441.04 0.9989 1.0012 38 2
TEST_TIME 57 436.54 0.9995 1.0003 23 1
TEST_TIME 58 429.51 0.9998 1.0001 12 1
TEST_TIME 59 425.35 0.9943 1.0041 81 2
TEST_TIME 60 424.37 0.9897 1.0070 130 4
TEST_TIME 61 424.85 0.9895 1.0029 42 3
TEST_TIME 62 425.25 0.9858 1.0123 62 4
TEST_TIME 63 424.78 0.9974 1.0142 98 2
TEST_TIME 64 426.04 0.9954 1.0036 151 4
TEST_TIME 65 422.86 0.9959 1.0026 41 3
TEST_TIME 66 418.22 0.9984 1.0013 41 4
TEST_TIME 67 412.80 0.9994 1.0006 31 2
TEST_TIME 68 411.51 0.9968 1.0133 46 3
TEST_TIME 69 417.32 0.9848 1.0083 154 7
TEST_TIME 70 417.53 0.9934 1.0065 49 5
TEST_TIME 71 419.02 0.9888 1.0028 123 4
TEST_TIME 72 414.52 0.9997 1.0002 18 1
TEST_TIME 73 416.41 0.9901 1.0059 128 4
TEST_TIME 74 416.96 0.9946 1.0013 16 2
TEST_TIME 75 418.12 0.9910 1.0033 92 6
TEST_TIME 76 420.75 0.9839 1.0070 110 4
TEST_TIME 77 419.67 0.9965 1.0056 108 8
TEST_TIME 78 417.79 0.9972 1.0036 123 7
TEST_TIME 79 414.62 0.9985 1.0016 26 3
TEST_TIME 80 413.41 0.9996 1.0004 29 2
TEST_TIME 81 412.56 0.9951 1.0038 75 4
TEST_TIME 82 413.33 0.9898 1.0072 194 6
TEST_TIME 83 413.90 0.9937 1.0019 75 5
TEST_TIME 84 411.82 0.9950 1.0100 68 4
TEST_TIME 85 411.44 0.9990 1.0022 49 4
TEST_TIME 86 408.66 0.9973 1.0074 84 5
TEST_TIME 87 411.21 0.9913 1.0046 228 6
TEST_TIME 88 410.30 0.9954 1.0084 100 6
TEST_TIME 89 412.60 0.9915 1.0076 143 7
TEST_TIME 90 411.98 0.9979 1.0127 84 8
TEST_TIME 91 414.04 0.9966 1.0059 158 7
TEST_TIME 92 420.75 0.9876 1.0055 117 5
TEST_TIME 93 425.33 0.9840 1.0115 107 6
TEST_TIME 94 428.51 0.9934 1.0163 131 9
TEST_TIME 95 431.56 0.9998 1.0001 14 4
TEST_TIME 96 427.20 0.9998 1.0002 21 1
TEST_TIME 97 427.05 0.9966 1.0057 35 4
TEST_TIME 98 427.61 0.9942 1.0031 51 3
TEST_TIME 99 427.42 0.9934 1.0110 60 6
TEST_TIME 100 430.21 0.9944 1.0071 118 5
TEST_TIME 101 430.63 0.9961 1.0053 142 5
TEST_TIME 102 433.44 0.9890 1.0085 74 5
TEST_TIME 103 433.04 0.9997 1.0003 28 3
TEST_TIME 104 433.40 0.9973 1.0072 93 4
TEST_TIME 105 435.93 0.9919 1.0052 125 6
TEST_TIME 106 437.55 0.9920 1.0154 132 10
TEST_TIME 107 442.19 0.9954 1.0019 141 7
TEST_TIME 108 443.94 0.9888 1.0016 60 4
TEST_TIME 109 441.55 0.9978 1.0004 40 2
TEST_TIME 110 437.92 0.9995 1.0003 32 2
TEST_TIME 111 437.55 0.9922 1.0037 73 5
TEST_TIME 112 439.92 0.9973 1.0101 56 5
TEST_TIME 113 443.40 0.9933 1.0100 67 6
TEST_TIME 114 450.64 0.9919 1.0061 61 4
TEST_TIME 115 454.71 0.9884 1.0056 72 6
TEST_TIME 116 458.23 0.9965 1.0018 46 3
TEST_TIME 117 457.68 0.9944 1.0062 39 4
TEST_TIME 118 459.20 0.9944 1.0012 36 5
TEST_TIME 119 456.09 0.9996 1.0003 41 3
TEST_TIME 120 456.36 0.9941 1.0052 58 3
TEST_TIME 121 458.87 0.9983 1.0010 24 2
TEST_TIME 122 456.23 0.9986 1.0087 45 4
TEST_TIME 123 461.83 0.9908 1.0081 69 9
TEST_TIME 124 466.46 0.9986 1.0013 110 5
TEST_TIME 125 465.33 0.9958 1.0023 135 4
TEST_TIME 126 467.36 0.9901 1.0031 130 6
TEST_TIME 127 468.11 0.9937 1.0049 59 6
TEST_TIME 128 468.09 0.9971 1.0113 114 8
TEST_TIME 129 477.04 0.9898 1.0022 131 11
TEST_TIME 130 477.32 0.9940 1.0133 151 17
TEST_TIME 131 485.75 0.9881 1.0094 150 15
TEST_TIME 132 490.98 0.9911 1.0068 165 11
TEST_TIME 133 491.48 0.9982 1.0006 79 6
TEST_TIME 134 492.35 0.9951 1.0035 138 8
TEST_TIME 135 491.71 0.9974 1.0026 174 8
TEST_TIME 136 491.89 0.9949 1.0106 67 6
TEST_TIME 137 494.16 0.9987 1.0025 81 6
TEST_TIME 138 497.64 0.9883 1.0034 87 8
TEST_TIME 139 496.05 0.9994 1.0008 31 3
TEST_TIME 140 501.35 0.9832 1.0070 168 7
TEST_TIME 141 502.32 0.9991 1.0027 90 4
TEST_TIME 142 500.29 0.9997 1.0001 24 2
TEST_TIME 143 497.10 0.9998 1.0001 23 2
TEST_TIME 144 494.92 0.9991 1.0003 28 1
TEST_TIME 145 492.63 0.9992 1.0003 11 2
TEST_TIME 146 495.13 0.9884 1.0071 98 7
TEST_TIME 147 503.01 0.9846 1.0044 203 10
TEST_TIME 148 503.37 0.9969 1.0064 71 5
TEST_TIME 149 506.51 0.9980 1.0026 73 4
TEST_TIME 150 507.23 0.9952 1.0043 77 4
TEST_TIME 151 506.10 0.9999 1.0000 11 1
TEST_TIME 152 513.19 0.9883 1.0112 92 8
TEST_TIME 153 524.59 0.9891 1.0145 250 12
TEST_TIME 154 531.31 0.9952 1.0097 68 8
TEST_TIME 155 536.23 0.9940 1.0052 98 4
TEST_TIME 157 543.58 0.9828 1.0134 199 10
TEST_TIME 158 551.44 0.9946 1.0022 126 7
TEST_TIME 159 552.55 0.9942 1.0100 55 4
TEST_TIME 160 559.78 0.9952 1.0033 103 3
TEST_TIME 161 560.65 0.9955 1.0032 49 5
TEST_TIME 162 559.03 0.9999 1.0000 11 1
TEST_TIME 163 559.95 0.9959 1.0025 48 3
TEST_TIME 164 559.20 0.9987 1.0005 89 3
TEST_TIME 165 562.79 0.9881 1.0039 171 5
TEST_TIME 166 567.38 0.9904 1.0065 176 6
TEST_TIME 167 570.60 0.9991 1.0006 86 3
TEST_TIME 168 567.58 0.9999 1.0000 12 1
TEST_TIME 169 565.36 0.9984 1.0033 65 3
TEST_TIME 170 566.83 0.9948 1.0008 68 4
TEST_TIME 171 566.14 0.9962 1.0055 15 4
TEST_TIME 172 567.80 0.9998 1.0003 30 2
TEST_TIME 173 564.73 0.9999 1.0000 8 2
TEST_TIME 174 567.58 0.9992 1.0004 65 3
TEST_TIME 175 566.05 0.9974 1.0003 35 3
TEST_TIME 176 563.06 0.9999 1.0000 8 1
TEST_TIME 177 560.24 0.9998 1.0001 33 2
TEST_TIME 178 557.19 1.0000 1.0000 7 1
TEST_TIME 179 555.29 0.9988 1.0008 113 4
TEST_TIME 180 553.36 0.9998 1.0001 39 2
TEST_TIME 181 550.41 1.0000 1.0000 2 1
TEST_TIME 182 547.68 0.9999 1.0000 6 1
TEST_TIME 184 542.02 0.9998 1.0001 25 1
TEST_TIME 186 538.21 0.9999 1.0001 24 1
TEST_TIME 187 535.42 0.9999 1.0000 9 1
TEST_TIME 188 536.31 0.9965 1.0008 58 2
TEST_TIME 189 536.07 0.9992 1.0004 29 3
TEST_TIME 190 533.62 0.9997 1.0003 103 100
Done for 9420 ms, from 2:27:28.50 to 2:27:37.92.

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 1 34097 46558 2655 <null> 48456 <null> 987 <null> 1072 566 61971 36016 98100 26750 274590 <null> 99604 873700 <null> 23:26:09 23:44:08
fetches per second 6 50047 43012 30785 <null> 71531 <null> 1092 723 <null> <null> 40286 <null> 130500 <null> 261729 53363 56986 1617000 <null> 00:56:09 01:14:08
fetches per second 9 33596 48000 11752 <null> <null> <null> 1890 <null> <null> <null> <null> <null> <null> <null> 261171 <null> 97187 <null> <null> 01:50:09 02:08:08
marks per second 1 6156 4214 249 <null> 4076 <null> 107 <null> 97 114 8300 5341 4028 2777 5129 <null> 909 7400 <null> 23:26:09 23:44:08
marks per second 6 8917 4051 1667 <null> 3220 <null> 47 117 <null> <null> 6627 <null> 2168 <null> 1173 5590 193 5004 <null> 00:56:09 01:14:08
marks per second 9 6364 4461 623 <null> <null> <null> 38 <null> <null> <null> <null> <null> <null> <null> 33478 <null> 219 <null> <null> 01:50:09 02:08:08
reads/fetches*100 1 10 5 20 <null> 6 <null> 16 <null> 16 24 7 5 6 5 3 <null> 21 1 <null> 23:26:09 23:44:08
reads/fetches*100 6 4 3 8 <null> 6 <null> 15 18 <null> <null> 7 <null> 5 <null> 3 5 28 0 <null> 00:56:09 01:14:08
reads/fetches*100 9 6 3 6 <null> <null> <null> 10 <null> <null> <null> <null> <null> <null> <null> 2 <null> 29 <null> <null> 01:50:09 02:08:08
writes/marks*100 1 10 13 4 <null> 7 <null> 1 <null> 2 3 6 7 6 0 5 <null> 37 1 <null> 23:26:09 23:44:08
writes/marks*100 6 13 10 6 <null> 10 <null> 2 2 <null> <null> 7 <null> 8 <null> 8 0 50 6 <null> 00:56:09 01:14:08
writes/marks*100 9 16 12 12 <null> <null> <null> 3 <null> <null> <null> <null> <null> <null> <null> 4 <null> 53 <null> <null> 01:50:09 02:08:08
Done for 4710 ms, from 2:27:38.14 to 2:27:42.85.

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 64199 59232 4967 7.73 0 21965 30 4967 2016-09-14 23:26 2016-09-15 02:26
doc_list_biud 64246 59231 5015 7.80 0 588355 955 5015 2016-09-14 23:26 2016-09-15 02:26
sp_add_invoice_to_stock 1188 402 786 66.16 4914 8266579 1898353 786 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_adding_invoice 156 84 72 46.15 15 1727329 124810 72 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_client_order 418 388 30 7.17 0 686 39 30 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_customer_reserve 5925 2442 3483 58.78 0 192505 6536 3483 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_pay_from_customer 149 148 1 0.67 0 234 22 1 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_pay_to_supplier 85 84 1 1.17 0 78 20 1 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_supplier_invoice 335 243 92 27.46 0 4462 170 92 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_supplier_order 100 27 73 73.00 390 1240545 106428 73 2016-09-14 23:26 2016-09-15 02:26
sp_cancel_write_off 2574 1139 1435 55.74 0 624 45 1435 2016-09-14 23:26 2016-09-15 02:26
sp_client_order 5279 5279 0 0.00 0 30764 614 0 2016-09-14 23:26 2016-09-15 02:26
sp_customer_reserve 71506 71506 0 0.00 16 101150 10990 0 2016-09-14 23:26 2016-09-15 02:26
sp_fill_shopping_cart 7965 7965 0 0.00 0 82712 935 0 2016-09-14 23:26 2016-09-15 02:26
sp_fill_shopping_cart_clo_res 71506 71506 0 0.00 0 1622 3 0 2016-09-14 23:26 2016-09-15 02:26
sp_get_clo_for_invoice 402 402 0 0.00 0 561 94 0 2016-09-14 23:26 2016-09-15 02:26
sp_kill_cost_storno 2894 1456 1438 49.68 0 187 5 1438 2016-09-14 23:26 2016-09-15 02:26
sp_kill_qstorno_ret_qs2qd 14694 6293 8401 57.17 0 192411 2546 8401 2016-09-14 23:26 2016-09-15 02:26
sp_kill_qty_storno 12131 7135 4996 41.18 0 588355 7924 4996 2016-09-14 23:26 2016-09-15 02:26
sp_lock_selected_doc 5006 3934 1072 21.41 0 31 0 1072 2016-09-14 23:26 2016-09-15 02:26
sp_make_cost_storno 5995 5995 0 0.00 0 2152 87 0 2016-09-14 23:26 2016-09-15 02:26
sp_multiply_rows_for_pdistr 5995 5995 0 0.00 0 375 9 0 2016-09-14 23:26 2016-09-15 02:26
sp_multiply_rows_for_qdistr 5279 5279 0 0.00 0 30217 559 0 2016-09-14 23:26 2016-09-15 02:26
sp_pay_from_customer 1745 1745 0 0.00 31 1186 114 0 2016-09-14 23:26 2016-09-15 02:26
sp_pay_to_supplier 1439 1439 0 0.00 31 2434 265 0 2016-09-14 23:26 2016-09-15 02:26
sp_payment_common 3184 3184 0 0.00 0 343 26 0 2016-09-14 23:26 2016-09-15 02:26
sp_qd_handle_on_cancel_clo 418 388 30 7.17 0 655 19 30 2016-09-14 23:26 2016-09-15 02:26
sp_qd_handle_on_invoice_upd_sts 536 487 49 9.14 0 588355 82988 49 2016-09-14 23:26 2016-09-15 02:26
sp_qd_handle_on_reserve_upd_sts 2410 2409 1 0.04 0 265 15 1 2016-09-14 23:26 2016-09-15 02:26
sp_reserve_write_off 2470 2409 61 2.46 0 1435 62 61 2016-09-14 23:26 2016-09-15 02:26
sp_supplier_invoice 1386 1386 0 0.00 31 82742 3200 0 2016-09-14 23:26 2016-09-15 02:26
sp_supplier_order 1300 1300 0 0.00 31 138013 7396 0 2016-09-14 23:26 2016-09-15 02:26
srv_find_qd_qs_mism 36449 31507 4942 13.55 0 21965 37 4942 2016-09-14 23:26 2016-09-15 02:26
srv_make_invnt_saldo 363 363 0 0.00 1623 36442 8284 0 2016-09-14 23:26 2016-09-15 02:26
srv_make_money_saldo 342 342 0 0.00 0 406 16 0 2016-09-14 23:26 2016-09-15 02:26
srv_recalc_idx_stat 11 11 0 0.00 1373 3572 2056 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_add_invoice_to_stock 786 786 0 0.00 0 78 6 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_adding_invoice 140 140 0 0.00 0 328 44 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_client_order 30 30 0 0.00 0 16 5 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_customer_reserve 2 2 0 0.00 0 31 15 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_pay_from_customer 1 1 0 0.00 0 0 0 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_pay_to_supplier 1 1 0 0.00 16 16 16 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_supplier_invoice 72 72 0 0.00 0 47 7 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_supplier_order 549 549 0 0.00 0 687 60 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_cancel_write_off 5 5 0 0.00 0 16 6 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-abend:sp_reserve_write_off 61 61 0 0.00 0 62 7 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_add_invoice_to_stock 441 441 0 0.00 15 6630 422 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_adding_invoice 44 44 0 0.00 0 655 145 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_client_order 388 388 0 0.00 0 172 10 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_customer_reserve 157 157 0 0.00 0 140 15 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_pay_from_customer 148 148 0 0.00 0 171 10 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_pay_to_supplier 84 84 0 0.00 0 63 8 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_supplier_invoice 24 24 0 0.00 0 47 10 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_supplier_order 27 27 0 0.00 15 4805 536 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_cancel_write_off 252 252 0 0.00 0 109 10 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_client_order 5301 5301 0 0.00 0 296 14 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_customer_reserve 227 227 0 0.00 0 140 12 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_pay_from_customer 1745 1745 0 0.00 0 187 10 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_pay_to_supplier 1439 1439 0 0.00 0 125 9 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_reserve_write_off 2409 2409 0 0.00 0 265 12 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_supplier_invoice 1387 1387 0 0.00 0 219 15 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:sp_supplier_order 1333 1333 0 0.00 0 546 16 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:srv_make_invnt_saldo 363 363 0 0.00 0 47 3 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:srv_make_money_saldo 342 342 0 0.00 0 125 3 0 2016-09-14 23:26 2016-09-15 02:26
t$perf-norm:srv_recalc_idx_stat 11 11 0 0.00 0 31 18 0 2016-09-14 23:26 2016-09-15 02:26
v_add_invoice_to_stock 2376 804 1572 66.16 0 1014 2 1572 2016-09-14 23:26 2016-09-15 02:26
v_all_customers 7960 7960 0 0.00 0 16 0 0 2016-09-14 23:26 2016-09-15 02:26
v_all_suppliers 5372 5372 0 0.00 0 16 0 0 2016-09-14 23:26 2016-09-15 02:26
v_all_wares 10558 10558 0 0.00 0 16 0 0 2016-09-14 23:26 2016-09-15 02:26
v_cancel_adding_invoice 168 86 82 48.80 0 62 7 82 2016-09-14 23:26 2016-09-15 02:26
v_cancel_client_order 836 776 60 7.17 0 16 0 60 2016-09-14 23:26 2016-09-15 02:26
v_cancel_customer_prepayment 298 296 2 0.67 0 16 1 2 2016-09-14 23:26 2016-09-15 02:26
v_cancel_customer_reserve 318 314 4 1.25 0 16 1 4 2016-09-14 23:26 2016-09-15 02:26
v_cancel_payment_to_supplier 170 168 2 1.17 0 16 0 2 2016-09-14 23:26 2016-09-15 02:26
v_cancel_supplier_invoice 192 48 144 75.00 0 16 2 144 2016-09-14 23:26 2016-09-15 02:26
v_cancel_supplier_order 200 54 146 73.00 0 16 2 146 2016-09-14 23:26 2016-09-15 02:26
v_cancel_write_off 514 504 10 1.94 0 32 2 10 2016-09-14 23:26 2016-09-15 02:26
v_max_id_clo_ord 1300 1300 0 0.00 0 1716 55 0 2016-09-14 23:26 2016-09-15 02:26
v_max_id_clo_res 227 227 0 0.00 0 32 3 0 2016-09-14 23:26 2016-09-15 02:26
v_max_id_ord_sup 1386 1386 0 0.00 0 15568 20 0 2016-09-14 23:26 2016-09-15 02:26
v_max_non_paid_invoice 1439 1439 0 0.00 0 78 3 0 2016-09-14 23:26 2016-09-15 02:26
v_max_non_paid_realizn 1745 1745 0 0.00 0 46 5 0 2016-09-14 23:26 2016-09-15 02:26
v_min_id_clo_ord 1300 1300 0 0.00 0 1685 72 0 2016-09-14 23:26 2016-09-15 02:26
v_min_id_clo_res 227 227 0 0.00 0 16 2 0 2016-09-14 23:26 2016-09-15 02:26
v_min_id_ord_sup 1386 1386 0 0.00 0 46286 107 0 2016-09-14 23:26 2016-09-15 02:26
v_min_non_paid_invoice 1439 1439 0 0.00 0 312 19 0 2016-09-14 23:26 2016-09-15 02:26
v_min_non_paid_realizn 1745 1745 0 0.00 0 124 13 0 2016-09-14 23:26 2016-09-15 02:26
v_our_firm 2598 2598 0 0.00 0 16 0 0 2016-09-14 23:26 2016-09-15 02:26
v_reserve_write_off 4940 4818 122 2.46 0 32 1 122 2016-09-14 23:26 2016-09-15 02:26
x_lock_depdocs_on_canc_invoice 521 303 218 41.84 0 62 4 218 2016-09-14 23:26 2016-09-15 02:26
x_lock_depdocs_on_canc_sup_ord 100 27 73 73.00 0 16 3 73 2016-09-14 23:26 2016-09-15 02:26
x_make_qstorno_1000_1200 1307 1307 0 0.00 15 104146 4702 0 2016-09-14 23:26 2016-09-15 02:26
x_make_qstorno_1200_2000 1386 1386 0 0.00 0 32916 717 0 2016-09-14 23:26 2016-09-15 02:26
x_make_qstorno_2100_3300 71506 71506 0 0.00 15 101150 10972 0 2016-09-14 23:26 2016-09-15 02:26
Done for 18420 ms, from 2:27:54.12 to 2:28:12.54.

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 7 sp_kill_cost_storno 335544336 2016-09-14 23:28 2016-09-15 01:19
deadlock 3 sp_qd_handle_on_invoice_upd_sts 335544336 2016-09-14 23:27 2016-09-15 00:07
lock_conflict 2 sp_kill_cost_storno 335544345 2016-09-15 01:16 2016-09-15 01:31
lock_conflict 926 sp_lock_selected_doc 335544345 2016-09-14 23:26 2016-09-15 02:25
lock_conflict 30 sp_qd_handle_on_cancel_clo 335544345 2016-09-14 23:28 2016-09-15 01:51
lock_conflict 31 sp_qd_handle_on_invoice_upd_sts 335544345 2016-09-14 23:27 2016-09-15 02:16
lock_conflict 1 sp_qd_handle_on_reserve_upd_sts 335544345 2016-09-14 23:57 2016-09-14 23:57
lock_conflict 49 x_lock_depdocs_on_canc_invoice 335544345 2016-09-14 23:26 2016-09-15 02:08
lock_conflict 25 x_lock_depdocs_on_canc_sup_ord 335544345 2016-09-14 23:28 2016-09-15 02:15
Done for 2720 ms, from 2:28:13.10 to 2:28:15.82.

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 92581
MON$OLDEST_ACTIVE 92582
MON$OLDEST_SNAPSHOT 92582
MON$NEXT_TRANSACTION 92582
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 173782
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.7.27025 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.7.27025 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.7.27025 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.7.27025 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 97058
Page size 8192
ODS version 11.2
Oldest transaction 92583
Oldest active 92584
Oldest snapshot 92584
Next transaction 92585
Bumped transaction 1
Sequence number 0
Next attachment ID 4443
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: 43.81, total records: 482819
Average version length: 46.18, total versions: 24546, max versions: 1
Data pages: 5154, data page slots: 5160, average fill: 73%
Fill distribution:
0 - 19% = 13
20 - 39% = 20
40 - 59% = 73
60 - 79% = 4909
80 - 99% = 139

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1610, nodes: 482819
Average data length: 11.83, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 163
20 - 39% = 29
40 - 59% = 689
60 - 79% = 81
80 - 99% = 648

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1411, nodes: 482819
Average data length: 5.95, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 25
40 - 59% = 1385
60 - 79% = 0
80 - 99% = 1

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 474, nodes: 482819
Average data length: 0.92, total dup: 412399, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 21
40 - 59% = 212
60 - 79% = 9
80 - 99% = 230

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 57.89, total records: 84163
Average version length: 50.09, total versions: 9435, max versions: 5
Data pages: 1062, data page slots: 1062, average fill: 80%
Fill distribution:
0 - 19% = 8
20 - 39% = 14
40 - 59% = 29
60 - 79% = 320
80 - 99% = 691

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 68, nodes: 84163
Average data length: 0.01, total dup: 84113, max dup: 18430
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 37
60 - 79% = 22
80 - 99% = 9

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 178, nodes: 84163
Average data length: 6.26, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 7
20 - 39% = 11
40 - 59% = 90
60 - 79% = 1
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.12, total records: 400
Average version length: 13.99, total versions: 90283, max versions: 260
Data pages: 362, data page slots: 362, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 361

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: 143048
Average version length: 68.64, total versions: 143025, max versions: 1
Data pages: 2463, data page slots: 2655, average fill: 74%
Fill distribution:
0 - 19% = 272
20 - 39% = 235
40 - 59% = 99
60 - 79% = 160
80 - 99% = 1697

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 407, nodes: 143048
Average data length: 8.14, total dup: 18064, max dup: 3
Fill distribution:
0 - 19% = 1
20 - 39% = 8
40 - 59% = 180
60 - 79% = 217
80 - 99% = 1

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

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.26, total records: 6533
Average version length: 44.51, total versions: 6495, max versions: 1
Data pages: 80, data page slots: 80, average fill: 80%
Fill distribution:
0 - 19% = 10
20 - 39% = 2
40 - 59% = 1
60 - 79% = 3
80 - 99% = 64

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 6, nodes: 6533
Average data length: 0.15, total dup: 6443, max dup: 1270
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 4
60 - 79% = 2
80 - 99% = 0

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: 24.57, total records: 127147
Average version length: 33.62, total versions: 79607, max versions: 10
Data pages: 1506, data page slots: 1506, average fill: 77%
Fill distribution:
0 - 19% = 10
20 - 39% = 70
40 - 59% = 131
60 - 79% = 501
80 - 99% = 794

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 119, nodes: 127147
Average data length: 0.01, total dup: 127098, max dup: 26348
Fill distribution:
0 - 19% = 2
20 - 39% = 8
40 - 59% = 74
60 - 79% = 17
80 - 99% = 18

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 141, nodes: 127147
Average data length: 0.90, total dup: 114402, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 4
40 - 59% = 93
60 - 79% = 25
80 - 99% = 19

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 146, nodes: 127147
Average data length: 0.90, total dup: 114402, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 7
40 - 59% = 86
60 - 79% = 33
80 - 99% = 20

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 138, nodes: 127147
Average data length: 0.67, total dup: 114402, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 15
40 - 59% = 63
60 - 79% = 47
80 - 99% = 13

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 16, nodes: 23375
Average data length: 0.01, total dup: 23189, max dup: 1248
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 5
60 - 79% = 7
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.92, total records: 1350865
Average version length: 153.00, total versions: 1, max versions: 1
Data pages: 30942, data page slots: 30942, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 30941

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1649, nodes: 1350865
Average data length: 0.60, total dup: 763979, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1189
60 - 79% = 288
80 - 99% = 172

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1648, nodes: 1350865
Average data length: 0.35, total dup: 1276496, max dup: 6912
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1385
60 - 79% = 138
80 - 99% = 125

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1478, nodes: 1350865
Average data length: 0.23, total dup: 1322958, max dup: 146437
Fill distribution:
0 - 19% = 4
20 - 39% = 0
40 - 59% = 1046
60 - 79% = 208
80 - 99% = 220

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: 50.42, total records: 89093
Average version length: 54.89, total versions: 7061, max versions: 1
Data pages: 1044, data page slots: 1044, average fill: 76%
Fill distribution:
0 - 19% = 4
20 - 39% = 3
40 - 59% = 6
60 - 79% = 952
80 - 99% = 79

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 112, nodes: 89093
Average data length: 1.13, total dup: 73896, max dup: 288
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 106
60 - 79% = 6
80 - 99% = 0

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 82, nodes: 89093
Average data length: 0.62, total dup: 81162, max dup: 79
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 41
60 - 79% = 33
80 - 99% = 8

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: 992, max versions: 509
Data pages: 4, data page slots: 4, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
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.14, total records: 370
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 5, data page slots: 5, average fill: 69%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 4
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.38, total records: 206082
Average version length: 69.76, total versions: 204974, max versions: 1
Data pages: 3059, data page slots: 3616, average fill: 86%
Fill distribution:
0 - 19% = 269
20 - 39% = 37
40 - 59% = 13
60 - 79% = 14
80 - 99% = 2726

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 320, nodes: 206082
Average data length: 1.23, total dup: 180666, max dup: 29
Fill distribution:
0 - 19% = 7
20 - 39% = 91
40 - 59% = 140
60 - 79% = 71
80 - 99% = 11

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 54.68, total records: 290227
Average version length: 69.25, total versions: 62058, max versions: 1
Data pages: 3960, data page slots: 4102, average fill: 81%
Fill distribution:
0 - 19% = 7
20 - 39% = 5
40 - 59% = 14
60 - 79% = 1854
80 - 99% = 2080

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 285, nodes: 290227
Average data length: 0.16, total dup: 283643, max dup: 169
Fill distribution:
0 - 19% = 5
20 - 39% = 37
40 - 59% = 146
60 - 79% = 13
80 - 99% = 84

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 364, nodes: 290227
Average data length: 1.25, total dup: 254434, max dup: 29
Fill distribution:
0 - 19% = 3
20 - 39% = 2
40 - 59% = 192
60 - 79% = 129
80 - 99% = 38

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.04, total records: 258480
Average version length: 69.69, total versions: 258333, max versions: 1
Data pages: 3686, data page slots: 4567, average fill: 89%
Fill distribution:
0 - 19% = 104
20 - 39% = 78
40 - 59% = 63
60 - 79% = 72
80 - 99% = 3369

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 370, nodes: 258480
Average data length: 1.04, total dup: 232086, max dup: 102
Fill distribution:
0 - 19% = 4
20 - 39% = 18
40 - 59% = 279
60 - 79% = 49
80 - 99% = 20

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 18.15, total records: 1080647
Average version length: 68.31, total versions: 798803, max versions: 1
Data pages: 14560, data page slots: 14560, average fill: 89%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3416
80 - 99% = 11143

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1376, nodes: 1080647
Average data length: 1.12, total dup: 956755, max dup: 75
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1090
60 - 79% = 101
80 - 99% = 184

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 19.29, total records: 144724
Average version length: 69.25, total versions: 104367, max versions: 1
Data pages: 2796, data page slots: 4537, average fill: 64%
Fill distribution:
0 - 19% = 545
20 - 39% = 295
40 - 59% = 140
60 - 79% = 390
80 - 99% = 1426

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 252, nodes: 144724
Average data length: 1.57, total dup: 122736, max dup: 77
Fill distribution:
0 - 19% = 0
20 - 39% = 82
40 - 59% = 116
60 - 79% = 53
80 - 99% = 1

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 37.65, total records: 770213
Average version length: 68.44, total versions: 349378, max versions: 1
Data pages: 10835, data page slots: 10954, average fill: 82%
Fill distribution:
0 - 19% = 126
20 - 39% = 222
40 - 59% = 254
60 - 79% = 3597
80 - 99% = 6636

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1119, nodes: 770213
Average data length: 1.33, total dup: 665458, max dup: 44
Fill distribution:
0 - 19% = 4
20 - 39% = 26
40 - 59% = 896
60 - 79% = 119
80 - 99% = 74

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.19, total records: 1012914
Average version length: 80.63, total versions: 30397, max versions: 1
Data pages: 15115, data page slots: 15115, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 6490
80 - 99% = 8625

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1108, nodes: 1012914
Average data length: 0.15, total dup: 990124, max dup: 172
Fill distribution:
0 - 19% = 6
20 - 39% = 0
40 - 59% = 788
60 - 79% = 251
80 - 99% = 63

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 801, nodes: 1012914
Average data length: 0.72, total dup: 891603, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 134
60 - 79% = 16
80 - 99% = 650

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1262, nodes: 1012914
Average data length: 0.74, total dup: 887438, max dup: 41
Fill distribution:
0 - 19% = 9
20 - 39% = 0
40 - 59% = 890
60 - 79% = 306
80 - 99% = 57

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 64.45, total records: 644609
Average version length: 80.20, total versions: 127226, max versions: 1
Data pages: 9773, data page slots: 9892, average fill: 81%
Fill distribution:
0 - 19% = 57
20 - 39% = 100
40 - 59% = 109
60 - 79% = 4053
80 - 99% = 5454

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 650, nodes: 644609
Average data length: 0.15, total dup: 630789, max dup: 289
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 326
60 - 79% = 265
80 - 99% = 57

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 531, nodes: 644609
Average data length: 0.84, total dup: 558354, max dup: 14
Fill distribution:
0 - 19% = 9
20 - 39% = 7
40 - 59% = 87
60 - 79% = 4
80 - 99% = 424

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 774, nodes: 644609
Average data length: 0.70, total dup: 571171, max dup: 47
Fill distribution:
0 - 19% = 32
20 - 39% = 0
40 - 59% = 390
60 - 79% = 308
80 - 99% = 44

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 75.25, total records: 1077957
Average version length: 81.24, total versions: 72170, max versions: 1
Data pages: 16090, data page slots: 16090, average fill: 81%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7242
80 - 99% = 8847

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1111, nodes: 1077957
Average data length: 0.05, total dup: 1071731, max dup: 1058
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 720
60 - 79% = 296
80 - 99% = 95

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 808, nodes: 1077957
Average data length: 0.68, total dup: 953838, max dup: 49
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 69
60 - 79% = 7
80 - 99% = 732

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1276, nodes: 1077957
Average data length: 0.68, total dup: 956673, max dup: 120
Fill distribution:
0 - 19% = 7
20 - 39% = 1
40 - 59% = 814
60 - 79% = 333
80 - 99% = 121

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: 67.87, total records: 811063
Average version length: 80.30, total versions: 127477, max versions: 1
Data pages: 12449, data page slots: 12642, average fill: 80%
Fill distribution:
0 - 19% = 138
20 - 39% = 200
40 - 59% = 202
60 - 79% = 4431
80 - 99% = 7478

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 762, nodes: 811063
Average data length: 0.05, total dup: 806539, max dup: 814
Fill distribution:
0 - 19% = 1
20 - 39% = 3
40 - 59% = 311
60 - 79% = 313
80 - 99% = 134

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 782, nodes: 811063
Average data length: 0.87, total dup: 699440, max dup: 14
Fill distribution:
0 - 19% = 23
20 - 39% = 20
40 - 59% = 290
60 - 79% = 1
80 - 99% = 448

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 872, nodes: 811063
Average data length: 0.68, total dup: 720745, max dup: 70
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 332
60 - 79% = 386
80 - 99% = 151

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 53.02, total records: 338955
Average version length: 68.34, total versions: 76204, max versions: 1
Data pages: 4564, data page slots: 4564, average fill: 81%
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 0
60 - 79% = 2805
80 - 99% = 1757

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 312, nodes: 338955
Average data length: 0.22, total dup: 328319, max dup: 290
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 120
60 - 79% = 120
80 - 99% = 72

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 359, nodes: 338955
Average data length: 0.82, total dup: 294961, max dup: 44
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 149
60 - 79% = 135
80 - 99% = 75

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 17430 ms, from 2:28:16.33 to 2:28:33.76.

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 482819 24546 5.0838
DOC_LIST 84163 9435 11.2103
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 90283 22570.7500
INVNT_TURNOVER_LOG 143048 143025 99.9839
MONEY_SALDO 49 4740 9673.4693
MONEY_TURNOVER_LOG 6533 6495 99.4183
OPTYPES 9 0 0.0000
PDISTR 127147 79607 62.6102
PERF_ESTIMATED 23375 2 0.0085
PERF_LOG 1350865 1 0.0000
PSTORNED 89093 7061 7.9254
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 992 24800.0000
SETTINGS 114 0 0.0000
TRACE_STAT 370 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 206082 204974 99.4623
XQD_1000_3300 290227 62058 21.3825
XQD_1200_2000 258480 258333 99.9431
XQD_2000_3300 1080647 798803 73.9189
XQD_2100_3300 144724 104367 72.1145
XQD_3300_3400 770213 349378 45.3612
XQS_1000_1200 1012914 30397 3.0009
XQS_1000_3300 644609 127226 19.7369
XQS_1200_2000 1077957 72170 6.6950
XQS_2100_3300 811063 127477 15.7172
XQS_3300_3400 338955 76204 22.4820
Z_USED_VIEWS 32 0 0.0000
Done for 2190 ms, from 2:28:43.35 to 2:28:45.54.

Database validation

02:28:45.75 Validation started

02:28:45.75 Relation 140 (DOC_LIST)
02:28:45.75 process pointer page 0 of 1
02:28:45.82 Index 1 (PK_DOC_LIST)
02:28:45.85 Index 2 (DOC_LIST_ID_DESC)
02:28:45.86 Index 3 (FK_DOC_LIST_AGENTS)
02:28:45.89 Relation 140 (DOC_LIST) is ok

02:28:45.89 Relation 141 (DOC_DATA)
02:28:45.89 process pointer page 0 of 3
02:28:45.96 process pointer page 1 of 3
02:28:46.00 process pointer page 2 of 3
02:28:46.02 Index 2 (DOC_DATA_DOC_WARE_UNQ)
02:28:46.10 Index 3 (DOC_DATA_ID_DESC)
02:28:46.21 Index 4 (FK_DOC_DATA_DOC_LIST)
02:28:46.33 Relation 141 (DOC_DATA) is ok

02:28:46.33 Relation 147 (INVNT_SALDO)
02:28:46.33 process pointer page 0 of 1
02:28:46.46 Index 1 (PK_INVNT_SALDO)
02:28:46.46 Relation 147 (INVNT_SALDO) is ok

02:28:46.46 Relation 150 (PDISTR)
02:28:46.46 process pointer page 0 of 1
02:28:46.52 Index 2 (PDISTR_SND_ID)
02:28:46.53 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
02:28:46.55 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
02:28:46.56 Index 5 (PDISTR_AGENT_ID)
02:28:46.58 Relation 150 (PDISTR) is ok

02:28:46.58 Relation 151 (PSTORNED)
02:28:46.58 process pointer page 0 of 1
02:28:46.60 Index 2 (PSTORNED_SND_ID)
02:28:46.61 Index 3 (PSTORNED_RCV_ID)
02:28:46.61 Relation 151 (PSTORNED) is ok

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

02:28:46.61 Relation 157 (INVNT_TURNOVER_LOG)
02:28:46.61 process pointer page 0 of 2
02:28:46.66 process pointer page 1 of 2
02:28:46.69 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
02:28:46.71 Relation 157 (INVNT_TURNOVER_LOG) is ok

02:28:46.71 Relation 160 (PERF_ESTIMATED)
02:28:46.71 process pointer page 0 of 1
02:28:46.72 Index 1 (PERF_EST_MINUTE_SINCE_START)
02:28:46.72 Relation 160 (PERF_ESTIMATED) is ok

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

02:28:46.72 Relation 162 (PERF_LOG)
02:28:46.72 process pointer page 0 of 17
02:28:46.74 process pointer page 1 of 17
02:28:46.77 process pointer page 2 of 17
02:28:46.80 process pointer page 3 of 17
02:28:46.81 process pointer page 4 of 17
02:28:46.85 process pointer page 5 of 17
02:28:46.92 process pointer page 6 of 17
02:28:47.00 process pointer page 7 of 17
02:28:47.06 process pointer page 8 of 17
02:28:47.14 process pointer page 9 of 17
02:28:47.22 process pointer page 10 of 17
02:28:47.28 process pointer page 11 of 17
02:28:47.34 process pointer page 12 of 17
02:28:47.38 process pointer page 13 of 17
02:28:47.39 process pointer page 14 of 17
02:28:47.42 process pointer page 15 of 17
02:28:47.45 process pointer page 16 of 17
02:28:47.45 Index 1 (PERF_LOG_DTS_BEG_DESC)
02:28:47.61 Index 2 (PERF_LOG_UNIT)
02:28:48.05 Index 3 (PERF_LOG_TRN_DESC)
02:28:48.42 Index 4 (PERF_LOG_GDSCODE)
02:28:48.67 Relation 162 (PERF_LOG) is ok

02:28:48.67 Relation 166 (V_STOPTEST)
02:28:48.67 Relation 166 (V_STOPTEST) is ok

02:28:48.67 Relation 183 (V_QDISTR_SOURCE)
02:28:48.67 Relation 183 (V_QDISTR_SOURCE) is ok

02:28:48.67 Relation 184 (V_QSTORNED_SOURCE)
02:28:48.67 Relation 184 (V_QSTORNED_SOURCE) is ok

02:28:48.67 Relation 258 (XQD_1000_1200)
02:28:48.67 process pointer page 0 of 2
02:28:48.78 process pointer page 1 of 2
02:28:48.86 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
02:28:48.92 Relation 258 (XQD_1000_1200) is ok

02:28:48.92 Relation 259 (XQD_1200_2000)
02:28:48.92 process pointer page 0 of 3
02:28:48.95 process pointer page 1 of 3
02:28:49.03 process pointer page 2 of 3
02:28:49.05 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
02:28:49.08 Relation 259 (XQD_1200_2000) is ok

02:28:49.08 Relation 260 (XQD_1000_3300)
02:28:49.08 process pointer page 0 of 3
02:28:49.12 process pointer page 1 of 3
02:28:49.15 process pointer page 2 of 3
02:28:49.15 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
02:28:49.19 Index 2 (XQD_1000_3300_DOC)
02:28:49.20 Relation 260 (XQD_1000_3300) is ok

02:28:49.20 Relation 261 (XQD_2000_3300)
02:28:49.20 process pointer page 0 of 8
02:28:49.25 process pointer page 1 of 8
02:28:49.29 process pointer page 2 of 8
02:28:49.34 process pointer page 3 of 8
02:28:49.39 process pointer page 4 of 8
02:28:49.44 process pointer page 5 of 8
02:28:49.47 process pointer page 6 of 8
02:28:49.50 process pointer page 7 of 8
02:28:49.51 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
02:28:49.61 Relation 261 (XQD_2000_3300) is ok

02:28:49.61 Relation 262 (XQD_2100_3300)
02:28:49.61 process pointer page 0 of 3
02:28:49.61 process pointer page 1 of 3
02:28:49.64 process pointer page 2 of 3
02:28:49.65 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
02:28:49.67 Relation 262 (XQD_2100_3300) is ok

02:28:49.67 Relation 263 (XQD_3300_3400)
02:28:49.67 process pointer page 0 of 6
02:28:49.72 process pointer page 1 of 6
02:28:49.83 process pointer page 2 of 6
02:28:49.87 process pointer page 3 of 6
02:28:50.00 process pointer page 4 of 6
02:28:50.06 process pointer page 5 of 6
02:28:50.09 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
02:28:50.25 Relation 263 (XQD_3300_3400) is ok

02:28:50.25 Relation 264 (XQS_1000_1200)
02:28:50.25 process pointer page 0 of 8
02:28:50.28 process pointer page 1 of 8
02:28:50.36 process pointer page 2 of 8
02:28:50.40 process pointer page 3 of 8
02:28:50.45 process pointer page 4 of 8
02:28:50.54 process pointer page 5 of 8
02:28:50.64 process pointer page 6 of 8
02:28:50.67 process pointer page 7 of 8
02:28:50.70 Index 1 (XQS_1000_1200_DOC_ID)
02:28:51.00 Index 2 (XQS_1000_1200_SND_ID)
02:28:51.26 Index 3 (XQS_1000_1200_RCV_ID)
02:28:51.35 Relation 264 (XQS_1000_1200) is ok

02:28:51.35 Relation 265 (XQS_1200_2000)
02:28:51.35 process pointer page 0 of 9
02:28:51.39 process pointer page 1 of 9
02:28:51.42 process pointer page 2 of 9
02:28:51.45 process pointer page 3 of 9
02:28:51.46 process pointer page 4 of 9
02:28:51.53 process pointer page 5 of 9
02:28:51.60 process pointer page 6 of 9
02:28:51.63 process pointer page 7 of 9
02:28:51.67 process pointer page 8 of 9
02:28:51.68 Index 1 (XQS_1200_2000_DOC_ID)
02:28:51.85 Index 2 (XQS_1200_2000_SND_ID)
02:28:51.96 Index 3 (XQS_1200_2000_RCV_ID)
02:28:52.12 Relation 265 (XQS_1200_2000) is ok

02:28:52.12 Relation 266 (XQS_1000_3300)
02:28:52.12 process pointer page 0 of 6
02:28:52.17 process pointer page 1 of 6
02:28:52.20 process pointer page 2 of 6
02:28:52.24 process pointer page 3 of 6
02:28:52.27 process pointer page 4 of 6
02:28:52.37 process pointer page 5 of 6
02:28:52.38 Index 1 (XQS_1000_3300_DOC_ID)
02:28:52.45 Index 2 (XQS_1000_3300_SND_ID)
02:28:52.56 Index 3 (XQS_1000_3300_RCV_ID)
02:28:52.70 Relation 266 (XQS_1000_3300) is ok

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

02:28:52.70 Relation 268 (XQS_2100_3300)
02:28:52.70 process pointer page 0 of 7
02:28:52.74 process pointer page 1 of 7
02:28:52.85 process pointer page 2 of 7
02:28:52.96 process pointer page 3 of 7
02:28:53.04 process pointer page 4 of 7
02:28:53.07 process pointer page 5 of 7
02:28:53.12 process pointer page 6 of 7
02:28:53.13 Index 1 (XQS_2100_3300_DOC_ID)
02:28:53.37 Index 2 (XQS_2100_3300_SND_ID)
02:28:53.65 Index 3 (XQS_2100_3300_RCV_ID)
02:28:53.80 Relation 268 (XQS_2100_3300) is ok

02:28:53.80 Relation 269 (XQS_3300_3400)
02:28:53.80 process pointer page 0 of 3
02:28:53.85 process pointer page 1 of 3
02:28:53.90 process pointer page 2 of 3
02:28:53.91 Index 1 (XQS_3300_3400_DOC_ID)
02:28:53.94 Index 2 (XQS_3300_3400_SND_ID)
02:28:53.96 Relation 269 (XQS_3300_3400) is ok

02:28:53.96 Relation 276 (TRACE_STAT)
02:28:53.96 process pointer page 0 of 1
02:28:53.96 Relation 276 (TRACE_STAT) is ok

02:28:53.96 Validation finished
Done for 8400 ms, from 2:28:45.57 to 2:28:53.97.

Differences between old and current firebird.log

2:28:54.54. 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-09-15 02:28 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-09-15 2:28:56.99 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html