Firebird 2.5 Performance Logs

Generated by E:\OLTP-HQBIRD\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 10. 2016-04-06 21:15:06.83.
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.5.26952 Firebird 2.5 HQbird #20160215
Server implementation: Firebird/x86-64/Windows NT
FB_ARCHITECTURE DB_NAME FORCED_WRITES SWEEP_INT PAGE_BUFFERS PAGE_SIZE
SuperClassic 2.5.5 D:\OLTP-HQBIRD\OLTP25-SMALL.FDB ON 0 1024 8192

Test configuration settings

File: E:\OLTP-HQBIRD\src\oltp25_config.win
PARAM_NAME PARAM_VALUE
fbc C:\Firebird\fb25hqbird\bin
dbnm D:\OLTP-HQBIRD\oltp25-small.fdb
host localhost
port 3049
usr SYSDBA
pwd masterke
tmpdir e:\temp\logs.hqbird.oltp25
working_mode small_03
warm_time 3
test_time 6
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-04-06 21:15:01.5930 -1 <null> 127.0.0.1 121564 4982 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 6 minutes: 4094.50 7265 24567 2016-04-06 21:09 2016-04-06 21:15
customer order: creation 57.17 68 343 2016-04-06 21:09 2016-04-06 21:15
customer order: refuse 3.40 52 17 2016-04-06 21:09 2016-04-06 21:15
order to supplier: creation 18.20 201 91 2016-04-06 21:09 2016-04-06 21:15
order to supplier: removal 1.00 88933 1 2016-04-06 21:09 2016-04-06 21:15
invoice (draft): creation 14.60 306 73 2016-04-06 21:09 2016-04-06 21:15
invoice (draft): removal 11.40 91 57 2016-04-06 21:09 2016-04-06 21:15
invoice accept: apply 11.60 39262 58 2016-04-06 21:09 2016-04-06 21:15
invoice accept: cancel 6.75 1137 27 2016-04-06 21:09 2016-04-06 21:15
customer reserve: creation 4123.80 97 20619 2016-04-06 21:09 2016-04-06 21:15
customer reserve: removal 546.60 30 2733 2016-04-06 21:09 2016-04-06 21:15
realization accept: apply 30.00 87 180 2016-04-06 21:09 2016-04-06 21:15
realization accept: cancel 23.75 30 95 2016-04-06 21:09 2016-04-06 21:15
payment from customer: creation 19.67 109 118 2016-04-06 21:09 2016-04-06 21:15
payment from customer: removal 2.80 32 14 2016-04-06 21:09 2016-04-06 21:15
payment to supplier: creation 18.00 118 90 2016-04-06 21:09 2016-04-06 21:15
payment to supplier: removal 1.67 35 5 2016-04-06 21:09 2016-04-06 21:15
service: total inventory turnovers 6.60 178 33 2016-04-06 21:09 2016-04-06 21:15
service: total monetary turnovers 2.60 3 13 2016-04-06 21:09 2016-04-06 21:15
service: refresh index statistics <null> <null> <null> 2016-04-06 21:09 2016-04-06 21:15
Done for 3510 ms, from 21:15:18.24 to 21:15:21.75.

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 <null> 7712 7706 6 0.08 21:09:02 21:09:38
interval # 2, overall 2 3376 3377 3376 1 0.03 21:09:39 21:10:15
interval # 3, overall 3 <null> 2374 2372 2 0.08 21:10:16 21:10:52
interval # 4, overall 4 4010 4016 4010 6 0.15 21:10:53 21:11:29
interval # 5, overall 5 2469 2473 2469 4 0.16 21:11:30 21:12:06
interval # 6, overall 6 <null> 1412 1412 0 0.00 21:12:07 21:12:43
interval # 7, overall 7 1059 1061 1059 2 0.19 21:12:44 21:13:20
interval # 8, overall 8 <null> 1150 1150 0 0.00 21:13:21 21:13:57
interval # 9, overall 9 749 749 749 0 0.00 21:13:58 21:14:34
interval # 10, overall 10 264 264 264 0 0.00 21:14:35 21:15:11
Done for 4360 ms, from 21:15:23.90 to 21:15:28.26.

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 12040.54 0.5170 1.4408 440 10
WARM_TIME 2 12056.24 0.7195 1.2506 425 10
WARM_TIME 3 11372.28 0.8839 1.1648 428 10
TEST_TIME 4 10235.31 0.9721 1.0257 136 6
TEST_TIME 5 9085.04 0.9245 1.0960 268 10
TEST_TIME 6 8416.45 0.9859 1.0234 111 7
TEST_TIME 7 7418.46 0.9952 1.0191 94 3
TEST_TIME 8 6918.98 0.9662 1.0208 94 5
TEST_TIME 9 6278.72 0.9999 1.0000 24 10
Done for 2410 ms, from 21:15:28.47 to 21:15:30.88.

Performance from TRACE for ISQL instance #1:

