Firebird 2.5 Performance Logs

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-03-27 23:56:36.31.
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.6.26984 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.6 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-03-27 23:56:07.9570 -1 <null> 127.0.0.1 90945 4271 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: 509.02 94860 91624 2016-03-27 20:56 2016-03-27 23:56
customer order: creation 31.04 1053 5588 2016-03-27 20:56 2016-03-27 23:56
customer order: refuse 2.34 54 416 2016-03-27 20:56 2016-03-27 23:56
order to supplier: creation 8.03 13110 1445 2016-03-27 20:56 2016-03-27 23:56
order to supplier: removal 0.21 55040 35 2016-03-27 20:56 2016-03-27 23:56
invoice (draft): creation 7.77 2492 1398 2016-03-27 20:56 2016-03-27 23:56
invoice (draft): removal 1.71 301 286 2016-03-27 20:56 2016-03-27 23:56
invoice accept: apply 2.40 1574774 432 2016-03-27 20:56 2016-03-27 23:56
invoice accept: cancel 0.50 127728 86 2016-03-27 20:56 2016-03-27 23:56
customer reserve: creation 397.07 9504 71473 2016-03-27 20:56 2016-03-27 23:56
customer reserve: removal 14.55 5628 2503 2016-03-27 20:56 2016-03-27 23:56
realization accept: apply 14.68 95 2643 2016-03-27 20:56 2016-03-27 23:56
realization accept: cancel 5.10 69 908 2016-03-27 20:56 2016-03-27 23:56
payment from customer: creation 10.18 151 1832 2016-03-27 20:56 2016-03-27 23:56
payment from customer: removal 1.12 38 184 2016-03-27 20:56 2016-03-27 23:56
payment to supplier: creation 8.68 376 1562 2016-03-27 20:56 2016-03-27 23:56
payment to supplier: removal 0.66 30 104 2016-03-27 20:56 2016-03-27 23:56
service: total inventory turnovers 1.91 9740 331 2016-03-27 20:56 2016-03-27 23:56
service: total monetary turnovers 2.15 17 387 2016-03-27 20:56 2016-03-27 23:56
service: refresh index statistics 0.07 2135 11 2016-03-27 20:56 2016-03-27 23:56
Done for 9000 ms, from 23:56:52.94 to 23:57:01.94.

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 663 12788 11931 857 6.70 20:56:08 21:14:08
interval # 2, overall 2 693 12781 12471 310 2.43 21:14:09 21:32:09
interval # 3, overall 3 722 13163 12991 172 1.31 21:32:10 21:50:10
interval # 4, overall 4 770 14231 13857 374 2.63 21:50:11 22:08:11
interval # 5, overall 5 741 13605 13329 276 2.03 22:08:12 22:26:12
interval # 6, overall 6 840 16052 15126 926 5.77 22:26:13 22:44:13
interval # 7, overall 7 304 5724 5473 251 4.39 22:44:14 23:02:14
interval # 8, overall 8 176 3209 3164 45 1.40 23:02:15 23:20:15
interval # 9, overall 9 140 2819 2526 293 10.39 23:20:16 23:38:16
interval # 10, overall 10 42 819 756 63 7.69 23:38:17 23:56:17
Done for 12480 ms, from 23:57:12.20 to 23:57:24.68.

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 2237.32 0.6918 1.2783 748 91
WARM_TIME 2 1663.62 0.8598 1.1297 521 67
WARM_TIME 3 1342.89 0.9333 1.0524 382 55
WARM_TIME 4 1121.29 0.9515 1.0416 262 49
WARM_TIME 5 991.19 0.9429 1.0631 329 49
WARM_TIME 6 902.81 0.9728 1.0293 297 45
WARM_TIME 7 838.49 0.9501 1.0460 375 51
WARM_TIME 8 793.79 0.9670 1.0426 299 45
WARM_TIME 9 771.58 0.9535 1.0261 192 39
WARM_TIME 10 751.73 0.9479 1.0462 290 48
TEST_TIME 11 733.04 0.9755 1.0392 285 41
TEST_TIME 12 717.75 0.9730 1.0206 257 45
TEST_TIME 13 690.49 0.9794 1.0293 296 42
TEST_TIME 14 686.54 0.9614 1.0183 307 40
TEST_TIME 15 673.39 0.9691 1.0165 289 44
TEST_TIME 16 663.24 0.9676 1.0311 572 49
TEST_TIME 17 667.66 0.9641 1.0367 855 38
TEST_TIME 18 675.87 0.9673 1.0338 833 21
TEST_TIME 19 677.85 0.9766 1.0388 544 12
TEST_TIME 20 673.48 0.9934 1.0052 141 8
TEST_TIME 21 649.35 0.9935 1.0038 38 2
TEST_TIME 22 635.26 0.9819 1.0119 136 7
TEST_TIME 23 617.54 0.9958 1.0059 119 5
TEST_TIME 24 600.84 0.9908 1.0132 142 6
TEST_TIME 25 593.76 0.9929 1.0105 117 5
TEST_TIME 26 587.72 0.9817 1.0228 193 5
TEST_TIME 27 592.43 0.9771 1.0133 144 7
TEST_TIME 28 592.34 0.9847 1.0134 295 6
TEST_TIME 29 584.90 0.9909 1.0091 111 5
TEST_TIME 30 576.55 0.9905 1.0122 102 5
TEST_TIME 31 568.91 0.9927 1.0046 140 4
TEST_TIME 32 555.37 0.9970 1.0026 118 3
TEST_TIME 33 542.07 0.9961 1.0028 42 2
TEST_TIME 34 536.99 0.9885 1.0111 169 6
TEST_TIME 35 539.94 0.9769 1.0100 215 5
TEST_TIME 36 535.13 0.9908 1.0018 64 3
TEST_TIME 37 530.95 0.9825 1.0161 148 7
TEST_TIME 38 526.68 0.9974 1.0065 80 6
TEST_TIME 39 518.98 0.9953 1.0130 62 3
TEST_TIME 40 516.82 0.9919 1.0067 113 4
TEST_TIME 41 515.38 0.9849 1.0129 199 6
TEST_TIME 42 513.97 0.9915 1.0032 61 5
TEST_TIME 43 516.71 0.9748 1.0122 92 8
TEST_TIME 44 516.64 0.9898 1.0099 74 4
TEST_TIME 45 517.94 0.9850 1.0102 93 6
TEST_TIME 46 519.83 0.9847 1.0159 150 6
TEST_TIME 47 521.11 0.9919 1.0240 76 6
TEST_TIME 48 529.69 0.9865 1.0175 135 8
TEST_TIME 49 536.97 0.9832 1.0071 239 7
TEST_TIME 50 534.68 0.9913 1.0112 90 6
TEST_TIME 51 542.52 0.9771 1.0110 271 12
TEST_TIME 52 538.39 0.9994 1.0006 26 3
TEST_TIME 53 532.48 0.9999 1.0000 4 1
TEST_TIME 54 526.72 0.9995 1.0004 30 1
TEST_TIME 55 522.28 0.9975 1.0044 60 3
TEST_TIME 56 519.87 0.9981 1.0058 78 5
TEST_TIME 57 517.60 0.9928 1.0055 52 3
TEST_TIME 58 517.28 0.9888 1.0125 31 4
TEST_TIME 59 519.25 0.9916 1.0083 200 7
TEST_TIME 60 515.55 0.9987 1.0094 54 3
TEST_TIME 61 516.09 0.9918 1.0080 10 3
TEST_TIME 62 517.14 0.9935 1.0090 58 4
TEST_TIME 63 518.20 0.9910 1.0135 72 8
TEST_TIME 64 527.85 0.9795 1.0126 295 10
TEST_TIME 65 527.28 0.9981 1.0019 144 5
TEST_TIME 66 526.22 0.9895 1.0050 40 4
TEST_TIME 67 522.10 0.9978 1.0072 9 3
TEST_TIME 68 529.97 0.9862 1.0037 117 6
TEST_TIME 69 527.45 0.9939 1.0037 124 6
TEST_TIME 70 526.65 0.9909 1.0079 132 9
TEST_TIME 71 525.34 0.9962 1.0039 132 5
TEST_TIME 72 534.24 0.9747 1.0064 180 10
TEST_TIME 73 532.74 0.9954 1.0095 141 6
TEST_TIME 74 538.50 0.9868 1.0053 147 7
TEST_TIME 75 547.35 0.9759 1.0327 291 13
TEST_TIME 76 560.99 0.9944 1.0139 76 7
TEST_TIME 77 561.83 0.9992 1.0006 55 3
TEST_TIME 78 559.69 0.9916 1.0093 91 6
TEST_TIME 79 562.15 0.9922 1.0026 65 4
TEST_TIME 80 559.63 0.9946 1.0084 128 6
TEST_TIME 81 564.12 0.9880 1.0129 193 11
TEST_TIME 82 568.17 0.9935 1.0028 123 7
TEST_TIME 83 570.95 0.9859 1.0053 147 9
TEST_TIME 84 571.22 0.9929 1.0092 94 4
TEST_TIME 85 575.18 0.9931 1.0073 246 10
TEST_TIME 86 575.45 0.9952 1.0055 212 8
TEST_TIME 87 573.68 0.9980 1.0025 131 6
TEST_TIME 88 569.56 0.9983 1.0042 129 5
TEST_TIME 89 571.42 0.9941 1.0082 78 4
TEST_TIME 90 570.52 0.9986 1.0062 106 4
TEST_TIME 91 568.98 0.9999 1.0000 9 1
TEST_TIME 92 568.30 0.9945 1.0044 66 4
TEST_TIME 93 565.11 0.9992 1.0034 20 3
TEST_TIME 94 561.15 0.9998 1.0001 24 1
TEST_TIME 95 558.79 0.9952 1.0110 51 5
TEST_TIME 96 567.50 0.9900 1.0034 32 4
TEST_TIME 97 570.19 0.9884 1.0062 100 8
TEST_TIME 98 577.18 0.9839 1.0220 90 13
TEST_TIME 99 585.34 0.9975 1.0020 238 11
TEST_TIME 100 586.58 0.9899 1.0127 142 11
TEST_TIME 101 589.62 0.9975 1.0089 139 9
TEST_TIME 102 590.41 0.9977 1.0069 100 6
TEST_TIME 103 596.53 0.9871 1.0060 137 8
TEST_TIME 104 602.40 0.9867 1.0128 151 12
TEST_TIME 105 612.24 0.9871 1.0099 184 14
TEST_TIME 106 615.09 0.9958 1.0039 137 8
TEST_TIME 107 617.63 0.9904 1.0090 168 8
TEST_TIME 108 622.49 0.9919 1.0050 68 6
TEST_TIME 109 628.33 0.9866 1.0228 167 12
TEST_TIME 110 648.23 0.9824 1.0085 122 8
TEST_TIME 111 651.17 0.9949 1.0056 169 8
TEST_TIME 112 659.49 0.9851 1.0189 126 7
TEST_TIME 113 681.41 0.9774 1.0159 185 12
TEST_TIME 114 694.33 0.9883 1.0086 182 10
TEST_TIME 115 704.26 0.9894 1.0091 169 10
TEST_TIME 116 713.25 0.9878 1.0092 62 7
TEST_TIME 117 718.41 0.9967 1.0032 67 7
TEST_TIME 118 714.69 0.9999 1.0001 17 1
TEST_TIME 119 713.20 0.9937 1.0027 54 4
TEST_TIME 120 711.65 0.9968 1.0028 59 4
TEST_TIME 121 713.20 0.9924 1.0054 121 6
TEST_TIME 122 715.68 0.9937 1.0076 159 7
TEST_TIME 123 715.94 0.9990 1.0005 87 5
TEST_TIME 124 711.03 0.9998 1.0002 38 1
TEST_TIME 125 705.87 0.9994 1.0003 29 3
TEST_TIME 126 705.91 0.9923 1.0050 85 5
TEST_TIME 127 704.03 0.9998 1.0001 37 2
TEST_TIME 128 698.95 0.9999 1.0001 11 2
TEST_TIME 130 690.37 0.9985 1.0004 53 3
TEST_TIME 131 687.94 0.9963 1.0026 55 5
TEST_TIME 132 684.56 0.9999 1.0000 9 1
TEST_TIME 133 679.73 0.9995 1.0001 14 2
TEST_TIME 134 675.06 0.9995 1.0009 28 2
TEST_TIME 135 670.82 0.9999 1.0000 4 1
TEST_TIME 136 666.31 0.9993 1.0004 15 2
TEST_TIME 137 662.48 1.0000 1.0000 3 1
TEST_TIME 138 657.80 0.9998 1.0001 30 1
TEST_TIME 139 654.29 0.9990 1.0008 23 2
TEST_TIME 140 651.37 0.9989 1.0008 25 3
TEST_TIME 141 648.38 0.9983 1.0012 49 2
TEST_TIME 142 645.33 0.9999 1.0001 18 1
TEST_TIME 143 641.31 0.9994 1.0003 10 2
TEST_TIME 144 638.13 0.9998 1.0001 27 1
TEST_TIME 147 626.77 0.9987 1.0013 74 2
TEST_TIME 148 623.85 0.9992 1.0007 25 2
TEST_TIME 150 617.60 0.9987 1.0002 26 2
TEST_TIME 151 614.67 0.9997 1.0002 50 2
TEST_TIME 153 607.96 0.9995 1.0002 12 2
TEST_TIME 154 605.79 0.9973 1.0020 130 4
TEST_TIME 155 603.44 0.9994 1.0007 14 2
TEST_TIME 156 602.92 0.9958 1.0055 170 8
TEST_TIME 157 603.75 0.9977 1.0022 67 6
TEST_TIME 158 604.82 0.9956 1.0031 65 6
TEST_TIME 159 606.05 0.9954 1.0019 96 6
TEST_TIME 160 604.02 0.9990 1.0003 49 2
TEST_TIME 161 601.18 0.9988 1.0014 23 3
TEST_TIME 162 598.78 0.9992 1.0007 55 2
TEST_TIME 163 595.75 0.9996 1.0004 78 2
TEST_TIME 164 592.51 1.0000 1.0000 1 1
TEST_TIME 165 590.35 0.9992 1.0004 75 2
TEST_TIME 166 588.30 0.9993 1.0011 57 2
TEST_TIME 168 584.12 0.9978 1.0022 100 3
TEST_TIME 169 582.81 0.9989 1.0016 15 2
TEST_TIME 170 581.01 0.9988 1.0006 78 4
TEST_TIME 171 578.11 0.9998 1.0002 40 2
TEST_TIME 172 575.74 0.9984 1.0008 82 3
TEST_TIME 173 572.95 0.9999 1.0001 19 2
TEST_TIME 174 570.17 0.9999 1.0000 17 1
TEST_TIME 175 568.24 0.9995 1.0011 19 2
TEST_TIME 176 566.82 0.9998 1.0002 49 1
TEST_TIME 180 555.77 0.9989 1.0010 31 2
TEST_TIME 181 553.27 1.0000 1.0000 1 1
TEST_TIME 182 551.69 0.9986 1.0006 10 2
TEST_TIME 183 549.03 0.9999 1.0000 4 1
TEST_TIME 187 537.63 1.0000 1.0000 2 1
TEST_TIME 188 535.22 0.9999 1.0000 16 1
TEST_TIME 189 533.93 0.9989 1.0002 17 2
TEST_TIME 190 531.87 0.9988 1.0004 239 100
Done for 8940 ms, from 23:57:24.91 to 23:57:33.85.

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 576 41418 311 <null> 9391 <null> <null> <null> 1705 <null> 16701 32453 31332 16117 67548 <null> 50322 <null> <null> 20:56:08 21:14:08
fetches per second 2 29005 <null> <null> <null> 7817 <null> 1515 <null> <null> <null> <null> <null> <null> <null> 136047 <null> <null> <null> <null> 21:14:09 21:32:09
fetches per second 4 31425 <null> 16722 <null> 20107 <null> 1352 <null> <null> 874 39721 68043 93191 <null> 224562 <null> 47897 1320144 <null> 21:50:11 22:08:11
fetches per second 5 19674 32731 11823 <null> 15227 55032 1438 1907 963 <null> 28122 <null> 79709 19857 158295 <null> 24696 1270166 <null> 22:08:12 22:26:12
fetches per second 6 <null> <null> <null> <null> <null> <null> 2589 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 22:26:13 22:44:13
marks per second 1 140 3907 41 <null> 1005 <null> <null> <null> 216 <null> 2360 4391 1464 1544 1662 <null> 420 <null> <null> 20:56:08 21:14:08
marks per second 2 5128 <null> <null> <null> 416 <null> 137 <null> <null> <null> <null> <null> <null> <null> 1593 <null> <null> <null> <null> 21:14:09 21:32:09
marks per second 4 5452 <null> 930 <null> 1002 <null> 64 <null> <null> 165 6446 11478 2116 <null> 1505 <null> 183 2766 <null> 21:50:11 22:08:11
marks per second 5 3499 2820 582 <null> 695 8064 21 208 70 <null> 3470 <null> 1129 2507 2245 <null> 85 5875 <null> 22:08:12 22:26:12
marks per second 6 <null> <null> <null> <null> <null> <null> 97 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 22:26:13 22:44:13
reads/fetches*100 1 27 5 27 <null> 8 <null> <null> <null> 18 <null> 8 5 7 4 3 <null> 17 <null> <null> 20:56:08 21:14:08
reads/fetches*100 2 7 <null> <null> <null> 6 <null> 14 <null> <null> <null> <null> <null> <null> <null> 3 <null> <null> <null> <null> 21:14:09 21:32:09
reads/fetches*100 4 4 <null> 10 <null> 6 <null> 15 <null> <null> 18 7 4 6 <null> 3 <null> 27 0 <null> 21:50:11 22:08:11
reads/fetches*100 5 4 8 9 <null> 6 4 14 7 18 <null> 6 <null> 5 3 3 <null> 29 0 <null> 22:08:12 22:26:12
reads/fetches*100 6 <null> <null> <null> <null> <null> <null> 12 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 22:26:13 22:44:13
writes/marks*100 1 4 11 2 <null> 5 <null> <null> <null> 1 <null> 8 9 3 0 1 <null> 35 <null> <null> 20:56:08 21:14:08
writes/marks*100 2 15 <null> <null> <null> 4 <null> 0 <null> <null> <null> <null> <null> <null> <null> 6 <null> <null> <null> <null> 21:14:09 21:32:09
writes/marks*100 4 12 <null> 7 <null> 6 <null> 1 <null> <null> 3 8 5 8 <null> 6 <null> 51 3 <null> 21:50:11 22:08:11
writes/marks*100 5 11 18 8 <null> 9 2 4 5 7 <null> 7 <null> 8 2 5 <null> 50 0 <null> 22:08:12 22:26:12
writes/marks*100 6 <null> <null> <null> <null> <null> <null> 2 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 22:26:13 22:44:13
Done for 5800 ms, from 23:57:34.04 to 23:57:39.84.

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 62981 60608 2373 3.76 0 7613 32 2373 2016-03-27 20:56 2016-03-27 23:56
doc_list_biud 63049 60608 2441 3.87 0 356686 669 2441 2016-03-27 20:56 2016-03-27 23:56
sp_add_invoice_to_stock 1269 432 837 65.95 16801 5682528 1574774 837 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_adding_invoice 142 86 56 39.43 47 1878426 127728 56 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_client_order 452 416 36 7.96 0 1186 54 36 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_customer_reserve 4219 2503 1716 40.67 0 111996 5628 1716 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_pay_from_customer 184 184 0 0.00 0 1513 38 0 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_pay_to_supplier 104 104 0 0.00 0 531 30 0 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_supplier_invoice 372 286 86 23.11 0 12932 301 86 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_supplier_order 111 35 76 68.46 78 694922 55040 76 2016-03-27 20:56 2016-03-27 23:56
sp_cancel_write_off 1568 908 660 42.09 0 936 69 660 2016-03-27 20:56 2016-03-27 23:56
sp_client_order 5588 5588 0 0.00 0 32636 1053 0 2016-03-27 20:56 2016-03-27 23:56
sp_customer_reserve 71473 71473 0 0.00 16 95360 9504 0 2016-03-27 20:56 2016-03-27 23:56
sp_fill_shopping_cart 8431 8431 0 0.00 0 82286 1014 0 2016-03-27 20:56 2016-03-27 23:56
sp_fill_shopping_cart_clo_res 71473 71473 0 0.00 0 374 4 0 2016-03-27 20:56 2016-03-27 23:56
sp_get_clo_for_invoice 432 432 0 0.00 0 546 85 0 2016-03-27 20:56 2016-03-27 23:56
sp_kill_cost_storno 1945 1282 663 34.08 0 515 12 663 2016-03-27 20:56 2016-03-27 23:56
sp_kill_qstorno_ret_qs2qd 10314 6235 4079 39.54 0 111902 2275 4079 2016-03-27 20:56 2016-03-27 23:56
sp_kill_qty_storno 9741 7309 2432 24.96 0 356686 5540 2432 2016-03-27 20:56 2016-03-27 23:56
sp_lock_selected_doc 5522 4341 1181 21.38 0 31 0 1181 2016-03-27 20:56 2016-03-27 23:56
sp_make_cost_storno 6469 6469 0 0.00 0 4244 125 0 2016-03-27 20:56 2016-03-27 23:56
sp_multiply_rows_for_pdistr 6469 6469 0 0.00 0 1264 15 0 2016-03-27 20:56 2016-03-27 23:56
sp_multiply_rows_for_qdistr 5588 5588 0 0.00 0 30981 973 0 2016-03-27 20:56 2016-03-27 23:56
sp_pay_from_customer 1832 1832 0 0.00 31 1763 151 0 2016-03-27 20:56 2016-03-27 23:56
sp_pay_to_supplier 1562 1562 0 0.00 47 4492 376 0 2016-03-27 20:56 2016-03-27 23:56
sp_payment_common 3394 3394 0 0.00 0 3229 35 0 2016-03-27 20:56 2016-03-27 23:56
sp_qd_handle_on_cancel_clo 452 416 36 7.96 0 1170 31 36 2016-03-27 20:56 2016-03-27 23:56
sp_qd_handle_on_invoice_upd_sts 549 518 31 5.64 0 356670 50522 31 2016-03-27 20:56 2016-03-27 23:56
sp_qd_handle_on_reserve_upd_sts 2643 2643 0 0.00 0 500 22 0 2016-03-27 20:56 2016-03-27 23:56
sp_reserve_write_off 2743 2643 100 3.64 0 3213 95 100 2016-03-27 20:56 2016-03-27 23:56
sp_supplier_invoice 1398 1398 0 0.00 31 84173 2492 0 2016-03-27 20:56 2016-03-27 23:56
sp_supplier_order 1445 1445 0 0.00 31 231366 13110 0 2016-03-27 20:56 2016-03-27 23:56
srv_find_qd_qs_mism 34522 32149 2373 6.87 0 7566 30 2373 2016-03-27 20:56 2016-03-27 23:56
srv_make_invnt_saldo 331 331 0 0.00 2558 55725 9740 0 2016-03-27 20:56 2016-03-27 23:56
srv_make_money_saldo 387 387 0 0.00 0 234 17 0 2016-03-27 20:56 2016-03-27 23:56
srv_recalc_idx_stat 11 11 0 0.00 1716 3635 2135 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_add_invoice_to_stock 837 837 0 0.00 0 156 10 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_adding_invoice 144 144 0 0.00 0 468 72 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_client_order 36 36 0 0.00 0 47 12 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_customer_reserve 10 10 0 0.00 0 31 7 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_supplier_invoice 80 80 0 0.00 0 156 15 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_supplier_order 227 227 0 0.00 0 1061 75 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_cancel_write_off 2 2 0 0.00 16 16 16 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-abend:sp_reserve_write_off 100 100 0 0.00 0 78 8 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_add_invoice_to_stock 462 462 0 0.00 15 19454 683 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_adding_invoice 57 57 0 0.00 13 1467 166 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_client_order 416 416 0 0.00 0 281 16 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_customer_reserve 154 154 0 0.00 0 125 18 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_pay_from_customer 184 184 0 0.00 0 141 15 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_pay_to_supplier 104 104 0 0.00 0 78 13 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_supplier_invoice 33 33 0 0.00 0 109 16 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_supplier_order 35 35 0 0.00 15 3654 384 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_cancel_write_off 283 283 0 0.00 0 265 17 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_client_order 5610 5610 0 0.00 0 375 21 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_customer_reserve 264 264 0 0.00 0 234 16 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_pay_from_customer 1832 1832 0 0.00 0 219 15 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_pay_to_supplier 1562 1562 0 0.00 0 328 15 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_reserve_write_off 2643 2643 0 0.00 0 343 19 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_supplier_invoice 1399 1399 0 0.00 0 344 22 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:sp_supplier_order 1489 1489 0 0.00 0 543 25 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:srv_make_invnt_saldo 332 332 0 0.00 0 103 5 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:srv_make_money_saldo 387 387 0 0.00 0 78 4 0 2016-03-27 20:56 2016-03-27 23:56
t$perf-norm:srv_recalc_idx_stat 11 11 0 0.00 0 47 24 0 2016-03-27 20:56 2016-03-27 23:56
v_add_invoice_to_stock 2538 864 1674 65.95 0 31 2 1674 2016-03-27 20:56 2016-03-27 23:56
v_all_customers 8276 8276 0 0.00 0 16 0 0 2016-03-27 20:56 2016-03-27 23:56
v_all_suppliers 5686 5686 0 0.00 0 16 0 0 2016-03-27 20:56 2016-03-27 23:56
v_all_wares 11176 11176 0 0.00 0 17 0 0 2016-03-27 20:56 2016-03-27 23:56
v_cancel_adding_invoice 194 114 80 41.23 0 62 5 80 2016-03-27 20:56 2016-03-27 23:56
v_cancel_client_order 904 832 72 7.96 0 16 1 72 2016-03-27 20:56 2016-03-27 23:56
v_cancel_customer_prepayment 368 368 0 0.00 0 16 1 0 2016-03-27 20:56 2016-03-27 23:56
v_cancel_customer_reserve 328 308 20 6.09 0 16 1 20 2016-03-27 20:56 2016-03-27 23:56
v_cancel_payment_to_supplier 208 208 0 0.00 0 16 1 0 2016-03-27 20:56 2016-03-27 23:56
v_cancel_supplier_invoice 226 66 160 70.79 0 16 2 160 2016-03-27 20:56 2016-03-27 23:56
v_cancel_supplier_order 222 70 152 68.46 0 16 0 152 2016-03-27 20:56 2016-03-27 23:56
v_cancel_write_off 570 566 4 0.70 0 78 3 4 2016-03-27 20:56 2016-03-27 23:56
v_max_id_clo_ord 1445 1445 0 0.00 0 1997 87 0 2016-03-27 20:56 2016-03-27 23:56
v_max_id_clo_res 264 264 0 0.00 0 109 3 0 2016-03-27 20:56 2016-03-27 23:56
v_max_id_ord_sup 1398 1398 0 0.00 0 1310 15 0 2016-03-27 20:56 2016-03-27 23:56
v_max_non_paid_invoice 1562 1562 0 0.00 0 1092 4 0 2016-03-27 20:56 2016-03-27 23:56
v_max_non_paid_realizn 1832 1832 0 0.00 0 63 5 0 2016-03-27 20:56 2016-03-27 23:56
v_min_id_clo_ord 1445 1445 0 0.00 0 2128 121 0 2016-03-27 20:56 2016-03-27 23:56
v_min_id_clo_res 264 264 0 0.00 0 16 1 0 2016-03-27 20:56 2016-03-27 23:56
v_min_id_ord_sup 1398 1398 0 0.00 0 6162 51 0 2016-03-27 20:56 2016-03-27 23:56
v_min_non_paid_invoice 1562 1562 0 0.00 0 764 35 0 2016-03-27 20:56 2016-03-27 23:56
v_min_non_paid_realizn 1832 1832 0 0.00 0 141 14 0 2016-03-27 20:56 2016-03-27 23:56
v_our_firm 2900 2900 0 0.00 0 16 0 0 2016-03-27 20:56 2016-03-27 23:56
v_reserve_write_off 5486 5286 200 3.64 0 874 1 200 2016-03-27 20:56 2016-03-27 23:56
x_lock_depdocs_on_canc_invoice 511 339 172 33.65 0 63 2 172 2016-03-27 20:56 2016-03-27 23:56
x_lock_depdocs_on_canc_sup_ord 111 35 76 68.46 0 16 1 76 2016-03-27 20:56 2016-03-27 23:56
x_make_qstorno_1000_1200 1453 1453 0 0.00 15 199791 9162 0 2016-03-27 20:56 2016-03-27 23:56
x_make_qstorno_1200_2000 1398 1398 0 0.00 0 25969 971 0 2016-03-27 20:56 2016-03-27 23:56
x_make_qstorno_2100_3300 71473 71473 0 0.00 16 95345 9486 0 2016-03-27 20:56 2016-03-27 23:56
Done for 22700 ms, from 23:57:55.94 to 23:58:18.64.

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 6 sp_kill_cost_storno 335544336 2016-03-27 21:09 2016-03-27 22:49
deadlock 4 sp_qd_handle_on_invoice_upd_sts 335544336 2016-03-27 21:18 2016-03-27 22:09
lock_conflict 1031 sp_lock_selected_doc 335544345 2016-03-27 20:56 2016-03-27 23:56
lock_conflict 36 sp_qd_handle_on_cancel_clo 335544345 2016-03-27 20:56 2016-03-27 23:32
lock_conflict 23 sp_qd_handle_on_invoice_upd_sts 335544345 2016-03-27 20:56 2016-03-27 23:39
lock_conflict 53 x_lock_depdocs_on_canc_invoice 335544345 2016-03-27 20:59 2016-03-27 22:48
lock_conflict 29 x_lock_depdocs_on_canc_sup_ord 335544345 2016-03-27 20:59 2016-03-27 23:20
Done for 2230 ms, from 23:58:19.15 to 23:58:21.38.

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 92583
MON$OLDEST_ACTIVE 92584
MON$OLDEST_SNAPSHOT 92584
MON$NEXT_TRANSACTION 92584
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.6.26984 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.6.26984 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.6.26984 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.6.26984 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 97064
Page size 8192
ODS version 11.2
Oldest transaction 92585
Oldest active 92586
Oldest snapshot 92586
Next transaction 92587
Bumped transaction 1
Sequence number 0
Next attachment ID 4442
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.10, total records: 480342
Average version length: 46.32, total versions: 21736, max versions: 1
Data pages: 5137, data page slots: 5137, average fill: 73%
Fill distribution:
0 - 19% = 6
20 - 39% = 19
40 - 59% = 83
60 - 79% = 4919
80 - 99% = 110

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1625, nodes: 480342
Average data length: 11.84, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 173
20 - 39% = 44
40 - 59% = 683
60 - 79% = 78
80 - 99% = 647

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1409, nodes: 480342
Average data length: 5.94, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 31
40 - 59% = 1378
60 - 79% = 0
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 478, nodes: 480342
Average data length: 0.93, total dup: 409887, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 27
40 - 59% = 209
60 - 79% = 10
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 57.96, total records: 84254
Average version length: 48.23, total versions: 9763, max versions: 5
Data pages: 1084, data page slots: 1084, average fill: 79%
Fill distribution:
0 - 19% = 11
20 - 39% = 28
40 - 59% = 51
60 - 79% = 302
80 - 99% = 692

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 70, nodes: 84254
Average data length: 0.01, total dup: 84204, max dup: 18379
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 43
60 - 79% = 21
80 - 99% = 6

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 177, nodes: 84254
Average data length: 6.25, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 4
20 - 39% = 15
40 - 59% = 87
60 - 79% = 1
80 - 99% = 70

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

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

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

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

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

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

