Logs 2.5

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-09-05 2:26:38.60.
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-05 02:26:07.4510 -1 <null> 127.0.0.1 94353 4246 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: 592.04 101761 106568 2016-09-04 23:26 2016-09-05 02:26
customer order: creation 33.55 309 6006 2016-09-04 23:26 2016-09-05 02:26
customer order: refuse 2.67 55 476 2016-09-04 23:26 2016-09-05 02:26
order to supplier: creation 8.76 6757 1560 2016-09-04 23:26 2016-09-05 02:26
order to supplier: removal 0.15 88781 27 2016-09-04 23:26 2016-09-05 02:26
invoice (draft): creation 8.28 3611 1482 2016-09-04 23:26 2016-09-05 02:26
invoice (draft): removal 1.33 297 237 2016-09-04 23:26 2016-09-05 02:26
invoice accept: apply 2.62 1697785 472 2016-09-04 23:26 2016-09-05 02:26
invoice accept: cancel 0.49 103101 88 2016-09-04 23:26 2016-09-05 02:26
customer reserve: creation 476.17 9643 85711 2016-09-04 23:26 2016-09-05 02:26
customer reserve: removal 14.10 6161 2510 2016-09-04 23:26 2016-09-05 02:26
realization accept: apply 14.82 89 2653 2016-09-04 23:26 2016-09-05 02:26
realization accept: cancel 4.03 73 718 2016-09-04 23:26 2016-09-05 02:26
payment from customer: creation 11.13 188 1992 2016-09-04 23:26 2016-09-05 02:26
payment from customer: removal 1.13 25 198 2016-09-04 23:26 2016-09-05 02:26
payment to supplier: creation 9.08 354 1626 2016-09-04 23:26 2016-09-05 02:26
payment to supplier: removal 0.66 29 117 2016-09-04 23:26 2016-09-05 02:26
service: total inventory turnovers 1.78 13736 318 2016-09-04 23:26 2016-09-05 02:26
service: total monetary turnovers 2.06 22 366 2016-09-04 23:26 2016-09-05 02:26
service: refresh index statistics 0.07 2439 11 2016-09-04 23:26 2016-09-05 02:26
Done for 5870 ms, from 2:26:54.34 to 2:27:00.21.

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 567 10803 10205 598 5.54 23:26:08 23:44:06
interval # 2, overall 2 455 8438 8189 249 2.95 23:44:07 00:02:05
interval # 3, overall 3 490 9069 8827 242 2.67 00:02:06 00:20:04
interval # 4, overall 4 708 13144 12738 406 3.09 00:20:05 00:38:03
interval # 5, overall 5 755 14109 13583 526 3.73 00:38:04 00:56:02
interval # 6, overall 6 643 11847 11578 269 2.27 00:56:03 01:14:01
interval # 7, overall 7 872 17065 15687 1378 8.08 01:14:02 01:32:00
interval # 8, overall 8 789 14644 13421 1223 8.35 01:32:01 01:49:59
interval # 9, overall 9 522 9072 8870 202 2.23 01:50:00 02:07:58
interval # 10, overall 10 193 3592 3470 122 3.40 02:07:59 02:25:57
Done for 8220 ms, from 2:27:05.79 to 2:27:14.01.

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 1835.70 0.6940 1.4403 971 95
WARM_TIME 2 1550.33 0.8527 1.1136 517 78
WARM_TIME 3 1264.37 0.9105 1.0880 503 64
WARM_TIME 4 1081.90 0.9538 1.0486 397 59
WARM_TIME 5 976.50 0.9296 1.0842 523 66
WARM_TIME 6 919.84 0.9594 1.0699 389 63
WARM_TIME 7 871.19 0.9684 1.0322 411 51
WARM_TIME 8 818.27 0.9617 1.0373 520 59
WARM_TIME 9 786.18 0.9599 1.0369 510 56
WARM_TIME 10 767.64 0.9559 1.0487 572 52
TEST_TIME 11 758.23 0.9654 1.0344 621 45
TEST_TIME 12 753.68 0.9540 1.0452 851 35
TEST_TIME 13 753.47 0.9651 1.0352 765 24
TEST_TIME 14 742.75 0.9752 1.0259 551 13
TEST_TIME 15 722.61 0.9842 1.0229 263 11
TEST_TIME 16 703.69 0.9848 1.0134 86 6
TEST_TIME 17 684.45 0.9883 1.0127 188 7
TEST_TIME 18 662.93 0.9887 1.0067 98 4
TEST_TIME 19 636.03 0.9941 1.0038 87 4
TEST_TIME 20 615.21 0.9950 1.0078 81 5
TEST_TIME 21 598.98 0.9859 1.0073 161 8
TEST_TIME 22 579.47 0.9940 1.0059 170 3
TEST_TIME 23 560.60 0.9946 1.0110 94 3
TEST_TIME 24 549.97 0.9901 1.0101 45 4
TEST_TIME 25 535.67 0.9956 1.0087 117 5
TEST_TIME 26 523.40 0.9965 1.0034 102 3
TEST_TIME 27 506.43 0.9987 1.0011 36 3
TEST_TIME 28 499.79 0.9881 1.0029 69 5
TEST_TIME 29 487.31 0.9932 1.0064 98 4
TEST_TIME 30 477.98 0.9919 1.0060 48 4
TEST_TIME 31 467.95 0.9945 1.0050 83 3
TEST_TIME 32 463.56 0.9885 1.0185 97 4
TEST_TIME 33 463.13 0.9887 1.0171 106 7
TEST_TIME 34 463.74 0.9860 1.0084 178 6
TEST_TIME 35 460.25 0.9939 1.0141 154 5
TEST_TIME 36 454.84 0.9977 1.0023 82 3
TEST_TIME 37 447.39 0.9915 1.0044 26 4
TEST_TIME 38 440.33 0.9938 1.0079 65 4
TEST_TIME 39 436.90 0.9898 1.0128 135 4
TEST_TIME 40 437.49 0.9862 1.0129 113 6
TEST_TIME 41 438.36 0.9863 1.0057 119 5
TEST_TIME 42 439.56 0.9851 1.0034 72 3
TEST_TIME 43 434.00 0.9927 1.0023 72 4
TEST_TIME 44 429.19 0.9906 1.0091 119 6
TEST_TIME 45 428.42 0.9885 1.0037 43 4
TEST_TIME 46 422.32 0.9961 1.0058 83 5
TEST_TIME 47 416.00 0.9994 1.0005 28 3
TEST_TIME 48 414.27 0.9838 1.0200 210 7
TEST_TIME 49 415.41 0.9964 1.0030 84 4
TEST_TIME 50 411.57 0.9995 1.0004 19 1
TEST_TIME 51 404.67 0.9980 1.0021 58 2
TEST_TIME 52 404.04 0.9844 1.0190 39 7
TEST_TIME 53 411.47 0.9817 1.0130 131 7
TEST_TIME 54 411.11 0.9952 1.0115 84 5
TEST_TIME 55 409.16 0.9985 1.0014 57 4
TEST_TIME 56 404.79 0.9942 1.0030 104 3
TEST_TIME 57 402.56 0.9993 1.0003 16 1
TEST_TIME 58 400.94 0.9879 1.0059 78 5
TEST_TIME 59 401.68 0.9871 1.0120 139 5
TEST_TIME 60 405.58 0.9952 1.0052 153 4
TEST_TIME 61 409.72 0.9860 1.0182 259 9
TEST_TIME 62 413.68 0.9922 1.0068 154 6
TEST_TIME 63 410.99 0.9974 1.0024 92 4
TEST_TIME 64 409.79 0.9896 1.0096 87 7
TEST_TIME 65 414.41 0.9830 1.0153 107 8
TEST_TIME 66 426.71 0.9711 1.0104 311 11
TEST_TIME 67 425.33 0.9986 1.0008 23 2
TEST_TIME 68 420.59 0.9972 1.0039 20 2
TEST_TIME 69 419.04 0.9931 1.0083 19 4
TEST_TIME 70 422.08 0.9887 1.0055 66 4
TEST_TIME 71 418.46 0.9999 1.0000 3 1
TEST_TIME 72 417.75 0.9974 1.0007 34 2
TEST_TIME 73 415.15 0.9932 1.0051 62 4
TEST_TIME 74 416.10 0.9900 1.0022 67 4
TEST_TIME 75 413.70 0.9946 1.0039 162 5
TEST_TIME 76 416.90 0.9831 1.0110 80 5
TEST_TIME 77 419.41 0.9919 1.0016 42 3
TEST_TIME 78 416.59 0.9964 1.0019 104 4
TEST_TIME 79 416.43 0.9897 1.0112 118 5
TEST_TIME 80 419.29 0.9917 1.0054 125 6
TEST_TIME 81 421.06 0.9888 1.0084 193 6
TEST_TIME 82 424.33 0.9884 1.0099 102 7
TEST_TIME 83 424.64 0.9970 1.0017 50 7
TEST_TIME 84 424.23 0.9908 1.0051 149 8
TEST_TIME 85 433.20 0.9749 1.0102 200 10
TEST_TIME 86 436.60 0.9907 1.0068 222 7
TEST_TIME 87 443.14 0.9806 1.0150 272 10
TEST_TIME 88 451.33 0.9853 1.0142 253 13
TEST_TIME 89 458.00 0.9882 1.0091 95 6
TEST_TIME 91 459.09 0.9876 1.0040 20 4
TEST_TIME 92 462.64 0.9855 1.0041 89 5
TEST_TIME 93 460.37 0.9983 1.0076 66 6
TEST_TIME 94 460.81 0.9959 1.0050 61 6
TEST_TIME 95 458.84 0.9988 1.0011 118 5
TEST_TIME 96 458.61 0.9912 1.0103 176 6
TEST_TIME 97 459.67 0.9976 1.0026 152 6
TEST_TIME 98 459.83 0.9921 1.0035 197 8
TEST_TIME 99 462.81 0.9870 1.0163 134 9
TEST_TIME 100 468.73 0.9934 1.0038 79 8
TEST_TIME 101 466.83 0.9979 1.0023 100 8
TEST_TIME 102 466.91 0.9923 1.0061 101 7
TEST_TIME 103 467.11 0.9959 1.0084 66 6
TEST_TIME 104 467.61 0.9976 1.0072 90 6
TEST_TIME 105 466.85 0.9992 1.0023 47 3
TEST_TIME 106 464.86 0.9971 1.0122 36 4
TEST_TIME 107 468.47 0.9951 1.0082 78 4
TEST_TIME 108 471.36 0.9928 1.0043 172 5
TEST_TIME 109 473.94 0.9897 1.0085 88 6
TEST_TIME 110 478.58 0.9896 1.0132 28 6
TEST_TIME 111 484.47 0.9918 1.0062 127 7
TEST_TIME 112 485.74 0.9946 1.0060 105 7
TEST_TIME 113 487.69 0.9932 1.0010 87 4
TEST_TIME 114 488.85 0.9899 1.0045 39 4
TEST_TIME 115 487.68 0.9981 1.0051 33 4
TEST_TIME 116 490.44 0.9977 1.0060 19 4
TEST_TIME 117 489.22 0.9999 1.0000 6 1
TEST_TIME 118 485.97 0.9987 1.0004 9 3
TEST_TIME 119 486.48 0.9909 1.0056 88 4
TEST_TIME 120 488.49 0.9931 1.0013 73 5
TEST_TIME 121 487.86 0.9944 1.0097 90 8
TEST_TIME 122 494.63 0.9891 1.0038 107 7
TEST_TIME 123 501.40 0.9875 1.0039 120 6
TEST_TIME 124 502.43 0.9938 1.0056 71 6
TEST_TIME 125 507.19 0.9965 1.0023 166 4
TEST_TIME 126 507.97 0.9937 1.0056 119 9
TEST_TIME 127 514.13 0.9858 1.0088 163 11
TEST_TIME 128 518.09 0.9933 1.0074 123 9
TEST_TIME 129 521.75 0.9926 1.0021 114 6
TEST_TIME 130 524.11 0.9899 1.0053 206 8
TEST_TIME 131 529.43 0.9941 1.0033 218 8
TEST_TIME 132 531.41 0.9996 1.0003 50 4
TEST_TIME 133 527.90 0.9993 1.0019 13 2
TEST_TIME 134 534.05 0.9829 1.0050 230 7
TEST_TIME 135 539.96 0.9867 1.0089 142 11
TEST_TIME 136 545.93 0.9905 1.0097 82 11
TEST_TIME 137 552.45 0.9905 1.0026 165 9
TEST_TIME 138 553.59 0.9933 1.0054 167 14
TEST_TIME 139 558.33 0.9897 1.0140 227 14
TEST_TIME 140 563.43 0.9976 1.0048 87 8
TEST_TIME 141 563.09 0.9983 1.0006 44 2
TEST_TIME 142 569.96 0.9867 1.0067 121 8
TEST_TIME 143 574.57 0.9917 1.0043 108 10
TEST_TIME 144 576.77 0.9936 1.0029 142 8
TEST_TIME 145 576.88 0.9959 1.0088 78 10
TEST_TIME 146 579.95 0.9966 1.0075 49 6
TEST_TIME 147 586.43 0.9896 1.0058 117 8
TEST_TIME 148 586.76 0.9984 1.0011 57 4
TEST_TIME 149 583.67 1.0000 1.0000 1 1
TEST_TIME 150 582.46 0.9953 1.0070 66 6
TEST_TIME 151 583.13 0.9991 1.0014 104 7
TEST_TIME 152 580.58 0.9991 1.0039 76 6
TEST_TIME 153 579.63 0.9989 1.0015 14 2
TEST_TIME 154 581.73 0.9914 1.0064 99 8
TEST_TIME 155 585.06 0.9943 1.0038 63 6
TEST_TIME 156 592.13 0.9854 1.0030 70 5
TEST_TIME 157 595.06 0.9943 1.0064 77 6
TEST_TIME 158 605.30 0.9832 1.0111 165 10
TEST_TIME 159 610.44 0.9962 1.0033 132 9
TEST_TIME 160 611.91 0.9947 1.0090 102 6
TEST_TIME 161 616.69 0.9988 1.0008 28 3
TEST_TIME 162 614.68 0.9979 1.0068 90 5
TEST_TIME 163 617.29 0.9964 1.0015 25 4
TEST_TIME 164 617.17 0.9956 1.0078 47 7
TEST_TIME 165 620.11 0.9970 1.0080 155 8
TEST_TIME 166 622.68 0.9978 1.0024 93 6
TEST_TIME 167 623.39 0.9952 1.0031 117 7
TEST_TIME 168 623.77 0.9965 1.0070 34 6
TEST_TIME 169 625.72 0.9979 1.0010 24 4
TEST_TIME 170 626.78 0.9934 1.0028 136 5
TEST_TIME 171 626.29 1.0000 1.0000 1 1
TEST_TIME 173 620.23 0.9985 1.0009 49 3
TEST_TIME 174 620.47 0.9947 1.0059 112 7
TEST_TIME 175 622.07 0.9976 1.0014 144 7
TEST_TIME 176 620.50 0.9982 1.0023 33 2
TEST_TIME 177 618.47 0.9999 1.0000 12 1
TEST_TIME 178 616.61 0.9975 1.0007 77 4
TEST_TIME 179 614.00 0.9994 1.0012 141 4
TEST_TIME 183 602.95 0.9982 1.0027 23 2
TEST_TIME 184 604.14 0.9966 1.0011 21 3
TEST_TIME 185 602.10 0.9999 1.0000 17 1
TEST_TIME 186 604.04 0.9915 1.0069 199 9
TEST_TIME 187 608.15 0.9947 1.0040 96 8
TEST_TIME 188 608.65 0.9979 1.0056 82 7
TEST_TIME 189 610.19 0.9989 1.0015 17 3
TEST_TIME 190 608.69 0.9987 1.0014 100 100
Done for 8590 ms, from 2:27:14.34 to 2:27:22.93.

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 35939 49095 36240 <null> 57791 <null> 1910 <null> <null> <null> 45879 62352 76717 48600 215993 <null> 67901 744504 <null> 23:26:08 23:44:06
fetches per second 2 36118 <null> 19917 <null> <null> <null> 1466 <null> <null> <null> 40857 <null> 59742 <null> 217005 <null> 60096 <null> <null> 23:44:07 00:02:05
fetches per second 5 32431 <null> <null> <null> <null> <null> 1935 <null> <null> <null> 21969 <null> <null> 57842 172976 <null> <null> 717000 <null> 00:38:04 00:56:02
fetches per second 9 31274 85835 17550 <null> 23123 <null> 1616 <null> 1307 <null> 85908 53628 241393 40769 322947 <null> 26561 1558135 <null> 01:50:00 02:07:58
marks per second 1 6635 3890 2896 <null> 4398 <null> 270 <null> <null> <null> 5737 7382 2685 5150 2798 <null> 538 1615 <null> 23:26:08 23:44:06
marks per second 2 6454 <null> 1282 <null> <null> <null> 162 <null> <null> <null> 4160 <null> 1470 <null> 2808 <null> 353 <null> <null> 23:44:07 00:02:05
marks per second 5 5228 <null> <null> <null> <null> <null> 119 <null> <null> <null> 3841 <null> <null> 5368 1125 <null> <null> 1515 <null> 00:38:04 00:56:02
marks per second 9 5389 7925 682 <null> 1172 <null> 55 <null> 89 <null> 6661 7447 1604 5076 3556 <null> 135 5195 <null> 01:50:00 02:07:58
reads/fetches*100 1 5 5 9 <null> 5 <null> 14 <null> <null> <null> 8 6 7 4 3 <null> 22 0 <null> 23:26:08 23:44:06
reads/fetches*100 2 8 <null> 9 <null> <null> <null> 15 <null> <null> <null> 8 <null> 6 <null> 3 <null> 26 <null> <null> 23:44:07 00:02:05
reads/fetches*100 5 4 <null> <null> <null> <null> <null> 12 <null> <null> <null> 7 <null> <null> 3 3 <null> <null> 0 <null> 00:38:04 00:56:02
reads/fetches*100 9 5 4 8 <null> 6 <null> 13 <null> 19 <null> 6 5 4 4 3 <null> 33 0 <null> 01:50:00 02:07:58
writes/marks*100 1 12 16 7 <null> 7 <null> 1 <null> <null> <null> 7 9 6 0 4 <null> 37 0 <null> 23:26:08 23:44:06
writes/marks*100 2 13 <null> 6 <null> <null> <null> 1 <null> <null> <null> 8 <null> 8 <null> 3 <null> 45 <null> <null> 23:44:07 00:02:05
writes/marks*100 5 13 <null> <null> <null> <null> <null> 1 <null> <null> <null> 7 <null> <null> 0 5 <null> <null> 0 <null> 00:38:04 00:56:02
writes/marks*100 9 11 12 8 <null> 7 <null> 2 <null> 7 <null> 9 8 14 2 4 <null> 57 2 <null> 01:50:00 02:07:58
Done for 6190 ms, from 2:27:23.17 to 2:27:29.36.

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 71325 67360 3965 5.55 0 8752 28 3965 2016-09-04 23:26 2016-09-05 02:26
doc_list_biud 71396 67355 4041 5.65 0 785212 709 4041 2016-09-04 23:26 2016-09-05 02:26
sp_add_invoice_to_stock 1344 472 872 64.88 12339 7477031 1697785 872 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_adding_invoice 157 88 69 43.94 0 2953086 103101 69 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_client_order 519 476 43 8.28 0 1466 55 43 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_customer_reserve 5231 2510 2721 52.01 0 141508 6161 2721 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_pay_from_customer 199 198 1 0.50 0 250 25 1 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_pay_to_supplier 119 117 2 1.68 0 125 29 2 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_supplier_invoice 310 237 73 23.54 0 4789 297 73 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_supplier_order 114 27 87 76.31 328 633439 88781 87 2016-09-04 23:26 2016-09-05 02:26
sp_cancel_write_off 1957 718 1239 63.31 0 2574 73 1239 2016-09-04 23:26 2016-09-05 02:26
sp_client_order 6006 6006 0 0.00 0 28704 309 0 2016-09-04 23:26 2016-09-05 02:26
sp_customer_reserve 85711 85711 0 0.00 62 59467 9643 0 2016-09-04 23:26 2016-09-05 02:26
sp_fill_shopping_cart 9048 9048 0 0.00 0 136578 1129 0 2016-09-04 23:26 2016-09-05 02:26
sp_fill_shopping_cart_clo_res 85711 85711 0 0.00 0 1623 5 0 2016-09-04 23:26 2016-09-05 02:26
sp_get_clo_for_invoice 474 474 0 0.00 0 748 111 0 2016-09-04 23:26 2016-09-05 02:26
sp_kill_cost_storno 2366 1123 1243 52.53 0 2480 10 1243 2016-09-04 23:26 2016-09-05 02:26
sp_kill_qstorno_ret_qs2qd 12654 6003 6651 52.56 0 141461 2588 6651 2016-09-04 23:26 2016-09-05 02:26
sp_kill_qty_storno 11206 7184 4022 35.89 0 785212 6638 4022 2016-09-04 23:26 2016-09-05 02:26
sp_lock_selected_doc 5765 4524 1241 21.52 0 63 0 1241 2016-09-04 23:26 2016-09-05 02:26
sp_make_cost_storno 6745 6745 0 0.00 0 5928 123 0 2016-09-04 23:26 2016-09-05 02:26
sp_multiply_rows_for_pdistr 6745 6745 0 0.00 0 3105 15 0 2016-09-04 23:26 2016-09-05 02:26
sp_multiply_rows_for_qdistr 6006 6006 0 0.00 0 28641 248 0 2016-09-04 23:26 2016-09-05 02:26
sp_pay_from_customer 1992 1992 0 0.00 31 5913 188 0 2016-09-04 23:26 2016-09-05 02:26
sp_pay_to_supplier 1626 1626 0 0.00 47 6256 354 0 2016-09-04 23:26 2016-09-05 02:26
sp_payment_common 3618 3618 0 0.00 0 3962 41 0 2016-09-04 23:26 2016-09-05 02:26
sp_qd_handle_on_cancel_clo 519 476 43 8.28 0 421 26 43 2016-09-04 23:26 2016-09-05 02:26
sp_qd_handle_on_invoice_upd_sts 600 562 38 6.33 0 785212 56979 38 2016-09-04 23:26 2016-09-05 02:26
sp_qd_handle_on_reserve_upd_sts 2653 2653 0 0.00 0 1185 24 0 2016-09-04 23:26 2016-09-05 02:26
sp_reserve_write_off 2761 2653 108 3.91 0 3760 89 108 2016-09-04 23:26 2016-09-05 02:26
sp_supplier_invoice 1482 1482 0 0.00 16 87984 3611 0 2016-09-04 23:26 2016-09-05 02:26
sp_supplier_order 1560 1560 0 0.00 32 139012 6757 0 2016-09-04 23:26 2016-09-05 02:26
srv_find_qd_qs_mism 39303 35338 3965 10.08 0 8674 26 3965 2016-09-04 23:26 2016-09-05 02:26
srv_make_invnt_saldo 318 318 0 0.00 2418 68921 13736 0 2016-09-04 23:26 2016-09-05 02:26
srv_make_money_saldo 366 366 0 0.00 0 203 22 0 2016-09-04 23:26 2016-09-05 02:26
srv_recalc_idx_stat 11 11 0 0.00 1389 4212 2439 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_add_invoice_to_stock 872 872 0 0.00 0 390 11 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_adding_invoice 129 129 0 0.00 0 593 68 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_client_order 43 43 0 0.00 0 94 12 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_customer_reserve 6 6 0 0.00 0 62 15 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_pay_from_customer 1 1 0 0.00 0 0 0 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_pay_to_supplier 2 2 0 0.00 0 16 8 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_supplier_invoice 63 63 0 0.00 0 62 9 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_supplier_order 459 459 0 0.00 0 592 121 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_cancel_write_off 7 7 0 0.00 0 47 9 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-abend:sp_reserve_write_off 108 108 0 0.00 0 124 12 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_add_invoice_to_stock 511 511 0 0.00 0 10000 918 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_adding_invoice 59 59 0 0.00 15 2496 295 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_client_order 476 476 0 0.00 0 561 20 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_customer_reserve 181 181 0 0.00 0 140 23 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_pay_from_customer 198 198 0 0.00 0 140 12 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_pay_to_supplier 117 117 0 0.00 0 109 13 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_supplier_invoice 52 52 0 0.00 0 406 31 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_supplier_order 28 28 0 0.00 15 5085 446 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_cancel_write_off 291 291 0 0.00 0 187 17 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_client_order 6021 6021 0 0.00 0 452 22 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_customer_reserve 307 307 0 0.00 0 203 20 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_pay_from_customer 1992 1992 0 0.00 0 281 16 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_pay_to_supplier 1627 1627 0 0.00 0 141 15 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_reserve_write_off 2655 2655 0 0.00 0 343 20 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_supplier_invoice 1482 1482 0 0.00 0 249 22 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:sp_supplier_order 1594 1594 0 0.00 0 359 26 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:srv_make_invnt_saldo 318 318 0 0.00 0 171 5 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:srv_make_money_saldo 366 366 0 0.00 0 47 5 0 2016-09-04 23:26 2016-09-05 02:26
t$perf-norm:srv_recalc_idx_stat 11 11 0 0.00 15 124 49 0 2016-09-04 23:26 2016-09-05 02:26
v_add_invoice_to_stock 2688 944 1744 64.88 0 31 1 1744 2016-09-04 23:26 2016-09-05 02:26
v_all_customers 9074 9074 0 0.00 0 16 0 0 2016-09-04 23:26 2016-09-05 02:26
v_all_suppliers 6084 6084 0 0.00 0 16 1 0 2016-09-04 23:26 2016-09-05 02:26
v_all_wares 12012 12012 0 0.00 0 16 0 0 2016-09-04 23:26 2016-09-05 02:26
v_cancel_adding_invoice 218 114 104 47.70 0 62 10 104 2016-09-04 23:26 2016-09-05 02:26
v_cancel_client_order 1038 952 86 8.28 0 1341 2 86 2016-09-04 23:26 2016-09-05 02:26
v_cancel_customer_prepayment 398 396 2 0.50 0 16 1 2 2016-09-04 23:26 2016-09-05 02:26
v_cancel_customer_reserve 374 362 12 3.20 0 16 2 12 2016-09-04 23:26 2016-09-05 02:26
v_cancel_payment_to_supplier 238 234 4 1.68 0 16 1 4 2016-09-04 23:26 2016-09-05 02:26
v_cancel_supplier_invoice 230 104 126 54.78 0 16 2 126 2016-09-04 23:26 2016-09-05 02:26
v_cancel_supplier_order 228 54 174 76.31 0 16 2 174 2016-09-04 23:26 2016-09-05 02:26
v_cancel_write_off 596 582 14 2.34 0 32 3 14 2016-09-04 23:26 2016-09-05 02:26
v_max_id_clo_ord 1561 1561 0 0.00 0 7737 41 0 2016-09-04 23:26 2016-09-05 02:26
v_max_id_clo_res 307 307 0 0.00 0 32 4 0 2016-09-04 23:26 2016-09-05 02:26
v_max_id_ord_sup 1482 1482 0 0.00 0 296 17 0 2016-09-04 23:26 2016-09-05 02:26
v_max_non_paid_invoice 1626 1626 0 0.00 0 499 4 0 2016-09-04 23:26 2016-09-05 02:26
v_max_non_paid_realizn 1992 1992 0 0.00 0 63 6 0 2016-09-04 23:26 2016-09-05 02:26
v_min_id_clo_ord 1560 1560 0 0.00 0 9562 130 0 2016-09-04 23:26 2016-09-05 02:26
v_min_id_clo_res 307 307 0 0.00 0 32 3 0 2016-09-04 23:26 2016-09-05 02:26
v_min_id_ord_sup 1482 1482 0 0.00 0 3151 73 0 2016-09-04 23:26 2016-09-05 02:26
v_min_non_paid_invoice 1626 1626 0 0.00 0 3604 42 0 2016-09-04 23:26 2016-09-05 02:26
v_min_non_paid_realizn 1992 1992 0 0.00 0 967 18 0 2016-09-04 23:26 2016-09-05 02:26
v_our_firm 2938 2938 0 0.00 0 16 0 0 2016-09-04 23:26 2016-09-05 02:26
v_reserve_write_off 5522 5306 216 3.91 0 2589 2 216 2016-09-04 23:26 2016-09-05 02:26
x_lock_depdocs_on_canc_invoice 472 270 202 42.79 0 109 5 202 2016-09-04 23:26 2016-09-05 02:26
x_lock_depdocs_on_canc_sup_ord 113 27 86 76.10 0 16 5 86 2016-09-04 23:26 2016-09-05 02:26
x_make_qstorno_1000_1200 1568 1568 0 0.00 15 64459 2940 0 2016-09-04 23:26 2016-09-05 02:26
x_make_qstorno_1200_2000 1482 1482 0 0.00 0 28112 1011 0 2016-09-04 23:26 2016-09-05 02:26
x_make_qstorno_2100_3300 85711 85711 0 0.00 62 59467 9624 0 2016-09-04 23:26 2016-09-05 02:26
Done for 18760 ms, from 2:27:37.68 to 2:27:56.44.

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-04 23:29 2016-09-05 01:55
deadlock 6 sp_qd_handle_on_invoice_upd_sts 335544336 2016-09-04 23:52 2016-09-05 01:22
lock_conflict 3 sp_kill_cost_storno 335544345 2016-09-04 23:27 2016-09-05 01:26
lock_conflict 1058 sp_lock_selected_doc 335544345 2016-09-04 23:26 2016-09-05 02:24
lock_conflict 43 sp_qd_handle_on_cancel_clo 335544345 2016-09-04 23:26 2016-09-05 02:14
lock_conflict 22 sp_qd_handle_on_invoice_upd_sts 335544345 2016-09-04 23:27 2016-09-05 02:11
lock_conflict 77 x_lock_depdocs_on_canc_invoice 335544345 2016-09-04 23:26 2016-09-05 02:11
lock_conflict 28 x_lock_depdocs_on_canc_sup_ord 335544345 2016-09-04 23:28 2016-09-05 02:22
Done for 2120 ms, from 2:27:56.94 to 2:27:59.06.

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 94984
MON$OLDEST_ACTIVE 94985
MON$OLDEST_SNAPSHOT 94985
MON$NEXT_TRANSACTION 94985
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 184643
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 99478
Page size 8192
ODS version 11.2
Oldest transaction 94986
Oldest active 94987
Oldest snapshot 94987
Next transaction 94988
Bumped transaction 1
Sequence number 0
Next attachment ID 4450
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.36, total records: 492591
Average version length: 46.32, total versions: 19820, max versions: 1
Data pages: 5255, data page slots: 5255, average fill: 73%
Fill distribution:
0 - 19% = 9
20 - 39% = 19
40 - 59% = 52
60 - 79% = 5068
80 - 99% = 107

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1657, nodes: 492591
Average data length: 11.87, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 165
20 - 39% = 34
40 - 59% = 716
60 - 79% = 91
80 - 99% = 651

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

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 499, nodes: 492591
Average data length: 0.94, total dup: 419197, max dup: 49
Fill distribution:
0 - 19% = 8
20 - 39% = 22
40 - 59% = 223
60 - 79% = 17
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.04, total records: 87593
Average version length: 47.03, total versions: 9675, max versions: 7
Data pages: 1114, data page slots: 1114, average fill: 79%
Fill distribution:
0 - 19% = 11
20 - 39% = 25
40 - 59% = 41
60 - 79% = 335
80 - 99% = 702

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 74, nodes: 87593
Average data length: 0.01, total dup: 87543, max dup: 18892
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 42
60 - 79% = 28
80 - 99% = 3

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 185, nodes: 87593
Average data length: 6.25, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 5
20 - 39% = 12
40 - 59% = 97
60 - 79% = 0
80 - 99% = 71

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: 63.77, total records: 400
Average version length: 14.27, total versions: 89956, max versions: 257
Data pages: 364, data page slots: 364, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 363

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.14, total records: 155081
Average version length: 68.85, total versions: 154799, max versions: 1
Data pages: 2886, data page slots: 2887, average fill: 70%
Fill distribution:
0 - 19% = 265
20 - 39% = 572
40 - 59% = 142
60 - 79% = 164
80 - 99% = 1743

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 461, nodes: 155081
Average data length: 8.22, total dup: 18298, max dup: 4
Fill distribution:
0 - 19% = 0
20 - 39% = 75
40 - 59% = 121
60 - 79% = 262
80 - 99% = 3

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 14.82, total records: 49
Average version length: 9.00, total versions: 4813, max versions: 424
Data pages: 18, data page slots: 18, average fill: 86%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
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.29, total records: 6841
Average version length: 44.21, total versions: 6799, max versions: 1
Data pages: 91, data page slots: 92, average fill: 74%
Fill distribution:
0 - 19% = 19
20 - 39% = 2
40 - 59% = 2
60 - 79% = 1
80 - 99% = 67

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 6, nodes: 6841
Average data length: 0.14, total dup: 6748, max dup: 1510
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 2
60 - 79% = 3
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: 25.98, total records: 136178
Average version length: 34.02, total versions: 78097, max versions: 11
Data pages: 1649, data page slots: 1650, average fill: 75%
Fill distribution:
0 - 19% = 29
20 - 39% = 150
40 - 59% = 138
60 - 79% = 523
80 - 99% = 809

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 131, nodes: 136178
Average data length: 0.01, total dup: 136129, max dup: 28387
Fill distribution:
0 - 19% = 2
20 - 39% = 9
40 - 59% = 83
60 - 79% = 21
80 - 99% = 16

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 148, nodes: 136178
Average data length: 0.89, total dup: 122566, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 81
60 - 79% = 41
80 - 99% = 23

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 159, nodes: 136178
Average data length: 0.90, total dup: 122566, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 4
40 - 59% = 103
60 - 79% = 34
80 - 99% = 18

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 143, nodes: 136178
Average data length: 0.67, total dup: 122566, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 8
40 - 59% = 66
60 - 79% = 56
80 - 99% = 13

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 17, nodes: 25680
Average data length: 0.01, total dup: 25494, max dup: 970
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
60 - 79% = 8
80 - 99% = 6

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

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1731, nodes: 1408146
Average data length: 0.62, total dup: 790819, max dup: 34
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1241
60 - 79% = 329
80 - 99% = 161

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1726, nodes: 1408146
Average data length: 0.35, total dup: 1331596, max dup: 3680
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1467
60 - 79% = 143
80 - 99% = 116

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1556, nodes: 1408146
Average data length: 0.23, total dup: 1379791, max dup: 150639
Fill distribution:
0 - 19% = 11
20 - 39% = 0
40 - 59% = 1127
60 - 79% = 211
80 - 99% = 207

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.74, total records: 86870
Average version length: 54.78, total versions: 6363, max versions: 1
Data pages: 1012, data page slots: 1012, average fill: 77%
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 2
60 - 79% = 938
80 - 99% = 70

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 111, nodes: 86870
Average data length: 1.19, total dup: 71356, max dup: 144
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 105
60 - 79% = 2
80 - 99% = 2

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 78, nodes: 86870
Average data length: 0.60, total dup: 79342, max dup: 95
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 37
60 - 79% = 30
80 - 99% = 11

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

