Logs 2.5

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-09-18 2:26:30.02.
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-18 02:26:08.4150 -1 <null> 127.0.0.1 86723 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: 333.95 139876 60111 2016-09-17 23:26 2016-09-18 02:26
customer order: creation 29.29 2097 5273 2016-09-17 23:26 2016-09-18 02:26
customer order: refuse 2.27 50 409 2016-09-17 23:26 2016-09-18 02:26
order to supplier: creation 7.39 16892 1331 2016-09-17 23:26 2016-09-18 02:26
order to supplier: removal 0.12 109572 21 2016-09-17 23:26 2016-09-18 02:26
invoice (draft): creation 7.36 2440 1325 2016-09-17 23:26 2016-09-18 02:26
invoice (draft): removal 0.78 106 139 2016-09-17 23:26 2016-09-18 02:26
invoice accept: apply 1.78 2284575 319 2016-09-17 23:26 2016-09-18 02:26
invoice accept: cancel 0.32 204556 58 2016-09-17 23:26 2016-09-18 02:26
customer reserve: creation 237.40 16379 42732 2016-09-17 23:26 2016-09-18 02:26
customer reserve: removal 7.64 13110 1375 2016-09-17 23:26 2016-09-18 02:26
realization accept: apply 13.27 91 2388 2016-09-17 23:26 2016-09-18 02:26
realization accept: cancel 3.13 44 564 2016-09-17 23:26 2016-09-18 02:26
payment from customer: creation 10.02 241 1803 2016-09-17 23:26 2016-09-18 02:26
payment from customer: removal 0.94 48 168 2016-09-17 23:26 2016-09-18 02:26
payment to supplier: creation 7.60 732 1368 2016-09-17 23:26 2016-09-18 02:26
payment to supplier: removal 0.53 45 94 2016-09-17 23:26 2016-09-18 02:26
service: total inventory turnovers 2.15 4941 387 2016-09-17 23:26 2016-09-18 02:26
service: total monetary turnovers 1.93 11 347 2016-09-17 23:26 2016-09-18 02:26
service: refresh index statistics 0.06 1714 10 2016-09-17 23:26 2016-09-18 02:26
Done for 4430 ms, from 2:26:42.28 to 2:26:46.71.

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 689 14845 12398 2447 16.48 23:26:09 23:44:08
interval # 2, overall 2 380 7018 6843 175 2.49 23:44:09 00:02:08
interval # 3, overall 3 302 5600 5438 162 2.89 00:02:09 00:20:08
interval # 4, overall 4 341 6321 6129 192 3.04 00:20:09 00:38:08
interval # 5, overall 5 308 5771 5542 229 3.97 00:38:09 00:56:08
interval # 6, overall 6 278 5442 5007 435 7.99 00:56:09 01:14:08
interval # 7, overall 7 264 5449 4752 697 12.79 01:14:09 01:32:08
interval # 8, overall 8 248 5021 4457 564 11.23 01:32:09 01:50:08
interval # 9, overall 9 276 5890 4960 930 15.79 01:50:09 02:08:08
interval # 10, overall 10 255 4873 4585 288 5.91 02:08:09 02:26:08
Done for 8910 ms, from 2:26:51.89 to 2:27:00.80.

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 1968.19 0.7219 1.2895 893 98
WARM_TIME 2 1643.15 0.7841 1.1657 497 78
WARM_TIME 3 1477.13 0.8647 1.1244 530 78
WARM_TIME 4 1362.53 0.9144 1.0823 529 83
WARM_TIME 5 1234.57 0.9557 1.0567 299 78
WARM_TIME 6 1161.43 0.9361 1.0576 459 86
WARM_TIME 7 1122.52 0.9381 1.0571 482 80
WARM_TIME 8 1109.79 0.9358 1.0962 411 81
WARM_TIME 9 1133.05 0.9545 1.0341 369 74
WARM_TIME 10 1125.08 0.9373 1.0476 538 79
TEST_TIME 11 1110.62 0.9648 1.0319 472 65
TEST_TIME 12 1065.90 0.9857 1.0158 335 63
TEST_TIME 13 1017.05 0.9827 1.0162 397 60
TEST_TIME 14 980.35 0.9790 1.0157 249 44
TEST_TIME 15 947.02 0.9814 1.0170 331 52
TEST_TIME 16 929.62 0.9743 1.0254 442 66
TEST_TIME 17 911.35 0.9845 1.0152 515 53
TEST_TIME 18 895.57 0.9757 1.0237 840 45
TEST_TIME 19 892.63 0.9731 1.0383 975 35
TEST_TIME 20 904.73 0.9733 1.0292 1038 19
TEST_TIME 21 897.43 0.9882 1.0120 418 9
TEST_TIME 22 870.23 0.9962 1.0039 139 5
TEST_TIME 23 842.20 0.9931 1.0066 103 5
TEST_TIME 24 813.50 0.9987 1.0012 56 2
TEST_TIME 25 786.08 0.9982 1.0012 44 2
TEST_TIME 26 758.13 0.9997 1.0002 10 1
TEST_TIME 27 736.70 0.9912 1.0105 184 4
TEST_TIME 28 725.46 0.9896 1.0200 201 9
TEST_TIME 29 721.98 0.9896 1.0090 298 8
TEST_TIME 30 711.81 0.9913 1.0196 133 7
TEST_TIME 31 704.53 0.9969 1.0015 59 4
TEST_TIME 32 690.95 0.9893 1.0119 123 5
TEST_TIME 33 679.85 0.9997 1.0003 16 1
TEST_TIME 34 665.08 0.9938 1.0059 85 4
TEST_TIME 35 656.19 0.9904 1.0038 91 4
TEST_TIME 36 641.38 0.9985 1.0027 58 2
TEST_TIME 37 630.05 0.9963 1.0019 87 4
TEST_TIME 38 617.67 0.9952 1.0034 114 4
TEST_TIME 39 605.12 0.9998 1.0001 7 1
TEST_TIME 40 590.52 0.9992 1.0006 26 2
TEST_TIME 41 578.27 0.9998 1.0001 9 1
TEST_TIME 42 567.22 0.9993 1.0006 32 1
TEST_TIME 43 559.13 0.9948 1.0018 75 3
TEST_TIME 44 547.63 0.9997 1.0002 15 3
TEST_TIME 45 537.86 0.9960 1.0035 57 3
TEST_TIME 46 528.63 0.9989 1.0011 59 1
TEST_TIME 47 519.42 0.9972 1.0025 49 2
TEST_TIME 48 512.23 0.9979 1.0036 41 2
TEST_TIME 49 510.65 0.9944 1.0058 72 4
TEST_TIME 50 505.63 0.9955 1.0013 30 3
TEST_TIME 51 499.83 0.9931 1.0037 162 5
TEST_TIME 52 492.37 0.9993 1.0006 32 2
TEST_TIME 53 485.36 0.9959 1.0041 42 5
TEST_TIME 54 480.33 0.9958 1.0012 31 3
TEST_TIME 55 472.56 0.9992 1.0008 36 3
TEST_TIME 56 471.57 0.9850 1.0104 208 6
TEST_TIME 57 468.57 0.9991 1.0007 46 3
TEST_TIME 58 466.05 0.9972 1.0025 124 5
TEST_TIME 60 457.57 0.9872 1.0051 29 5
TEST_TIME 61 453.45 0.9976 1.0047 79 3
TEST_TIME 62 450.95 0.9941 1.0024 13 3
TEST_TIME 63 445.15 0.9993 1.0003 12 3
TEST_TIME 64 440.91 0.9978 1.0056 73 4
TEST_TIME 65 440.07 0.9920 1.0082 285 7
TEST_TIME 66 444.56 0.9829 1.0116 449 10
TEST_TIME 67 445.46 0.9945 1.0068 156 5
TEST_TIME 68 446.14 0.9906 1.0101 267 8
TEST_TIME 69 444.79 0.9986 1.0013 93 3
TEST_TIME 70 439.11 1.0000 1.0000 2 1
TEST_TIME 71 436.06 0.9928 1.0047 29 3
TEST_TIME 72 434.58 0.9942 1.0057 116 4
TEST_TIME 73 435.57 0.9897 1.0048 143 4
TEST_TIME 74 431.95 0.9996 1.0003 27 3
TEST_TIME 75 428.95 0.9996 1.0003 23 1
TEST_TIME 76 423.56 0.9997 1.0002 16 1
TEST_TIME 78 416.25 0.9928 1.0066 47 3
TEST_TIME 79 413.90 0.9995 1.0004 39 2
TEST_TIME 80 409.83 0.9979 1.0018 19 2
TEST_TIME 81 405.89 0.9994 1.0005 39 1
TEST_TIME 82 402.46 0.9968 1.0021 10 2
TEST_TIME 83 400.99 0.9937 1.0073 80 3
TEST_TIME 84 400.47 0.9966 1.0071 147 6
TEST_TIME 85 399.64 0.9974 1.0028 17 2
TEST_TIME 86 399.60 0.9912 1.0099 150 6
TEST_TIME 87 401.38 0.9938 1.0033 187 5
TEST_TIME 89 394.68 0.9998 1.0001 13 1
TEST_TIME 90 392.18 0.9953 1.0038 85 2
TEST_TIME 91 389.46 0.9997 1.0005 21 2
TEST_TIME 92 385.47 0.9999 1.0001 7 1
TEST_TIME 93 381.67 0.9999 1.0000 3 1
TEST_TIME 94 377.96 1.0000 1.0000 1 1
TEST_TIME 96 372.81 0.9985 1.0023 56 2
TEST_TIME 97 372.51 0.9928 1.0024 129 2
TEST_TIME 98 370.72 0.9970 1.0012 68 3
TEST_TIME 99 368.22 0.9986 1.0061 28 2
TEST_TIME 100 367.08 0.9992 1.0033 36 2
TEST_TIME 101 366.37 0.9953 1.0066 42 5
TEST_TIME 102 369.05 0.9895 1.0063 65 4
TEST_TIME 103 368.99 0.9984 1.0063 46 5
TEST_TIME 104 367.78 1.0000 1.0000 2 1
TEST_TIME 105 366.53 0.9999 1.0000 7 1
TEST_TIME 106 363.17 0.9998 1.0001 17 1
TEST_TIME 107 362.54 0.9925 1.0008 44 2
TEST_TIME 108 360.04 0.9985 1.0012 31 3
TEST_TIME 109 358.00 0.9977 1.0048 115 5
TEST_TIME 110 358.73 0.9937 1.0066 90 5
TEST_TIME 111 362.65 0.9932 1.0005 26 2
TEST_TIME 113 358.19 0.9997 1.0002 19 1
TEST_TIME 114 355.94 0.9977 1.0045 3 2
TEST_TIME 115 357.44 0.9916 1.0079 155 4
TEST_TIME 116 357.33 0.9995 1.0003 38 1
TEST_TIME 117 355.10 0.9980 1.0021 46 3
TEST_TIME 118 354.94 0.9941 1.0067 81 5
TEST_TIME 119 360.06 0.9841 1.0082 99 5
TEST_TIME 120 361.35 0.9962 1.0026 38 3
TEST_TIME 121 359.51 0.9994 1.0005 14 2
TEST_TIME 123 357.34 0.9902 1.0036 102 6
TEST_TIME 124 356.14 0.9989 1.0010 106 5
TEST_TIME 125 353.83 0.9995 1.0004 43 2
TEST_TIME 126 352.79 0.9990 1.0051 42 3
TEST_TIME 127 352.54 0.9997 1.0003 32 1
TEST_TIME 128 350.98 0.9969 1.0065 61 3
TEST_TIME 129 350.55 1.0000 1.0000 2 1
TEST_TIME 130 350.30 0.9938 1.0018 84 3
TEST_TIME 132 346.49 0.9998 1.0002 20 1
TEST_TIME 137 335.01 0.9991 1.0002 14 2
TEST_TIME 138 332.76 0.9996 1.0003 27 1
TEST_TIME 139 336.06 0.9949 1.0061 116 4
TEST_TIME 140 335.93 0.9993 1.0006 65 2
TEST_TIME 141 334.92 0.9999 1.0000 4 1
TEST_TIME 142 334.77 0.9934 1.0013 71 3
TEST_TIME 143 333.72 0.9974 1.0009 74 3
TEST_TIME 144 332.12 0.9987 1.0021 27 2
TEST_TIME 145 333.12 0.9993 1.0006 70 2
TEST_TIME 146 331.16 0.9997 1.0003 27 2
TEST_TIME 147 329.36 0.9989 1.0045 31 2
TEST_TIME 148 329.88 0.9962 1.0023 86 3
TEST_TIME 149 328.50 0.9998 1.0001 17 1
TEST_TIME 150 328.36 0.9939 1.0021 24 3
TEST_TIME 151 328.98 0.9936 1.0077 96 5
TEST_TIME 152 330.28 0.9994 1.0006 63 1
TEST_TIME 153 329.93 0.9951 1.0022 8 3
TEST_TIME 154 328.64 0.9996 1.0003 35 1
TEST_TIME 157 324.88 0.9995 1.0007 36 2
TEST_TIME 158 323.58 0.9983 1.0016 28 3
TEST_TIME 159 322.89 0.9974 1.0016 68 2
TEST_TIME 160 322.05 0.9980 1.0016 54 2
TEST_TIME 161 323.25 0.9917 1.0037 75 5
TEST_TIME 162 323.22 0.9976 1.0030 61 6
TEST_TIME 163 322.29 0.9997 1.0003 18 2
TEST_TIME 166 319.13 0.9988 1.0005 41 3
TEST_TIME 167 319.48 0.9934 1.0039 152 5
TEST_TIME 168 321.45 0.9919 1.0039 138 6
TEST_TIME 169 321.07 0.9991 1.0008 98 3
TEST_TIME 170 322.32 0.9910 1.0038 68 5
TEST_TIME 171 323.31 0.9948 1.0040 147 6
TEST_TIME 172 326.33 0.9890 1.0072 169 6
TEST_TIME 173 328.12 0.9960 1.0023 69 5
TEST_TIME 174 331.51 0.9863 1.0092 222 7
TEST_TIME 175 334.17 0.9955 1.0015 135 4
TEST_TIME 176 338.45 0.9885 1.0080 65 6
TEST_TIME 177 345.53 0.9818 1.0073 130 8
TEST_TIME 178 347.32 0.9965 1.0050 116 7
TEST_TIME 179 349.01 0.9946 1.0049 45 4
TEST_TIME 180 348.83 0.9999 1.0000 6 1
TEST_TIME 181 348.87 0.9945 1.0026 51 3
TEST_TIME 182 350.97 0.9963 1.0090 27 3
TEST_TIME 183 353.39 0.9983 1.0009 24 2
TEST_TIME 184 356.38 0.9871 1.0028 120 5
TEST_TIME 185 355.56 1.0000 1.0000 6 1
TEST_TIME 186 357.26 0.9922 1.0040 30 4
TEST_TIME 187 363.75 0.9809 1.0061 130 7
TEST_TIME 188 366.86 0.9922 1.0044 63 5
TEST_TIME 189 373.37 0.9818 1.0150 197 10
TEST_TIME 190 377.27 0.9992 1.0002 146 100
Done for 8440 ms, from 2:27:01.14 to 2:27:09.58.

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 842 30490 421 <null> 21424 <null> <null> <null> 7194 <null> 19745 <null> 73802 <null> 276983 4680 104312 <null> <null> 23:26:09 23:44:08
fetches per second 5 55609 70401 17476 <null> 15499 <null> 798 <null> <null> <null> 56298 62630 172103 161571 325227 79071 80850 1939363 <null> 00:38:09 00:56:08
fetches per second 8 32730 29894 16716 <null> 38327 <null> 583 <null> <null> <null> 68146 <null> 163491 <null> <null> <null> 82179 <null> <null> 01:32:09 01:50:08
fetches per second 10 39542 69880 19204 <null> 5734 <null> 765 <null> <null> <null> 189630 <null> <null> 46688 192614 <null> 66155 1380714 <null> 02:08:09 02:26:08
marks per second 1 201 2648 64 <null> 2757 <null> <null> <null> 876 <null> 3656 <null> 5399 <null> 8383 896 1168 <null> <null> 23:26:09 23:44:08
marks per second 5 10020 6840 1171 <null> 812 <null> 60 <null> <null> <null> 9884 6703 2619 18285 3482 8000 422 7181 <null> 00:38:09 00:56:08
marks per second 8 5412 2982 842 <null> 2279 <null> 35 <null> <null> <null> 7826 <null> 2253 <null> <null> <null> 252 <null> <null> 01:32:09 01:50:08
marks per second 10 7471 5880 696 <null> 254 <null> 35 <null> <null> <null> 3297 <null> <null> 4371 2572 <null> 189 4714 <null> 02:08:09 02:26:08
reads/fetches*100 1 27 5 28 <null> 7 <null> <null> <null> 12 <null> 10 <null> 7 <null> 3 13 9 <null> <null> 23:26:09 23:44:08
reads/fetches*100 5 5 5 8 <null> 6 <null> 15 <null> <null> <null> 6 4 5 4 3 3 27 0 <null> 00:38:09 00:56:08
reads/fetches*100 8 4 4 9 <null> 6 <null> 17 <null> <null> <null> 5 <null> 5 <null> <null> <null> 27 <null> <null> 01:32:09 01:50:08
reads/fetches*100 10 4 5 9 <null> 7 <null> 17 <null> <null> <null> 4 <null> <null> 3 3 <null> 28 0 <null> 02:08:09 02:26:08
writes/marks*100 1 3 15 2 <null> 7 <null> <null> <null> 8 <null> 6 <null> 4 <null> 2 1 29 <null> <null> 23:26:09 23:44:08
writes/marks*100 5 14 15 8 <null> 7 <null> 2 <null> <null> <null> 7 11 9 0 5 0 49 0 <null> 00:38:09 00:56:08
writes/marks*100 8 16 15 9 <null> 9 <null> 1 <null> <null> <null> 9 <null> 11 <null> <null> <null> 49 <null> <null> 01:32:09 01:50:08
writes/marks*100 10 10 13 8 <null> 9 <null> 1 <null> <null> <null> 9 <null> <null> 0 4 <null> 51 0 <null> 02:08:09 02:26:08
Done for 5600 ms, from 2:27:09.78 to 2:27:15.38.

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 52348 47358 4990 9.53 0 12184 50 4990 2016-09-17 23:26 2016-09-18 02:26
doc_list_biud 52394 47356 5038 9.61 0 872686 1045 5038 2016-09-17 23:26 2016-09-18 02:26
sp_add_invoice_to_stock 1156 319 837 72.40 827 10203060 2284575 837 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_adding_invoice 133 58 75 56.39 31 2742387 204556 75 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_client_order 431 409 22 5.10 0 1809 50 22 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_customer_reserve 5028 1375 3653 72.65 0 299017 13110 3653 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_pay_from_customer 170 168 2 1.17 0 733 48 2 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_pay_to_supplier 96 94 2 2.08 0 764 45 2 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_supplier_invoice 207 139 68 32.85 0 749 106 68 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_supplier_order 98 21 77 78.57 140 1388597 109572 77 2016-09-17 23:26 2016-09-18 02:26
sp_cancel_write_off 1880 564 1316 70.00 0 843 44 1316 2016-09-17 23:26 2016-09-18 02:26
sp_client_order 5273 5273 0 0.00 0 52309 2097 0 2016-09-17 23:26 2016-09-18 02:26
sp_customer_reserve 42732 42732 0 0.00 0 102714 16379 0 2016-09-17 23:26 2016-09-18 02:26
sp_fill_shopping_cart 7929 7929 0 0.00 0 52745 1005 0 2016-09-17 23:26 2016-09-18 02:26
sp_fill_shopping_cart_clo_res 42732 42732 0 0.00 0 234 3 0 2016-09-17 23:26 2016-09-18 02:26
sp_get_clo_for_invoice 319 319 0 0.00 0 421 85 0 2016-09-17 23:26 2016-09-18 02:26
sp_kill_cost_storno 2206 884 1322 59.92 0 733 16 1322 2016-09-17 23:26 2016-09-18 02:26
sp_kill_qstorno_ret_qs2qd 12076 3474 8602 71.23 0 298955 5244 8602 2016-09-17 23:26 2016-09-18 02:26
sp_kill_qty_storno 10293 5273 5020 48.77 0 872686 9382 5020 2016-09-17 23:26 2016-09-18 02:26
sp_lock_selected_doc 5007 3881 1126 22.48 0 31 0 1126 2016-09-17 23:26 2016-09-18 02:26
sp_make_cost_storno 5878 5878 0 0.00 0 11747 218 0 2016-09-17 23:26 2016-09-18 02:26
sp_multiply_rows_for_pdistr 5878 5878 0 0.00 0 1685 40 0 2016-09-17 23:26 2016-09-18 02:26
sp_multiply_rows_for_qdistr 5273 5273 0 0.00 0 51482 2003 0 2016-09-17 23:26 2016-09-18 02:26
sp_pay_from_customer 1803 1803 0 0.00 31 4633 241 0 2016-09-17 23:26 2016-09-18 02:26
sp_pay_to_supplier 1368 1368 0 0.00 31 12355 732 0 2016-09-17 23:26 2016-09-18 02:26
sp_payment_common 3171 3171 0 0.00 0 406 28 0 2016-09-17 23:26 2016-09-18 02:26
sp_qd_handle_on_cancel_clo 431 409 22 5.10 0 1763 31 22 2016-09-17 23:26 2016-09-18 02:26
sp_qd_handle_on_invoice_upd_sts 418 377 41 9.80 0 872686 82658 41 2016-09-17 23:26 2016-09-18 02:26
sp_qd_handle_on_reserve_upd_sts 2388 2388 0 0.00 0 187 14 0 2016-09-17 23:26 2016-09-18 02:26
sp_reserve_write_off 2455 2388 67 2.72 0 1950 91 67 2016-09-17 23:26 2016-09-18 02:26
sp_supplier_invoice 1325 1325 0 0.00 31 52791 2440 0 2016-09-17 23:26 2016-09-18 02:26
sp_supplier_order 1331 1331 0 0.00 31 235254 16892 0 2016-09-17 23:26 2016-09-18 02:26
srv_find_qd_qs_mism 29622 24638 4984 16.82 0 7161 34 4984 2016-09-17 23:26 2016-09-18 02:26
srv_make_invnt_saldo 387 387 0 0.00 593 14399 4941 0 2016-09-17 23:26 2016-09-18 02:26
srv_make_money_saldo 347 347 0 0.00 0 47 11 0 2016-09-17 23:26 2016-09-18 02:26
srv_recalc_idx_stat 10 10 0 0.00 1123 2511 1714 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_add_invoice_to_stock 837 837 0 0.00 0 156 9 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_adding_invoice 113 113 0 0.00 0 156 26 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_client_order 22 22 0 0.00 0 109 18 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_customer_reserve 6 6 0 0.00 0 31 7 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_pay_from_customer 2 2 0 0.00 0 0 0 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_pay_to_supplier 2 2 0 0.00 0 31 15 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_supplier_invoice 55 55 0 0.00 0 156 7 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_supplier_order 562 562 0 0.00 0 250 45 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_cancel_write_off 6 6 0 0.00 0 16 5 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-abend:sp_reserve_write_off 67 67 0 0.00 0 93 7 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_add_invoice_to_stock 325 325 0 0.00 0 2168 236 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_adding_invoice 35 35 0 0.00 15 608 94 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_client_order 409 409 0 0.00 0 219 14 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_customer_reserve 162 162 0 0.00 0 140 14 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_pay_from_customer 168 168 0 0.00 0 156 13 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_pay_to_supplier 94 94 0 0.00 0 172 10 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_supplier_invoice 32 32 0 0.00 0 93 12 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_supplier_order 23 23 0 0.00 0 1482 228 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_cancel_write_off 253 253 0 0.00 0 249 16 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_client_order 5316 5316 0 0.00 0 421 20 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_customer_reserve 237 237 0 0.00 0 234 13 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_pay_from_customer 1803 1803 0 0.00 0 250 12 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_pay_to_supplier 1368 1368 0 0.00 0 203 11 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_reserve_write_off 2388 2388 0 0.00 0 296 16 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_supplier_invoice 1326 1326 0 0.00 0 297 16 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:sp_supplier_order 1377 1377 0 0.00 0 281 19 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:srv_make_invnt_saldo 387 387 0 0.00 0 109 4 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:srv_make_money_saldo 347 347 0 0.00 0 63 3 0 2016-09-17 23:26 2016-09-18 02:26
t$perf-norm:srv_recalc_idx_stat 10 10 0 0.00 0 31 15 0 2016-09-17 23:26 2016-09-18 02:26
v_add_invoice_to_stock 2312 638 1674 72.40 0 16 2 1674 2016-09-17 23:26 2016-09-18 02:26
v_all_customers 7966 7966 0 0.00 0 16 0 0 2016-09-17 23:26 2016-09-18 02:26
v_all_suppliers 5312 5312 0 0.00 0 31 0 0 2016-09-17 23:26 2016-09-18 02:26
v_all_wares 10546 10546 0 0.00 0 47 0 0 2016-09-17 23:26 2016-09-18 02:26
v_cancel_adding_invoice 174 70 104 59.77 0 32 6 104 2016-09-17 23:26 2016-09-18 02:26
v_cancel_client_order 862 818 44 5.10 0 47 0 44 2016-09-17 23:26 2016-09-18 02:26
v_cancel_customer_prepayment 340 336 4 1.17 0 31 0 4 2016-09-17 23:26 2016-09-18 02:26
v_cancel_customer_reserve 336 324 12 3.57 0 16 0 12 2016-09-17 23:26 2016-09-18 02:26
v_cancel_payment_to_supplier 192 188 4 2.08 0 16 1 4 2016-09-17 23:26 2016-09-18 02:26
v_cancel_supplier_invoice 174 64 110 63.21 0 16 4 110 2016-09-17 23:26 2016-09-18 02:26
v_cancel_supplier_order 196 42 154 78.57 0 16 1 154 2016-09-17 23:26 2016-09-18 02:26
v_cancel_write_off 518 506 12 2.31 0 32 2 12 2016-09-17 23:26 2016-09-18 02:26
v_max_id_clo_ord 1333 1333 0 0.00 0 1294 90 0 2016-09-17 23:26 2016-09-18 02:26
v_max_id_clo_res 237 237 0 0.00 0 16 2 0 2016-09-17 23:26 2016-09-18 02:26
v_max_id_ord_sup 1325 1325 0 0.00 0 203 8 0 2016-09-17 23:26 2016-09-18 02:26
v_max_non_paid_invoice 1368 1368 0 0.00 0 249 6 0 2016-09-17 23:26 2016-09-18 02:26
v_max_non_paid_realizn 1803 1803 0 0.00 0 78 6 0 2016-09-17 23:26 2016-09-18 02:26
v_min_id_clo_ord 1331 1331 0 0.00 0 1825 147 0 2016-09-17 23:26 2016-09-18 02:26
v_min_id_clo_res 237 237 0 0.00 0 47 2 0 2016-09-17 23:26 2016-09-18 02:26
v_min_id_ord_sup 1325 1325 0 0.00 0 1560 49 0 2016-09-17 23:26 2016-09-18 02:26
v_min_non_paid_invoice 1368 1368 0 0.00 0 203 16 0 2016-09-17 23:26 2016-09-18 02:26
v_min_non_paid_realizn 1803 1803 0 0.00 0 171 13 0 2016-09-17 23:26 2016-09-18 02:26
v_our_firm 2580 2580 0 0.00 0 16 0 0 2016-09-17 23:26 2016-09-18 02:26
v_reserve_write_off 4910 4776 134 2.72 0 125 1 134 2016-09-17 23:26 2016-09-18 02:26
x_lock_depdocs_on_canc_invoice 377 165 212 56.23 0 32 2 212 2016-09-17 23:26 2016-09-18 02:26
x_lock_depdocs_on_canc_sup_ord 98 21 77 78.57 0 15 0 77 2016-09-17 23:26 2016-09-18 02:26
x_make_qstorno_1000_1200 1343 1343 0 0.00 15 210372 13601 0 2016-09-17 23:26 2016-09-18 02:26
x_make_qstorno_1200_2000 1325 1325 0 0.00 0 8097 608 0 2016-09-17 23:26 2016-09-18 02:26
x_make_qstorno_2100_3300 42732 42732 0 0.00 0 102698 16360 0 2016-09-17 23:26 2016-09-18 02:26
Done for 17270 ms, from 2:27:24.09 to 2:27:41.36.

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 4 sp_kill_cost_storno 335544336 2016-09-17 23:28 2016-09-18 00:20
deadlock 1 sp_lock_selected_doc 335544336 2016-09-17 23:35 2016-09-17 23:35
deadlock 4 sp_qd_handle_on_invoice_upd_sts 335544336 2016-09-17 23:31 2016-09-18 01:06
lock_conflict 4 sp_kill_cost_storno 335544345 2016-09-17 23:27 2016-09-18 00:07
lock_conflict 971 sp_lock_selected_doc 335544345 2016-09-17 23:26 2016-09-18 02:26
lock_conflict 22 sp_qd_handle_on_cancel_clo 335544345 2016-09-17 23:28 2016-09-18 02:25
lock_conflict 23 sp_qd_handle_on_invoice_upd_sts 335544345 2016-09-17 23:28 2016-09-18 02:25
lock_conflict 70 x_lock_depdocs_on_canc_invoice 335544345 2016-09-17 23:26 2016-09-18 02:25
lock_conflict 28 x_lock_depdocs_on_canc_sup_ord 335544345 2016-09-17 23:34 2016-09-18 02:25
Done for 2030 ms, from 2:27:41.70 to 2:27:43.73.

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 92263
MON$OLDEST_ACTIVE 92264
MON$OLDEST_SNAPSHOT 92264
MON$NEXT_TRANSACTION 92264
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 96749
Page size 8192
ODS version 11.2
Oldest transaction 92265
Oldest active 92266
Oldest snapshot 92266
Next transaction 92267
Bumped transaction 1
Sequence number 0
Next attachment ID 4437
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.08, total records: 478345
Average version length: 46.10, total versions: 20748, max versions: 1
Data pages: 5093, data page slots: 5093, average fill: 73%
Fill distribution:
0 - 19% = 2
20 - 39% = 6
40 - 59% = 65
60 - 79% = 4932
80 - 99% = 88

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1588, nodes: 478345
Average data length: 11.71, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 161
20 - 39% = 31
40 - 59% = 660
60 - 79% = 89
80 - 99% = 647

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

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 468, nodes: 478345
Average data length: 0.87, total dup: 412814, max dup: 49
Fill distribution:
0 - 19% = 5
20 - 39% = 19
40 - 59% = 208
60 - 79% = 7
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.58, total records: 78652
Average version length: 49.99, total versions: 7338, max versions: 7
Data pages: 1013, data page slots: 1013, average fill: 78%
Fill distribution:
0 - 19% = 4
20 - 39% = 17
40 - 59% = 49
60 - 79% = 466
80 - 99% = 477

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 66, nodes: 78652
Average data length: 0.01, total dup: 78602, max dup: 18230
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 48
60 - 79% = 12
80 - 99% = 6

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 166, nodes: 78652
Average data length: 6.26, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 6
20 - 39% = 16
40 - 59% = 73
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: 62.86, total records: 400
Average version length: 13.78, total versions: 92882, max versions: 275
Data pages: 370, data page slots: 370, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 370

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.31, total records: 146825
Average version length: 68.35, total versions: 146182, max versions: 1
Data pages: 2083, data page slots: 2083, average fill: 88%
Fill distribution:
0 - 19% = 4
20 - 39% = 23
40 - 59% = 41
60 - 79% = 157
80 - 99% = 1858

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 399, nodes: 146825
Average data length: 8.47, total dup: 13595, max dup: 6
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 180
60 - 79% = 160
80 - 99% = 57

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.94, total records: 49
Average version length: 9.00, total versions: 4713, max versions: 394
Data pages: 18, data page slots: 18, average fill: 84%
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 0
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.09, total records: 7107
Average version length: 44.13, total versions: 7093, max versions: 1
Data pages: 74, data page slots: 74, average fill: 92%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 1
80 - 99% = 72

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

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.15, total records: 132857
Average version length: 32.72, total versions: 88359, max versions: 9
Data pages: 1413, data page slots: 1413, average fill: 86%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
60 - 79% = 338
80 - 99% = 1072

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 113, nodes: 132857
Average data length: 0.01, total dup: 132808, max dup: 30120
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 64
60 - 79% = 23
80 - 99% = 24

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 137, nodes: 132857
Average data length: 0.89, total dup: 119618, max dup: 43
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 79
60 - 79% = 32
80 - 99% = 25

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 145, nodes: 132857
Average data length: 0.89, total dup: 119618, max dup: 43
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 85
60 - 79% = 35
80 - 99% = 22

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 128, nodes: 132857
Average data length: 0.66, total dup: 119618, max dup: 43
Fill distribution:
0 - 19% = 0
20 - 39% = 4
40 - 59% = 57
60 - 79% = 43
80 - 99% = 24

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 27.08, total records: 23173
Average version length: 18.00, total versions: 2, max versions: 1
Data pages: 193, data page slots: 193, average fill: 65%
Fill distribution:
0 - 19% = 1
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: 23173
Average data length: 0.01, total dup: 22997, max dup: 1145
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 2
60 - 79% = 12
80 - 99% = 2

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

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

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

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1546, nodes: 1231143
Average data length: 0.59, total dup: 693246, max dup: 35
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1216
60 - 79% = 224
80 - 99% = 106

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1526, nodes: 1231143
Average data length: 0.39, total dup: 1156961, max dup: 5797
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1301
60 - 79% = 128
80 - 99% = 97

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1371, nodes: 1231143
Average data length: 0.32, total dup: 1193556, max dup: 137831
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 980
60 - 79% = 192
80 - 99% = 197

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

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

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

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

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

