Firebird 2.5 Performance Logs

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-06-01 2:56:29.27.
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.27014 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-06-01 02:56:06.6680 -1 <null> 127.0.0.1 79364 4252 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: 146.03 195313 26285 2016-05-31 23:56 2016-06-01 02:56
customer order: creation 17.84 319 3194 2016-05-31 23:56 2016-06-01 02:56
customer order: refuse 1.28 30 229 2016-05-31 23:56 2016-06-01 02:56
order to supplier: creation 4.62 4849 827 2016-05-31 23:56 2016-06-01 02:56
order to supplier: removal 0.08 228022 14 2016-05-31 23:56 2016-06-01 02:56
invoice (draft): creation 4.46 2166 798 2016-05-31 23:56 2016-06-01 02:56
invoice (draft): removal 0.84 75 151 2016-05-31 23:56 2016-06-01 02:56
invoice accept: apply 0.72 3211403 128 2016-05-31 23:56 2016-06-01 02:56
invoice accept: cancel 0.16 207254 28 2016-05-31 23:56 2016-06-01 02:56
customer reserve: creation 89.60 30740 16038 2016-05-31 23:56 2016-06-01 02:56
customer reserve: removal 3.23 19815 581 2016-05-31 23:56 2016-06-01 02:56
realization accept: apply 8.30 43 1486 2016-05-31 23:56 2016-06-01 02:56
realization accept: cancel 1.71 31 294 2016-05-31 23:56 2016-06-01 02:56
payment from customer: creation 5.86 79 1049 2016-05-31 23:56 2016-06-01 02:56
payment from customer: removal 0.57 16 102 2016-05-31 23:56 2016-06-01 02:56
payment to supplier: creation 4.80 199 860 2016-05-31 23:56 2016-06-01 02:56
payment to supplier: removal 0.34 17 61 2016-05-31 23:56 2016-06-01 02:56
service: total inventory turnovers 1.36 4110 244 2016-05-31 23:56 2016-06-01 02:56
service: total monetary turnovers 1.07 10 191 2016-05-31 23:56 2016-06-01 02:56
service: refresh index statistics 0.06 1771 10 2016-05-31 23:56 2016-06-01 02:56
Done for 4570 ms, from 2:56:43.47 to 2:56:48.04.

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 368 7382 6632 750 10.16 23:56:07 00:14:05
interval # 2, overall 2 183 3501 3290 211 6.03 00:14:06 00:32:04
interval # 3, overall 3 212 3968 3807 161 4.06 00:32:05 00:50:03
interval # 4, overall 4 135 2842 2425 417 14.67 00:50:04 01:08:02
interval # 5, overall 5 88 1628 1587 41 2.52 01:08:03 01:26:01
interval # 6, overall 6 114 2179 2060 119 5.46 01:26:02 01:44:00
interval # 7, overall 7 131 2338 2233 105 4.49 01:44:01 02:01:59
interval # 8, overall 8 86 1513 1456 57 3.77 02:02:00 02:19:58
interval # 9, overall 9 84 1573 1520 53 3.37 02:19:59 02:37:57
interval # 10, overall 10 71 1333 1275 58 4.35 02:37:58 02:55:56
Done for 6740 ms, from 2:56:52.18 to 2:56:58.92.

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 1917.42 0.7317 1.2923 926 91
WARM_TIME 2 1465.44 0.8458 1.1955 575 75
WARM_TIME 3 1262.81 0.9251 1.0737 503 62
WARM_TIME 4 1198.97 0.8667 1.0911 367 61
WARM_TIME 5 1103.47 0.9486 1.0392 254 53
WARM_TIME 6 1001.56 0.9541 1.0541 356 49
WARM_TIME 7 969.52 0.9335 1.0616 263 60
WARM_TIME 8 927.23 0.9714 1.0287 417 59
WARM_TIME 9 874.38 0.9698 1.0367 423 53
WARM_TIME 10 840.60 0.9707 1.0293 554 53
TEST_TIME 11 816.81 0.9631 1.0362 713 46
TEST_TIME 12 815.26 0.9518 1.0541 1025 31
TEST_TIME 13 812.09 0.9769 1.0244 540 15
TEST_TIME 14 793.42 0.9737 1.0207 351 11
TEST_TIME 15 761.71 0.9924 1.0062 113 4
TEST_TIME 16 719.54 0.9987 1.0013 34 3
TEST_TIME 17 681.71 0.9947 1.0057 111 2
TEST_TIME 18 650.82 0.9950 1.0062 73 2
TEST_TIME 19 621.99 0.9975 1.0022 63 2
TEST_TIME 20 606.34 0.9884 1.0104 137 2
TEST_TIME 21 589.99 0.9891 1.0161 200 4
TEST_TIME 22 576.00 0.9935 1.0044 111 4
TEST_TIME 23 555.66 0.9959 1.0046 96 2
TEST_TIME 24 535.04 1.0000 1.0000 1 1
TEST_TIME 25 515.39 0.9990 1.0009 28 1
TEST_TIME 26 497.79 0.9965 1.0096 12 2
TEST_TIME 27 484.08 0.9998 1.0001 4 1
TEST_TIME 28 470.82 0.9937 1.0067 85 3
TEST_TIME 29 458.99 0.9990 1.0009 29 3
TEST_TIME 31 433.80 0.9993 1.0005 5 1
TEST_TIME 33 409.31 0.9985 1.0014 43 1
TEST_TIME 34 401.12 0.9919 1.0100 90 3
TEST_TIME 35 395.12 0.9961 1.0032 57 3
TEST_TIME 36 388.40 0.9923 1.0037 78 4
TEST_TIME 37 380.82 0.9961 1.0150 62 2
TEST_TIME 38 376.66 0.9992 1.0008 25 1
TEST_TIME 39 368.27 0.9974 1.0026 85 2
TEST_TIME 40 361.78 0.9994 1.0006 18 1
TEST_TIME 41 357.89 0.9887 1.0046 7 2
TEST_TIME 43 347.22 0.9998 1.0001 8 1
TEST_TIME 44 341.63 0.9934 1.0052 164 2
TEST_TIME 45 335.82 1.0000 1.0000 1 1
TEST_TIME 46 330.00 0.9955 1.0036 46 2
TEST_TIME 48 319.46 0.9971 1.0030 99 1
TEST_TIME 49 317.08 0.9950 1.0024 39 3
TEST_TIME 50 314.00 0.9921 1.0074 66 5
TEST_TIME 51 310.23 0.9997 1.0002 9 1
TEST_TIME 52 306.54 0.9950 1.0073 52 3
TEST_TIME 53 304.55 0.9948 1.0060 102 4
TEST_TIME 54 302.97 0.9926 1.0057 34 3
TEST_TIME 55 302.45 0.9991 1.0010 37 2
TEST_TIME 56 307.52 0.9787 1.0062 73 4
TEST_TIME 57 305.53 0.9950 1.0036 68 4
TEST_TIME 58 303.56 0.9928 1.0056 218 5
TEST_TIME 59 300.58 0.9985 1.0067 54 2
TEST_TIME 60 302.29 0.9896 1.0174 93 4
TEST_TIME 61 306.76 0.9861 1.0060 66 4
TEST_TIME 63 300.34 0.9994 1.0006 27 1
TEST_TIME 64 297.93 0.9930 1.0030 116 2
TEST_TIME 65 295.67 0.9972 1.0025 73 3
TEST_TIME 66 293.48 0.9998 1.0002 8 1
TEST_TIME 67 290.02 0.9987 1.0071 50 3
TEST_TIME 68 287.85 0.9998 1.0002 8 1
TEST_TIME 69 285.60 0.9935 1.0030 24 3
TEST_TIME 70 282.80 0.9985 1.0014 61 2
TEST_TIME 71 279.92 0.9995 1.0004 21 2
TEST_TIME 72 276.94 0.9997 1.0002 9 2
TEST_TIME 73 276.04 0.9897 1.0030 57 5
TEST_TIME 74 273.40 0.9991 1.0009 41 2
TEST_TIME 75 271.95 0.9996 1.0003 15 1
TEST_TIME 77 266.53 0.9998 1.0002 10 1
TEST_TIME 78 265.81 0.9901 1.0039 153 3
TEST_TIME 79 263.89 0.9984 1.0015 69 1
TEST_TIME 83 251.75 0.9992 1.0060 21 2
TEST_TIME 84 254.44 0.9883 1.0057 144 5
TEST_TIME 85 252.94 0.9998 1.0002 10 1
TEST_TIME 86 251.57 0.9998 1.0001 9 1
TEST_TIME 87 249.04 0.9989 1.0010 46 1
TEST_TIME 88 248.28 0.9973 1.0044 35 2
TEST_TIME 90 244.91 0.9992 1.0008 36 1
TEST_TIME 91 242.42 1.0000 1.0000 2 1
TEST_TIME 94 234.96 0.9989 1.0037 34 2
TEST_TIME 97 229.95 0.9996 1.0004 18 1
TEST_TIME 100 224.55 0.9996 1.0003 18 1
TEST_TIME 101 222.45 0.9998 1.0002 14 1
TEST_TIME 102 222.11 0.9992 1.0007 31 1
TEST_TIME 103 222.99 0.9908 1.0062 106 3
TEST_TIME 104 223.11 0.9961 1.0056 129 5
TEST_TIME 105 223.34 0.9950 1.0014 51 2
TEST_TIME 106 222.54 0.9980 1.0018 101 2
TEST_TIME 108 220.30 0.9974 1.0022 105 2
TEST_TIME 109 218.88 0.9995 1.0004 25 1
TEST_TIME 110 217.16 0.9997 1.0002 12 1
TEST_TIME 111 215.34 0.9999 1.0000 6 1
TEST_TIME 114 212.22 0.9948 1.0111 115 3
TEST_TIME 115 212.79 0.9997 1.0003 17 2
TEST_TIME 117 210.40 0.9987 1.0013 71 1
TEST_TIME 118 209.49 0.9971 1.0017 8 2
TEST_TIME 119 208.70 0.9971 1.0011 21 2
TEST_TIME 120 207.39 0.9991 1.0009 47 2
TEST_TIME 121 205.96 0.9995 1.0005 28 1
TEST_TIME 124 202.49 0.9974 1.0042 54 3
TEST_TIME 125 205.05 0.9968 1.0035 142 4
TEST_TIME 126 204.19 0.9998 1.0001 11 1
TEST_TIME 127 203.56 0.9977 1.0024 127 2
TEST_TIME 128 202.51 0.9998 1.0002 13 1
TEST_TIME 129 202.29 0.9999 1.0001 8 2
TEST_TIME 130 203.94 0.9895 1.0036 171 5
TEST_TIME 131 204.33 0.9940 1.0031 177 4
TEST_TIME 132 205.91 0.9940 1.0045 26 3
TEST_TIME 133 205.93 0.9968 1.0057 77 3
TEST_TIME 134 207.46 0.9908 1.0034 104 3
TEST_TIME 137 204.82 0.9950 1.0016 18 2
TEST_TIME 138 203.73 0.9997 1.0003 18 1
TEST_TIME 139 203.09 1.0000 1.0000 3 1
TEST_TIME 141 201.91 0.9991 1.0009 42 2
TEST_TIME 142 200.86 0.9991 1.0006 20 2
TEST_TIME 143 200.47 0.9995 1.0004 27 1
TEST_TIME 144 201.95 0.9929 1.0031 8 3
TEST_TIME 145 202.05 0.9957 1.0019 59 3
TEST_TIME 146 201.66 0.9970 1.0046 32 3
TEST_TIME 147 201.55 0.9984 1.0069 50 3
TEST_TIME 148 201.64 0.9997 1.0003 20 2
TEST_TIME 149 200.43 0.9996 1.0003 20 1
TEST_TIME 150 201.92 0.9930 1.0015 50 2
TEST_TIME 153 198.71 1.0000 1.0001 4 1
TEST_TIME 154 197.52 0.9995 1.0004 25 1
TEST_TIME 155 196.42 0.9995 1.0004 29 1
TEST_TIME 157 194.66 1.0000 1.0000 2 1
TEST_TIME 159 193.38 0.9998 1.0001 9 2
TEST_TIME 160 194.25 0.9957 1.0010 35 2
TEST_TIME 161 193.27 0.9998 1.0001 9 2
TEST_TIME 162 192.15 0.9997 1.0005 9 2
TEST_TIME 163 191.51 0.9977 1.0030 19 2
TEST_TIME 165 190.69 0.9952 1.0064 69 3
TEST_TIME 166 190.79 0.9998 1.0001 10 1
TEST_TIME 167 190.18 0.9998 1.0002 15 1
TEST_TIME 168 189.70 0.9968 1.0021 82 3
TEST_TIME 169 189.19 0.9988 1.0017 75 4
TEST_TIME 170 189.71 0.9998 1.0002 13 1
TEST_TIME 171 189.32 0.9964 1.0014 76 3
TEST_TIME 172 188.50 0.9999 1.0001 6 2
TEST_TIME 173 188.02 0.9968 1.0031 71 4
TEST_TIME 174 188.98 0.9923 1.0022 129 4
TEST_TIME 175 188.61 0.9985 1.0014 104 2
TEST_TIME 176 188.97 0.9972 1.0027 35 3
TEST_TIME 177 189.05 0.9966 1.0005 8 2
TEST_TIME 178 188.84 0.9998 1.0002 13 1
TEST_TIME 179 189.95 0.9919 1.0076 43 2
TEST_TIME 180 190.61 0.9986 1.0019 80 4
TEST_TIME 181 192.09 0.9888 1.0026 130 4
TEST_TIME 182 192.51 0.9949 1.0032 47 5
TEST_TIME 183 193.60 0.9991 1.0003 9 2
TEST_TIME 184 193.35 0.9995 1.0003 20 1
TEST_TIME 187 191.21 0.9998 1.0002 16 1
TEST_TIME 188 190.38 0.9992 1.0008 63 1
TEST_TIME 189 190.98 0.9924 1.0016 110 2
TEST_TIME 190 190.28 1.0000 1.0000 200 100
Done for 9340 ms, from 2:56:59.18 to 2:57:08.52.

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 3 80084 <null> 46921 <null> 73986 <null> 1791 <null> <null> <null> <null> <null> <null> <null> <null> <null> 132376 <null> 4399 00:32:05 00:50:03
marks per second 3 15364 <null> 3781 <null> 5800 <null> 209 <null> <null> <null> <null> <null> <null> <null> <null> <null> 1139 <null> 410 00:32:05 00:50:03
reads/fetches*100 3 4 <null> 5 <null> 6 <null> 12 <null> <null> <null> <null> <null> <null> <null> <null> <null> 23 <null> 1 00:32:05 00:50:03
writes/marks*100 3 11 <null> 17 <null> 8 <null> 1 <null> <null> <null> <null> <null> <null> <null> <null> <null> 46 <null> 0 00:32:05 00:50:03
Done for 4320 ms, from 2:57:08.77 to 2:57:13.09.

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 25122 23889 1233 4.90 0 4690 21 1233 2016-05-31 23:56 2016-06-01 02:56
doc_list_biud 25155 23887 1268 5.04 0 290914 829 1268 2016-05-31 23:56 2016-06-01 02:56
sp_add_invoice_to_stock 659 128 531 80.57 9251 10265833 3211403 531 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_adding_invoice 78 28 50 64.10 172 1145601 207254 50 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_client_order 248 229 19 7.66 0 375 30 19 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_customer_reserve 1483 581 902 60.82 15 234175 19815 902 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_pay_from_customer 103 102 1 0.97 0 47 16 1 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_pay_to_supplier 62 61 1 1.61 0 62 17 1 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_supplier_invoice 187 151 36 19.25 0 499 75 36 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_supplier_order 62 14 48 77.41 31 2201664 228022 48 2016-05-31 23:56 2016-06-01 02:56
sp_cancel_write_off 625 294 331 52.96 0 140 31 331 2016-05-31 23:56 2016-06-01 02:56
sp_client_order 3194 3194 0 0.00 0 14040 319 0 2016-05-31 23:56 2016-06-01 02:56
sp_customer_reserve 16038 16038 0 0.00 94 132087 30740 0 2016-05-31 23:56 2016-06-01 02:56
sp_fill_shopping_cart 4819 4819 0 0.00 0 62683 689 0 2016-05-31 23:56 2016-06-01 02:56
sp_fill_shopping_cart_clo_res 16038 16038 0 0.00 0 62 2 0 2016-05-31 23:56 2016-06-01 02:56
sp_get_clo_for_invoice 130 130 0 0.00 0 156 40 0 2016-05-31 23:56 2016-06-01 02:56
sp_kill_cost_storno 816 485 331 40.56 0 78 5 331 2016-05-31 23:56 2016-06-01 02:56
sp_kill_qstorno_ret_qs2qd 3734 1621 2113 56.58 0 234143 7107 2113 2016-05-31 23:56 2016-06-01 02:56
sp_kill_qty_storno 4164 2911 1253 30.09 0 290914 6799 1253 2016-05-31 23:56 2016-06-01 02:56
sp_lock_selected_doc 3040 2300 740 24.34 0 16 0 740 2016-05-31 23:56 2016-06-01 02:56
sp_make_cost_storno 3525 3525 0 0.00 0 1232 59 0 2016-05-31 23:56 2016-06-01 02:56
sp_multiply_rows_for_pdistr 3525 3525 0 0.00 0 265 6 0 2016-05-31 23:56 2016-06-01 02:56
sp_multiply_rows_for_qdistr 3194 3194 0 0.00 0 13665 280 0 2016-05-31 23:56 2016-06-01 02:56
sp_pay_from_customer 1049 1049 0 0.00 30 452 79 0 2016-05-31 23:56 2016-06-01 02:56
sp_pay_to_supplier 860 860 0 0.00 15 1310 199 0 2016-05-31 23:56 2016-06-01 02:56
sp_payment_common 1909 1909 0 0.00 0 125 23 0 2016-05-31 23:56 2016-06-01 02:56
sp_qd_handle_on_cancel_clo 248 229 19 7.66 0 359 14 19 2016-05-31 23:56 2016-06-01 02:56
sp_qd_handle_on_invoice_upd_sts 176 156 20 11.36 0 290914 52766 20 2016-05-31 23:56 2016-06-01 02:56
sp_qd_handle_on_reserve_upd_sts 1486 1486 0 0.00 0 172 10 0 2016-05-31 23:56 2016-06-01 02:56
sp_reserve_write_off 1539 1486 53 3.44 0 281 43 53 2016-05-31 23:56 2016-06-01 02:56
sp_supplier_invoice 798 798 0 0.00 15 62714 2166 0 2016-05-31 23:56 2016-06-01 02:56
sp_supplier_order 827 827 0 0.00 31 81117 4849 0 2016-05-31 23:56 2016-06-01 02:56
srv_find_qd_qs_mism 13628 12397 1231 9.03 0 4612 20 1231 2016-05-31 23:56 2016-06-01 02:56
srv_make_invnt_saldo 244 244 0 0.00 1233 11623 4110 0 2016-05-31 23:56 2016-06-01 02:56
srv_make_money_saldo 191 191 0 0.00 0 46 10 0 2016-05-31 23:56 2016-06-01 02:56
srv_recalc_idx_stat 10 10 0 0.00 1014 4089 1771 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_add_invoice_to_stock 531 531 0 0.00 0 78 4 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_adding_invoice 117 117 0 0.00 0 187 25 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_client_order 19 19 0 0.00 0 32 7 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_customer_reserve 4 4 0 0.00 0 16 7 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_pay_from_customer 1 1 0 0.00 0 0 0 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_pay_to_supplier 1 1 0 0.00 31 31 31 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_supplier_invoice 33 33 0 0.00 0 31 7 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_supplier_order 123 123 0 0.00 0 94 18 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_cancel_write_off 4 4 0 0.00 0 16 8 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-abend:sp_reserve_write_off 53 53 0 0.00 0 16 2 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_add_invoice_to_stock 162 162 0 0.00 0 734 160 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_adding_invoice 21 21 0 0.00 0 110 46 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_client_order 229 229 0 0.00 0 110 6 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_customer_reserve 100 100 0 0.00 0 62 8 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_pay_from_customer 102 102 0 0.00 0 78 7 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_pay_to_supplier 61 61 0 0.00 0 47 4 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_supplier_invoice 36 36 0 0.00 0 62 6 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_supplier_order 14 14 0 0.00 0 421 68 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_cancel_write_off 123 123 0 0.00 0 171 8 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_client_order 3204 3204 0 0.00 0 203 9 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_customer_reserve 143 143 0 0.00 0 63 9 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_pay_from_customer 1050 1050 0 0.00 0 167 6 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_pay_to_supplier 861 861 0 0.00 0 110 6 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_reserve_write_off 1486 1486 0 0.00 0 172 8 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_supplier_invoice 799 799 0 0.00 0 125 9 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:sp_supplier_order 870 870 0 0.00 0 187 11 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:srv_make_invnt_saldo 245 245 0 0.00 0 16 2 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:srv_make_money_saldo 191 191 0 0.00 0 31 1 0 2016-05-31 23:56 2016-06-01 02:56
t$perf-norm:srv_recalc_idx_stat 10 10 0 0.00 0 16 9 0 2016-05-31 23:56 2016-06-01 02:56
v_add_invoice_to_stock 1318 256 1062 80.57 0 62 4 1062 2016-05-31 23:56 2016-06-01 02:56
v_all_customers 4768 4768 0 0.00 0 16 0 0 2016-05-31 23:56 2016-06-01 02:56
v_all_suppliers 3250 3250 0 0.00 0 16 0 0 2016-05-31 23:56 2016-06-01 02:56
v_all_wares 6388 6388 0 0.00 0 16 0 0 2016-05-31 23:56 2016-06-01 02:56
v_cancel_adding_invoice 134 42 92 68.65 0 31 5 92 2016-05-31 23:56 2016-06-01 02:56
v_cancel_client_order 496 458 38 7.66 0 16 0 38 2016-05-31 23:56 2016-06-01 02:56
v_cancel_customer_prepayment 206 204 2 0.97 0 16 1 2 2016-05-31 23:56 2016-06-01 02:56
v_cancel_customer_reserve 208 200 8 3.84 0 16 1 8 2016-05-31 23:56 2016-06-01 02:56
v_cancel_payment_to_supplier 124 122 2 1.61 0 16 1 2 2016-05-31 23:56 2016-06-01 02:56
v_cancel_supplier_invoice 138 72 66 47.82 0 31 3 66 2016-05-31 23:56 2016-06-01 02:56
v_cancel_supplier_order 124 28 96 77.41 0 0 0 96 2016-05-31 23:56 2016-06-01 02:56
v_cancel_write_off 254 246 8 3.14 0 31 2 8 2016-05-31 23:56 2016-06-01 02:56
v_max_id_clo_ord 828 828 0 0.00 0 655 29 0 2016-05-31 23:56 2016-06-01 02:56
v_max_id_clo_res 143 143 0 0.00 0 31 2 0 2016-05-31 23:56 2016-06-01 02:56
v_max_id_ord_sup 798 798 0 0.00 0 94 7 0 2016-05-31 23:56 2016-06-01 02:56
v_max_non_paid_invoice 860 860 0 0.00 0 47 3 0 2016-05-31 23:56 2016-06-01 02:56
v_max_non_paid_realizn 1049 1049 0 0.00 0 31 5 0 2016-05-31 23:56 2016-06-01 02:56
v_min_id_clo_ord 827 827 0 0.00 0 1024 81 0 2016-05-31 23:56 2016-06-01 02:56
v_min_id_clo_res 143 143 0 0.00 0 16 0 0 2016-05-31 23:56 2016-06-01 02:56
v_min_id_ord_sup 798 798 0 0.00 0 1779 46 0 2016-05-31 23:56 2016-06-01 02:56
v_min_non_paid_invoice 860 860 0 0.00 0 109 17 0 2016-05-31 23:56 2016-06-01 02:56
v_min_non_paid_realizn 1049 1049 0 0.00 0 47 10 0 2016-05-31 23:56 2016-06-01 02:56
v_our_firm 1620 1620 0 0.00 0 16 0 0 2016-05-31 23:56 2016-06-01 02:56
v_reserve_write_off 3078 2972 106 3.44 0 32 0 106 2016-05-31 23:56 2016-06-01 02:56
x_lock_depdocs_on_canc_invoice 275 143 132 48.00 0 16 1 132 2016-05-31 23:56 2016-06-01 02:56
x_lock_depdocs_on_canc_sup_ord 62 14 48 77.41 0 16 4 48 2016-05-31 23:56 2016-06-01 02:56
x_make_qstorno_1000_1200 834 834 0 0.00 0 66230 2948 0 2016-05-31 23:56 2016-06-01 02:56
x_make_qstorno_1200_2000 799 799 0 0.00 0 3994 334 0 2016-05-31 23:56 2016-06-01 02:56
x_make_qstorno_2100_3300 16038 16038 0 0.00 94 132069 30722 0 2016-05-31 23:56 2016-06-01 02:56
Done for 15420 ms, from 2:57:20.14 to 2:57:35.56.

