Logs 2.5

Generated by E:\OLTP-EMUL\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 100. 2016-11-22 11:25:49.24.
Common Performance Final Results
  1. Test configuration
  2. Test Finish details
  3. Test workload details
  4. Indices DDL for heavy-loaded table(s)
  1. Performance, TOTAL score
  2. Performance, DYNAMIC, 10 intervals
  3. Performance, per MINUTE, since launch
  4. Performance, TRACE data for ISQL #1
  5. Performance, DETAILS per units
  6. MON$-analysis, per business units
  7. Exceptions during test run
  1. mon$database and 'show version' results
  2. Database Statistics, full
  3. Ratio "Versions / Records" for tables
  4. Database Validation Results
  5. New in firebird.log while test was run
  6. Final processing of ISQL logs

Server and database settings

Server version: WI-V2.5.7.27026 Firebird 2.5
Server implementation: Firebird/x86-64/Windows NT
FB_ARCHITECTURE DB_NAME FORCED_WRITES SWEEP_INT PAGE_BUFFERS PAGE_SIZE
SuperClassic 2.5.7 D:\OLTP-EMUL\OLTP25-SMALL.FDB ON 0 384 8192

Test configuration settings

File: E:\OLTP-EMUL\src\oltp25_config.win
PARAM_NAME PARAM_VALUE
fbc E:\FB25.TMPINSTANCE\bin\
dbnm D:\OLTP-EMUL\oltp25-small.fdb
host localhost
port 3255
usr SYSDBA
pwd masterke
tmpdir e:\temp\logs.oltp25
working_mode small_03
warm_time 10
test_time 180
idle_time 0
use_mtee 0
is_embed 0
remove_isql_logs if_no_severe_errors
no_auto_undo 1
detailed_info 0
mon_unit_perf 0
trc_unit_perf 0
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 fb257
upload_report 1
max_snapshots_to_store 0
replace_instance 0

Test finish info

FINISH_STATE DTS_END FB_GDSCODE FB_MNEMONA STACK IP TRN_ID ATT_ID EXC_UNIT
NORMAL: TEST_TIME EXPIRED. 2016-11-22 11:25:23.8140 -1 <null> 127.0.0.1 81022 4285 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 179 minutes: 67.87 155704 12148 2016-11-22 08:25 2016-11-22 11:24
customer order: creation 9.81 34 1756 2016-11-22 08:25 2016-11-22 11:24
customer order: refuse 0.77 19 134 2016-11-22 08:25 2016-11-22 11:24
order to supplier: creation 2.54 1469 454 2016-11-22 08:25 2016-11-22 11:24
order to supplier: removal 0.08 592 12 2016-11-22 08:25 2016-11-22 11:24
invoice (draft): creation 2.69 1693 463 2016-11-22 08:25 2016-11-22 11:24
invoice (draft): removal 0.57 59 91 2016-11-22 08:25 2016-11-22 11:24
invoice accept: apply 0.34 2420912 60 2016-11-22 08:25 2016-11-22 11:24
invoice accept: cancel 0.06 446137 11 2016-11-22 08:25 2016-11-22 11:24
customer reserve: creation 35.95 57862 6399 2016-11-22 08:25 2016-11-22 11:24
customer reserve: removal 1.51 24964 265 2016-11-22 08:25 2016-11-22 11:24
realization accept: apply 4.73 47 846 2016-11-22 08:25 2016-11-22 11:24
realization accept: cancel 0.96 34 171 2016-11-22 08:25 2016-11-22 11:24
payment from customer: creation 3.36 95 585 2016-11-22 08:25 2016-11-22 11:24
payment from customer: removal 0.29 27 51 2016-11-22 08:25 2016-11-22 11:24
payment to supplier: creation 2.80 1266 502 2016-11-22 08:25 2016-11-22 11:24
payment to supplier: removal 0.20 25 34 2016-11-22 08:25 2016-11-22 11:24
service: total inventory turnovers 1.04 2066 181 2016-11-22 08:25 2016-11-22 11:24
service: total monetary turnovers 0.69 10 124 2016-11-22 08:25 2016-11-22 11:24
service: refresh index statistics 0.06 1072 9 2016-11-22 08:25 2016-11-22 11:24
Done for 5350 ms, from 11:26:04.73 to 11:26:10.08.

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 118 2254 2123 131 5.81 08:25:22 08:43:15
interval # 2, overall 2 104 3023 1870 1153 38.14 08:43:16 09:01:09
interval # 3, overall 3 74 1897 1337 560 29.52 09:01:10 09:19:03
interval # 4, overall 4 57 1002 971 31 3.09 09:19:04 09:36:57
interval # 5, overall 5 72 2190 1294 896 40.91 09:36:58 09:54:51
interval # 6, overall 6 57 1271 1034 237 18.65 09:54:52 10:12:45
interval # 7, overall 7 52 1169 941 228 19.50 10:12:46 10:30:39
interval # 8, overall 8 68 1560 1230 330 21.15 10:30:40 10:48:33
interval # 9, overall 9 38 888 692 196 22.07 10:48:34 11:06:27
interval # 10, overall 10 36 692 656 36 5.20 11:06:28 11:24:21
Done for 5120 ms, from 11:26:12.68 to 11:26:17.80.

Performance for every MINUTE:

TEST_PHASE MINUTE_SINCE_TEST_START AVG_ESTIMATED MIN_TO_AVG_RATIO MAX_TO_AVG_RATIO ROWS_AGGREGATED DISTINCT_ATTACHMENTS
WARM_TIME 1 2219.88 0.5288 1.6645 1386 100
WARM_TIME 2 2082.48 0.8874 1.1916 676 84
WARM_TIME 3 1791.10 0.9236 1.0978 888 78
WARM_TIME 4 1570.36 0.9392 1.0615 827 63
WARM_TIME 5 1413.12 0.9438 1.0549 821 52
WARM_TIME 6 1287.42 0.9651 1.0363 583 41
WARM_TIME 7 1184.68 0.9654 1.0353 579 30
WARM_TIME 8 1107.52 0.9690 1.0307 537 23
WARM_TIME 9 1033.84 0.9816 1.0184 383 13
WARM_TIME 10 963.94 0.9831 1.0157 335 11
TEST_TIME 11 896.93 0.9924 1.0082 126 5
TEST_TIME 12 837.03 0.9914 1.0088 167 7
TEST_TIME 13 790.16 0.9865 1.0097 190 7
TEST_TIME 14 745.93 0.9932 1.0081 150 6
TEST_TIME 15 703.40 0.9979 1.0026 38 3
TEST_TIME 16 663.06 0.9999 1.0000 3 1
TEST_TIME 17 624.69 0.9991 1.0006 20 2
TEST_TIME 18 592.28 0.9968 1.0017 34 2
TEST_TIME 19 565.13 0.9947 1.0056 108 4
TEST_TIME 21 515.07 0.9983 1.0015 39 1
TEST_TIME 22 492.55 0.9997 1.0001 6 1
TEST_TIME 24 452.61 0.9978 1.0023 53 1
TEST_TIME 28 391.96 0.9948 1.0049 112 2
TEST_TIME 29 381.31 0.9983 1.0049 16 3
TEST_TIME 30 371.21 0.9979 1.0019 48 2
TEST_TIME 31 362.14 0.9970 1.0039 62 2
TEST_TIME 32 353.58 0.9962 1.0022 43 2
TEST_TIME 33 343.73 0.9997 1.0002 6 1
TEST_TIME 34 333.78 0.9998 1.0002 6 1
TEST_TIME 37 309.39 0.9938 1.0053 69 3
TEST_TIME 38 304.81 0.9937 1.0106 112 6
TEST_TIME 39 301.02 0.9971 1.0028 70 3
TEST_TIME 40 296.77 0.9984 1.0015 40 2
TEST_TIME 41 294.19 0.9924 1.0042 111 3
TEST_TIME 42 288.54 0.9995 1.0005 15 1
TEST_TIME 43 282.28 0.9990 1.0008 25 1
TEST_TIME 44 277.75 0.9940 1.0057 86 3
TEST_TIME 45 274.71 0.9943 1.0132 103 3
TEST_TIME 46 272.33 0.9998 1.0001 4 1
TEST_TIME 47 266.59 1.0000 1.0000 1 1
TEST_TIME 50 252.56 0.9973 1.0024 35 2
TEST_TIME 51 249.82 0.9936 1.0047 103 2
TEST_TIME 52 246.45 0.9990 1.0010 27 1
TEST_TIME 53 242.67 0.9998 1.0001 5 1
TEST_TIME 55 233.95 0.9997 1.0002 6 1
TEST_TIME 56 231.30 0.9936 1.0078 76 3
TEST_TIME 57 229.58 0.9976 1.0018 33 3
TEST_TIME 58 230.11 0.9823 1.0098 180 4
TEST_TIME 59 229.45 0.9956 1.0043 106 3
TEST_TIME 60 226.79 0.9991 1.0003 5 1
TEST_TIME 65 209.85 0.9996 1.0003 10 1
TEST_TIME 66 207.67 0.9989 1.0010 32 1
TEST_TIME 67 205.90 0.9987 1.0010 32 1
TEST_TIME 68 203.83 0.9964 1.0036 109 2
TEST_TIME 69 201.95 0.9983 1.0017 52 1
TEST_TIME 70 200.44 0.9992 1.0008 25 1
TEST_TIME 71 198.20 0.9994 1.0006 19 1
TEST_TIME 72 196.52 0.9952 1.0034 102 3
TEST_TIME 73 194.62 0.9994 1.0005 19 2
TEST_TIME 79 180.98 0.9999 1.0001 3 1
TEST_TIME 84 172.58 0.9995 1.0004 17 1
TEST_TIME 85 170.90 0.9984 1.0016 52 1
TEST_TIME 86 169.62 0.9975 1.0024 78 1
TEST_TIME 87 169.82 0.9898 1.0047 31 2
TEST_TIME 88 168.84 0.9991 1.0008 28 1
TEST_TIME 89 167.12 0.9998 1.0001 7 1
TEST_TIME 91 164.33 0.9991 1.0009 29 1
TEST_TIME 92 162.86 0.9990 1.0009 29 2
TEST_TIME 93 162.69 0.9952 1.0031 105 3
TEST_TIME 94 162.42 0.9941 1.0041 78 2
TEST_TIME 95 161.69 0.9982 1.0066 44 2
TEST_TIME 96 162.28 1.0000 1.0000 2 1
TEST_TIME 97 161.37 0.9972 1.0026 27 2
TEST_TIME 98 161.78 0.9899 1.0037 79 3
TEST_TIME 99 160.93 0.9992 1.0008 31 2
TEST_TIME 100 160.00 0.9966 1.0035 114 2
TEST_TIME 111 145.60 0.9969 1.0024 77 2
TEST_TIME 112 145.78 0.9987 1.0013 44 2
TEST_TIME 113 145.16 0.9967 1.0034 117 2
TEST_TIME 114 145.75 0.9962 1.0039 27 3
TEST_TIME 115 145.72 0.9954 1.0017 28 2
TEST_TIME 117 143.52 0.9997 1.0002 9 1
TEST_TIME 118 143.36 0.9997 1.0004 17 1
TEST_TIME 119 142.70 0.9984 1.0065 46 3
TEST_TIME 120 142.60 0.9988 1.0013 45 1
TEST_TIME 121 142.66 0.9926 1.0016 44 2
TEST_TIME 122 142.89 0.9918 1.0041 105 2
TEST_TIME 123 142.39 0.9995 1.0005 20 1
TEST_TIME 124 141.82 0.9997 1.0003 13 1
TEST_TIME 125 140.82 1.0000 1.0000 2 1
TEST_TIME 129 137.74 0.9957 1.0025 17 2
TEST_TIME 130 137.16 0.9990 1.0009 36 1
TEST_TIME 131 137.90 0.9995 1.0006 14 1
TEST_TIME 134 135.11 0.9993 1.0006 28 1
TEST_TIME 136 134.05 0.9992 1.0029 16 2
TEST_TIME 137 133.89 0.9998 1.0002 8 1
TEST_TIME 138 133.22 0.9980 1.0015 60 2
TEST_TIME 139 133.24 0.9942 1.0027 108 3
TEST_TIME 140 132.75 0.9993 1.0007 27 2
TEST_TIME 141 132.12 0.9984 1.0018 75 2
TEST_TIME 142 131.44 1.0000 1.0000 3 1
TEST_TIME 144 130.07 0.9986 1.0014 53 1
TEST_TIME 145 129.92 0.9957 1.0046 71 3
TEST_TIME 146 130.35 0.9944 1.0095 121 5
TEST_TIME 147 130.84 0.9989 1.0010 47 2
TEST_TIME 148 130.94 0.9998 1.0002 9 1
TEST_TIME 149 131.28 0.9993 1.0006 30 1
TEST_TIME 150 131.15 0.9991 1.0009 43 1
TEST_TIME 151 130.79 0.9971 1.0064 36 2
TEST_TIME 152 131.28 0.9996 1.0004 19 2
TEST_TIME 153 130.51 0.9998 1.0003 11 2
TEST_TIME 154 129.70 1.0000 1.0000 1 1
TEST_TIME 156 128.33 0.9978 1.0071 30 2
TEST_TIME 157 128.64 0.9983 1.0008 24 2
TEST_TIME 161 126.65 0.9998 1.0002 9 1
TEST_TIME 164 125.13 0.9984 1.0025 52 2
TEST_TIME 165 124.84 0.9987 1.0012 54 1
TEST_TIME 166 124.42 1.0000 1.0000 1 1
TEST_TIME 169 123.08 0.9996 1.0008 13 2
TEST_TIME 170 123.42 0.9923 1.0030 97 3
TEST_TIME 171 123.59 0.9958 1.0031 12 2
TEST_TIME 172 123.32 0.9995 1.0005 22 1
TEST_TIME 173 123.89 0.9953 1.0038 82 3
TEST_TIME 174 124.32 0.9946 1.0055 77 3
TEST_TIME 175 125.84 0.9877 1.0048 92 3
TEST_TIME 178 125.54 0.9982 1.0010 48 2
TEST_TIME 179 125.04 0.9996 1.0005 22 1
TEST_TIME 180 125.06 0.9948 1.0087 104 3
TEST_TIME 181 125.46 1.0000 1.0001 4 1
TEST_TIME 182 125.65 0.9980 1.0015 31 2
TEST_TIME 183 125.21 0.9996 1.0003 19 1
TEST_TIME 184 124.89 0.9997 1.0002 14 1
TEST_TIME 185 124.29 1.0000 1.0000 4 1
TEST_TIME 186 123.64 1.0000 1.0000 1 1
TEST_TIME 188 122.85 1.0000 1.0000 3 1
TEST_TIME 189 122.23 0.9999 1.0002 10 1
TEST_TIME 190 121.62 1.0000 1.0000 100 100
Done for 12090 ms, from 11:26:18.10 to 11:26:30.19.