PSTORNED (151)
Primary pointer page: 248, Index root page: 249
Average record length: 51.14, total records: 88876
Average version length: 54.84, total versions: 5889, max versions: 1
Data pages: 1036, data page slots: 1036, average fill: 77%
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 1
60 - 79% = 969
80 - 99% = 64

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 109, nodes: 88876
Average data length: 1.12, total dup: 73859, max dup: 144
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 102
60 - 79% = 4
80 - 99% = 3

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 79, nodes: 88876
Average data length: 0.61, total dup: 81082, max dup: 89
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 35
60 - 79% = 34
80 - 99% = 10

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: 1017, max versions: 550
Data pages: 4, data page slots: 4, average fill: 82%
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.63, total records: 254
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 4, data page slots: 4, average fill: 60%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3
80 - 99% = 0

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

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

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

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

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

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

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

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

XQD_1000_1200 (258)
Primary pointer page: 645, Index root page: 646
Average record length: 0.08, total records: 248603
Average version length: 69.37, total versions: 248309, max versions: 1
Data pages: 3331, data page slots: 3331, average fill: 94%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 3330

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 291, nodes: 248603
Average data length: 1.26, total dup: 217525, max dup: 29
Fill distribution:
0 - 19% = 8
20 - 39% = 13
40 - 59% = 79
60 - 79% = 139
80 - 99% = 52

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 49.98, total records: 241545
Average version length: 69.14, total versions: 67525, max versions: 1
Data pages: 3284, data page slots: 3286, average fill: 83%
Fill distribution:
0 - 19% = 7
20 - 39% = 15
40 - 59% = 12
60 - 79% = 1367
80 - 99% = 1883

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 209, nodes: 241545
Average data length: 0.15, total dup: 236198, max dup: 209
Fill distribution:
0 - 19% = 0
20 - 39% = 26
40 - 59% = 81
60 - 79% = 17
80 - 99% = 85

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 266, nodes: 241545
Average data length: 1.26, total dup: 211718, max dup: 39
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 87
60 - 79% = 94
80 - 99% = 83

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.75, total records: 298345
Average version length: 69.34, total versions: 295163, max versions: 1
Data pages: 4004, data page slots: 4004, average fill: 94%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 35
80 - 99% = 3968

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 331, nodes: 298345
Average data length: 0.99, total dup: 269380, max dup: 99
Fill distribution:
0 - 19% = 1
20 - 39% = 3
40 - 59% = 131
60 - 79% = 134
80 - 99% = 62

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 18.45, total records: 1048793
Average version length: 68.25, total versions: 769716, max versions: 1
Data pages: 14130, data page slots: 14130, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 1
60 - 79% = 3473
80 - 99% = 10655

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1335, nodes: 1048793
Average data length: 1.13, total dup: 928148, max dup: 89
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1034
60 - 79% = 125
80 - 99% = 176

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 3.04, total records: 157314
Average version length: 68.99, total versions: 150390, max versions: 1
Data pages: 4349, data page slots: 4513, average fill: 48%
Fill distribution:
0 - 19% = 1003
20 - 39% = 1193
40 - 59% = 511
60 - 79% = 608
80 - 99% = 1034

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 242, nodes: 157314
Average data length: 1.44, total dup: 135221, max dup: 89
Fill distribution:
0 - 19% = 0
20 - 39% = 36
40 - 59% = 135
60 - 79% = 71
80 - 99% = 0

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 37.86, total records: 780708
Average version length: 68.41, total versions: 351022, max versions: 1
Data pages: 10932, data page slots: 10943, average fill: 82%
Fill distribution:
0 - 19% = 61
20 - 39% = 160
40 - 59% = 339
60 - 79% = 4037
80 - 99% = 6335

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1112, nodes: 780708
Average data length: 1.29, total dup: 677805, max dup: 59
Fill distribution:
0 - 19% = 0
20 - 39% = 24
40 - 59% = 863
60 - 79% = 137
80 - 99% = 88

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.23, total records: 1008029
Average version length: 80.51, total versions: 28065, max versions: 1
Data pages: 15029, data page slots: 15029, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 6523
80 - 99% = 8505

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1110, nodes: 1008029
Average data length: 0.16, total dup: 985237, max dup: 152
Fill distribution:
0 - 19% = 10
20 - 39% = 0
40 - 59% = 796
60 - 79% = 244
80 - 99% = 60

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 824, nodes: 1008029
Average data length: 0.72, total dup: 887904, max dup: 49
Fill distribution:
0 - 19% = 6
20 - 39% = 0
40 - 59% = 174
60 - 79% = 22
80 - 99% = 622

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1258, nodes: 1008029
Average data length: 0.75, total dup: 882471, max dup: 44
Fill distribution:
0 - 19% = 11
20 - 39% = 0
40 - 59% = 883
60 - 79% = 299
80 - 99% = 65

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 66.00, total records: 692517
Average version length: 80.25, total versions: 123376, max versions: 1
Data pages: 10494, data page slots: 10505, average fill: 81%
Fill distribution:
0 - 19% = 48
20 - 39% = 60
40 - 59% = 156
60 - 79% = 4644
80 - 99% = 5586

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 678, nodes: 692517
Average data length: 0.14, total dup: 678448, max dup: 379
Fill distribution:
0 - 19% = 1
20 - 39% = 4
40 - 59% = 287
60 - 79% = 306
80 - 99% = 80

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 568, nodes: 692517
Average data length: 0.82, total dup: 601638, max dup: 14
Fill distribution:
0 - 19% = 6
20 - 39% = 11
40 - 59% = 89
60 - 79% = 7
80 - 99% = 455

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 807, nodes: 692517
Average data length: 0.67, total dup: 617419, max dup: 60
Fill distribution:
0 - 19% = 33
20 - 39% = 6
40 - 59% = 357
60 - 79% = 349
80 - 99% = 62

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 76.78, total records: 1048407
Average version length: 80.99, total versions: 48232, max versions: 1
Data pages: 15632, data page slots: 15632, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 7331
80 - 99% = 8300

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1087, nodes: 1048407
Average data length: 0.05, total dup: 1042162, max dup: 922
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 704
60 - 79% = 293
80 - 99% = 89

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 781, nodes: 1048407
Average data length: 0.69, total dup: 927350, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 57
60 - 79% = 4
80 - 99% = 719

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1244, nodes: 1048407
Average data length: 0.69, total dup: 928633, max dup: 141
Fill distribution:
0 - 19% = 4
20 - 39% = 1
40 - 59% = 778
60 - 79% = 351
80 - 99% = 110

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: 68.87, total records: 834378
Average version length: 80.31, total versions: 120204, max versions: 1
Data pages: 12808, data page slots: 12845, average fill: 80%
Fill distribution:
0 - 19% = 102
20 - 39% = 124
40 - 59% = 313
60 - 79% = 5222
80 - 99% = 7047

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 768, nodes: 834378
Average data length: 0.05, total dup: 829813, max dup: 680
Fill distribution:
0 - 19% = 2
20 - 39% = 12
40 - 59% = 275
60 - 79% = 320
80 - 99% = 159

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 761, nodes: 834378
Average data length: 0.84, total dup: 723134, max dup: 14
Fill distribution:
0 - 19% = 15
20 - 39% = 35
40 - 59% = 203
60 - 79% = 9
80 - 99% = 499

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 870, nodes: 834378
Average data length: 0.66, total dup: 744689, max dup: 79
Fill distribution:
0 - 19% = 1
20 - 39% = 18
40 - 59% = 275
60 - 79% = 403
80 - 99% = 173

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 57.34, total records: 339305
Average version length: 68.32, total versions: 54817, max versions: 1
Data pages: 4568, data page slots: 4568, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3236
80 - 99% = 1331

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 311, nodes: 339305
Average data length: 0.22, total dup: 328752, max dup: 223
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 119
60 - 79% = 117
80 - 99% = 75

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 353, nodes: 339305
Average data length: 0.81, total dup: 295580, max dup: 59
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 131
60 - 79% = 138
80 - 99% = 84

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 4010 ms, from 2:27:44.10 to 2:27:48.11.

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 478345 20748 4.3374
DOC_LIST 78652 7338 9.3297
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 92882 23220.5000
INVNT_TURNOVER_LOG 146825 146182 99.5620
MONEY_SALDO 49 4713 9618.3673
MONEY_TURNOVER_LOG 7107 7093 99.8030
OPTYPES 9 0 0.0000
PDISTR 132857 88359 66.5068
PERF_ESTIMATED 23173 2 0.0086
PERF_LOG 1231143 1 0.0000
PSTORNED 88876 5889 6.6260
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 1017 25425.0000
SETTINGS 114 0 0.0000
TRACE_STAT 254 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 248603 248309 99.8817
XQD_1000_3300 241545 67525 27.9554
XQD_1200_2000 298345 295163 98.9334
XQD_2000_3300 1048793 769716 73.3906
XQD_2100_3300 157314 150390 95.5986
XQD_3300_3400 780708 351022 44.9620
XQS_1000_1200 1008029 28065 2.7841
XQS_1000_3300 692517 123376 17.8155
XQS_1200_2000 1048407 48232 4.6005
XQS_2100_3300 834378 120204 14.4064
XQS_3300_3400 339305 54817 16.1556
Z_USED_VIEWS 32 0 0.0000
Done for 2490 ms, from 2:27:57.60 to 2:28:00.09.