INVNT_SALDO (147)
Primary pointer page: 216, Index root page: 217
Average record length: 64.04, total records: 400
Average version length: 14.05, total versions: 90950, max versions: 259
Data pages: 366, data page slots: 366, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 365

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.27, total records: 153233
Average version length: 68.76, total versions: 152639, max versions: 1
Data pages: 2689, data page slots: 2695, average fill: 73%
Fill distribution:
0 - 19% = 297
20 - 39% = 317
40 - 59% = 86
60 - 79% = 178
80 - 99% = 1811

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 410, nodes: 153233
Average data length: 8.10, total dup: 19717, max dup: 4
Fill distribution:
0 - 19% = 1
20 - 39% = 8
40 - 59% = 108
60 - 79% = 290
80 - 99% = 3

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

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

MONEY_TURNOVER_LOG (142)
Primary pointer page: 206, Index root page: 207
Average record length: 0.05, total records: 7224
Average version length: 44.30, total versions: 7217, max versions: 1
Data pages: 79, data page slots: 82, average fill: 88%
Fill distribution:
0 - 19% = 1
20 - 39% = 2
40 - 59% = 3
60 - 79% = 1
80 - 99% = 72

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 6, nodes: 7224
Average data length: 0.13, total dup: 7130, max dup: 1520
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
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: 23.89, total records: 137712
Average version length: 32.95, total versions: 92408, max versions: 9
Data pages: 1540, data page slots: 1540, average fill: 82%
Fill distribution:
0 - 19% = 12
20 - 39% = 59
40 - 59% = 38
60 - 79% = 367
80 - 99% = 1064

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 126, nodes: 137712
Average data length: 0.01, total dup: 137663, max dup: 29470
Fill distribution:
0 - 19% = 2
20 - 39% = 7
40 - 59% = 77
60 - 79% = 19
80 - 99% = 21

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 150, nodes: 137712
Average data length: 0.92, total dup: 123537, max dup: 41
Fill distribution:
0 - 19% = 0
20 - 39% = 6
40 - 59% = 87
60 - 79% = 36
80 - 99% = 21

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 161, nodes: 137712
Average data length: 0.92, total dup: 123537, max dup: 41
Fill distribution:
0 - 19% = 0
20 - 39% = 8
40 - 59% = 100
60 - 79% = 37
80 - 99% = 16

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 141, nodes: 137712
Average data length: 0.69, total dup: 123537, max dup: 41
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 70
60 - 79% = 48
80 - 99% = 17

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 16, nodes: 23672
Average data length: 0.01, total dup: 23493, max dup: 1297
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 5
60 - 79% = 5
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: 144.94, total records: 1334390
Average version length: 153.00, total versions: 1, max versions: 1
Data pages: 30569, data page slots: 30569, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 30568

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1653, nodes: 1334390
Average data length: 0.62, total dup: 732808, max dup: 30
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1228
60 - 79% = 274
80 - 99% = 150

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1639, nodes: 1334390
Average data length: 0.36, total dup: 1259878, max dup: 3110
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1379
60 - 79% = 160
80 - 99% = 100

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1521, nodes: 1334390
Average data length: 0.44, total dup: 1275732, max dup: 143568
Fill distribution:
0 - 19% = 4
20 - 39% = 1
40 - 59% = 1083
60 - 79% = 212
80 - 99% = 221

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: 49.73, total records: 90378
Average version length: 54.68, total versions: 8341, max versions: 1
Data pages: 1055, data page slots: 1055, average fill: 77%
Fill distribution:
0 - 19% = 1
20 - 39% = 2
40 - 59% = 5
60 - 79% = 942
80 - 99% = 105

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 111, nodes: 90378
Average data length: 1.12, total dup: 75083, max dup: 245
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 105
60 - 79% = 6
80 - 99% = 0

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 83, nodes: 90378
Average data length: 0.65, total dup: 81854, max dup: 73
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 32
60 - 79% = 40
80 - 99% = 9

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: 956, max versions: 483
Data pages: 4, data page slots: 4, average fill: 77%
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.59, total records: 324
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 4, data page slots: 4, average fill: 76%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
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.41, total records: 233291
Average version length: 69.84, total versions: 231921, max versions: 1
Data pages: 3127, data page slots: 3424, average fill: 95%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 5
80 - 99% = 3121

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 295, nodes: 233291
Average data length: 1.23, total dup: 204432, max dup: 44
Fill distribution:
0 - 19% = 5
20 - 39% = 15
40 - 59% = 141
60 - 79% = 87
80 - 99% = 47

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 53.42, total records: 254835
Average version length: 69.17, total versions: 59557, max versions: 1
Data pages: 3538, data page slots: 3553, average fill: 80%
Fill distribution:
0 - 19% = 24
20 - 39% = 28
40 - 59% = 54
60 - 79% = 1461
80 - 99% = 1971

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 247, nodes: 254835
Average data length: 0.16, total dup: 248834, max dup: 185
Fill distribution:
0 - 19% = 1
20 - 39% = 33
40 - 59% = 128
60 - 79% = 10
80 - 99% = 75

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 302, nodes: 254835
Average data length: 1.26, total dup: 223201, max dup: 37
Fill distribution:
0 - 19% = 1
20 - 39% = 2
40 - 59% = 141
60 - 79% = 99
80 - 99% = 59

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 1.60, total records: 315505
Average version length: 69.81, total versions: 308264, max versions: 1
Data pages: 4239, data page slots: 4239, average fill: 94%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 33
80 - 99% = 4206

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 355, nodes: 315505
Average data length: 0.92, total dup: 286689, max dup: 185
Fill distribution:
0 - 19% = 5
20 - 39% = 0
40 - 59% = 159
60 - 79% = 129
80 - 99% = 62

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 17.22, total records: 1080971
Average version length: 68.38, total versions: 813792, max versions: 1
Data pages: 14565, data page slots: 14565, average fill: 90%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3220
80 - 99% = 11344

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1380, nodes: 1080971
Average data length: 1.10, total dup: 959008, max dup: 89
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 1091
60 - 79% = 115
80 - 99% = 171

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 5.87, total records: 130480
Average version length: 69.27, total versions: 119375, max versions: 1
Data pages: 2440, data page slots: 4336, average fill: 68%
Fill distribution:
0 - 19% = 362
20 - 39% = 160
40 - 59% = 169
60 - 79% = 308
80 - 99% = 1441

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 279, nodes: 130480
Average data length: 1.48, total dup: 112194, max dup: 129
Fill distribution:
0 - 19% = 0
20 - 39% = 165
40 - 59% = 105
60 - 79% = 7
80 - 99% = 2

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 38.43, total records: 773338
Average version length: 68.39, total versions: 342255, max versions: 1
Data pages: 10867, data page slots: 10905, average fill: 81%
Fill distribution:
0 - 19% = 120
20 - 39% = 196
40 - 59% = 312
60 - 79% = 3599
80 - 99% = 6640

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1091, nodes: 773338
Average data length: 1.34, total dup: 667707, max dup: 41
Fill distribution:
0 - 19% = 0
20 - 39% = 18
40 - 59% = 857
60 - 79% = 118
80 - 99% = 98

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.19, total records: 1006347
Average version length: 80.90, total versions: 30928, max versions: 1
Data pages: 15024, data page slots: 15024, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 6372
80 - 99% = 8651

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1119, nodes: 1006347
Average data length: 0.16, total dup: 983552, max dup: 161
Fill distribution:
0 - 19% = 9
20 - 39% = 0
40 - 59% = 820
60 - 79% = 252
80 - 99% = 38

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 807, nodes: 1006347
Average data length: 0.72, total dup: 884827, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 1
40 - 59% = 140
60 - 79% = 28
80 - 99% = 635

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1263, nodes: 1006347
Average data length: 0.74, total dup: 881397, max dup: 44
Fill distribution:
0 - 19% = 10
20 - 39% = 0
40 - 59% = 902
60 - 79% = 303
80 - 99% = 48

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 68.28, total records: 636212
Average version length: 80.09, total versions: 95351, max versions: 1
Data pages: 9649, data page slots: 9675, average fill: 81%
Fill distribution:
0 - 19% = 53
20 - 39% = 86
40 - 59% = 124
60 - 79% = 4706
80 - 99% = 4680

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 646, nodes: 636212
Average data length: 0.15, total dup: 622450, max dup: 257
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 352
60 - 79% = 231
80 - 99% = 61

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 530, nodes: 636212
Average data length: 0.84, total dup: 550995, max dup: 14
Fill distribution:
0 - 19% = 6
20 - 39% = 14
40 - 59% = 95
60 - 79% = 4
80 - 99% = 411

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 772, nodes: 636212
Average data length: 0.71, total dup: 563117, max dup: 44
Fill distribution:
0 - 19% = 30
20 - 39% = 0
40 - 59% = 425
60 - 79% = 276
80 - 99% = 41

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 74.44, total records: 1075339
Average version length: 82.12, total versions: 83369, max versions: 1
Data pages: 16062, data page slots: 16062, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7371
80 - 99% = 8691

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1109, nodes: 1075339
Average data length: 0.05, total dup: 1069095, max dup: 883
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 717
60 - 79% = 285
80 - 99% = 106

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 798, nodes: 1075339
Average data length: 0.67, total dup: 953190, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 53
60 - 79% = 9
80 - 99% = 735

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1244, nodes: 1075339
Average data length: 0.68, total dup: 954221, max dup: 185
Fill distribution:
0 - 19% = 4
20 - 39% = 2
40 - 59% = 754
60 - 79% = 330
80 - 99% = 154

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.02, total records: 809707
Average version length: 80.21, total versions: 96021, max versions: 1
Data pages: 12521, data page slots: 12568, average fill: 79%
Fill distribution:
0 - 19% = 156
20 - 39% = 237
40 - 59% = 292
60 - 79% = 5254
80 - 99% = 6582

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 742, nodes: 809707
Average data length: 0.05, total dup: 805177, max dup: 878
Fill distribution:
0 - 19% = 1
20 - 39% = 12
40 - 59% = 253
60 - 79% = 324
80 - 99% = 152

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 801, nodes: 809707
Average data length: 0.87, total dup: 698195, max dup: 14
Fill distribution:
0 - 19% = 26
20 - 39% = 39
40 - 59% = 301
60 - 79% = 6
80 - 99% = 429

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 850, nodes: 809707
Average data length: 0.68, total dup: 719642, max dup: 77
Fill distribution:
0 - 19% = 0
20 - 39% = 13
40 - 59% = 280
60 - 79% = 373
80 - 99% = 184

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 57.53, total records: 336073
Average version length: 68.21, total versions: 53470, max versions: 1
Data pages: 4525, data page slots: 4525, average fill: 80%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1
60 - 79% = 3204
80 - 99% = 1319

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 306, nodes: 336073
Average data length: 0.22, total dup: 325346, max dup: 221
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 116
60 - 79% = 108
80 - 99% = 82

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 359, nodes: 336073
Average data length: 0.82, total dup: 292426, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 152
60 - 79% = 139
80 - 99% = 68

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 5240 ms, from 23:58:21.85 to 23:58:27.09.

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 480342 21736 4.5251
DOC_LIST 84254 9763 11.5875
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 90950 22737.5000
INVNT_TURNOVER_LOG 153233 152639 99.6123
MONEY_SALDO 49 4922 10044.8979
MONEY_TURNOVER_LOG 7224 7217 99.9031
OPTYPES 9 0 0.0000
PDISTR 137712 92408 67.1023
PERF_ESTIMATED 23672 2 0.0084
PERF_LOG 1334390 1 0.0000
PSTORNED 90378 8341 9.2290
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 956 23900.0000
SETTINGS 114 0 0.0000
TRACE_STAT 324 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 233291 231921 99.4127
XQD_1000_3300 254835 59557 23.3708
XQD_1200_2000 315505 308264 97.7049
XQD_2000_3300 1080971 813792 75.2834
XQD_2100_3300 130480 119375 91.4891
XQD_3300_3400 773338 342255 44.2568
XQS_1000_1200 1006347 30928 3.0732
XQS_1000_3300 636212 95351 14.9872
XQS_1200_2000 1075339 83369 7.7528
XQS_2100_3300 809707 96021 11.8587
XQS_3300_3400 336073 53470 15.9102
Z_USED_VIEWS 32 0 0.0000
Done for 2320 ms, from 23:58:36.50 to 23:58:38.82.