Config param. trc_unit_perf=0, trace for ISQL session #1 was not launched.

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 16735 13381 3354 20.04 0 7223 60 3354 2016-11-22 08:25 2016-11-22 11:25
doc_list_biud 16763 13378 3385 20.19 0 289616 617 3385 2016-11-22 08:25 2016-11-22 11:25
sp_add_invoice_to_stock 390 60 330 84.61 5725 10123445 2420912 330 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_adding_invoice 36 11 25 69.44 32 1518558 446137 25 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_client_order 142 134 8 5.63 0 78 19 8 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_customer_reserve 2606 265 2341 89.83 0 270818 24964 2341 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_pay_from_customer 51 51 0 0.00 0 562 27 0 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_pay_to_supplier 35 34 1 2.85 0 187 25 1 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_supplier_invoice 121 91 30 24.79 0 358 59 30 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_supplier_order 35 12 23 65.71 62 2574 592 23 2016-11-22 08:25 2016-11-22 11:25
sp_cancel_write_off 1185 171 1014 85.56 0 141 34 1014 2016-11-22 08:25 2016-11-22 11:25
sp_client_order 1756 1756 0 0.00 0 375 34 0 2016-11-22 08:25 2016-11-22 11:25
sp_customer_reserve 6399 6399 0 0.00 780 177997 57862 0 2016-11-22 08:25 2016-11-22 11:25
sp_fill_shopping_cart 2673 2673 0 0.00 0 25435 495 0 2016-11-22 08:25 2016-11-22 11:25
sp_fill_shopping_cart_clo_res 6399 6399 0 0.00 0 93 2 0 2016-11-22 08:25 2016-11-22 11:25
sp_get_clo_for_invoice 61 61 0 0.00 0 203 31 0 2016-11-22 08:25 2016-11-22 11:25
sp_kill_cost_storno 1283 267 1016 79.18 0 562 9 1016 2016-11-22 08:25 2016-11-22 11:25
sp_kill_qstorno_ret_qs2qd 6485 804 5681 87.60 0 270694 8233 5681 2016-11-22 08:25 2016-11-22 11:25
sp_kill_qty_storno 4963 1590 3373 67.96 0 289616 5188 3373 2016-11-22 08:25 2016-11-22 11:25
sp_lock_selected_doc 1743 1307 436 25.01 0 16 0 436 2016-11-22 08:25 2016-11-22 11:25
sp_make_cost_storno 1994 1994 0 0.00 0 6037 354 0 2016-11-22 08:25 2016-11-22 11:25
sp_multiply_rows_for_pdistr 1994 1994 0 0.00 0 1638 14 0 2016-11-22 08:25 2016-11-22 11:25
sp_multiply_rows_for_qdistr 1756 1756 0 0.00 0 265 12 0 2016-11-22 08:25 2016-11-22 11:25
sp_pay_from_customer 585 585 0 0.00 31 1794 95 0 2016-11-22 08:25 2016-11-22 11:25
sp_pay_to_supplier 502 502 0 0.00 125 7909 1266 0 2016-11-22 08:25 2016-11-22 11:25
sp_payment_common 1087 1087 0 0.00 0 686 24 0 2016-11-22 08:25 2016-11-22 11:25
sp_qd_handle_on_cancel_clo 142 134 8 5.63 0 47 6 8 2016-11-22 08:25 2016-11-22 11:25
sp_qd_handle_on_invoice_upd_sts 92 71 21 22.82 0 289616 22813 21 2016-11-22 08:25 2016-11-22 11:25
sp_qd_handle_on_reserve_upd_sts 846 846 0 0.00 0 188 9 0 2016-11-22 08:25 2016-11-22 11:25
sp_reserve_write_off 872 846 26 2.98 0 1248 47 26 2016-11-22 08:25 2016-11-22 11:25
sp_supplier_invoice 463 463 0 0.00 15 25466 1693 0 2016-11-22 08:25 2016-11-22 11:25
sp_supplier_order 454 454 0 0.00 16 15865 1469 0 2016-11-22 08:25 2016-11-22 11:25
srv_find_qd_qs_mism 10279 6922 3357 32.65 0 1965 8 3357 2016-11-22 08:25 2016-11-22 11:25
srv_make_invnt_saldo 181 181 0 0.00 780 4446 2066 0 2016-11-22 08:25 2016-11-22 11:25
srv_make_money_saldo 124 124 0 0.00 0 32 10 0 2016-11-22 08:25 2016-11-22 11:25
srv_recalc_idx_stat 9 9 0 0.00 733 1700 1072 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_add_invoice_to_stock 330 330 0 0.00 0 78 2 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_adding_invoice 61 61 0 0.00 0 109 23 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_client_order 8 8 0 0.00 0 16 2 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_customer_reserve 1 1 0 0.00 0 0 0 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_pay_to_supplier 1 1 0 0.00 0 0 0 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_supplier_invoice 29 29 0 0.00 0 16 1 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_supplier_order 366 366 0 0.00 0 125 16 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_cancel_write_off 1 1 0 0.00 0 0 0 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-abend:sp_reserve_write_off 26 26 0 0.00 0 16 1 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_add_invoice_to_stock 113 113 0 0.00 0 546 118 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_adding_invoice 9 9 0 0.00 0 140 57 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_client_order 134 134 0 0.00 0 31 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_customer_reserve 60 60 0 0.00 0 32 6 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_pay_from_customer 51 51 0 0.00 0 16 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_pay_to_supplier 34 34 0 0.00 0 16 2 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_supplier_invoice 12 12 0 0.00 0 47 5 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_supplier_order 12 12 0 0.00 0 47 16 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_cancel_write_off 91 91 0 0.00 0 31 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_client_order 1756 1756 0 0.00 0 78 4 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_customer_reserve 99 99 0 0.00 0 32 6 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_pay_from_customer 585 585 0 0.00 0 47 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_pay_to_supplier 502 502 0 0.00 0 47 4 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_reserve_write_off 846 846 0 0.00 0 109 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_supplier_invoice 465 465 0 0.00 0 63 4 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:sp_supplier_order 454 454 0 0.00 0 47 4 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:srv_make_invnt_saldo 182 182 0 0.00 0 109 3 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:srv_make_money_saldo 124 124 0 0.00 0 32 2 0 2016-11-22 08:25 2016-11-22 11:25
t$perf-norm:srv_recalc_idx_stat 9 9 0 0.00 0 16 8 0 2016-11-22 08:25 2016-11-22 11:25
v_add_invoice_to_stock 780 120 660 84.61 0 16 3 660 2016-11-22 08:25 2016-11-22 11:25
v_all_customers 2620 2620 0 0.00 0 16 0 0 2016-11-22 08:25 2016-11-22 11:25
v_all_suppliers 1834 1834 0 0.00 0 16 0 0 2016-11-22 08:25 2016-11-22 11:25
v_all_wares 3512 3512 0 0.00 0 16 0 0 2016-11-22 08:25 2016-11-22 11:25
v_cancel_adding_invoice 52 18 34 65.38 0 32 6 34 2016-11-22 08:25 2016-11-22 11:25
v_cancel_client_order 284 268 16 5.63 0 16 0 16 2016-11-22 08:25 2016-11-22 11:25
v_cancel_customer_prepayment 102 102 0 0.00 0 31 0 0 2016-11-22 08:25 2016-11-22 11:25
v_cancel_customer_reserve 118 116 2 1.69 0 16 0 2 2016-11-22 08:25 2016-11-22 11:25
v_cancel_payment_to_supplier 70 68 2 2.85 0 16 0 2 2016-11-22 08:25 2016-11-22 11:25
v_cancel_supplier_invoice 82 24 58 70.73 0 16 3 58 2016-11-22 08:25 2016-11-22 11:25
v_cancel_supplier_order 70 24 46 65.71 0 15 1 46 2016-11-22 08:25 2016-11-22 11:25
v_cancel_write_off 184 182 2 1.08 0 16 1 2 2016-11-22 08:25 2016-11-22 11:25
v_max_id_clo_ord 454 454 0 0.00 0 109 4 0 2016-11-22 08:25 2016-11-22 11:25
v_max_id_clo_res 94 94 0 0.00 0 16 1 0 2016-11-22 08:25 2016-11-22 11:25
v_max_id_ord_sup 463 463 0 0.00 0 47 4 0 2016-11-22 08:25 2016-11-22 11:25
v_max_non_paid_invoice 502 502 0 0.00 0 203 4 0 2016-11-22 08:25 2016-11-22 11:25
v_max_non_paid_realizn 585 585 0 0.00 0 31 6 0 2016-11-22 08:25 2016-11-22 11:25
v_min_id_clo_ord 454 454 0 0.00 0 436 27 0 2016-11-22 08:25 2016-11-22 11:25
v_min_id_clo_res 94 94 0 0.00 0 46 1 0 2016-11-22 08:25 2016-11-22 11:25
v_min_id_ord_sup 463 463 0 0.00 0 858 59 0 2016-11-22 08:25 2016-11-22 11:25
v_min_non_paid_invoice 502 502 0 0.00 0 483 14 0 2016-11-22 08:25 2016-11-22 11:25
v_min_non_paid_realizn 585 585 0 0.00 0 249 11 0 2016-11-22 08:25 2016-11-22 11:25
v_our_firm 892 892 0 0.00 0 16 0 0 2016-11-22 08:25 2016-11-22 11:25
v_reserve_write_off 1744 1692 52 2.98 0 78 0 52 2016-11-22 08:25 2016-11-22 11:25
x_lock_depdocs_on_canc_invoice 180 90 90 50.00 0 16 0 90 2016-11-22 08:25 2016-11-22 11:25
x_lock_depdocs_on_canc_sup_ord 35 12 23 65.71 0 16 3 23 2016-11-22 08:25 2016-11-22 11:25
x_make_qstorno_1000_1200 454 454 0 0.00 0 3151 144 0 2016-11-22 08:25 2016-11-22 11:25
x_make_qstorno_1200_2000 465 465 0 0.00 0 2854 138 0 2016-11-22 08:25 2016-11-22 11:25
x_make_qstorno_2100_3300 6399 6399 0 0.00 780 177997 57843 0 2016-11-22 08:25 2016-11-22 11:25
Done for 14390 ms, from 11:26:34.52 to 11:26:48.91.

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 1 sp_kill_cost_storno 335544336 2016-11-22 08:52 2016-11-22 08:52
lock_conflict 1 sp_kill_cost_storno 335544345 2016-11-22 09:27 2016-11-22 09:27
lock_conflict 387 sp_lock_selected_doc 335544345 2016-11-22 08:25 2016-11-22 11:24
lock_conflict 8 sp_qd_handle_on_cancel_clo 335544345 2016-11-22 09:13 2016-11-22 11:15
lock_conflict 20 sp_qd_handle_on_invoice_upd_sts 335544345 2016-11-22 08:27 2016-11-22 11:06
lock_conflict 13 x_lock_depdocs_on_canc_invoice 335544345 2016-11-22 08:25 2016-11-22 10:45
lock_conflict 7 x_lock_depdocs_on_canc_sup_ord 335544345 2016-11-22 08:29 2016-11-22 10:46
Done for 2590 ms, from 11:26:49.06 to 11:26:51.65.

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 82624
MON$OLDEST_ACTIVE 82625
MON$OLDEST_SNAPSHOT 82625
MON$NEXT_TRANSACTION 82625
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.7.27026 Firebird 2.5
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.7.27026 Firebird 2.5"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.7.27026 Firebird 2.5/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.7.27026 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 87082
Page size 8192
ODS version 11.2
Oldest transaction 82626
Oldest active 82627
Oldest snapshot 82627
Next transaction 82628
Bumped transaction 1
Sequence number 0
Next attachment ID 4421
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.63, total records: 412442
Average version length: 46.07, total versions: 12833, max versions: 1
Data pages: 4458, data page slots: 4458, average fill: 72%
Fill distribution:
0 - 19% = 4
20 - 39% = 24
40 - 59% = 122
60 - 79% = 4268
80 - 99% = 40

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 1258, nodes: 412442
Average data length: 11.52, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 129
20 - 39% = 41
40 - 59% = 361
60 - 79% = 80
80 - 99% = 647

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 1230, nodes: 412442
Average data length: 6.03, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 33
40 - 59% = 1194
60 - 79% = 3
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 2, leaf buckets: 367, nodes: 412442
Average data length: 0.79, total dup: 361749, max dup: 49
Fill distribution:
0 - 19% = 4
20 - 39% = 31
40 - 59% = 100
60 - 79% = 3
80 - 99% = 229

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 59.09, total records: 62925
Average version length: 53.24, total versions: 4231, max versions: 10
Data pages: 826, data page slots: 826, average fill: 76%
Fill distribution:
0 - 19% = 5
20 - 39% = 29
40 - 59% = 59
60 - 79% = 382
80 - 99% = 351

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 54, nodes: 62925
Average data length: 0.01, total dup: 62875, max dup: 16299
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 38
60 - 79% = 7
80 - 99% = 9

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 119, nodes: 62925
Average data length: 6.30, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 21
40 - 59% = 28
60 - 79% = 0
80 - 99% = 69

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

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

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

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

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

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