Database validation

02:28:00.22 Validation started

02:28:00.22 Relation 140 (DOC_LIST)
02:28:00.22 process pointer page 0 of 1
02:28:00.28 Index 1 (PK_DOC_LIST)
02:28:00.30 Index 2 (DOC_LIST_ID_DESC)
02:28:00.33 Index 3 (FK_DOC_LIST_AGENTS)
02:28:00.34 Relation 140 (DOC_LIST) is ok

02:28:00.34 Relation 141 (DOC_DATA)
02:28:00.34 process pointer page 0 of 3
02:28:00.44 process pointer page 1 of 3
02:28:00.55 process pointer page 2 of 3
02:28:00.56 Index 2 (DOC_DATA_DOC_WARE_UNQ)
02:28:00.64 Index 3 (DOC_DATA_ID_DESC)
02:28:00.70 Index 4 (FK_DOC_DATA_DOC_LIST)
02:28:00.75 Relation 141 (DOC_DATA) is ok

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

02:28:00.78 Relation 150 (PDISTR)
02:28:00.78 process pointer page 0 of 1
02:28:00.83 Index 2 (PDISTR_SND_ID)
02:28:00.84 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
02:28:00.86 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
02:28:00.87 Index 5 (PDISTR_AGENT_ID)
02:28:00.89 Relation 150 (PDISTR) is ok