Config param. mon_unit_perf=0, data from MON$ tables were NOT gathered.

Exceptions occured during test work:

FB_MNEMONA CNT UNIT FB_GDSCODE DTS_BEG DTS_END
deadlock 7 sp_kill_cost_storno 335544336 2016-05-31 23:59 2016-06-01 02:25
deadlock 5 sp_qd_handle_on_invoice_upd_sts 335544336 2016-06-01 00:00 2016-06-01 00:44
lock_conflict 2 sp_kill_cost_storno 335544345 2016-05-31 23:56 2016-06-01 01:40
lock_conflict 627 sp_lock_selected_doc 335544345 2016-05-31 23:56 2016-06-01 02:55
lock_conflict 19 sp_qd_handle_on_cancel_clo 335544345 2016-05-31 23:56 2016-06-01 02:50
lock_conflict 13 sp_qd_handle_on_invoice_upd_sts 335544345 2016-05-31 23:56 2016-06-01 02:34
lock_conflict 56 x_lock_depdocs_on_canc_invoice 335544345 2016-05-31 23:56 2016-06-01 02:41
lock_conflict 15 x_lock_depdocs_on_canc_sup_ord 335544345 2016-05-31 23:58 2016-06-01 02:55
Done for 2320 ms, from 2:57:35.91 to 2:57:38.23.

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 84486
MON$OLDEST_ACTIVE 84487
MON$OLDEST_SNAPSHOT 84487
MON$NEXT_TRANSACTION 84487
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 144884
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.6.27014 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.6.27014 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.6.27014 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.6.27014 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 88946
Page size 8192
ODS version 11.2
Oldest transaction 84488
Oldest active 84489
Oldest snapshot 84489
Next transaction 84490
Bumped transaction 1
Sequence number 0
Next attachment ID 4425
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.77, total records: 431190
Average version length: 46.11, total versions: 12307, max versions: 1
Data pages: 4604, data page slots: 4605, average fill: 73%
Fill distribution:
0 - 19% = 4
20 - 39% = 7
40 - 59% = 74
60 - 79% = 4472
80 - 99% = 47

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1351, nodes: 431190
Average data length: 11.59, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 136
20 - 39% = 35
40 - 59% = 454
60 - 79% = 77
80 - 99% = 649

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1269, nodes: 431190
Average data length: 6.00, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 23
40 - 59% = 1245
60 - 79% = 0
80 - 99% = 1

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 391, nodes: 431190
Average data length: 0.82, total dup: 375967, max dup: 49
Fill distribution:
0 - 19% = 3
20 - 39% = 24
40 - 59% = 123
60 - 79% = 12
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.78, total records: 68237
Average version length: 50.75, total versions: 5579, max versions: 6
Data pages: 879, data page slots: 880, average fill: 78%
Fill distribution:
0 - 19% = 3
20 - 39% = 21
40 - 59% = 56
60 - 79% = 297
80 - 99% = 502

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 61, nodes: 68237
Average data length: 0.01, total dup: 68187, max dup: 16767
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 47
60 - 79% = 8
80 - 99% = 5

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 133, nodes: 68237
Average data length: 6.28, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 3
20 - 39% = 22
40 - 59% = 38
60 - 79% = 0
80 - 99% = 70

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

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

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

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

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

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