Database validation

23:58:38.92 Validation started

23:58:38.92 Relation 140 (DOC_LIST)
23:58:38.92 process pointer page 0 of 1
23:58:38.96 Index 1 (PK_DOC_LIST)
23:58:38.98 Index 2 (DOC_LIST_ID_DESC)
23:58:39.01 Index 3 (FK_DOC_LIST_AGENTS)
23:58:39.04 Relation 140 (DOC_LIST) is ok

23:58:39.04 Relation 141 (DOC_DATA)
23:58:39.04 process pointer page 0 of 3
23:58:39.13 process pointer page 1 of 3
23:58:39.24 process pointer page 2 of 3
23:58:39.32 Index 2 (DOC_DATA_DOC_WARE_UNQ)
23:58:39.45 Index 3 (DOC_DATA_ID_DESC)
23:58:39.62 Index 4 (FK_DOC_DATA_DOC_LIST)
23:58:39.74 Relation 141 (DOC_DATA) is ok

23:58:39.74 Relation 147 (INVNT_SALDO)
23:58:39.74 process pointer page 0 of 1
23:58:39.87 Index 1 (PK_INVNT_SALDO)
23:58:39.87 Relation 147 (INVNT_SALDO) is ok

23:58:39.87 Relation 150 (PDISTR)
23:58:39.87 process pointer page 0 of 1
23:58:39.96 Index 2 (PDISTR_SND_ID)
23:58:40.01 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
23:58:40.04 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
23:58:40.05 Index 5 (PDISTR_AGENT_ID)
23:58:40.05 Relation 150 (PDISTR) is ok