02:28:00.89 Relation 151 (PSTORNED)
02:28:00.89 process pointer page 0 of 1
02:28:00.94 Index 2 (PSTORNED_SND_ID)
02:28:00.97 Index 3 (PSTORNED_RCV_ID)
02:28:00.98 Relation 151 (PSTORNED) is ok

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

02:28:00.98 Relation 157 (INVNT_TURNOVER_LOG)
02:28:00.98 process pointer page 0 of 2
02:28:01.17 process pointer page 1 of 2
02:28:01.19 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
02:28:01.28 Relation 157 (INVNT_TURNOVER_LOG) is ok

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

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

02:28:01.29 Relation 162 (PERF_LOG)
02:28:01.29 process pointer page 0 of 15
02:28:01.37 process pointer page 1 of 15
02:28:01.44 process pointer page 2 of 15
02:28:01.50 process pointer page 3 of 15
02:28:01.53 process pointer page 4 of 15
02:28:01.56 process pointer page 5 of 15
02:28:01.59 process pointer page 6 of 15
02:28:01.62 process pointer page 7 of 15
02:28:01.64 process pointer page 8 of 15
02:28:01.67 process pointer page 9 of 15
02:28:01.68 process pointer page 10 of 15
02:28:01.72 process pointer page 11 of 15
02:28:01.73 process pointer page 12 of 15
02:28:01.76 process pointer page 13 of 15
02:28:01.78 process pointer page 14 of 15
02:28:01.79 Index 1 (PERF_LOG_DTS_BEG_DESC)
02:28:02.00 Index 2 (PERF_LOG_UNIT)
02:28:02.46 Index 3 (PERF_LOG_TRN_DESC)
02:28:02.71 Index 4 (PERF_LOG_GDSCODE)
02:28:02.85 Relation 162 (PERF_LOG) is ok

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

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

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