INVNT_SALDO (147)
Primary pointer page: 216, Index root page: 217
Average record length: 62.77, total records: 400
Average version length: 12.92, total versions: 58931, max versions: 182
Data pages: 231, data page slots: 231, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 230

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.17, total records: 107485
Average version length: 68.36, total versions: 107213, max versions: 1
Data pages: 1637, data page slots: 1642, average fill: 83%
Fill distribution:
0 - 19% = 8
20 - 39% = 32
40 - 59% = 65
60 - 79% = 288
80 - 99% = 1244

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 3, leaf buckets: 297, nodes: 107485
Average data length: 8.32, total dup: 13239, max dup: 9
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 141
60 - 79% = 128
80 - 99% = 25

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.84, total records: 49
Average version length: 9.00, total versions: 2758, max versions: 226
Data pages: 11, data page slots: 11, average fill: 82%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 9

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.03, total records: 5178
Average version length: 44.17, total versions: 5175, max versions: 1
Data pages: 56, data page slots: 56, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 0
60 - 79% = 1
80 - 99% = 52

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 4, nodes: 5178
Average data length: 0.18, total dup: 5085, max dup: 1125
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
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: 26.23, total records: 114741
Average version length: 32.41, total versions: 67762, max versions: 10
Data pages: 1204, data page slots: 1204, average fill: 85%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 2
60 - 79% = 346
80 - 99% = 855

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 93, nodes: 114741
Average data length: 0.01, total dup: 114692, max dup: 23954
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 50
60 - 79% = 18
80 - 99% = 22

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 118, nodes: 114741
Average data length: 0.89, total dup: 103275, max dup: 49
Fill distribution:
0 - 19% = 0
20 - 39% = 4
40 - 59% = 69
60 - 79% = 26
80 - 99% = 19

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 124, nodes: 114741
Average data length: 0.89, total dup: 103275, max dup: 49
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 82
60 - 79% = 22
80 - 99% = 18

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 111, nodes: 114741
Average data length: 0.67, total dup: 103275, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 2
40 - 59% = 54
60 - 79% = 37
80 - 99% = 16

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

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 10, nodes: 14076
Average data length: 0.01, total dup: 13938, max dup: 1385
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
60 - 79% = 5
80 - 99% = 2

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

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

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

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 1225, nodes: 940458
Average data length: 0.59, total dup: 497817, max dup: 35
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1049
60 - 79% = 133
80 - 99% = 43

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 1231, nodes: 940458
Average data length: 0.45, total dup: 875231, max dup: 5699
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1135
60 - 79% = 62
80 - 99% = 34

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 1051, nodes: 940458
Average data length: 0.29, total dup: 915394, max dup: 106905
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 773
60 - 79% = 140
80 - 99% = 137

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.73, total records: 77918
Average version length: 54.36, total versions: 4183, max versions: 1
Data pages: 909, data page slots: 909, average fill: 76%
Fill distribution:
0 - 19% = 2
20 - 39% = 3
40 - 59% = 4
60 - 79% = 854
80 - 99% = 46

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 98, nodes: 77918
Average data length: 1.13, total dup: 64730, max dup: 144
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 92
60 - 79% = 3
80 - 99% = 2

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 73, nodes: 77918
Average data length: 0.60, total dup: 71225, max dup: 71
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 40
60 - 79% = 28
80 - 99% = 5

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: 676, max versions: 389
Data pages: 3, data page slots: 3, average fill: 73%
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: 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

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.02, total records: 172930
Average version length: 69.41, total versions: 172886, max versions: 1
Data pages: 2322, data page slots: 2322, average fill: 94%
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 2318

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 191, nodes: 172930
Average data length: 1.29, total dup: 151592, max dup: 32
Fill distribution:
0 - 19% = 6
20 - 39% = 2
40 - 59% = 62
60 - 79% = 68
80 - 99% = 53

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 48.22, total records: 187330
Average version length: 69.11, total versions: 57146, max versions: 1
Data pages: 2635, data page slots: 2870, average fill: 80%
Fill distribution:
0 - 19% = 36
20 - 39% = 69
40 - 59% = 63
60 - 79% = 1195
80 - 99% = 1272

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 168, nodes: 187330
Average data length: 0.15, total dup: 183195, max dup: 211
Fill distribution:
0 - 19% = 2
20 - 39% = 19
40 - 59% = 78
60 - 79% = 12
80 - 99% = 57

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 233, nodes: 187330
Average data length: 1.30, total dup: 164212, max dup: 29
Fill distribution:
0 - 19% = 1
20 - 39% = 10
40 - 59% = 109
60 - 79% = 103
80 - 99% = 10

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 0.54, total records: 226099
Average version length: 69.33, total versions: 224351, max versions: 1
Data pages: 3037, data page slots: 3037, average fill: 94%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 23
80 - 99% = 3014

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 243, nodes: 226099
Average data length: 0.95, total dup: 205944, max dup: 117
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 82
60 - 79% = 121
80 - 99% = 40

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 15.93, total records: 920053
Average version length: 68.18, total versions: 708336, max versions: 1
Data pages: 12389, data page slots: 12389, average fill: 90%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 2680
80 - 99% = 9709

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1190, nodes: 920053
Average data length: 1.14, total dup: 812709, max dup: 84
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 912
60 - 79% = 167
80 - 99% = 110

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 17.15, total records: 187674
Average version length: 68.53, total versions: 140697, max versions: 1
Data pages: 3318, data page slots: 3550, average fill: 70%
Fill distribution:
0 - 19% = 216
20 - 39% = 348
40 - 59% = 319
60 - 79% = 673
80 - 99% = 1762

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 292, nodes: 187674
Average data length: 1.48, total dup: 159874, max dup: 84
Fill distribution:
0 - 19% = 0
20 - 39% = 65
40 - 59% = 164
60 - 79% = 62
80 - 99% = 1

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 38.92, total records: 610097
Average version length: 68.29, total versions: 263760, max versions: 1
Data pages: 9413, data page slots: 9471, average fill: 74%
Fill distribution:
0 - 19% = 201
20 - 39% = 504
40 - 59% = 1146
60 - 79% = 3594
80 - 99% = 3968

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 903, nodes: 610097
Average data length: 1.27, total dup: 531495, max dup: 69
Fill distribution:
0 - 19% = 0
20 - 39% = 78
40 - 59% = 603
60 - 79% = 179
80 - 99% = 43

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 78.67, total records: 879871
Average version length: 80.62, total versions: 18370, max versions: 1
Data pages: 13115, data page slots: 13115, average fill: 80%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 6734
80 - 99% = 6380

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 985, nodes: 879871
Average data length: 0.16, total dup: 859939, max dup: 176
Fill distribution:
0 - 19% = 7
20 - 39% = 0
40 - 59% = 746
60 - 79% = 199
80 - 99% = 33

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 689, nodes: 879871
Average data length: 0.74, total dup: 772237, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 94
60 - 79% = 17
80 - 99% = 576

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1120, nodes: 879871
Average data length: 0.76, total dup: 770425, max dup: 32
Fill distribution:
0 - 19% = 10
20 - 39% = 0
40 - 59% = 839
60 - 79% = 233
80 - 99% = 38

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 70.91, total records: 589944
Average version length: 80.04, total versions: 67993, max versions: 1
Data pages: 9014, data page slots: 9020, average fill: 79%
Fill distribution:
0 - 19% = 41
20 - 39% = 85
40 - 59% = 240
60 - 79% = 5383
80 - 99% = 3265

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 618, nodes: 589944
Average data length: 0.15, total dup: 577310, max dup: 260
Fill distribution:
0 - 19% = 1
20 - 39% = 7
40 - 59% = 378
60 - 79% = 187
80 - 99% = 45