23:58:40.05 Relation 151 (PSTORNED)
23:58:40.05 process pointer page 0 of 1
23:58:40.10 Index 2 (PSTORNED_SND_ID)
23:58:40.12 Index 3 (PSTORNED_RCV_ID)
23:58:40.13 Relation 151 (PSTORNED) is ok

23:58:40.13 Relation 156 (SEMAPHORES)
23:58:40.13 process pointer page 0 of 1
23:58:40.15 Index 1 (PK_SEMAPHORES)
23:58:40.15 Index 2 (SEMAPHORES_TASK_UNQ)
23:58:40.15 Relation 156 (SEMAPHORES) is ok

23:58:40.15 Relation 157 (INVNT_TURNOVER_LOG)
23:58:40.15 process pointer page 0 of 2
23:58:40.29 process pointer page 1 of 2
23:58:40.37 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
23:58:40.46 Relation 157 (INVNT_TURNOVER_LOG) is ok

23:58:40.46 Relation 160 (PERF_ESTIMATED)
23:58:40.46 process pointer page 0 of 1
23:58:40.48 Index 1 (PERF_EST_MINUTE_SINCE_START)
23:58:40.48 Relation 160 (PERF_ESTIMATED) is ok

23:58:40.48 Relation 161 (PERF_ISQL_STAT)
23:58:40.48 process pointer page 0 of 1
23:58:40.48 Index 1 (PERF_ISQL_STAT_TRN)
23:58:40.48 Relation 161 (PERF_ISQL_STAT) is ok