02:28:02.85 Relation 258 (XQD_1000_1200)
02:28:02.85 process pointer page 0 of 2
02:28:02.98 process pointer page 1 of 2
02:28:03.09 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
02:28:03.17 Relation 258 (XQD_1000_1200) is ok

02:28:03.17 Relation 259 (XQD_1200_2000)
02:28:03.17 process pointer page 0 of 3
02:28:03.35 process pointer page 1 of 3
02:28:03.53 process pointer page 2 of 3
02:28:03.54 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
02:28:03.62 Relation 259 (XQD_1200_2000) is ok

02:28:03.62 Relation 260 (XQD_1000_3300)
02:28:03.62 process pointer page 0 of 2
02:28:03.74 process pointer page 1 of 2
02:28:03.79 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
02:28:03.82 Index 2 (XQD_1000_3300_DOC)
02:28:03.88 Relation 260 (XQD_1000_3300) is ok

02:28:03.88 Relation 261 (XQD_2000_3300)
02:28:03.88 process pointer page 0 of 8
02:28:04.06 process pointer page 1 of 8
02:28:04.17 process pointer page 2 of 8
02:28:04.31 process pointer page 3 of 8
02:28:04.48 process pointer page 4 of 8
02:28:04.56 process pointer page 5 of 8
02:28:04.62 process pointer page 6 of 8
02:28:04.70 process pointer page 7 of 8
02:28:04.71 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
02:28:04.91 Relation 261 (XQD_2000_3300) is ok