Index XQS_1000_3300_RCV_ID (2)
Depth: 2, leaf buckets: 465, nodes: 589944
Average data length: 0.80, total dup: 513971, max dup: 14
Fill distribution:
0 - 19% = 4
20 - 39% = 23
40 - 59% = 27
60 - 79% = 7
80 - 99% = 404

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 737, nodes: 589944
Average data length: 0.73, total dup: 520754, max dup: 44
Fill distribution:
0 - 19% = 33
20 - 39% = 5
40 - 59% = 453
60 - 79% = 207
80 - 99% = 39

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 76.15, total records: 922265
Average version length: 80.82, total versions: 48295, max versions: 1
Data pages: 13748, data page slots: 13748, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 7280
80 - 99% = 6467

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 965, nodes: 922265
Average data length: 0.05, total dup: 916740, max dup: 778
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 671
60 - 79% = 219
80 - 99% = 75

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 678, nodes: 922265
Average data length: 0.70, total dup: 814668, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 31
60 - 79% = 2
80 - 99% = 644

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1103, nodes: 922265
Average data length: 0.71, total dup: 814858, max dup: 117
Fill distribution:
0 - 19% = 4
20 - 39% = 1
40 - 59% = 720
60 - 79% = 281
80 - 99% = 97

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: 73.10, total records: 675815
Average version length: 80.01, total versions: 60539, max versions: 1
Data pages: 11065, data page slots: 11106, average fill: 74%
Fill distribution:
0 - 19% = 174
20 - 39% = 449
40 - 59% = 1084
60 - 79% = 6295
80 - 99% = 3063

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 643, nodes: 675815
Average data length: 0.05, total dup: 671621, max dup: 612
Fill distribution:
0 - 19% = 3
20 - 39% = 14
40 - 59% = 276
60 - 79% = 237
80 - 99% = 113

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 645, nodes: 675815
Average data length: 0.82, total dup: 588148, max dup: 14
Fill distribution:
0 - 19% = 6
20 - 39% = 157
40 - 59% = 69
60 - 79% = 20
80 - 99% = 393

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 751, nodes: 675815
Average data length: 0.74, total dup: 595013, max dup: 72
Fill distribution:
0 - 19% = 0
20 - 39% = 24
40 - 59% = 292
60 - 79% = 317
80 - 99% = 118

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 60.11, total records: 305624
Average version length: 68.16, total versions: 36685, max versions: 1
Data pages: 4113, data page slots: 4113, average fill: 79%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 3204
80 - 99% = 908

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 273, nodes: 305624
Average data length: 0.21, total dup: 296302, max dup: 384
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 95
60 - 79% = 99
80 - 99% = 79

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 317, nodes: 305624
Average data length: 0.82, total dup: 266059, max dup: 69
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 110
60 - 79% = 138
80 - 99% = 69

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 5490 ms, from 11:26:52.23 to 11:26:57.72.

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 412442 12833 3.1114
DOC_LIST 62925 4231 6.7238
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 58931 14732.7500
INVNT_TURNOVER_LOG 107485 107213 99.7469
MONEY_SALDO 49 2758 5628.5714
MONEY_TURNOVER_LOG 5178 5175 99.9420
OPTYPES 9 0 0.0000
PDISTR 114741 67762 59.0564
PERF_ESTIMATED 14076 2 0.0142
PERF_LOG 940458 1 0.0001
PSTORNED 77918 4183 5.3684
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 676 16900.0000
SETTINGS 114 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 172930 172886 99.9745
XQD_1000_3300 187330 57146 30.5055
XQD_1200_2000 226099 224351 99.2268
XQD_2000_3300 920053 708336 76.9886
XQD_2100_3300 187674 140697 74.9688
XQD_3300_3400 610097 263760 43.2324
XQS_1000_1200 879871 18370 2.0878
XQS_1000_3300 589944 67993 11.5253
XQS_1200_2000 922265 48295 5.2365
XQS_2100_3300 675815 60539 8.9579
XQS_3300_3400 305624 36685 12.0033
Z_USED_VIEWS 32 0 0.0000
Done for 3900 ms, from 11:27:09.06 to 11:27:12.96.