TRACE_STAT (276)
Primary pointer page: 513, Index root page: 95177
Average record length: 59.37, total records: 369
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.79, total records: 224107
Average version length: 70.02, total versions: 221594, max versions: 1
Data pages: 3005, data page slots: 4151, average fill: 95%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 14
80 - 99% = 2990

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 366, nodes: 224107
Average data length: 1.24, total dup: 196124, max dup: 29
Fill distribution:
0 - 19% = 13
20 - 39% = 69
40 - 59% = 235
60 - 79% = 34
80 - 99% = 15

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 53.65, total records: 275178
Average version length: 69.26, total versions: 63731, max versions: 1
Data pages: 3917, data page slots: 4014, average fill: 79%
Fill distribution:
0 - 19% = 41
20 - 39% = 54
40 - 59% = 125
60 - 79% = 1906
80 - 99% = 1791

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 260, nodes: 275178
Average data length: 0.16, total dup: 268688, max dup: 183
Fill distribution:
0 - 19% = 0
20 - 39% = 29
40 - 59% = 132
60 - 79% = 12
80 - 99% = 87

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 351, nodes: 275178
Average data length: 1.26, total dup: 241044, max dup: 38
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 205
60 - 79% = 109
80 - 99% = 35

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.63, total records: 285319
Average version length: 69.92, total versions: 282721, max versions: 1
Data pages: 3833, data page slots: 5177, average fill: 95%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 2
60 - 79% = 20
80 - 99% = 3810

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 405, nodes: 285319
Average data length: 1.05, total dup: 255782, max dup: 95
Fill distribution:
0 - 19% = 1
20 - 39% = 28
40 - 59% = 285
60 - 79% = 87
80 - 99% = 4

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 18.45, total records: 1110161
Average version length: 68.37, total versions: 816467, max versions: 1
Data pages: 14959, data page slots: 14959, average fill: 89%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3522
80 - 99% = 11436

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1434, nodes: 1110161
Average data length: 1.11, total dup: 984550, max dup: 99
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1166
60 - 79% = 111
80 - 99% = 156

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 5.15, total records: 133537
Average version length: 69.43, total versions: 123602, max versions: 1
Data pages: 2791, data page slots: 4480, average fill: 62%
Fill distribution:
0 - 19% = 451
20 - 39% = 501
40 - 59% = 171
60 - 79% = 278
80 - 99% = 1390

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 286, nodes: 133537
Average data length: 1.44, total dup: 115376, max dup: 116
Fill distribution:
0 - 19% = 1
20 - 39% = 187
40 - 59% = 84
60 - 79% = 11
80 - 99% = 3

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 38.48, total records: 765523
Average version length: 68.40, total versions: 338299, max versions: 1
Data pages: 10679, data page slots: 10694, average fill: 82%
Fill distribution:
0 - 19% = 102
20 - 39% = 166
40 - 59% = 215
60 - 79% = 3290
80 - 99% = 6906

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1095, nodes: 765523
Average data length: 1.35, total dup: 660056, max dup: 44
Fill distribution:
0 - 19% = 1
20 - 39% = 16
40 - 59% = 847
60 - 79% = 134
80 - 99% = 97

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.33, total records: 1035209
Average version length: 80.71, total versions: 31107, max versions: 1
Data pages: 15462, data page slots: 15462, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 6344
80 - 99% = 9117

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1146, nodes: 1035209
Average data length: 0.16, total dup: 1011706, max dup: 156
Fill distribution:
0 - 19% = 7
20 - 39% = 1
40 - 59% = 841
60 - 79% = 247
80 - 99% = 50

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 834, nodes: 1035209
Average data length: 0.72, total dup: 910255, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 161
60 - 79% = 19
80 - 99% = 651

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1306, nodes: 1035209
Average data length: 0.74, total dup: 906382, max dup: 41
Fill distribution:
0 - 19% = 11
20 - 39% = 0
40 - 59% = 953
60 - 79% = 295
80 - 99% = 47

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 69.49, total records: 636095
Average version length: 80.26, total versions: 85660, max versions: 1
Data pages: 9631, data page slots: 9663, average fill: 81%
Fill distribution:
0 - 19% = 77
20 - 39% = 74
40 - 59% = 67
60 - 79% = 4854
80 - 99% = 4559

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 646, nodes: 636095
Average data length: 0.15, total dup: 622186, max dup: 301
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 338
60 - 79% = 247
80 - 99% = 55

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 519, nodes: 636095
Average data length: 0.84, total dup: 550551, max dup: 14
Fill distribution:
0 - 19% = 5
20 - 39% = 6
40 - 59% = 86
60 - 79% = 2
80 - 99% = 420

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 774, nodes: 636095
Average data length: 0.72, total dup: 562542, max dup: 44
Fill distribution:
0 - 19% = 33
20 - 39% = 3
40 - 59% = 412
60 - 79% = 287
80 - 99% = 39

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 75.21, total records: 1104072
Average version length: 81.61, total versions: 76192, max versions: 1
Data pages: 16494, data page slots: 16494, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7332
80 - 99% = 9162

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1128, nodes: 1104072
Average data length: 0.05, total dup: 1097598, max dup: 1150
Fill distribution:
0 - 19% = 5
20 - 39% = 0
40 - 59% = 729
60 - 79% = 261
80 - 99% = 133

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 829, nodes: 1104072
Average data length: 0.67, total dup: 978262, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 70
60 - 79% = 9
80 - 99% = 747

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1280, nodes: 1104072
Average data length: 0.68, total dup: 979117, max dup: 113
Fill distribution:
0 - 19% = 5
20 - 39% = 1
40 - 59% = 761
60 - 79% = 362
80 - 99% = 151

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: 71.95, total records: 811157
Average version length: 80.51, total versions: 86906, max versions: 1
Data pages: 12455, data page slots: 12516, average fill: 79%
Fill distribution:
0 - 19% = 179
20 - 39% = 176
40 - 59% = 155
60 - 79% = 5362
80 - 99% = 6583

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 749, nodes: 811157
Average data length: 0.05, total dup: 806590, max dup: 903
Fill distribution:
0 - 19% = 1
20 - 39% = 8
40 - 59% = 276
60 - 79% = 315
80 - 99% = 149

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 778, nodes: 811157
Average data length: 0.87, total dup: 698557, max dup: 14
Fill distribution:
0 - 19% = 16
20 - 39% = 17
40 - 59% = 300
60 - 79% = 2
80 - 99% = 443

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 839, nodes: 811157
Average data length: 0.68, total dup: 720266, max dup: 77
Fill distribution:
0 - 19% = 0
20 - 39% = 4
40 - 59% = 262
60 - 79% = 384
80 - 99% = 189

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 59.45, total records: 341763
Average version length: 68.37, total versions: 44736, max versions: 1
Data pages: 4601, data page slots: 4601, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3449
80 - 99% = 1151

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 303, nodes: 341763
Average data length: 0.22, total dup: 330905, max dup: 195
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 98
60 - 79% = 115
80 - 99% = 90

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 357, nodes: 341763
Average data length: 0.82, total dup: 297483, max dup: 44
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 140
60 - 79% = 138
80 - 99% = 79

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 17920 ms, from 2:27:59.66 to 2:28:17.58.

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 492591 19820 4.0236
DOC_LIST 87593 9675 11.0454
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 89956 22489.0000
INVNT_TURNOVER_LOG 155081 154799 99.8181
MONEY_SALDO 49 4813 9822.4489
MONEY_TURNOVER_LOG 6841 6799 99.3860
OPTYPES 9 0 0.0000
PDISTR 136178 78097 57.3492
PERF_ESTIMATED 25680 2 0.0077
PERF_LOG 1408146 1 0.0000
PSTORNED 86870 6363 7.3247
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 933 23325.0000
SETTINGS 114 0 0.0000
TRACE_STAT 369 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 224107 221594 98.8786
XQD_1000_3300 275178 63731 23.1599
XQD_1200_2000 285319 282721 99.0894
XQD_2000_3300 1110161 816467 73.5449
XQD_2100_3300 133537 123602 92.5601
XQD_3300_3400 765523 338299 44.1918
XQS_1000_1200 1035209 31107 3.0049
XQS_1000_3300 636095 85660 13.4665
XQS_1200_2000 1104072 76192 6.9009
XQS_2100_3300 811157 86906 10.7138
XQS_3300_3400 341763 44736 13.0897
Z_USED_VIEWS 32 0 0.0000
Done for 2150 ms, from 2:28:27.94 to 2:28:30.09.