INVNT_SALDO (147)
Primary pointer page: 216, Index root page: 217
Average record length: 62.72, total records: 400
Average version length: 13.42, total versions: 61964, max versions: 189
Data pages: 246, data page slots: 246, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 245

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.03, total records: 124988
Average version length: 68.42, total versions: 124928, max versions: 1
Data pages: 1816, data page slots: 1819, average fill: 87%
Fill distribution:
0 - 19% = 7
20 - 39% = 19
40 - 59% = 69
60 - 79% = 170
80 - 99% = 1551

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 342, nodes: 124988
Average data length: 8.44, total dup: 12971, max dup: 5
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 180
60 - 79% = 115
80 - 99% = 46

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 14.98, total records: 49
Average version length: 9.00, total versions: 3222, max versions: 252
Data pages: 13, data page slots: 13, average fill: 81%
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 11

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: 5743
Average version length: 44.09, total versions: 5736, max versions: 1
Data pages: 60, data page slots: 60, average fill: 92%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 2
80 - 99% = 58

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

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

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

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

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

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

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

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

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

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

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

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

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

OPTYPES (138)
Primary pointer page: 186, Index root page: 187
Average record length: 67.89, total records: 9
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 9%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

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

PDISTR (150)
Primary pointer page: 241, Index root page: 242
Average record length: 25.33, total records: 121880
Average version length: 31.41, total versions: 79839, max versions: 9
Data pages: 1295, data page slots: 1295, average fill: 86%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 2
60 - 79% = 336
80 - 99% = 956

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 105, nodes: 121880
Average data length: 0.01, total dup: 121831, max dup: 25672
Fill distribution:
0 - 19% = 2
20 - 39% = 3
40 - 59% = 60
60 - 79% = 21
80 - 99% = 19

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 127, nodes: 121880
Average data length: 0.90, total dup: 109526, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 74
60 - 79% = 35
80 - 99% = 17

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 133, nodes: 121880
Average data length: 0.90, total dup: 109526, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 86
60 - 79% = 25
80 - 99% = 21

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 118, nodes: 121880
Average data length: 0.68, total dup: 109526, max dup: 32
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 63
60 - 79% = 37
80 - 99% = 17

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 12, nodes: 16227
Average data length: 0.01, total dup: 16068, max dup: 1319
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
60 - 79% = 9
80 - 99% = 0

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

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1292, nodes: 998946
Average data length: 0.61, total dup: 527040, max dup: 31
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1078
60 - 79% = 155
80 - 99% = 58

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1291, nodes: 998946
Average data length: 0.43, total dup: 931704, max dup: 2108
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1170
60 - 79% = 82
80 - 99% = 39

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1136, nodes: 998946
Average data length: 0.43, total dup: 955680, max dup: 114855
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 819
60 - 79% = 154
80 - 99% = 163

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.74, total records: 83058
Average version length: 54.43, total versions: 4522, max versions: 1
Data pages: 966, data page slots: 966, average fill: 76%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 2
60 - 79% = 915
80 - 99% = 48

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 101, nodes: 83058
Average data length: 1.09, total dup: 69458, max dup: 144
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 96
60 - 79% = 1
80 - 99% = 4

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 76, nodes: 83058
Average data length: 0.61, total dup: 75788, max dup: 70
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 37
60 - 79% = 33
80 - 99% = 6

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

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: 60.11, total records: 36
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 1, data page slots: 1, average fill: 34%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

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

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

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

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

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

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

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