02:28:04.91 Relation 262 (XQD_2100_3300)
02:28:04.91 process pointer page 0 of 3
02:28:04.96 process pointer page 1 of 3
02:28:05.09 process pointer page 2 of 3
02:28:05.12 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
02:28:05.18 Relation 262 (XQD_2100_3300) is ok

02:28:05.18 Relation 263 (XQD_3300_3400)
02:28:05.18 process pointer page 0 of 6
02:28:05.30 process pointer page 1 of 6
02:28:05.40 process pointer page 2 of 6
02:28:05.44 process pointer page 3 of 6
02:28:05.57 process pointer page 4 of 6
02:28:05.68 process pointer page 5 of 6
02:28:05.74 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
02:28:05.83 Relation 263 (XQD_3300_3400) is ok

02:28:05.83 Relation 264 (XQS_1000_1200)
02:28:05.83 process pointer page 0 of 8
02:28:05.87 process pointer page 1 of 8
02:28:05.90 process pointer page 2 of 8
02:28:05.93 process pointer page 3 of 8
02:28:05.96 process pointer page 4 of 8
02:28:06.01 process pointer page 5 of 8
02:28:06.08 process pointer page 6 of 8
02:28:06.12 process pointer page 7 of 8
02:28:06.16 Index 1 (XQS_1000_1200_DOC_ID)
02:28:06.29 Index 2 (XQS_1000_1200_SND_ID)
02:28:06.40 Index 3 (XQS_1000_1200_RCV_ID)
02:28:06.46 Relation 264 (XQS_1000_1200) is ok