Database validation

02:28:30.22 Validation started

02:28:30.22 Relation 140 (DOC_LIST)
02:28:30.22 process pointer page 0 of 1
02:28:30.30 Index 1 (PK_DOC_LIST)
02:28:30.31 Index 2 (DOC_LIST_ID_DESC)
02:28:30.34 Index 3 (FK_DOC_LIST_AGENTS)
02:28:30.37 Relation 140 (DOC_LIST) is ok

02:28:30.37 Relation 141 (DOC_DATA)
02:28:30.37 process pointer page 0 of 3
02:28:30.47 process pointer page 1 of 3
02:28:30.55 process pointer page 2 of 3
02:28:30.58 Index 2 (DOC_DATA_DOC_WARE_UNQ)
02:28:30.65 Index 3 (DOC_DATA_ID_DESC)
02:28:30.73 Index 4 (FK_DOC_DATA_DOC_LIST)
02:28:30.78 Relation 141 (DOC_DATA) is ok

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

02:28:30.83 Relation 150 (PDISTR)
02:28:30.83 process pointer page 0 of 1
02:28:30.87 Index 2 (PDISTR_SND_ID)
02:28:30.89 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
02:28:30.90 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
02:28:30.92 Index 5 (PDISTR_AGENT_ID)
02:28:30.92 Relation 150 (PDISTR) is ok