TRACED_DATA ITRV_NO SP_CLIENT_ORDER SP_CANCEL_CLIENT_ORDER SP_SUPPLIER_ORDER SP_CANCEL_SUPPLIER_ORDER SP_SUPPLIER_INVOICE SP_CANCEL_SUPPLIER_INVOICE SP_ADD_INVOICE_TO_STOCK SP_CANCEL_ADDING_INVOICE SP_CUSTOMER_RESERVE SP_CANCEL_CUSTOMER_RESERVE SP_RESERVE_WRITE_OFF SP_CANCEL_WRITE_OFF SP_PAY_FROM_CUSTOMER SP_CANCEL_PAY_FROM_CUSTOMER SP_PAY_TO_SUPPLIER SP_CANCEL_PAY_TO_SUPPLIER SRV_MAKE_INVNT_SALDO SRV_MAKE_MONEY_SALDO SRV_RECALC_IDX_STAT ITRV_BEG ITRV_END
fetches per second 1 18628 10710 27431 <null> 52348 <null> 187748 <null> <null> <null> 22907 <null> 50507 <null> 138563 <null> <null> 20568 <null> 21:09:02 21:09:38
fetches per second 2 17790 <null> <null> <null> 65862 20314 <null> <null> <null> <null> <null> <null> 96218 <null> 266014 <null> <null> <null> <null> 21:09:39 21:10:15
fetches per second 3 41512 <null> <null> <null> <null> <null> 25512 <null> 11456 <null> 40502 <null> 162000 <null> 226915 35151 447014 642833 <null> 21:10:16 21:10:52
fetches per second 4 31438 <null> 52233 <null> 78601 <null> 39791 <null> 4952 <null> 35504 9997 84068 <null> 210403 <null> 1056448 884600 <null> 21:10:53 21:11:29
fetches per second 5 24300 108850 50526 <null> 126341 <null> 42198 <null> <null> 57708 49354 <null> 55040 21608 246147 <null> <null> 967428 <null> 21:11:30 21:12:06
fetches per second 6 45586 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 1115268 <null> <null> 21:12:07 21:12:43
fetches per second 10 22199 46926 65717 <null> <null> <null> 38425 <null> <null> <null> 68818 <null> 23372 <null> 180566 <null> <null> <null> <null> 21:14:35 21:15:11
marks per second 1 3359 1044 3839 <null> 7239 <null> 2117 <null> <null> <null> 1983 <null> 1342 <null> 1991 <null> <null> 808 <null> 21:09:02 21:09:38
marks per second 2 2694 <null> <null> <null> 8787 2867 <null> <null> <null> <null> <null> <null> 2302 <null> 4926 <null> <null> <null> <null> 21:09:39 21:10:15
marks per second 3 7803 <null> <null> <null> <null> <null> 968 <null> 506 <null> 3526 <null> 3841 <null> 3019 3727 5653 13000 <null> 21:10:16 21:10:52
marks per second 4 5685 <null> 6781 <null> 9089 <null> 1692 <null> 454 <null> 3177 1281 2227 <null> 4162 <null> 13559 15600 <null> 21:10:53 21:11:29
marks per second 5 4496 9600 6489 <null> 16618 <null> 1019 <null> <null> 6144 5702 <null> 3137 2369 9705 <null> <null> 49142 <null> 21:11:30 21:12:06
marks per second 6 8103 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 19577 <null> <null> 21:12:07 21:12:43
marks per second 10 4090 4294 8523 <null> <null> <null> 743 <null> <null> <null> 1798 <null> 1052 <null> 3300 <null> <null> <null> <null> 21:14:35 21:15:11
reads/fetches*100 1 10 9 7 <null> 5 <null> 1 <null> <null> <null> 13 <null> 7 <null> 4 <null> <null> 1 <null> 21:09:02 21:09:38
reads/fetches*100 2 8 <null> <null> <null> 4 6 <null> <null> <null> <null> <null> <null> 6 <null> 4 <null> <null> <null> <null> 21:09:39 21:10:15
reads/fetches*100 3 9 <null> <null> <null> <null> <null> 3 <null> 8 <null> 10 <null> 6 <null> 4 6 0 1 <null> 21:10:16 21:10:52
reads/fetches*100 4 9 <null> 3 <null> 3 <null> 4 <null> 7 <null> 10 10 6 <null> 4 <null> 0 1 <null> 21:10:53 21:11:29
reads/fetches*100 5 9 7 3 <null> 3 <null> 2 <null> <null> 8 11 <null> 5 6 3 <null> <null> 1 <null> 21:11:30 21:12:06
reads/fetches*100 6 11 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 0 <null> <null> 21:12:07 21:12:43
reads/fetches*100 10 10 6 2 <null> <null> <null> 2 <null> <null> <null> 7 <null> 7 <null> 3 <null> <null> <null> <null> 21:14:35 21:15:11
writes/marks*100 1 11 14 7 <null> 8 <null> 2 <null> <null> <null> 7 <null> 0 <null> 0 <null> <null> 0 <null> 21:09:02 21:09:38
writes/marks*100 2 13 <null> <null> <null> 8 3 <null> <null> <null> <null> <null> <null> 0 <null> 0 <null> <null> <null> <null> 21:09:39 21:10:15
writes/marks*100 3 12 <null> <null> <null> <null> <null> 2 <null> 5 <null> 8 <null> 0 <null> 0 0 11 0 <null> 21:10:16 21:10:52
writes/marks*100 4 11 <null> 8 <null> 10 <null> 1 <null> 6 <null> 7 8 0 <null> 0 <null> 18 0 <null> 21:10:53 21:11:29
writes/marks*100 5 12 23 9 <null> 8 <null> 1 <null> <null> 8 7 <null> 0 0 0 <null> <null> 0 <null> 21:11:30 21:12:06
writes/marks*100 6 15 <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> <null> 15 <null> <null> 21:12:07 21:12:43
writes/marks*100 10 15 15 4 <null> <null> <null> 2 <null> <null> <null> 7 <null> 0 <null> 0 <null> <null> <null> <null> 21:14:35 21:15:11
Done for 6670 ms, from 21:15:31.07 to 21:15:37.74.

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 13400 13400 0 0.00 0 521 4 0 2016-04-06 21:09 2016-04-06 21:15
doc_list_biud 13399 13399 0 0.00 0 1504 7 0 2016-04-06 21:09 2016-04-06 21:15
sp_add_invoice_to_stock 76 58 18 23.68 575 201132 39262 18 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_adding_invoice 27 27 0 0.00 42 12885 1137 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_client_order 17 17 0 0.00 16 186 52 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_customer_reserve 2733 2733 0 0.00 1 395 30 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_pay_from_customer 14 14 0 0.00 11 73 32 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_pay_to_supplier 5 5 0 0.00 6 119 35 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_supplier_invoice 58 57 1 1.72 9 461 91 1 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_supplier_order 1 1 0 0.00 88933 88933 88933 0 2016-04-06 21:09 2016-04-06 21:15
sp_cancel_write_off 95 95 0 0.00 3 188 30 0 2016-04-06 21:09 2016-04-06 21:15
sp_client_order 343 343 0 0.00 10 736 68 0 2016-04-06 21:09 2016-04-06 21:15
sp_customer_reserve 20619 20619 0 0.00 0 2039 97 0 2016-04-06 21:09 2016-04-06 21:15
sp_fill_shopping_cart 507 507 0 0.00 1 382 20 0 2016-04-06 21:09 2016-04-06 21:15
sp_fill_shopping_cart_clo_res 20620 20620 0 0.00 0 107 1 0 2016-04-06 21:09 2016-04-06 21:15
sp_get_clo_for_invoice 58 58 0 0.00 4 254 88 0 2016-04-06 21:09 2016-04-06 21:15
sp_kill_cost_storno 142 142 0 0.00 0 101 6 0 2016-04-06 21:09 2016-04-06 21:15
sp_kill_qstorno_ret_qs2qd 5619 5619 0 0.00 0 389 13 0 2016-04-06 21:09 2016-04-06 21:15
sp_kill_qty_storno 3168 3168 0 0.00 0 1502 31 0 2016-04-06 21:09 2016-04-06 21:15
sp_lock_selected_doc 338 317 21 6.21 0 5 0 21 2016-04-06 21:09 2016-04-06 21:15
sp_make_cost_storno 446 446 0 0.00 1 307 44 0 2016-04-06 21:09 2016-04-06 21:15
sp_multiply_rows_for_pdistr 446 446 0 0.00 0 236 13 0 2016-04-06 21:09 2016-04-06 21:15
sp_multiply_rows_for_qdistr 343 343 0 0.00 0 281 23 0 2016-04-06 21:09 2016-04-06 21:15
sp_pay_from_customer 118 118 0 0.00 34 546 109 0 2016-04-06 21:09 2016-04-06 21:15
sp_pay_to_supplier 90 90 0 0.00 36 426 118 0 2016-04-06 21:09 2016-04-06 21:15
sp_payment_common 208 208 0 0.00 6 202 23 0 2016-04-06 21:09 2016-04-06 21:15
sp_qd_handle_on_cancel_clo 17 17 0 0.00 2 122 19 0 2016-04-06 21:09 2016-04-06 21:15
sp_qd_handle_on_invoice_upd_sts 85 85 0 0.00 7 1502 198 0 2016-04-06 21:09 2016-04-06 21:15
sp_qd_handle_on_reserve_upd_sts 180 180 0 0.00 0 196 16 0 2016-04-06 21:09 2016-04-06 21:15
sp_reserve_write_off 182 180 2 1.09 12 450 87 2 2016-04-06 21:09 2016-04-06 21:15
sp_supplier_invoice 73 73 0 0.00 21 1018 306 0 2016-04-06 21:09 2016-04-06 21:15
sp_supplier_order 91 91 0 0.00 19 653 201 0 2016-04-06 21:09 2016-04-06 21:15
srv_find_qd_qs_mism 8171 8171 0 0.00 0 347 3 0 2016-04-06 21:09 2016-04-06 21:15
srv_make_invnt_saldo 33 33 0 0.00 38 581 178 0 2016-04-06 21:09 2016-04-06 21:15
srv_make_money_saldo 13 13 0 0.00 1 9 3 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-abend:sp_add_invoice_to_stock 18 18 0 0.00 1 54 8 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-abend:sp_cancel_supplier_invoice 1 1 0 0.00 4 4 4 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-abend:sp_reserve_write_off 2 2 0 0.00 7 9 8 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_add_invoice_to_stock 62 62 0 0.00 8 9694 1226 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_adding_invoice 9 9 0 0.00 46 1837 522 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_client_order 17 17 0 0.00 1 100 18 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_customer_reserve 18 18 0 0.00 1 102 31 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_pay_from_customer 14 14 0 0.00 1 20 4 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_pay_to_supplier 5 5 0 0.00 1 10 4 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_supplier_invoice 4 4 0 0.00 2 88 29 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_supplier_order 1 1 0 0.00 16001 16001 16001 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_cancel_write_off 12 12 0 0.00 1 129 23 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_client_order 343 343 0 0.00 1 553 38 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_customer_reserve 14 14 0 0.00 1 95 25 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_pay_from_customer 118 118 0 0.00 0 279 28 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_pay_to_supplier 90 90 0 0.00 1 158 15 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_reserve_write_off 180 180 0 0.00 0 342 22 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_supplier_invoice 73 73 0 0.00 1 261 25 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:sp_supplier_order 91 91 0 0.00 1 282 42 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:srv_make_invnt_saldo 33 33 0 0.00 0 77 10 0 2016-04-06 21:09 2016-04-06 21:15
t$perf-norm:srv_make_money_saldo 13 13 0 0.00 1 87 10 0 2016-04-06 21:09 2016-04-06 21:15
v_add_invoice_to_stock 152 116 36 23.68 0 67 6 36 2016-04-06 21:09 2016-04-06 21:15
v_all_customers 518 518 0 0.00 0 6 0 0 2016-04-06 21:09 2016-04-06 21:15
v_all_suppliers 328 328 0 0.00 0 4 0 0 2016-04-06 21:09 2016-04-06 21:15
v_all_wares 686 686 0 0.00 0 6 0 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_adding_invoice 16 16 0 0.00 0 19 7 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_client_order 34 34 0 0.00 0 11 1 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_customer_prepayment 28 28 0 0.00 0 15 1 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_customer_reserve 36 36 0 0.00 0 5 1 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_payment_to_supplier 10 10 0 0.00 0 2 0 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_supplier_invoice 10 8 2 20.00 0 149 34 2 2016-04-06 21:09 2016-04-06 21:15
v_cancel_supplier_order 2 2 0 0.00 0 1 0 0 2016-04-06 21:09 2016-04-06 21:15
v_cancel_write_off 24 24 0 0.00 0 63 7 0 2016-04-06 21:09 2016-04-06 21:15
v_max_id_clo_ord 91 91 0 0.00 0 59 1 0 2016-04-06 21:09 2016-04-06 21:15
v_max_id_clo_res 14 14 0 0.00 1 5 2 0 2016-04-06 21:09 2016-04-06 21:15
v_max_id_ord_sup 73 73 0 0.00 0 5 1 0 2016-04-06 21:09 2016-04-06 21:15
v_max_non_paid_invoice 90 90 0 0.00 0 10 1 0 2016-04-06 21:09 2016-04-06 21:15
v_max_non_paid_realizn 118 118 0 0.00 3 40 6 0 2016-04-06 21:09 2016-04-06 21:15
v_min_id_clo_ord 91 91 0 0.00 0 80 6 0 2016-04-06 21:09 2016-04-06 21:15
v_min_id_clo_res 14 14 0 0.00 1 185 15 0 2016-04-06 21:09 2016-04-06 21:15
v_min_id_ord_sup 73 73 0 0.00 0 41 2 0 2016-04-06 21:09 2016-04-06 21:15
v_min_non_paid_invoice 90 90 0 0.00 3 139 13 0 2016-04-06 21:09 2016-04-06 21:15
v_min_non_paid_realizn 118 118 0 0.00 5 110 12 0 2016-04-06 21:09 2016-04-06 21:15
v_our_firm 168 168 0 0.00 0 5 0 0 2016-04-06 21:09 2016-04-06 21:15
v_reserve_write_off 364 360 4 1.09 0 74 1 4 2016-04-06 21:09 2016-04-06 21:15
x_lock_depdocs_on_canc_invoice 80 80 0 0.00 0 37 5 0 2016-04-06 21:09 2016-04-06 21:15
x_lock_depdocs_on_canc_sup_ord 1 1 0 0.00 77 77 77 0 2016-04-06 21:09 2016-04-06 21:15
x_make_qstorno_1000_1200 91 91 0 0.00 9 591 113 0 2016-04-06 21:09 2016-04-06 21:15
x_make_qstorno_1200_2000 73 73 0 0.00 14 876 263 0 2016-04-06 21:09 2016-04-06 21:15
x_make_qstorno_2100_3300 20620 20620 0 0.00 0 2029 90 0 2016-04-06 21:09 2016-04-06 21:15
Done for 11350 ms, from 21:15:41.25 to 21:15:52.60.

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
lock_conflict 21 sp_lock_selected_doc 335544345 2016-04-06 21:09 2016-04-06 21:13
Done for 1800 ms, from 21:15:52.73 to 21:15:54.53.