02:28:06.47 Relation 265 (XQS_1200_2000)
02:28:06.47 process pointer page 0 of 9
02:28:06.51 process pointer page 1 of 9
02:28:06.54 process pointer page 2 of 9
02:28:06.63 process pointer page 3 of 9
02:28:06.71 process pointer page 4 of 9
02:28:06.75 process pointer page 5 of 9
02:28:06.80 process pointer page 6 of 9
02:28:06.83 process pointer page 7 of 9
02:28:06.86 process pointer page 8 of 9
02:28:06.86 Index 1 (XQS_1200_2000_DOC_ID)
02:28:06.96 Index 2 (XQS_1200_2000_SND_ID)
02:28:07.14 Index 3 (XQS_1200_2000_RCV_ID)
02:28:07.24 Relation 265 (XQS_1200_2000) is ok

02:28:07.24 Relation 266 (XQS_1000_3300)
02:28:07.24 process pointer page 0 of 6
02:28:07.33 process pointer page 1 of 6
02:28:07.44 process pointer page 2 of 6
02:28:07.55 process pointer page 3 of 6
02:28:07.64 process pointer page 4 of 6
02:28:07.74 process pointer page 5 of 6
02:28:07.75 Index 1 (XQS_1000_3300_DOC_ID)
02:28:07.82 Index 2 (XQS_1000_3300_SND_ID)
02:28:07.89 Index 3 (XQS_1000_3300_RCV_ID)
02:28:07.94 Relation 266 (XQS_1000_3300) is ok

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