XQD_1000_1200 (258)
Primary pointer page: 645, Index root page: 646
Average record length: 0.22, total records: 194443
Average version length: 69.50, total versions: 193827, max versions: 1
Data pages: 2611, data page slots: 2611, average fill: 94%
Fill distribution:
0 - 19% = 3
20 - 39% = 1
40 - 59% = 1
60 - 79% = 5
80 - 99% = 2601

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 236, nodes: 194443
Average data length: 1.28, total dup: 170206, max dup: 29
Fill distribution:
0 - 19% = 21
20 - 39% = 3
40 - 59% = 94
60 - 79% = 69
80 - 99% = 49

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 49.31, total records: 197510
Average version length: 69.18, total versions: 57330, max versions: 1
Data pages: 2751, data page slots: 2779, average fill: 81%
Fill distribution:
0 - 19% = 36
20 - 39% = 45
40 - 59% = 50
60 - 79% = 1235
80 - 99% = 1385

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 179, nodes: 197510
Average data length: 0.15, total dup: 193165, max dup: 197
Fill distribution:
0 - 19% = 1
20 - 39% = 23
40 - 59% = 81
60 - 79% = 12
80 - 99% = 62

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 232, nodes: 197510
Average data length: 1.29, total dup: 172963, max dup: 29
Fill distribution:
0 - 19% = 2
20 - 39% = 1
40 - 59% = 101
60 - 79% = 99
80 - 99% = 29

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 1.35, total records: 254964
Average version length: 69.42, total versions: 250065, max versions: 1
Data pages: 3439, data page slots: 3439, average fill: 94%
Fill distribution:
0 - 19% = 9
20 - 39% = 6
40 - 59% = 6
60 - 79% = 8
80 - 99% = 3410

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 271, nodes: 254964
Average data length: 0.91, total dup: 232682, max dup: 181
Fill distribution:
0 - 19% = 2
20 - 39% = 2
40 - 59% = 94
60 - 79% = 114
80 - 99% = 59

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 16.25, total records: 951733
Average version length: 68.21, total versions: 728797, max versions: 1
Data pages: 12818, data page slots: 12818, average fill: 90%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 2767
80 - 99% = 10050

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1224, nodes: 951733
Average data length: 1.14, total dup: 840820, max dup: 97
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 924
60 - 79% = 182
80 - 99% = 117

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 3.06, total records: 166773
Average version length: 68.60, total versions: 159360, max versions: 1
Data pages: 3368, data page slots: 3433, average fill: 64%
Fill distribution:
0 - 19% = 171
20 - 39% = 262
40 - 59% = 703
60 - 79% = 1558
80 - 99% = 674

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 240, nodes: 166773
Average data length: 1.53, total dup: 141288, max dup: 97
Fill distribution:
0 - 19% = 0
20 - 39% = 28
40 - 59% = 128
60 - 79% = 78
80 - 99% = 6

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 38.19, total records: 697285
Average version length: 68.23, total versions: 309459, max versions: 1
Data pages: 9836, data page slots: 9863, average fill: 81%
Fill distribution:
0 - 19% = 85
20 - 39% = 212
40 - 59% = 373
60 - 79% = 3697
80 - 99% = 5469

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 942, nodes: 697285
Average data length: 1.29, total dup: 605883, max dup: 29
Fill distribution:
0 - 19% = 1
20 - 39% = 18
40 - 59% = 666
60 - 79% = 140
80 - 99% = 117

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.75, total records: 908683
Average version length: 80.33, total versions: 18908, max versions: 1
Data pages: 13549, data page slots: 13549, average fill: 80%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 6593
80 - 99% = 6955

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1012, nodes: 908683
Average data length: 0.16, total dup: 888097, max dup: 162
Fill distribution:
0 - 19% = 7
20 - 39% = 0
40 - 59% = 771
60 - 79% = 186
80 - 99% = 48

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 712, nodes: 908683
Average data length: 0.74, total dup: 797792, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 103
60 - 79% = 13
80 - 99% = 594

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1158, nodes: 908683
Average data length: 0.76, total dup: 795511, max dup: 29
Fill distribution:
0 - 19% = 11
20 - 39% = 0
40 - 59% = 876
60 - 79% = 225
80 - 99% = 46

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 71.62, total records: 596392
Average version length: 80.06, total versions: 63596, max versions: 1
Data pages: 9080, data page slots: 9084, average fill: 80%
Fill distribution:
0 - 19% = 57
20 - 39% = 104
40 - 59% = 146
60 - 79% = 5260
80 - 99% = 3513

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 620, nodes: 596392
Average data length: 0.15, total dup: 583406, max dup: 275
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 370
60 - 79% = 210
80 - 99% = 37