MON$DATABASE and FB VERSION info

MON$DATABASE_NAME D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
MON$PAGE_SIZE 8192
MON$ODS_MAJOR 11
MON$ODS_MINOR 2
MON$OLDEST_TRANSACTION 100509
MON$OLDEST_ACTIVE 119025
MON$OLDEST_SNAPSHOT 119025
MON$NEXT_TRANSACTION 121809
MON$PAGE_BUFFERS 1024
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 314809
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215/tcp (WIN-2BE1UI8LGDL)/P12
on disk structure version 11.2

Database statistics, full


Database "D:\OLTP-HQBIRD\oltp25-small.fdb"
Database header page information:
Flags 0
Checksum 12345
Generation 126894
Page size 8192
ODS version 11.2
Oldest transaction 100509
Oldest active 119025
Oldest snapshot 119025
Next transaction 121812
Bumped transaction 1
Sequence number 0
Next attachment ID 5040
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
Database GUID: {9DE52B4C-5F48-45BB-FC86-E1F63A260D94}
*END*


Database file sequence:
File D:\OLTP-HQBIRD\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: 38.49, total records: 745325
Average version length: 46.78, total versions: 129485, max versions: 1
Data pages: 7938, data page slots: 7938, average fill: 77%
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 15
60 - 79% = 6472
80 - 99% = 1445

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 2828, nodes: 745324
Average data length: 13.03, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 286
20 - 39% = 62
40 - 59% = 1462
60 - 79% = 66
80 - 99% = 952

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 2171, nodes: 745324
Average data length: 5.80, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 45
40 - 59% = 2124
60 - 79% = 2
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 3, leaf buckets: 915, nodes: 745325
Average data length: 1.47, total dup: 567861, max dup: 49
Fill distribution:
0 - 19% = 61
20 - 39% = 25
40 - 59% = 456
60 - 79% = 4
80 - 99% = 369

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 57.19, total records: 165970
Average version length: 37.51, total versions: 19493, max versions: 3
Data pages: 2084, data page slots: 2084, average fill: 79%
Fill distribution:
0 - 19% = 2
20 - 39% = 5
40 - 59% = 7
60 - 79% = 1602
80 - 99% = 468

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 159, nodes: 165970
Average data length: 0.01, total dup: 165920, max dup: 22802
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 120
60 - 79% = 21
80 - 99% = 18

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 402, nodes: 165970
Average data length: 6.15, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 46
20 - 39% = 53
40 - 59% = 98
60 - 79% = 59
80 - 99% = 146

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

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

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

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

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

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