02:28:30.92 Relation 151 (PSTORNED)
02:28:30.92 process pointer page 0 of 1
02:28:30.94 Index 2 (PSTORNED_SND_ID)
02:28:30.95 Index 3 (PSTORNED_RCV_ID)
02:28:30.95 Relation 151 (PSTORNED) is ok

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

02:28:30.95 Relation 157 (INVNT_TURNOVER_LOG)
02:28:30.95 process pointer page 0 of 2
02:28:31.00 process pointer page 1 of 2
02:28:31.01 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
02:28:31.04 Relation 157 (INVNT_TURNOVER_LOG) is ok

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

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

02:28:31.04 Relation 162 (PERF_LOG)
02:28:31.04 process pointer page 0 of 17
02:28:31.11 process pointer page 1 of 17
02:28:31.18 process pointer page 2 of 17
02:28:31.26 process pointer page 3 of 17
02:28:31.29 process pointer page 4 of 17
02:28:31.33 process pointer page 5 of 17
02:28:31.34 process pointer page 6 of 17
02:28:31.37 process pointer page 7 of 17
02:28:31.40 process pointer page 8 of 17
02:28:31.43 process pointer page 9 of 17
02:28:31.47 process pointer page 10 of 17
02:28:31.50 process pointer page 11 of 17
02:28:31.54 process pointer page 12 of 17
02:28:31.61 process pointer page 13 of 17
02:28:31.67 process pointer page 14 of 17
02:28:31.70 process pointer page 15 of 17
02:28:31.73 process pointer page 16 of 17
02:28:31.75 Index 1 (PERF_LOG_DTS_BEG_DESC)
02:28:31.90 Index 2 (PERF_LOG_UNIT)
02:28:32.11 Index 3 (PERF_LOG_TRN_DESC)
02:28:32.21 Index 4 (PERF_LOG_GDSCODE)
02:28:32.39 Relation 162 (PERF_LOG) is ok

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

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

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