Index XQS_1000_3300_RCV_ID (2)
Depth: 2, leaf buckets: 478, nodes: 596392
Average data length: 0.82, total dup: 518801, max dup: 14
Fill distribution:
0 - 19% = 6
20 - 39% = 8
40 - 59% = 61
60 - 79% = 7
80 - 99% = 396

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 740, nodes: 596392
Average data length: 0.73, total dup: 526054, max dup: 44
Fill distribution:
0 - 19% = 28
20 - 39% = 4
40 - 59% = 448
60 - 79% = 224
80 - 99% = 36

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 75.98, total records: 953414
Average version length: 81.14, total versions: 52696, max versions: 1
Data pages: 14217, data page slots: 14217, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7343
80 - 99% = 6874

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 992, nodes: 953414
Average data length: 0.05, total dup: 947698, max dup: 961
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 680
60 - 79% = 225
80 - 99% = 87

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 710, nodes: 953414
Average data length: 0.70, total dup: 842186, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 52
60 - 79% = 2
80 - 99% = 655

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1134, nodes: 953414
Average data length: 0.70, total dup: 842862, max dup: 181
Fill distribution:
0 - 19% = 5
20 - 39% = 1
40 - 59% = 722
60 - 79% = 303
80 - 99% = 103

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: 74.11, total records: 726842
Average version length: 80.09, total versions: 56473, max versions: 1
Data pages: 11263, data page slots: 11290, average fill: 78%
Fill distribution:
0 - 19% = 109
20 - 39% = 227
40 - 59% = 344
60 - 79% = 5939
80 - 99% = 4644

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 662, nodes: 726842
Average data length: 0.05, total dup: 722572, max dup: 613
Fill distribution:
0 - 19% = 1
20 - 39% = 11
40 - 59% = 222
60 - 79% = 286
80 - 99% = 142

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 689, nodes: 726842
Average data length: 0.83, total dup: 631036, max dup: 14
Fill distribution:
0 - 19% = 20
20 - 39% = 23
40 - 59% = 234
60 - 79% = 13
80 - 99% = 399

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 758, nodes: 726842
Average data length: 0.72, total dup: 642124, max dup: 68
Fill distribution:
0 - 19% = 0
20 - 39% = 10
40 - 59% = 230
60 - 79% = 354
80 - 99% = 164

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 61.69, total records: 312964
Average version length: 68.21, total versions: 30421, max versions: 1
Data pages: 4212, data page slots: 4212, average fill: 79%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3439
80 - 99% = 772

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 284, nodes: 312964
Average data length: 0.22, total dup: 303263, max dup: 187
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 108
60 - 79% = 107
80 - 99% = 69

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 329, nodes: 312964
Average data length: 0.82, total dup: 272303, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 133
60 - 79% = 124
80 - 99% = 72

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 18840 ms, from 2:57:38.73 to 2:57:57.57.

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 431190 12307 2.8541
DOC_LIST 68237 5579 8.1759
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 61964 15491.0000
INVNT_TURNOVER_LOG 124988 124928 99.9519
MONEY_SALDO 49 3222 6575.5102
MONEY_TURNOVER_LOG 5743 5736 99.8781
OPTYPES 9 0 0.0000
PDISTR 121880 79839 65.5062
PERF_ESTIMATED 16227 2 0.0123
PERF_LOG 998946 1 0.0001
PSTORNED 83058 4522 5.4443
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 667 16675.0000
SETTINGS 114 0 0.0000
TRACE_STAT 36 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 194443 193827 99.6831
XQD_1000_3300 197510 57330 29.0263
XQD_1200_2000 254964 250065 98.0785
XQD_2000_3300 951733 728797 76.5757
XQD_2100_3300 166773 159360 95.5550
XQD_3300_3400 697285 309459 44.3805
XQS_1000_1200 908683 18908 2.0808
XQS_1000_3300 596392 63596 10.6634
XQS_1200_2000 953414 52696 5.5270
XQS_2100_3300 726842 56473 7.7696
XQS_3300_3400 312964 30421 9.7202
Z_USED_VIEWS 32 0 0.0000
Done for 2690 ms, from 2:58:07.35 to 2:58:10.04.