Database validation

11:27:13.21 Validation started

11:27:13.21 Relation 140 (DOC_LIST)
11:27:13.21 process pointer page 0 of 1
11:27:13.26 Index 1 (PK_DOC_LIST)
11:27:13.27 Index 2 (DOC_LIST_ID_DESC)
11:27:13.29 Index 3 (FK_DOC_LIST_AGENTS)
11:27:13.32 Relation 140 (DOC_LIST) is ok

11:27:13.32 Relation 141 (DOC_DATA)
11:27:13.32 process pointer page 0 of 3
11:27:13.42 process pointer page 1 of 3
11:27:13.52 process pointer page 2 of 3
11:27:13.56 Index 2 (DOC_DATA_DOC_WARE_UNQ)
11:27:13.71 Index 3 (DOC_DATA_ID_DESC)
11:27:13.82 Index 4 (FK_DOC_DATA_DOC_LIST)
11:27:13.85 Relation 141 (DOC_DATA) is ok

11:27:13.85 Relation 147 (INVNT_SALDO)
11:27:13.85 process pointer page 0 of 1
11:27:13.93 Index 1 (PK_INVNT_SALDO)
11:27:13.93 Relation 147 (INVNT_SALDO) is ok

11:27:13.93 Relation 150 (PDISTR)
11:27:13.93 process pointer page 0 of 1
11:27:14.05 Index 2 (PDISTR_SND_ID)
11:27:14.09 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
11:27:14.12 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
11:27:14.15 Index 5 (PDISTR_AGENT_ID)
11:27:14.18 Relation 150 (PDISTR) is ok