23:58:40.48 Relation 162 (PERF_LOG)
23:58:40.48 process pointer page 0 of 16
23:58:40.55 process pointer page 1 of 16
23:58:40.63 process pointer page 2 of 16
23:58:40.71 process pointer page 3 of 16
23:58:40.77 process pointer page 4 of 16
23:58:40.85 process pointer page 5 of 16
23:58:40.93 process pointer page 6 of 16
23:58:41.01 process pointer page 7 of 16
23:58:41.08 process pointer page 8 of 16
23:58:41.15 process pointer page 9 of 16
23:58:41.22 process pointer page 10 of 16
23:58:41.29 process pointer page 11 of 16
23:58:41.36 process pointer page 12 of 16
23:58:41.43 process pointer page 13 of 16
23:58:41.50 process pointer page 14 of 16
23:58:41.57 process pointer page 15 of 16
23:58:41.63 Index 1 (PERF_LOG_DTS_BEG_DESC)
23:58:42.07 Index 2 (PERF_LOG_UNIT)
23:58:42.77 Index 3 (PERF_LOG_TRN_DESC)
23:58:43.06 Index 4 (PERF_LOG_GDSCODE)
23:58:43.35 Relation 162 (PERF_LOG) is ok

23:58:43.35 Relation 166 (V_STOPTEST)
23:58:43.35 Relation 166 (V_STOPTEST) is ok