Database validation

02:58:10.23 Validation started

02:58:10.23 Relation 140 (DOC_LIST)
02:58:10.23 process pointer page 0 of 1
02:58:10.27 Index 1 (PK_DOC_LIST)
02:58:10.30 Index 2 (DOC_LIST_ID_DESC)
02:58:10.32 Index 3 (FK_DOC_LIST_AGENTS)
02:58:10.34 Relation 140 (DOC_LIST) is ok

02:58:10.34 Relation 141 (DOC_DATA)
02:58:10.34 process pointer page 0 of 3
02:58:10.38 process pointer page 1 of 3
02:58:10.46 process pointer page 2 of 3
02:58:10.51 Index 2 (DOC_DATA_DOC_WARE_UNQ)
02:58:10.60 Index 3 (DOC_DATA_ID_DESC)
02:58:10.76 Index 4 (FK_DOC_DATA_DOC_LIST)
02:58:10.87 Relation 141 (DOC_DATA) is ok

02:58:10.87 Relation 147 (INVNT_SALDO)
02:58:10.87 process pointer page 0 of 1
02:58:10.94 Index 1 (PK_INVNT_SALDO)
02:58:10.94 Relation 147 (INVNT_SALDO) is ok

02:58:10.94 Relation 150 (PDISTR)
02:58:10.94 process pointer page 0 of 1
02:58:11.08 Index 2 (PDISTR_SND_ID)
02:58:11.12 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
02:58:11.15 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
02:58:11.18 Index 5 (PDISTR_AGENT_ID)
02:58:11.21 Relation 150 (PDISTR) is ok