11:27:14.18 Relation 151 (PSTORNED)
11:27:14.18 process pointer page 0 of 1
11:27:14.23 Index 2 (PSTORNED_SND_ID)
11:27:14.26 Index 3 (PSTORNED_RCV_ID)
11:27:14.27 Relation 151 (PSTORNED) is ok

11:27:14.27 Relation 156 (SEMAPHORES)
11:27:14.27 process pointer page 0 of 1
11:27:14.27 Index 1 (PK_SEMAPHORES)
11:27:14.27 Index 2 (SEMAPHORES_TASK_UNQ)
11:27:14.27 Relation 156 (SEMAPHORES) is ok

11:27:14.27 Relation 157 (INVNT_TURNOVER_LOG)
11:27:14.27 process pointer page 0 of 1
11:27:14.41 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
11:27:14.48 Relation 157 (INVNT_TURNOVER_LOG) is ok

11:27:14.48 Relation 160 (PERF_ESTIMATED)
11:27:14.48 process pointer page 0 of 1
11:27:14.48 Index 1 (PERF_EST_MINUTE_SINCE_START)
11:27:14.48 Relation 160 (PERF_ESTIMATED) is ok

11:27:14.48 Relation 161 (PERF_ISQL_STAT)
11:27:14.48 process pointer page 0 of 1
11:27:14.48 Index 1 (PERF_ISQL_STAT_TRN)
11:27:14.48 Relation 161 (PERF_ISQL_STAT) is ok

11:27:14.48 Relation 162 (PERF_LOG)
11:27:14.48 process pointer page 0 of 12
11:27:14.55 process pointer page 1 of 12
11:27:14.63 process pointer page 2 of 12
11:27:14.71 process pointer page 3 of 12
11:27:14.77 process pointer page 4 of 12
11:27:14.85 process pointer page 5 of 12
11:27:14.93 process pointer page 6 of 12
11:27:15.01 process pointer page 7 of 12
11:27:15.08 process pointer page 8 of 12
11:27:15.15 process pointer page 9 of 12
11:27:15.22 process pointer page 10 of 12
11:27:15.30 process pointer page 11 of 12
11:27:15.30 Index 1 (PERF_LOG_DTS_BEG_DESC)
11:27:15.58 Index 2 (PERF_LOG_UNIT)
11:27:16.05 Index 3 (PERF_LOG_TRN_DESC)
11:27:16.33 Index 4 (PERF_LOG_GDSCODE)
11:27:16.55 Relation 162 (PERF_LOG) is ok

11:27:16.55 Relation 166 (V_STOPTEST)
11:27:16.55 Relation 166 (V_STOPTEST) is ok

11:27:16.55 Relation 183 (V_QDISTR_SOURCE)
11:27:16.55 Relation 183 (V_QDISTR_SOURCE) is ok

11:27:16.55 Relation 184 (V_QSTORNED_SOURCE)
11:27:16.55 Relation 184 (V_QSTORNED_SOURCE) is ok

11:27:16.55 Relation 258 (XQD_1000_1200)
11:27:16.55 process pointer page 0 of 2
11:27:16.72 process pointer page 1 of 2
11:27:16.77 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
11:27:16.82 Relation 258 (XQD_1000_1200) is ok

11:27:16.82 Relation 259 (XQD_1200_2000)
11:27:16.82 process pointer page 0 of 2
11:27:17.00 process pointer page 1 of 2
11:27:17.10 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
11:27:17.17 Relation 259 (XQD_1200_2000) is ok