02:28:07.94 Relation 268 (XQS_2100_3300)
02:28:07.94 process pointer page 0 of 7
02:28:07.97 process pointer page 1 of 7
02:28:08.08 process pointer page 2 of 7
02:28:08.17 process pointer page 3 of 7
02:28:08.28 process pointer page 4 of 7
02:28:08.36 process pointer page 5 of 7
02:28:08.39 process pointer page 6 of 7
02:28:08.41 Index 1 (XQS_2100_3300_DOC_ID)
02:28:08.50 Index 2 (XQS_2100_3300_SND_ID)
02:28:08.61 Index 3 (XQS_2100_3300_RCV_ID)
02:28:08.74 Relation 268 (XQS_2100_3300) is ok

02:28:08.74 Relation 269 (XQS_3300_3400)
02:28:08.74 process pointer page 0 of 3
02:28:08.78 process pointer page 1 of 3
02:28:08.81 process pointer page 2 of 3
02:28:08.83 Index 1 (XQS_3300_3400_DOC_ID)
02:28:08.86 Index 2 (XQS_3300_3400_SND_ID)
02:28:08.88 Relation 269 (XQS_3300_3400) is ok

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

02:28:08.88 Validation finished
Done for 8780 ms, from 2:28:00.11 to 2:28:08.89.

Differences between old and current firebird.log

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