02:28:32.39 Relation 258 (XQD_1000_1200)
02:28:32.39 process pointer page 0 of 3
02:28:32.46 process pointer page 1 of 3
02:28:32.59 process pointer page 2 of 3
02:28:32.60 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
02:28:32.62 Relation 258 (XQD_1000_1200) is ok

02:28:32.62 Relation 259 (XQD_1200_2000)
02:28:32.62 process pointer page 0 of 3
02:28:32.65 process pointer page 1 of 3
02:28:32.78 process pointer page 2 of 3
02:28:32.82 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
02:28:32.85 Relation 259 (XQD_1200_2000) is ok

02:28:32.85 Relation 260 (XQD_1000_3300)
02:28:32.85 process pointer page 0 of 3
02:28:32.90 process pointer page 1 of 3
02:28:32.99 process pointer page 2 of 3
02:28:32.99 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
02:28:33.03 Index 2 (XQD_1000_3300_DOC)
02:28:33.06 Relation 260 (XQD_1000_3300) is ok

02:28:33.06 Relation 261 (XQD_2000_3300)
02:28:33.06 process pointer page 0 of 8
02:28:33.24 process pointer page 1 of 8
02:28:33.43 process pointer page 2 of 8
02:28:33.52 process pointer page 3 of 8
02:28:33.65 process pointer page 4 of 8
02:28:33.71 process pointer page 5 of 8
02:28:33.85 process pointer page 6 of 8
02:28:33.90 process pointer page 7 of 8
02:28:33.98 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
02:28:34.16 Relation 261 (XQD_2000_3300) is ok