INVNT_SALDO (147)
Primary pointer page: 216, Index root page: 217
Average record length: 63.99, total records: 400
Average version length: 15.11, total versions: 12296, max versions: 44
Data pages: 56, data page slots: 56, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 56

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.13, total records: 39481
Average version length: 71.07, total versions: 39409, max versions: 1
Data pages: 553, data page slots: 553, average fill: 92%
Fill distribution:
0 - 19% = 1
20 - 39% = 7
40 - 59% = 5
60 - 79% = 19
80 - 99% = 521

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 2, leaf buckets: 99, nodes: 39444
Average data length: 8.38, total dup: 3055, max dup: 3
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 51
60 - 79% = 27
80 - 99% = 21

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

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.63, total records: 1180
Average version length: 46.45, total versions: 1164, max versions: 1
Data pages: 13, data page slots: 13, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 12

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 1, nodes: 1180
Average data length: 0.68, total dup: 1117, max dup: 201
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
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: 290
Average version length: 57.53, total versions: 290, max versions: 1
Data pages: 4, data page slots: 4, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 3

Index MON_LOG_TABLE_STATS_DTS (4)
Depth: 1, leaf buckets: 1, nodes: 290
Average data length: 0.53, total dup: 166, max dup: 20
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: 290
Average data length: 0.00, total dup: 289, max dup: 289
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: 290
Average data length: 0.14, total dup: 285, max dup: 57
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: 290
Average data length: 2.47, total dup: 232, max dup: 4
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