23:58:43.35 Relation 183 (V_QDISTR_SOURCE)
23:58:43.35 Relation 183 (V_QDISTR_SOURCE) is ok

23:58:43.35 Relation 184 (V_QSTORNED_SOURCE)
23:58:43.35 Relation 184 (V_QSTORNED_SOURCE) is ok

23:58:43.35 Relation 258 (XQD_1000_1200)
23:58:43.35 process pointer page 0 of 2
23:58:43.47 process pointer page 1 of 2
23:58:43.61 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
23:58:43.69 Relation 258 (XQD_1000_1200) is ok

23:58:43.69 Relation 259 (XQD_1200_2000)
23:58:43.69 process pointer page 0 of 3
23:58:43.88 process pointer page 1 of 3
23:58:44.05 process pointer page 2 of 3
23:58:44.10 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
23:58:44.18 Relation 259 (XQD_1200_2000) is ok

23:58:44.18 Relation 260 (XQD_1000_3300)
23:58:44.18 process pointer page 0 of 2
23:58:44.29 process pointer page 1 of 2
23:58:44.38 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
23:58:44.46 Index 2 (XQD_1000_3300_DOC)
23:58:44.52 Relation 260 (XQD_1000_3300) is ok

23:58:44.52 Relation 261 (XQD_2000_3300)
23:58:44.52 process pointer page 0 of 8
23:58:44.71 process pointer page 1 of 8
23:58:44.88 process pointer page 2 of 8
23:58:45.07 process pointer page 3 of 8
23:58:45.23 process pointer page 4 of 8
23:58:45.32 process pointer page 5 of 8
23:58:45.44 process pointer page 6 of 8
23:58:45.57 process pointer page 7 of 8
23:58:45.63 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
23:58:45.91 Relation 261 (XQD_2000_3300) is ok