02:58:11.21 Relation 151 (PSTORNED)
02:58:11.21 process pointer page 0 of 1
02:58:11.27 Index 2 (PSTORNED_SND_ID)
02:58:11.29 Index 3 (PSTORNED_RCV_ID)
02:58:11.30 Relation 151 (PSTORNED) is ok

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

02:58:11.30 Relation 157 (INVNT_TURNOVER_LOG)
02:58:11.30 process pointer page 0 of 1
02:58:11.47 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
02:58:11.54 Relation 157 (INVNT_TURNOVER_LOG) is ok

02:58:11.54 Relation 160 (PERF_ESTIMATED)
02:58:11.55 process pointer page 0 of 1
02:58:11.55 Index 1 (PERF_EST_MINUTE_SINCE_START)
02:58:11.55 Relation 160 (PERF_ESTIMATED) is ok

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

02:58:11.55 Relation 162 (PERF_LOG)
02:58:11.55 process pointer page 0 of 12
02:58:11.63 process pointer page 1 of 12
02:58:11.71 process pointer page 2 of 12
02:58:11.77 process pointer page 3 of 12
02:58:11.85 process pointer page 4 of 12
02:58:11.93 process pointer page 5 of 12
02:58:12.00 process pointer page 6 of 12
02:58:12.08 process pointer page 7 of 12
02:58:12.16 process pointer page 8 of 12
02:58:12.22 process pointer page 9 of 12
02:58:12.30 process pointer page 10 of 12
02:58:12.36 process pointer page 11 of 12
02:58:12.43 Index 1 (PERF_LOG_DTS_BEG_DESC)
02:58:12.72 Index 2 (PERF_LOG_UNIT)
02:58:13.24 Index 3 (PERF_LOG_TRN_DESC)
02:58:13.52 Index 4 (PERF_LOG_GDSCODE)
02:58:13.75 Relation 162 (PERF_LOG) is ok