Index PK_MON_LOG_TABLE_STATS (0)
Depth: 1, leaf buckets: 1, nodes: 290
Average data length: 5.19, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 1
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: 37.02, total records: 85117
Average version length: 30.80, total versions: 21163, max versions: 6
Data pages: 1341, data page slots: 1405, average fill: 53%
Fill distribution:
0 - 19% = 308
20 - 39% = 264
40 - 59% = 13
60 - 79% = 553
80 - 99% = 203

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 81, nodes: 85117
Average data length: 0.01, total dup: 85068, max dup: 9383
Fill distribution:
0 - 19% = 1
20 - 39% = 14
40 - 59% = 41
60 - 79% = 20
80 - 99% = 5

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 101, nodes: 85117
Average data length: 0.95, total dup: 76192, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 27
40 - 59% = 41
60 - 79% = 20
80 - 99% = 13

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 104, nodes: 85117
Average data length: 0.95, total dup: 76192, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 29
40 - 59% = 47
60 - 79% = 17
80 - 99% = 11

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 101, nodes: 85117
Average data length: 0.72, total dup: 76192, max dup: 30
Fill distribution:
0 - 19% = 1
20 - 39% = 30
40 - 59% = 44
60 - 79% = 16
80 - 99% = 10

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 16.62, total records: 3910
Average version length: 27.18, total versions: 1420, max versions: 1
Data pages: 33, data page slots: 311, average fill: 72%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 21
80 - 99% = 11

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

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: 149.71, total records: 3691946
Average version length: 75.67, total versions: 6, max versions: 3
Data pages: 86826, data page slots: 86826, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 0
80 - 99% = 86825

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 3910, nodes: 3691946
Average data length: 0.37, total dup: 2685897, max dup: 66
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 2107
60 - 79% = 1132
80 - 99% = 669

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 4194, nodes: 3691946
Average data length: 0.18, total dup: 3591650, max dup: 16262
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3259
60 - 79% = 498
80 - 99% = 437

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 4214, nodes: 3691946
Average data length: 0.19, total dup: 3633905, max dup: 377158
Fill distribution:
0 - 19% = 7
20 - 39% = 1
40 - 59% = 3436
60 - 79% = 318
80 - 99% = 452

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: 46.21, total records: 130119
Average version length: 55.20, total versions: 21436, max versions: 1
Data pages: 1528, data page slots: 1528, average fill: 78%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1
60 - 79% = 1173
80 - 99% = 353

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 156, nodes: 130119
Average data length: 1.10, total dup: 108551, max dup: 415
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 112
60 - 79% = 38
80 - 99% = 4

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 122, nodes: 130119
Average data length: 0.66, total dup: 117567, max dup: 90
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 52
60 - 79% = 47
80 - 99% = 23

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

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: 9.00, total versions: 2, max versions: 1
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: 38.29, total records: 868
Average version length: 59.47, total versions: 304, max versions: 1
Data pages: 11, data page slots: 14, average fill: 79%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 5
80 - 99% = 5

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: 1.73, total records: 34724
Average version length: 72.16, total versions: 33900, max versions: 1
Data pages: 485, data page slots: 485, average fill: 93%
Fill distribution:
0 - 19% = 2
20 - 39% = 1
40 - 59% = 0
60 - 79% = 7
80 - 99% = 475

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 42, nodes: 34724
Average data length: 1.48, total dup: 30312, max dup: 14
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 21
60 - 79% = 11
80 - 99% = 7

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 55.70, total records: 258204
Average version length: 70.02, total versions: 56594, max versions: 1
Data pages: 3555, data page slots: 3592, average fill: 82%
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 0
60 - 79% = 849
80 - 99% = 2704

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 252, nodes: 258210
Average data length: 0.27, total dup: 247791, max dup: 116
Fill distribution:
0 - 19% = 3
20 - 39% = 46
40 - 59% = 79
60 - 79% = 50
80 - 99% = 74

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 333, nodes: 258204
Average data length: 1.32, total dup: 223706, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 11
40 - 59% = 203
60 - 79% = 65
80 - 99% = 54

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 21.21, total records: 116154
Average version length: 71.44, total versions: 81701, max versions: 1
Data pages: 1600, data page slots: 1600, average fill: 89%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 141
80 - 99% = 1459

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 125, nodes: 116154
Average data length: 1.42, total dup: 99966, max dup: 52
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 38
60 - 79% = 51
80 - 99% = 34

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 12.53, total records: 1959329
Average version length: 69.55, total versions: 1615698, max versions: 1
Data pages: 26665, data page slots: 26665, average fill: 91%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 4157
80 - 99% = 22508

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 2551, nodes: 1959329
Average data length: 0.85, total dup: 1790634, max dup: 99
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 2265
60 - 79% = 144
80 - 99% = 141

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 0.68, total records: 83755
Average version length: 71.14, total versions: 82933, max versions: 1
Data pages: 1565, data page slots: 1656, average fill: 69%
Fill distribution:
0 - 19% = 413
20 - 39% = 27
40 - 59% = 11
60 - 79% = 8
80 - 99% = 1106

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 85, nodes: 83755
Average data length: 0.97, total dup: 76604, max dup: 95
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 32
60 - 79% = 30
80 - 99% = 23

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 35.38, total records: 1486212
Average version length: 69.36, total versions: 741321, max versions: 1
Data pages: 20267, data page slots: 20275, average fill: 86%
Fill distribution:
0 - 19% = 16
20 - 39% = 28
40 - 59% = 42
60 - 79% = 3580
80 - 99% = 16601

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 2154, nodes: 1485928
Average data length: 1.48, total dup: 1250533, max dup: 29
Fill distribution:
0 - 19% = 3
20 - 39% = 1
40 - 59% = 1857
60 - 79% = 153
80 - 99% = 140

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 77.34, total records: 1362886
Average version length: 81.69, total versions: 70977, max versions: 1
Data pages: 20463, data page slots: 20463, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 6257
80 - 99% = 14205

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1502, nodes: 1362886
Average data length: 0.15, total dup: 1332338, max dup: 172
Fill distribution:
0 - 19% = 13
20 - 39% = 0
40 - 59% = 1042
60 - 79% = 386
80 - 99% = 61

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 1063, nodes: 1362886
Average data length: 0.69, total dup: 1199162, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 150
60 - 79% = 22
80 - 99% = 890

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1681, nodes: 1362886
Average data length: 0.72, total dup: 1195278, max dup: 44
Fill distribution:
0 - 19% = 11
20 - 39% = 0
40 - 59% = 1139
60 - 79% = 450
80 - 99% = 81

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 50.54, total records: 1263759
Average version length: 81.17, total versions: 482788, max versions: 1
Data pages: 19000, data page slots: 19005, average fill: 86%
Fill distribution:
0 - 19% = 17
20 - 39% = 20
40 - 59% = 45
60 - 79% = 1814
80 - 99% = 17104

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1146, nodes: 1263525
Average data length: 0.11, total dup: 1243692, max dup: 504
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 412
60 - 79% = 406
80 - 99% = 327

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1270, nodes: 1263759
Average data length: 0.96, total dup: 1063849, max dup: 14
Fill distribution:
0 - 19% = 57
20 - 39% = 27
40 - 59% = 449
60 - 79% = 16
80 - 99% = 721

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 1288, nodes: 1263521
Average data length: 0.49, total dup: 1159671, max dup: 100
Fill distribution:
0 - 19% = 33
20 - 39% = 1
40 - 59% = 468
60 - 79% = 455
80 - 99% = 331

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 54.22, total records: 1969954
Average version length: 82.99, total versions: 663204, max versions: 1
Data pages: 29668, data page slots: 29668, average fill: 85%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7007
80 - 99% = 22660

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1910, nodes: 1969954
Average data length: 0.04, total dup: 1961748, max dup: 1657
Fill distribution:
0 - 19% = 5
20 - 39% = 7
40 - 59% = 967
60 - 79% = 617
80 - 99% = 314

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 1472, nodes: 1969954
Average data length: 0.50, total dup: 1799445, max dup: 49
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 173
60 - 79% = 29
80 - 99% = 1268

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 2106, nodes: 1969954
Average data length: 0.48, total dup: 1807460, max dup: 228
Fill distribution:
0 - 19% = 4
20 - 39% = 2
40 - 59% = 1063
60 - 79% = 689
80 - 99% = 348

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: 53.56, total records: 1480953
Average version length: 81.45, total versions: 513429, max versions: 1
Data pages: 22300, data page slots: 22309, average fill: 85%
Fill distribution:
0 - 19% = 20
20 - 39% = 21
40 - 59% = 51
60 - 79% = 1995
80 - 99% = 20213

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1385, nodes: 1480688
Average data length: 0.04, total dup: 1474765, max dup: 1357
Fill distribution:
0 - 19% = 1
20 - 39% = 16
40 - 59% = 591
60 - 79% = 461
80 - 99% = 316

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1624, nodes: 1481157
Average data length: 0.97, total dup: 1246252, max dup: 14
Fill distribution:
0 - 19% = 61
20 - 39% = 85
40 - 59% = 686
60 - 79% = 43
80 - 99% = 749

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 1524, nodes: 1480524
Average data length: 0.47, total dup: 1363798, max dup: 129
Fill distribution:
0 - 19% = 3
20 - 39% = 15
40 - 59% = 625
60 - 79% = 537
80 - 99% = 344

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 39.76, total records: 389486
Average version length: 68.49, total versions: 163794, max versions: 1
Data pages: 5248, data page slots: 5248, average fill: 84%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 1735
80 - 99% = 3512

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 362, nodes: 389486
Average data length: 0.25, total dup: 375290, max dup: 197
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 129
60 - 79% = 148
80 - 99% = 84

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 414, nodes: 389486
Average data length: 0.84, total dup: 337817, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 157
60 - 79% = 168
80 - 99% = 89

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 8610 ms, from 21:15:55.08 to 21:16:03.69.

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 745325 129485 17.3729
DOC_LIST 165970 19493 11.7448
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 12296 3074.0000
INVNT_TURNOVER_LOG 39481 39409 99.8176
MONEY_SALDO 49 457 932.6530
MONEY_TURNOVER_LOG 1180 1164 98.6440
MON_LOG_TABLE_STATS 290 290 100.0000
OPTYPES 9 0 0.0000
PDISTR 85117 21163 24.8634
PERF_ESTIMATED 3910 1420 36.3171
PERF_LOG 3691946 6 0.0001
PSTORNED 130119 21436 16.4741
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 115 2875.0000
SETTINGS 114 2 1.7543
TRACE_STAT 868 304 35.0230
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 34724 33900 97.6270
XQD_1000_3300 258204 56594 21.9183
XQD_1200_2000 116154 81701 70.3385
XQD_2000_3300 1959329 1615698 82.4618
XQD_2100_3300 83755 82933 99.0185
XQD_3300_3400 1486212 741321 49.8798
XQS_1000_1200 1362886 70977 5.2078
XQS_1000_3300 1263759 482788 38.2025
XQS_1200_2000 1969954 663204 33.6659
XQS_2100_3300 1480953 513429 34.6688
XQS_3300_3400 389486 163794 42.0538
Z_USED_VIEWS 32 0 0.0000
Done for 2620 ms, from 21:16:14.40 to 21:16:17.02.