02:28:34.16 Relation 262 (XQD_2100_3300)
02:28:34.16 process pointer page 0 of 3
02:28:34.16 process pointer page 1 of 3
02:28:34.21 process pointer page 2 of 3
02:28:34.23 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
02:28:34.24 Relation 262 (XQD_2100_3300) is ok

02:28:34.24 Relation 263 (XQD_3300_3400)
02:28:34.24 process pointer page 0 of 6
02:28:34.29 process pointer page 1 of 6
02:28:34.40 process pointer page 2 of 6
02:28:34.52 process pointer page 3 of 6
02:28:34.65 process pointer page 4 of 6
02:28:34.76 process pointer page 5 of 6
02:28:34.80 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
02:28:34.94 Relation 263 (XQD_3300_3400) is ok

02:28:34.94 Relation 264 (XQS_1000_1200)
02:28:34.94 process pointer page 0 of 9
02:28:35.01 process pointer page 1 of 9
02:28:35.10 process pointer page 2 of 9
02:28:35.19 process pointer page 3 of 9
02:28:35.26 process pointer page 4 of 9
02:28:35.30 process pointer page 5 of 9
02:28:35.33 process pointer page 6 of 9
02:28:35.37 process pointer page 7 of 9
02:28:35.41 process pointer page 8 of 9
02:28:35.41 Index 1 (XQS_1000_1200_DOC_ID)
02:28:35.51 Index 2 (XQS_1000_1200_SND_ID)
02:28:35.69 Index 3 (XQS_1000_1200_RCV_ID)
02:28:35.83 Relation 264 (XQS_1000_1200) is ok