23:58:45.91 Relation 262 (XQD_2100_3300)
23:58:45.91 process pointer page 0 of 3
23:58:45.93 process pointer page 1 of 3
23:58:46.05 process pointer page 2 of 3
23:58:46.08 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
23:58:46.15 Relation 262 (XQD_2100_3300) is ok

23:58:46.15 Relation 263 (XQD_3300_3400)
23:58:46.15 process pointer page 0 of 6
23:58:46.30 process pointer page 1 of 6
23:58:46.46 process pointer page 2 of 6
23:58:46.58 process pointer page 3 of 6
23:58:46.71 process pointer page 4 of 6
23:58:46.80 process pointer page 5 of 6
23:58:46.86 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
23:58:47.13 Relation 263 (XQD_3300_3400) is ok

23:58:47.13 Relation 264 (XQS_1000_1200)
23:58:47.13 process pointer page 0 of 8
23:58:47.22 process pointer page 1 of 8
23:58:47.32 process pointer page 2 of 8
23:58:47.41 process pointer page 3 of 8
23:58:47.49 process pointer page 4 of 8
23:58:47.58 process pointer page 5 of 8
23:58:47.64 process pointer page 6 of 8
23:58:47.67 process pointer page 7 of 8
23:58:47.71 Index 1 (XQS_1000_1200_DOC_ID)
23:58:47.96 Index 2 (XQS_1000_1200_SND_ID)
23:58:48.25 Index 3 (XQS_1000_1200_RCV_ID)
23:58:48.49 Relation 264 (XQS_1000_1200) is ok