Database validation

21:16:17.14 Validation started

21:16:17.14 Relation 140 (DOC_LIST)
21:16:17.14 process pointer page 0 of 2
21:16:18.08 process pointer page 1 of 2
21:16:18.20 Index 1 (PK_DOC_LIST)
21:16:18.25 Index 2 (DOC_LIST_ID_DESC)
21:16:18.31 Index 3 (FK_DOC_LIST_AGENTS)
21:16:18.37 Relation 140 (DOC_LIST) is ok

21:16:18.37 Relation 141 (DOC_DATA)
21:16:18.37 process pointer page 0 of 5
21:16:18.48 process pointer page 1 of 5
21:16:18.60 process pointer page 2 of 5
21:16:18.74 process pointer page 3 of 5
21:16:20.72 process pointer page 4 of 5
21:16:20.87 Index 2 (DOC_DATA_DOC_WARE_UNQ)
21:16:21.13 Index 3 (DOC_DATA_ID_DESC)
21:16:21.43 Index 4 (FK_DOC_DATA_DOC_LIST)
21:16:21.61 Relation 141 (DOC_DATA) is ok

21:16:21.61 Relation 147 (INVNT_SALDO)
21:16:21.61 process pointer page 0 of 1
21:16:21.63 Index 1 (PK_INVNT_SALDO)
21:16:21.63 Relation 147 (INVNT_SALDO) is ok

21:16:21.63 Relation 150 (PDISTR)
21:16:21.63 process pointer page 0 of 1
21:16:22.18 Index 2 (PDISTR_SND_ID)
21:16:22.21 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
21:16:22.24 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
21:16:22.26 Index 5 (PDISTR_AGENT_ID)
21:16:22.29 Relation 150 (PDISTR) is ok

21:16:22.29 Relation 151 (PSTORNED)
21:16:22.29 process pointer page 0 of 1
21:16:22.86 Index 2 (PSTORNED_SND_ID)
21:16:22.90 Index 3 (PSTORNED_RCV_ID)
21:16:22.93 Relation 151 (PSTORNED) is ok

21:16:22.93 Relation 156 (SEMAPHORES)
21:16:22.93 process pointer page 0 of 1
21:16:22.93 Index 1 (PK_SEMAPHORES)
21:16:22.93 Index 2 (SEMAPHORES_TASK_UNQ)
21:16:22.93 Relation 156 (SEMAPHORES) is ok

21:16:22.93 Relation 157 (INVNT_TURNOVER_LOG)
21:16:22.93 process pointer page 0 of 2
21:16:22.98 process pointer page 1 of 2
21:16:22.98 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
21:16:23.00 Relation 157 (INVNT_TURNOVER_LOG) is ok

21:16:23.00 Relation 160 (PERF_ESTIMATED)
21:16:23.00 process pointer page 0 of 1
21:16:23.05 Index 1 (PERF_EST_MINUTE_SINCE_START)
21:16:23.05 Relation 160 (PERF_ESTIMATED) is ok

21:16:23.05 Relation 161 (PERF_ISQL_STAT)
21:16:23.05 process pointer page 0 of 1
21:16:23.05 Index 1 (PERF_ISQL_STAT_TRN)
21:16:23.05 Relation 161 (PERF_ISQL_STAT) is ok