02:28:35.83 Relation 265 (XQS_1200_2000)
02:28:35.83 process pointer page 0 of 9
02:28:35.93 process pointer page 1 of 9
02:28:36.02 process pointer page 2 of 9
02:28:36.10 process pointer page 3 of 9
02:28:36.19 process pointer page 4 of 9
02:28:36.24 process pointer page 5 of 9
02:28:36.27 process pointer page 6 of 9
02:28:36.32 process pointer page 7 of 9
02:28:36.35 process pointer page 8 of 9
02:28:36.36 Index 1 (XQS_1200_2000_DOC_ID)
02:28:36.46 Index 2 (XQS_1200_2000_SND_ID)
02:28:36.55 Index 3 (XQS_1200_2000_RCV_ID)
02:28:36.61 Relation 265 (XQS_1200_2000) is ok

02:28:36.61 Relation 266 (XQS_1000_3300)
02:28:36.61 process pointer page 0 of 6
02:28:36.64 process pointer page 1 of 6
02:28:36.68 process pointer page 2 of 6
02:28:36.74 process pointer page 3 of 6
02:28:36.83 process pointer page 4 of 6
02:28:36.93 process pointer page 5 of 6
02:28:36.94 Index 1 (XQS_1000_3300_DOC_ID)
02:28:37.10 Index 2 (XQS_1000_3300_SND_ID)
02:28:37.21 Index 3 (XQS_1000_3300_RCV_ID)
02:28:37.36 Relation 266 (XQS_1000_3300) is ok

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