11:27:17.17 Relation 260 (XQD_1000_3300)
11:27:17.17 process pointer page 0 of 2
11:27:17.30 process pointer page 1 of 2
11:27:17.33 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
11:27:17.38 Index 2 (XQD_1000_3300_DOC)
11:27:17.42 Relation 260 (XQD_1000_3300) is ok

11:27:17.42 Relation 261 (XQD_2000_3300)
11:27:17.42 process pointer page 0 of 7
11:27:17.61 process pointer page 1 of 7
11:27:17.78 process pointer page 2 of 7
11:27:17.95 process pointer page 3 of 7
11:27:18.14 process pointer page 4 of 7
11:27:18.31 process pointer page 5 of 7
11:27:18.42 process pointer page 6 of 7
11:27:18.47 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
11:27:18.78 Relation 261 (XQD_2000_3300) is ok

11:27:18.78 Relation 262 (XQD_2100_3300)
11:27:18.78 process pointer page 0 of 2
11:27:18.94 process pointer page 1 of 2
11:27:18.98 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
11:27:19.02 Relation 262 (XQD_2100_3300) is ok

11:27:19.02 Relation 263 (XQD_3300_3400)
11:27:19.02 process pointer page 0 of 5
11:27:19.16 process pointer page 1 of 5
11:27:19.30 process pointer page 2 of 5
11:27:19.41 process pointer page 3 of 5
11:27:19.53 process pointer page 4 of 5
11:27:19.61 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
11:27:19.83 Relation 263 (XQD_3300_3400) is ok

11:27:19.83 Relation 264 (XQS_1000_1200)
11:27:19.83 process pointer page 0 of 7
11:27:19.92 process pointer page 1 of 7
11:27:20.01 process pointer page 2 of 7
11:27:20.11 process pointer page 3 of 7
11:27:20.19 process pointer page 4 of 7
11:27:20.28 process pointer page 5 of 7
11:27:20.37 process pointer page 6 of 7
11:27:20.45 Index 1 (XQS_1000_1200_DOC_ID)
11:27:20.72 Index 2 (XQS_1000_1200_SND_ID)
11:27:21.00 Index 3 (XQS_1000_1200_RCV_ID)
11:27:21.22 Relation 264 (XQS_1000_1200) is ok

11:27:21.22 Relation 265 (XQS_1200_2000)
11:27:21.22 process pointer page 0 of 8
11:27:21.31 process pointer page 1 of 8
11:27:21.40 process pointer page 2 of 8
11:27:21.50 process pointer page 3 of 8
11:27:21.57 process pointer page 4 of 8
11:27:21.67 process pointer page 5 of 8
11:27:21.78 process pointer page 6 of 8
11:27:21.87 process pointer page 7 of 8
11:27:21.89 Index 1 (XQS_1200_2000_DOC_ID)
11:27:22.14 Index 2 (XQS_1200_2000_SND_ID)
11:27:22.43 Index 3 (XQS_1200_2000_RCV_ID)
11:27:22.53 Relation 265 (XQS_1200_2000) is ok

11:27:22.53 Relation 266 (XQS_1000_3300)
11:27:22.53 process pointer page 0 of 5
11:27:22.57 process pointer page 1 of 5
11:27:22.62 process pointer page 2 of 5
11:27:22.73 process pointer page 3 of 5
11:27:22.82 process pointer page 4 of 5
11:27:22.88 Index 1 (XQS_1000_3300_DOC_ID)
11:27:23.04 Index 2 (XQS_1000_3300_SND_ID)
11:27:23.21 Index 3 (XQS_1000_3300_RCV_ID)
11:27:23.35 Relation 266 (XQS_1000_3300) is ok

11:27:23.35 Relation 267 (XQS_2000_3300)
11:27:23.35 process pointer page 0 of 1
11:27:23.35 Index 1 (XQS_2000_3300_DOC_ID)
11:27:23.35 Index 2 (XQS_2000_3300_SND_ID)
11:27:23.35 Index 3 (XQS_2000_3300_RCV_ID)
11:27:23.35 Relation 267 (XQS_2000_3300) is ok

11:27:23.35 Relation 268 (XQS_2100_3300)
11:27:23.35 process pointer page 0 of 6
11:27:23.45 process pointer page 1 of 6
11:27:23.56 process pointer page 2 of 6
11:27:23.65 process pointer page 3 of 6
11:27:23.76 process pointer page 4 of 6
11:27:23.84 process pointer page 5 of 6
11:27:23.90 Index 1 (XQS_2100_3300_DOC_ID)
11:27:24.12 Index 2 (XQS_2100_3300_SND_ID)
11:27:24.23 Index 3 (XQS_2100_3300_RCV_ID)
11:27:24.30 Relation 268 (XQS_2100_3300) is ok

11:27:24.30 Relation 269 (XQS_3300_3400)
11:27:24.30 process pointer page 0 of 3
11:27:24.41 process pointer page 1 of 3
11:27:24.52 process pointer page 2 of 3
11:27:24.54 Index 1 (XQS_3300_3400_DOC_ID)
11:27:24.60 Index 2 (XQS_3300_3400_SND_ID)
11:27:24.66 Relation 269 (XQS_3300_3400) is ok

11:27:24.66 Relation 276 (TRACE_STAT)
11:27:24.66 process pointer page 0 of 1
11:27:24.66 Relation 276 (TRACE_STAT) is ok

11:27:24.66 Validation finished
Done for 11640 ms, from 11:27:13.04 to 11:27:24.68.

Differences between old and current firebird.log

11:27:25.33. 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-11-22 11:27 309 oltp25_fb_log_when_test_finished.log

End of gathering firebird.log AFTER test finish.

Comparison of old and new firebird.log (get messages that appeared during test):

+++ Start of comparison +++
result: files match. No new messages appeared in firebird.log during test ran.
+++ End of comparison +++

Final processing ISQL logs in e:\temp\logs.oltp25


Remove 401 logs of every ISQL session if there were no serious errors.

Remove logs of every ISQL session if there were no serious errors, pattern: e:\temp\logs.oltp25\oltp25_*.*:

ERRORS_CHECKING_RESULT
NO_SEVERE_ERRORS_FOUND
ISQL logs are removed because no severe errors occured during test.
2016-11-22 11:27:27.21 - end of report, text file: e:\temp\logs.oltp25\oltp25.report.txt, html: e:\temp\logs.oltp25\oltp25.report.html