02:58:13.75 Relation 166 (V_STOPTEST)
02:58:13.75 Relation 166 (V_STOPTEST) is ok

02:58:13.75 Relation 183 (V_QDISTR_SOURCE)
02:58:13.75 Relation 183 (V_QDISTR_SOURCE) is ok

02:58:13.75 Relation 184 (V_QSTORNED_SOURCE)
02:58:13.75 Relation 184 (V_QSTORNED_SOURCE) is ok

02:58:13.75 Relation 258 (XQD_1000_1200)
02:58:13.75 process pointer page 0 of 2
02:58:13.94 process pointer page 1 of 2
02:58:14.00 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
02:58:14.06 Relation 258 (XQD_1000_1200) is ok

02:58:14.06 Relation 259 (XQD_1200_2000)
02:58:14.06 process pointer page 0 of 2
02:58:14.25 process pointer page 1 of 2
02:58:14.39 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
02:58:14.47 Relation 259 (XQD_1200_2000) is ok

02:58:14.47 Relation 260 (XQD_1000_3300)
02:58:14.47 process pointer page 0 of 2
02:58:14.59 process pointer page 1 of 2
02:58:14.63 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
02:58:14.69 Index 2 (XQD_1000_3300_DOC)
02:58:14.73 Relation 260 (XQD_1000_3300) is ok

02:58:14.73 Relation 261 (XQD_2000_3300)
02:58:14.73 process pointer page 0 of 7
02:58:14.91 process pointer page 1 of 7
02:58:15.09 process pointer page 2 of 7
02:58:15.28 process pointer page 3 of 7
02:58:15.47 process pointer page 4 of 7
02:58:15.62 process pointer page 5 of 7
02:58:15.73 process pointer page 6 of 7
02:58:15.81 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
02:58:16.11 Relation 261 (XQD_2000_3300) is ok

02:58:16.11 Relation 262 (XQD_2100_3300)
02:58:16.11 process pointer page 0 of 2
02:58:16.25 process pointer page 1 of 2
02:58:16.34 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
02:58:16.42 Relation 262 (XQD_2100_3300) is ok

02:58:16.42 Relation 263 (XQD_3300_3400)
02:58:16.42 process pointer page 0 of 6
02:58:16.58 process pointer page 1 of 6
02:58:16.72 process pointer page 2 of 6
02:58:16.86 process pointer page 3 of 6
02:58:16.97 process pointer page 4 of 6
02:58:17.06 process pointer page 5 of 6
02:58:17.06 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
02:58:17.29 Relation 263 (XQD_3300_3400) is ok

02:58:17.29 Relation 264 (XQS_1000_1200)
02:58:17.29 process pointer page 0 of 8
02:58:17.39 process pointer page 1 of 8
02:58:17.48 process pointer page 2 of 8
02:58:17.56 process pointer page 3 of 8
02:58:17.65 process pointer page 4 of 8
02:58:17.75 process pointer page 5 of 8
02:58:17.84 process pointer page 6 of 8
02:58:17.92 process pointer page 7 of 8
02:58:17.93 Index 1 (XQS_1000_1200_DOC_ID)
02:58:18.18 Index 2 (XQS_1000_1200_SND_ID)
02:58:18.46 Index 3 (XQS_1000_1200_RCV_ID)
02:58:18.67 Relation 264 (XQS_1000_1200) is ok

02:58:18.67 Relation 265 (XQS_1200_2000)
02:58:18.67 process pointer page 0 of 8
02:58:18.76 process pointer page 1 of 8
02:58:18.84 process pointer page 2 of 8
02:58:18.93 process pointer page 3 of 8
02:58:19.01 process pointer page 4 of 8
02:58:19.10 process pointer page 5 of 8
02:58:19.20 process pointer page 6 of 8
02:58:19.31 process pointer page 7 of 8
02:58:19.34 Index 1 (XQS_1200_2000_DOC_ID)
02:58:19.59 Index 2 (XQS_1200_2000_SND_ID)
02:58:19.87 Index 3 (XQS_1200_2000_RCV_ID)
02:58:20.09 Relation 265 (XQS_1200_2000) is ok

02:58:20.09 Relation 266 (XQS_1000_3300)
02:58:20.09 process pointer page 0 of 5
02:58:20.18 process pointer page 1 of 5
02:58:20.27 process pointer page 2 of 5
02:58:20.38 process pointer page 3 of 5
02:58:20.48 process pointer page 4 of 5
02:58:20.54 Index 1 (XQS_1000_3300_DOC_ID)
02:58:20.69 Index 2 (XQS_1000_3300_SND_ID)
02:58:20.85 Index 3 (XQS_1000_3300_RCV_ID)
02:58:20.99 Relation 266 (XQS_1000_3300) is ok

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

02:58:20.99 Relation 268 (XQS_2100_3300)
02:58:20.99 process pointer page 0 of 6
02:58:21.08 process pointer page 1 of 6
02:58:21.18 process pointer page 2 of 6
02:58:21.29 process pointer page 3 of 6
02:58:21.38 process pointer page 4 of 6
02:58:21.46 process pointer page 5 of 6
02:58:21.54 Index 1 (XQS_2100_3300_DOC_ID)
02:58:21.77 Index 2 (XQS_2100_3300_SND_ID)
02:58:22.02 Index 3 (XQS_2100_3300_RCV_ID)
02:58:22.19 Relation 268 (XQS_2100_3300) is ok

02:58:22.19 Relation 269 (XQS_3300_3400)
02:58:22.19 process pointer page 0 of 3
02:58:22.30 process pointer page 1 of 3
02:58:22.39 process pointer page 2 of 3
02:58:22.41 Index 1 (XQS_3300_3400_DOC_ID)
02:58:22.49 Index 2 (XQS_3300_3400_SND_ID)
02:58:22.55 Relation 269 (XQS_3300_3400) is ok

02:58:22.55 Relation 276 (TRACE_STAT)
02:58:22.57 process pointer page 0 of 1
02:58:22.57 Relation 276 (TRACE_STAT) is ok

02:58:22.57 Validation finished
Done for 12510 ms, from 2:58:10.07 to 2:58:22.58.

Differences between old and current firebird.log

2:58:23.13. Got:
STDOUT: ---------- E:\TEMP\LOGS.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 4 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-06-01 02:58 301 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-06-01 2:58:25.03 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html