02:28:37.36 Relation 268 (XQS_2100_3300)
02:28:37.36 process pointer page 0 of 7
02:28:37.47 process pointer page 1 of 7
02:28:37.57 process pointer page 2 of 7
02:28:37.60 process pointer page 3 of 7
02:28:37.63 process pointer page 4 of 7
02:28:37.67 process pointer page 5 of 7
02:28:37.74 process pointer page 6 of 7
02:28:37.77 Index 1 (XQS_2100_3300_DOC_ID)
02:28:37.96 Index 2 (XQS_2100_3300_SND_ID)
02:28:38.05 Index 3 (XQS_2100_3300_RCV_ID)
02:28:38.11 Relation 268 (XQS_2100_3300) is ok

02:28:38.11 Relation 269 (XQS_3300_3400)
02:28:38.13 process pointer page 0 of 3
02:28:38.16 process pointer page 1 of 3
02:28:38.19 process pointer page 2 of 3
02:28:38.20 Index 1 (XQS_3300_3400_DOC_ID)
02:28:38.22 Index 2 (XQS_3300_3400_SND_ID)
02:28:38.25 Relation 269 (XQS_3300_3400) is ok

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

02:28:38.25 Validation finished
Done for 8140 ms, from 2:28:30.11 to 2:28:38.25.

Differences between old and current firebird.log

2:28:38.70. 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-05 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-05 2:28:41.32 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html