21:16:23.05 Relation 162 (PERF_LOG)
21:16:23.05 process pointer page 0 of 46
21:16:23.13 process pointer page 1 of 46
21:16:23.17 process pointer page 2 of 46
21:16:23.20 process pointer page 3 of 46
21:16:23.23 process pointer page 4 of 46
21:16:23.28 process pointer page 5 of 46
21:16:23.31 process pointer page 6 of 46
21:16:23.35 process pointer page 7 of 46
21:16:23.38 process pointer page 8 of 46
21:16:23.41 process pointer page 9 of 46
21:16:23.45 process pointer page 10 of 46
21:16:23.48 process pointer page 11 of 46
21:16:23.51 process pointer page 12 of 46
21:16:23.53 process pointer page 13 of 46
21:16:23.55 process pointer page 14 of 46
21:16:23.58 process pointer page 15 of 46
21:16:23.61 process pointer page 16 of 46
21:16:23.64 process pointer page 17 of 46
21:16:23.67 process pointer page 18 of 46
21:16:23.70 process pointer page 19 of 46
21:16:23.75 process pointer page 20 of 46
21:16:23.83 process pointer page 21 of 46
21:16:23.86 process pointer page 22 of 46
21:16:23.89 process pointer page 23 of 46
21:16:23.94 process pointer page 24 of 46
21:16:25.39 process pointer page 25 of 46
21:16:26.68 process pointer page 26 of 46
21:16:27.66 process pointer page 27 of 46
21:16:28.92 process pointer page 28 of 46
21:16:30.11 process pointer page 29 of 46
21:16:31.05 process pointer page 30 of 46
21:16:32.48 process pointer page 31 of 46
21:16:33.99 process pointer page 32 of 46
21:16:35.34 process pointer page 33 of 46
21:16:36.86 process pointer page 34 of 46
21:16:38.42 process pointer page 35 of 46
21:16:39.88 process pointer page 36 of 46
21:16:40.88 process pointer page 37 of 46
21:16:41.56 process pointer page 38 of 46
21:16:42.36 process pointer page 39 of 46
21:16:43.03 process pointer page 40 of 46
21:16:44.04 process pointer page 41 of 46
21:16:44.80 process pointer page 42 of 46
21:16:45.45 process pointer page 43 of 46
21:16:45.85 process pointer page 44 of 46
21:16:46.22 process pointer page 45 of 46
21:16:46.34 Index 1 (PERF_LOG_DTS_BEG_DESC)
21:16:47.05 Index 2 (PERF_LOG_UNIT)
21:16:48.52 Index 3 (PERF_LOG_TRN_DESC)
21:16:49.14 Index 4 (PERF_LOG_GDSCODE)
21:16:49.60 Relation 162 (PERF_LOG) is ok

21:16:49.60 Relation 166 (V_STOPTEST)
21:16:49.60 Relation 166 (V_STOPTEST) is ok

21:16:49.60 Relation 183 (V_QDISTR_SOURCE)
21:16:49.60 Relation 183 (V_QDISTR_SOURCE) is ok

21:16:49.60 Relation 184 (V_QSTORNED_SOURCE)
21:16:49.60 Relation 184 (V_QSTORNED_SOURCE) is ok

21:16:49.60 Relation 258 (XQD_1000_1200)
21:16:49.61 process pointer page 0 of 2
21:16:49.66 process pointer page 1 of 2
21:16:49.66 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
21:16:49.68 Relation 258 (XQD_1000_1200) is ok

21:16:49.68 Relation 259 (XQD_1200_2000)
21:16:49.68 process pointer page 0 of 2
21:16:50.27 process pointer page 1 of 2
21:16:50.27 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
21:16:50.30 Relation 259 (XQD_1200_2000) is ok

21:16:50.30 Relation 260 (XQD_1000_3300)
21:16:50.30 process pointer page 0 of 2
21:16:51.57 process pointer page 1 of 2
21:16:52.72 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
21:16:52.75 Index 1 is corrupt (record 1016193 have missing entries)
21:16:52.75 Index 2 (XQD_1000_3300_DOC)
21:16:52.79 Relation has 1 orphan backversions (56594 in use)
21:16:52.79 Relation 260 (XQD_1000_3300) : 2 ERRORS found

21:16:52.79 Relation 261 (XQD_2000_3300)
21:16:52.79 process pointer page 0 of 14
21:16:52.94 process pointer page 1 of 14
21:16:53.12 process pointer page 2 of 14
21:16:53.31 process pointer page 3 of 14
21:16:53.43 process pointer page 4 of 14
21:16:53.55 process pointer page 5 of 14
21:16:53.74 process pointer page 6 of 14
21:16:53.92 process pointer page 7 of 14
21:16:54.01 process pointer page 8 of 14
21:16:54.24 process pointer page 9 of 14
21:16:54.53 process pointer page 10 of 14
21:16:55.20 process pointer page 11 of 14
21:16:55.97 process pointer page 12 of 14
21:16:57.46 process pointer page 13 of 14
21:16:58.80 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
21:16:59.38 Relation 261 (XQD_2000_3300) is ok

21:16:59.38 Relation 262 (XQD_2100_3300)
21:16:59.38 process pointer page 0 of 3
21:16:59.51 process pointer page 1 of 3
21:16:59.51 process pointer page 2 of 3
21:16:59.51 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
21:16:59.54 Relation has 3 orphan backversions (82933 in use)
21:16:59.54 Relation 262 (XQD_2100_3300) : 1 ERRORS found

21:16:59.54 Relation 263 (XQD_3300_3400)
21:16:59.54 process pointer page 0 of 11
21:16:59.80 process pointer page 1 of 11
21:16:59.98 process pointer page 2 of 11
21:17:00.16 process pointer page 3 of 11
21:17:00.36 process pointer page 4 of 11
21:17:00.53 process pointer page 5 of 11
21:17:00.69 process pointer page 6 of 11
21:17:00.85 process pointer page 7 of 11
21:17:02.17 process pointer page 8 of 11
21:17:03.23 process pointer page 9 of 11
21:17:04.88 process pointer page 10 of 11
21:17:05.91 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
21:17:06.48 Relation 263 (XQD_3300_3400) is ok

21:17:06.48 Relation 264 (XQS_1000_1200)
21:17:06.48 process pointer page 0 of 11
21:17:06.52 process pointer page 1 of 11
21:17:06.62 process pointer page 2 of 11
21:17:06.66 process pointer page 3 of 11
21:17:06.74 process pointer page 4 of 11
21:17:06.84 process pointer page 5 of 11
21:17:06.95 process pointer page 6 of 11
21:17:07.05 process pointer page 7 of 11
21:17:07.16 process pointer page 8 of 11
21:17:07.67 process pointer page 9 of 11
21:17:08.27 process pointer page 10 of 11
21:17:08.61 Index 1 (XQS_1000_1200_DOC_ID)
21:17:08.92 Index 2 (XQS_1000_1200_SND_ID)
21:17:09.34 Index 3 (XQS_1000_1200_RCV_ID)
21:17:09.52 Relation 264 (XQS_1000_1200) is ok