23:58:48.49 Relation 265 (XQS_1200_2000)
23:58:48.50 process pointer page 0 of 9
23:58:48.58 process pointer page 1 of 9
23:58:48.67 process pointer page 2 of 9
23:58:48.75 process pointer page 3 of 9
23:58:48.84 process pointer page 4 of 9
23:58:48.94 process pointer page 5 of 9
23:58:49.03 process pointer page 6 of 9
23:58:49.13 process pointer page 7 of 9
23:58:49.25 process pointer page 8 of 9
23:58:49.28 Index 1 (XQS_1200_2000_DOC_ID)
23:58:49.56 Index 2 (XQS_1200_2000_SND_ID)
23:58:49.87 Index 3 (XQS_1200_2000_RCV_ID)
23:58:50.11 Relation 265 (XQS_1200_2000) is ok

23:58:50.11 Relation 266 (XQS_1000_3300)
23:58:50.12 process pointer page 0 of 6
23:58:50.22 process pointer page 1 of 6
23:58:50.33 process pointer page 2 of 6
23:58:50.42 process pointer page 3 of 6
23:58:50.53 process pointer page 4 of 6
23:58:50.59 process pointer page 5 of 6
23:58:50.59 Index 1 (XQS_1000_3300_DOC_ID)
23:58:50.65 Index 2 (XQS_1000_3300_SND_ID)
23:58:50.72 Index 3 (XQS_1000_3300_RCV_ID)
23:58:50.86 Relation 266 (XQS_1000_3300) is ok

23:58:50.86 Relation 267 (XQS_2000_3300)
23:58:50.86 process pointer page 0 of 1
23:58:50.86 Index 1 (XQS_2000_3300_DOC_ID)
23:58:50.86 Index 2 (XQS_2000_3300_SND_ID)
23:58:50.86 Index 3 (XQS_2000_3300_RCV_ID)
23:58:50.86 Relation 267 (XQS_2000_3300) is ok

23:58:50.86 Relation 268 (XQS_2100_3300)
23:58:50.86 process pointer page 0 of 7
23:58:50.97 process pointer page 1 of 7
23:58:51.04 process pointer page 2 of 7
23:58:51.09 process pointer page 3 of 7
23:58:51.18 process pointer page 4 of 7
23:58:51.28 process pointer page 5 of 7
23:58:51.37 process pointer page 6 of 7
23:58:51.42 Index 1 (XQS_2100_3300_DOC_ID)
23:58:51.68 Index 2 (XQS_2100_3300_SND_ID)
23:58:51.81 Index 3 (XQS_2100_3300_RCV_ID)
23:58:51.93 Relation 268 (XQS_2100_3300) is ok

23:58:51.93 Relation 269 (XQS_3300_3400)
23:58:51.93 process pointer page 0 of 3
23:58:52.04 process pointer page 1 of 3
23:58:52.15 process pointer page 2 of 3
23:58:52.18 Index 1 (XQS_3300_3400_DOC_ID)
23:58:52.26 Index 2 (XQS_3300_3400_SND_ID)
23:58:52.34 Relation 269 (XQS_3300_3400) is ok

23:58:52.34 Relation 276 (TRACE_STAT)
23:58:52.34 process pointer page 0 of 1
23:58:52.34 Relation 276 (TRACE_STAT) is ok

23:58:52.34 Validation finished
Done for 13510 ms, from 23:58:38.84 to 23:58:52.35.

Differences between old and current firebird.log

23:58:52.92. 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-03-27 23:58 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 302 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-03-27 23:58:55.16 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html