21:17:09.52 Relation 265 (XQS_1200_2000)
21:17:09.52 process pointer page 0 of 16
21:17:09.56 process pointer page 1 of 16
21:17:09.61 process pointer page 2 of 16
21:17:09.65 process pointer page 3 of 16
21:17:09.69 process pointer page 4 of 16
21:17:09.74 process pointer page 5 of 16
21:17:09.82 process pointer page 6 of 16
21:17:09.87 process pointer page 7 of 16
21:17:09.96 process pointer page 8 of 16
21:17:10.07 process pointer page 9 of 16
21:17:10.17 process pointer page 10 of 16
21:17:10.48 process pointer page 11 of 16
21:17:11.26 process pointer page 12 of 16
21:17:11.84 process pointer page 13 of 16
21:17:12.64 process pointer page 14 of 16
21:17:13.93 process pointer page 15 of 16
21:17:14.32 Index 1 (XQS_1200_2000_DOC_ID)
21:17:14.92 Index 2 (XQS_1200_2000_SND_ID)
21:17:15.32 Index 3 (XQS_1200_2000_RCV_ID)
21:17:15.70 Relation 265 (XQS_1200_2000) is ok

21:17:15.70 Relation 266 (XQS_1000_3300)
21:17:15.71 process pointer page 0 of 10
21:17:15.85 process pointer page 1 of 10
21:17:15.99 process pointer page 2 of 10
21:17:16.15 process pointer page 3 of 10
21:17:16.29 process pointer page 4 of 10
21:17:16.44 process pointer page 5 of 10
21:17:16.58 process pointer page 6 of 10
21:17:17.19 process pointer page 7 of 10
21:17:18.20 process pointer page 8 of 10
21:17:19.77 process pointer page 9 of 10
21:17:21.27 Index 1 (XQS_1000_3300_DOC_ID)
21:17:21.66 Index 2 (XQS_1000_3300_SND_ID)
21:17:21.83 Index 3 (XQS_1000_3300_RCV_ID)
21:17:21.93 Relation 266 (XQS_1000_3300) is ok

21:17:21.93 Relation 267 (XQS_2000_3300)
21:17:21.94 process pointer page 0 of 1
21:17:21.94 Index 1 (XQS_2000_3300_DOC_ID)
21:17:21.94 Index 2 (XQS_2000_3300_SND_ID)
21:17:21.94 Index 3 (XQS_2000_3300_RCV_ID)
21:17:21.94 Relation 267 (XQS_2000_3300) is ok

21:17:21.94 Relation 268 (XQS_2100_3300)
21:17:21.94 process pointer page 0 of 12
21:17:21.98 process pointer page 1 of 12
21:17:22.02 process pointer page 2 of 12
21:17:22.07 process pointer page 3 of 12
21:17:22.11 process pointer page 4 of 12
21:17:22.15 process pointer page 5 of 12
21:17:22.19 process pointer page 6 of 12
21:17:22.24 process pointer page 7 of 12
21:17:22.42 process pointer page 8 of 12
21:17:23.72 process pointer page 9 of 12
21:17:25.08 process pointer page 10 of 12
21:17:26.49 process pointer page 11 of 12
21:17:27.38 Index 1 (XQS_2100_3300_DOC_ID)
21:17:27.38 Index 1 misses node on page 1166 level 1
21:17:27.62 Index 2 (XQS_2100_3300_SND_ID)
21:17:27.63 Index 2 has inconsistent left sibling pointer, page 215596 level 1
21:17:28.07 Index 3 (XQS_2100_3300_RCV_ID)
21:17:28.48 Relation 268 (XQS_2100_3300) : 2 ERRORS found

21:17:28.49 Relation 269 (XQS_3300_3400)
21:17:28.49 process pointer page 0 of 3
21:17:28.64 process pointer page 1 of 3
21:17:28.82 process pointer page 2 of 3
21:17:29.25 Index 1 (XQS_3300_3400_DOC_ID)
21:17:29.34 Index 2 (XQS_3300_3400_SND_ID)
21:17:29.44 Relation 269 (XQS_3300_3400) is ok

21:17:29.44 Relation 276 (TRACE_STAT)
21:17:29.44 process pointer page 0 of 1
21:17:29.45 Relation 276 (TRACE_STAT) is ok

21:17:29.45 Validation finished
Done for 72420 ms, from 21:16:17.05 to 21:17:29.47.

Differences between old and current firebird.log

21:17:30.55. Got:
STDOUT: ---------- E:\TEMP\LOGS.HQBIRD.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 61321 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-04-06 21:17 4454753 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 +++
***** E:\TEMP\LOGS.HQBIRD.OLTP25\oltp25_fb_log_when_test_started.log
***** E:\TEMP\LOGS.HQBIRD.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG
73550: WIN-2BE1UI8LGDL Wed Apr 06 21:16:52 2016
73551: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73552: Index 1 is corrupt (record 1016193 have missing entries) in table XQD_1000_3300 (260)
73553:
73554:
73555: WIN-2BE1UI8LGDL Wed Apr 06 21:16:52 2016
73556: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73557: Relation has 1 orphan backversions (56594 in use) in table XQD_1000_3300 (260)
73558:
73559:
73560: WIN-2BE1UI8LGDL Wed Apr 06 21:16:59 2016
73561: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73562: Relation has 3 orphan backversions (82933 in use) in table XQD_2100_3300 (262)
73563:
73564:
73565: WIN-2BE1UI8LGDL Wed Apr 06 21:17:27 2016
73566: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73567: Index 1 misses node on page 1166 level 1 in table XQS_2100_3300 (268)
73568:
73569:
73570: WIN-2BE1UI8LGDL Wed Apr 06 21:17:27 2016
73571: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73572: Index 2 has inconsistent left sibling pointer, page 215596 level 1 in table XQS_2100_3300 (268)
73573:
73574:
*****
+++ End of comparison +++

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


Remove 32 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.hqbird.oltp25\oltp25_*.*:

ERRORS_CHECKING_RESULT
NO_SEVERE_ERRORS_FOUND
ISQL logs are removed because no severe errors occured during test.
2016-04-06 21:17:32.49 - end of report, text file: e:\temp\logs.hqbird.oltp25\oltp25.report.txt, html: e:\temp\logs.hqbird.oltp25\oltp25.report.html