Firebird 2.5 Performance Logs

Generated by E:\OLTP-HQBIRD\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 10. 2016-07-09 21:25:46.28.
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 #20160429
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 384 8192

Test configuration settings

File: E:\OLTP-HQBIRD\src\oltp25_config.win
PARAM_NAME PARAM_VALUE
fbc E:\HQBIRD\bin
dbnm D:\OLTP-HQBIRD\oltp25-small.fdb
host localhost
port 3005
usr SYSDBA
pwd masterke
tmpdir e:\temp\logs.hqbird.oltp25
working_mode small_03
warm_time 3
test_time 40
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-07-09 21:25:34.3970 -1 <null> 127.0.0.1 341652 87592 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 40 minutes: 11160.68 2091 446427 2016-07-09 20:45 2016-07-09 21:25
customer order: creation 173.20 63 6928 2016-07-09 20:45 2016-07-09 21:25
customer order: refuse 13.79 48 538 2016-07-09 20:45 2016-07-09 21:25
order to supplier: creation 43.80 205 1752 2016-07-09 20:45 2016-07-09 21:25
order to supplier: removal 1.33 17523 52 2016-07-09 20:45 2016-07-09 21:25
invoice (draft): creation 45.43 426 1817 2016-07-09 20:45 2016-07-09 21:25
invoice (draft): removal 27.32 112 1038 2016-07-09 20:45 2016-07-09 21:25
invoice accept: apply 22.53 14926 901 2016-07-09 20:45 2016-07-09 21:25
invoice accept: cancel 11.95 578 466 2016-07-09 20:45 2016-07-09 21:25
customer reserve: creation 9487.65 30 379506 2016-07-09 20:45 2016-07-09 21:25
customer reserve: removal 1100.92 16 42936 2016-07-09 20:45 2016-07-09 21:25
realization accept: apply 81.22 82 3249 2016-07-09 20:45 2016-07-09 21:25
realization accept: cancel 43.38 37 1692 2016-07-09 20:45 2016-07-09 21:25
payment from customer: creation 55.95 100 2238 2016-07-09 20:45 2016-07-09 21:25
payment from customer: removal 5.18 42 202 2016-07-09 20:45 2016-07-09 21:25
payment to supplier: creation 48.95 101 1909 2016-07-09 20:45 2016-07-09 21:25
payment to supplier: removal 3.46 39 135 2016-07-09 20:45 2016-07-09 21:25
service: total inventory turnovers 16.48 135 659 2016-07-09 20:45 2016-07-09 21:25
service: total monetary turnovers 10.44 5 407 2016-07-09 20:45 2016-07-09 21:25
service: refresh index statistics 0.13 5265 2 2016-07-09 20:45 2016-07-09 21:25
Done for 22030 ms, from 21:26:13.95 to 21:26:35.98.

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 10154 40725 40614 111 0.27 20:45:35 20:49:35
interval # 2, overall 2 3661 14993 14645 348 2.32 20:49:36 20:53:36
interval # 3, overall 3 4386 17558 17542 16 0.09 20:53:37 20:57:37
interval # 4, overall 4 13571 55438 54285 1153 2.08 20:57:38 21:01:38
interval # 5, overall 5 14605 61535 58418 3117 5.07 21:01:39 21:05:39
interval # 6, overall 6 14374 61099 57495 3604 5.90 21:05:40 21:09:40
interval # 7, overall 7 12306 54236 49224 5012 9.24 21:09:41 21:13:41
interval # 8, overall 8 13617 58456 54467 3989 6.82 21:13:42 21:17:42
interval # 9, overall 9 13121 52582 52483 99 0.19 21:17:43 21:21:43
interval # 10, overall 10 11814 48890 47254 1636 3.35 21:21:44 21:25:44
Done for 36150 ms, from 21:27:11.97 to 21:27:48.12.

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 9109.27 0.3840 1.8219 805 10
WARM_TIME 2 12126.01 0.6843 1.3204 552 10
WARM_TIME 3 11154.75 0.9569 1.0381 70 5
TEST_TIME 4 9297.69 0.9341 1.0641 265 7
TEST_TIME 5 9768.46 0.8103 1.1244 835 10
TEST_TIME 6 10060.47 0.9098 1.1190 591 10
TEST_TIME 7 10485.87 0.9203 1.0675 703 10
TEST_TIME 8 10326.43 0.9485 1.0370 388 10
TEST_TIME 9 9593.82 0.9973 1.0009 58 3
TEST_TIME 10 8713.35 0.9985 1.0021 75 3
TEST_TIME 11 8078.45 0.9895 1.0031 75 4
TEST_TIME 12 7459.31 0.9984 1.0002 23 1
TEST_TIME 13 6952.02 0.9952 1.0109 47 3
TEST_TIME 14 6753.62 0.9681 1.0288 220 7
TEST_TIME 15 6936.43 0.9350 1.0804 555 10
TEST_TIME 16 7456.00 0.9423 1.0597 516 10
TEST_TIME 17 7750.33 0.9595 1.0311 615 10
TEST_TIME 18 7958.05 0.9484 1.0432 655 10
TEST_TIME 19 8258.08 0.9524 1.0551 746 10
TEST_TIME 20 8585.39 0.9642 1.0411 704 10
TEST_TIME 21 8822.82 0.9648 1.0458 606 10
TEST_TIME 22 9211.87 0.9561 1.0305 988 10
TEST_TIME 23 9354.78 0.9707 1.0315 794 10
TEST_TIME 24 9577.30 0.9656 1.0203 877 10
TEST_TIME 25 9678.63 0.9693 1.0256 665 9
TEST_TIME 26 9788.97 0.9751 1.0339 651 10
TEST_TIME 27 10040.90 0.9706 1.0245 508 9
TEST_TIME 28 10237.43 0.9689 1.0274 714 10
TEST_TIME 29 10347.36 0.9815 1.0177 772 10
TEST_TIME 30 10376.66 0.9824 1.0224 694 10
TEST_TIME 31 10451.10 0.9824 1.0181 638 9
TEST_TIME 32 10435.11 0.9878 1.0206 635 10
TEST_TIME 33 10567.41 0.9773 1.0201 846 10
TEST_TIME 34 10682.11 0.9795 1.0191 654 10
TEST_TIME 35 10782.40 0.9807 1.0191 680 10
TEST_TIME 36 10872.55 0.9826 1.0211 722 10
TEST_TIME 37 10975.78 0.9842 1.0152 652 10
TEST_TIME 38 11054.45 0.9814 1.0163 698 10
TEST_TIME 39 11045.85 0.9913 1.0098 493 9
TEST_TIME 40 11043.59 0.9848 1.0171 735 10
TEST_TIME 41 11125.87 0.9849 1.0151 734 10
TEST_TIME 42 11155.36 0.9883 1.0128 666 10
TEST_TIME 43 11123.68 0.9921 1.0079 400 10
Done for 3400 ms, from 21:27:48.93 to 21:27:52.33.

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 28037 54028 51787 <null> 72656 62615 172764 106846 31656 44425 28392 13284 43495 21047 90433 <null> 274280 232108 <null> 20:45:35 20:49:35
fetches per second 2 30139 26859 50783 44529 39752 <null> 90315 <null> <null> <null> 27960 9221 <null> <null> 126562 <null> 115444 <null> <null> 20:49:36 20:53:36
fetches per second 3 14768 <null> <null> <null> <null> <null> 64621 <null> <null> <null> <null> 10984 <null> <null> <null> <null> <null> <null> <null> 20:53:37 20:57:37
fetches per second 4 32110 30254 49891 22079 78147 59328 228054 67211 28117 22718 42310 24506 72185 10996 88684 <null> 544792 498518 <null> 20:57:38 21:01:38
fetches per second 5 32640 35071 46155 161969 67676 80800 157640 55213 39841 36618 34811 18045 61353 18020 93743 38464 395157 298349 <null> 21:01:39 21:05:39
fetches per second 6 32409 35383 46569 <null> 70906 63901 266701 64499 28234 36640 30838 18211 67250 8196 77691 25250 825108 149547 <null> 21:05:40 21:09:40
fetches per second 7 22875 33544 40721 67668 58372 75380 125132 <null> 30495 27162 26376 26892 64250 4650 73326 <null> <null> 194430 <null> 21:09:41 21:13:41
fetches per second 8 32495 51047 54470 53107 57619 <null> 275189 69538 17934 39175 24960 13365 63342 <null> 65175 16826 522864 217940 <null> 21:13:42 21:17:42
fetches per second 9 36939 33345 60763 <null> 83205 <null> 206910 48081 21810 38346 37861 17556 71825 26215 55680 29659 623616 221408 <null> 21:17:43 21:21:43
fetches per second 10 28699 43152 42727 153125 78587 <null> 129505 60519 36055 20367 41748 20005 66843 18264 25250 <null> 273655 461767 <null> 21:21:44 21:25:44
marks per second 1 5166 5609 8879 <null> 12714 10779 3031 10013 2201 4725 3101 1664 2177 2573 3060 <null> 17627 9903 <null> 20:45:35 20:49:35
marks per second 2 5650 2957 7290 5637 6978 <null> 2766 <null> <null> <null> 2769 1000 <null> <null> 5837 <null> 11076 <null> <null> 20:49:36 20:53:36
marks per second 3 2844 <null> <null> <null> <null> <null> 902 <null> <null> <null> <null> 1232 <null> <null> <null> <null> <null> <null> <null> 20:53:37 20:57:37
marks per second 4 5755 3071 8049 2204 11142 11776 3221 6340 2075 2597 3943 2670 2672 1188 3238 <null> 14394 31823 <null> 20:57:38 21:01:38
marks per second 5 5937 3573 7954 30031 10342 14080 3222 5449 1887 4994 3346 2086 2068 2473 4337 4615 18025 12311 <null> 21:01:39 21:05:39
marks per second 6 6116 3693 7880 <null> 11826 9983 3368 6055 1536 3523 4291 1791 3612 1049 5462 3877 20862 3398 <null> 21:05:40 21:09:40
marks per second 7 4230 3071 6382 6748 8824 13840 3315 <null> 2061 3168 2994 2800 2012 587 5296 <null> <null> 11805 <null> 21:09:41 21:13:41
marks per second 8 5777 5160 9052 5379 8841 <null> 3719 7040 1653 3875 3549 1515 2055 <null> 4508 1965 7612 6624 <null> 21:13:42 21:17:42
marks per second 9 6406 3268 9986 <null> 14128 <null> 3352 4609 1918 4376 4352 1880 2578 2994 4558 3863 14604 10391 <null> 21:17:43 21:21:43
marks per second 10 5288 4350 7195 28478 13107 <null> 4050 6122 2975 2261 3285 2360 2144 2191 2552 <null> 18592 27005 <null> 21:21:44 21:25:44
reads/fetches*100 1 9 7 5 <null> 5 3 2 1 7 7 12 11 9 7 6 <null> 0 2 <null> 20:45:35 20:49:35
reads/fetches*100 2 8 8 5 2 7 <null> 2 <null> <null> <null> 12 9 <null> <null> 7 <null> 1 <null> <null> 20:49:36 20:53:36
reads/fetches*100 3 6 <null> <null> <null> <null> <null> 1 <null> <null> <null> <null> 10 <null> <null> <null> <null> <null> <null> <null> 20:53:37 20:57:37
reads/fetches*100 4 8 7 5 7 5 3 1 1 8 11 11 9 9 7 8 <null> 1 2 <null> 20:57:38 21:01:38
reads/fetches*100 5 9 10 5 2 5 4 2 3 8 10 12 11 9 10 8 7 1 2 <null> 21:01:39 21:05:39
reads/fetches*100 6 9 10 5 <null> 4 5 1 2 11 8 12 8 9 11 7 8 1 3 <null> 21:05:40 21:09:40
reads/fetches*100 7 10 9 5 2 4 4 2 <null> 7 9 13 9 9 14 6 <null> <null> 2 <null> 21:09:41 21:13:41
reads/fetches*100 8 10 9 5 2 5 <null> 1 2 9 16 13 13 9 <null> 6 7 1 1 <null> 21:13:42 21:17:42
reads/fetches*100 9 10 9 4 <null> 4 <null> 1 2 7 9 13 11 9 7 7 6 1 3 <null> 21:17:43 21:21:43
reads/fetches*100 10 10 8 6 2 4 <null> 2 2 7 11 12 12 9 7 7 <null> 1 2 <null> 21:21:44 21:25:44
writes/marks*100 1 10 15 8 <null> 7 1 2 2 8 6 8 9 4 0 3 <null> 13 2 <null> 20:45:35 20:49:35
writes/marks*100 2 11 12 10 3 7 <null> 2 <null> <null> <null> 7 8 <null> <null> 5 <null> 12 <null> <null> 20:49:36 20:53:36
writes/marks*100 3 11 <null> <null> <null> <null> <null> 1 <null> <null> <null> <null> 11 <null> <null> <null> <null> <null> <null> <null> 20:53:37 20:57:37
writes/marks*100 4 10 16 8 10 8 2 2 2 14 6 8 8 5 0 4 <null> 11 0 <null> 20:57:38 21:01:38
writes/marks*100 5 10 16 7 2 8 0 3 4 13 5 8 13 6 0 3 1 11 2 <null> 21:01:39 21:05:39
writes/marks*100 6 9 12 6 <null> 8 0 2 2 5 4 7 11 6 0 4 0 9 0 <null> 21:05:40 21:09:40
writes/marks*100 7 11 15 7 3 7 12 3 <null> 10 6 7 10 6 1 2 <null> <null> 6 <null> 21:09:41 21:13:41
writes/marks*100 8 11 18 6 2 8 <null> 2 2 14 8 7 17 7 <null> 1 0 11 5 <null> 21:13:42 21:17:42
writes/marks*100 9 12 15 8 <null> 7 <null> 2 2 0 7 8 10 7 0 1 0 13 0 <null> 21:17:43 21:21:43
writes/marks*100 10 11 14 7 3 7 <null> 3 3 5 7 9 15 7 0 0 <null> 20 4 <null> 21:21:44 21:25:44
Done for 8930 ms, from 21:27:52.84 to 21:28:01.77.

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 246014 227893 18121 7.36 0 1732 4 18121 2016-07-09 20:45 2016-07-09 21:25
doc_list_biud 246063 227892 18171 7.38 0 3011 4 18171 2016-07-09 20:45 2016-07-09 21:25
sp_add_invoice_to_stock 1660 901 759 45.72 125 400468 14926 759 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_adding_invoice 572 466 106 18.53 15 6147 578 106 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_client_order 580 538 42 7.24 0 343 48 42 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_customer_reserve 60575 42936 17639 29.11 0 1295 16 17639 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_pay_from_customer 202 202 0 0.00 0 344 42 0 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_pay_to_supplier 135 135 0 0.00 0 171 39 0 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_supplier_invoice 1238 1038 200 16.15 0 765 112 200 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_supplier_order 118 52 66 55.93 15 74381 17523 66 2016-07-09 20:45 2016-07-09 21:25
sp_cancel_write_off 1930 1692 238 12.33 0 374 37 238 2016-07-09 20:45 2016-07-09 21:25
sp_client_order 6928 6928 0 0.00 0 437 63 0 2016-07-09 20:45 2016-07-09 21:25
sp_customer_reserve 379506 379506 0 0.00 0 3463 30 0 2016-07-09 20:45 2016-07-09 21:25
sp_fill_shopping_cart 10497 10497 0 0.00 0 1466 13 0 2016-07-09 20:45 2016-07-09 21:25
sp_fill_shopping_cart_clo_res 379506 379506 0 0.00 0 375 1 0 2016-07-09 20:45 2016-07-09 21:25
sp_get_clo_for_invoice 902 902 0 0.00 0 655 145 0 2016-07-09 20:45 2016-07-09 21:25
sp_kill_cost_storno 2831 2495 336 11.86 0 561 12 336 2016-07-09 20:45 2016-07-09 21:25
sp_kill_qstorno_ret_qs2qd 124312 88654 35658 28.68 0 1279 7 35658 2016-07-09 20:45 2016-07-09 21:25
sp_kill_qty_storno 69035 50872 18163 26.30 0 3011 17 18163 2016-07-09 20:45 2016-07-09 21:25
sp_lock_selected_doc 6780 5820 960 14.15 0 140 0 960 2016-07-09 20:45 2016-07-09 21:25
sp_make_cost_storno 8298 8298 0 0.00 0 795 35 0 2016-07-09 20:45 2016-07-09 21:25
sp_multiply_rows_for_pdistr 8298 8298 0 0.00 0 608 17 0 2016-07-09 20:45 2016-07-09 21:25
sp_multiply_rows_for_qdistr 6928 6928 0 0.00 0 343 21 0 2016-07-09 20:45 2016-07-09 21:25
sp_pay_from_customer 2238 2238 0 0.00 31 967 100 0 2016-07-09 20:45 2016-07-09 21:25
sp_pay_to_supplier 1909 1909 0 0.00 0 702 101 0 2016-07-09 20:45 2016-07-09 21:25
sp_payment_common 4147 4147 0 0.00 0 296 22 0 2016-07-09 20:45 2016-07-09 21:25
sp_qd_handle_on_cancel_clo 580 538 42 7.24 0 312 16 42 2016-07-09 20:45 2016-07-09 21:25
sp_qd_handle_on_invoice_upd_sts 1472 1367 105 7.13 0 3011 108 105 2016-07-09 20:45 2016-07-09 21:25
sp_qd_handle_on_reserve_upd_sts 3249 3249 0 0.00 0 343 10 0 2016-07-09 20:45 2016-07-09 21:25
sp_reserve_write_off 3284 3249 35 1.06 0 640 82 35 2016-07-09 20:45 2016-07-09 21:25
sp_supplier_invoice 1817 1817 0 0.00 15 2777 426 0 2016-07-09 20:45 2016-07-09 21:25
sp_supplier_order 1752 1752 0 0.00 15 1810 205 0 2016-07-09 20:45 2016-07-09 21:25
srv_find_qd_qs_mism 155258 137141 18117 11.66 0 1732 3 18117 2016-07-09 20:45 2016-07-09 21:25
srv_make_invnt_saldo 659 659 0 0.00 0 936 135 0 2016-07-09 20:45 2016-07-09 21:25
srv_make_money_saldo 407 407 0 0.00 0 109 5 0 2016-07-09 20:45 2016-07-09 21:25
srv_recalc_idx_stat 2 2 0 0.00 2496 8034 5265 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_add_invoice_to_stock 759 759 0 0.00 0 234 17 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_adding_invoice 4 4 0 0.00 15 63 27 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_client_order 42 42 0 0.00 0 188 17 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_customer_reserve 2 2 0 0.00 0 15 7 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_supplier_invoice 52 52 0 0.00 0 156 15 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_supplier_order 2077 2077 0 0.00 0 858 92 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_cancel_write_off 2 2 0 0.00 15 31 23 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-abend:sp_reserve_write_off 35 35 0 0.00 0 94 17 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_add_invoice_to_stock 910 910 0 0.00 0 16022 1976 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_adding_invoice 124 124 0 0.00 0 4805 776 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_client_order 538 538 0 0.00 0 296 28 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_customer_reserve 209 209 0 0.00 0 250 27 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_pay_from_customer 202 202 0 0.00 0 312 30 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_pay_to_supplier 135 135 0 0.00 0 203 23 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_supplier_invoice 69 69 0 0.00 0 359 35 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_supplier_order 52 52 0 0.00 0 28454 3968 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_cancel_write_off 341 341 0 0.00 0 405 31 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_client_order 6928 6928 0 0.00 0 468 35 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_customer_reserve 326 326 0 0.00 0 281 29 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_pay_from_customer 2238 2238 0 0.00 0 343 25 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_pay_to_supplier 1909 1909 0 0.00 0 375 25 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_reserve_write_off 3249 3249 0 0.00 0 359 31 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_supplier_invoice 1817 1817 0 0.00 0 453 35 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:sp_supplier_order 1752 1752 0 0.00 0 1451 36 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:srv_make_invnt_saldo 659 659 0 0.00 0 250 17 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:srv_make_money_saldo 407 407 0 0.00 0 281 15 0 2016-07-09 20:45 2016-07-09 21:25
t$perf-norm:srv_recalc_idx_stat 2 2 0 0.00 125 218 171 0 2016-07-09 20:45 2016-07-09 21:25
v_add_invoice_to_stock 3320 1802 1518 45.72 0 280 4 1518 2016-07-09 20:45 2016-07-09 21:25
v_all_customers 10356 10356 0 0.00 0 16 0 0 2016-07-09 20:45 2016-07-09 21:25
v_all_suppliers 7588 7588 0 0.00 0 16 0 0 2016-07-09 20:45 2016-07-09 21:25
v_all_wares 13856 13856 0 0.00 0 16 0 0 2016-07-09 20:45 2016-07-09 21:25
v_cancel_adding_invoice 252 248 4 1.58 0 172 15 4 2016-07-09 20:45 2016-07-09 21:25
v_cancel_client_order 1160 1076 84 7.24 0 63 1 84 2016-07-09 20:45 2016-07-09 21:25
v_cancel_customer_prepayment 404 404 0 0.00 0 47 1 0 2016-07-09 20:45 2016-07-09 21:25
v_cancel_customer_reserve 422 418 4 0.94 0 31 2 4 2016-07-09 20:45 2016-07-09 21:25
v_cancel_payment_to_supplier 270 270 0 0.00 0 32 1 0 2016-07-09 20:45 2016-07-09 21:25
v_cancel_supplier_invoice 242 138 104 42.97 0 32 3 104 2016-07-09 20:45 2016-07-09 21:25
v_cancel_supplier_order 236 104 132 55.93 0 16 0 132 2016-07-09 20:45 2016-07-09 21:25
v_cancel_write_off 686 682 4 0.58 0 203 11 4 2016-07-09 20:45 2016-07-09 21:25
v_max_id_clo_ord 1752 1752 0 0.00 0 140 1 0 2016-07-09 20:45 2016-07-09 21:25
v_max_id_clo_res 326 326 0 0.00 0 156 5 0 2016-07-09 20:45 2016-07-09 21:25
v_max_id_ord_sup 1817 1817 0 0.00 0 32 0 0 2016-07-09 20:45 2016-07-09 21:25
v_max_non_paid_invoice 1684 1684 0 0.00 0 265 1 0 2016-07-09 20:45 2016-07-09 21:25
v_max_non_paid_realizn 2238 2238 0 0.00 0 141 6 0 2016-07-09 20:45 2016-07-09 21:25
v_min_id_clo_ord 1752 1752 0 0.00 0 140 3 0 2016-07-09 20:45 2016-07-09 21:25
v_min_id_clo_res 326 326 0 0.00 0 32 1 0 2016-07-09 20:45 2016-07-09 21:25
v_min_id_ord_sup 1817 1817 0 0.00 0 141 2 0 2016-07-09 20:45 2016-07-09 21:25
v_min_non_paid_invoice 1909 1909 0 0.00 0 296 14 0 2016-07-09 20:45 2016-07-09 21:25
v_min_non_paid_realizn 2238 2238 0 0.00 0 172 11 0 2016-07-09 20:45 2016-07-09 21:25
v_our_firm 3500 3500 0 0.00 0 16 0 0 2016-07-09 20:45 2016-07-09 21:25
v_reserve_write_off 6568 6498 70 1.06 0 140 2 70 2016-07-09 20:45 2016-07-09 21:25
x_lock_depdocs_on_canc_invoice 1921 1435 486 25.29 0 94 6 486 2016-07-09 20:45 2016-07-09 21:25
x_lock_depdocs_on_canc_sup_ord 118 52 66 55.93 0 47 10 66 2016-07-09 20:45 2016-07-09 21:25
x_make_qstorno_1000_1200 1752 1752 0 0.00 0 1779 159 0 2016-07-09 20:45 2016-07-09 21:25
x_make_qstorno_1200_2000 1817 1817 0 0.00 0 2730 386 0 2016-07-09 20:45 2016-07-09 21:25
x_make_qstorno_2100_3300 379506 379506 0 0.00 0 3463 24 0 2016-07-09 20:45 2016-07-09 21:25
Done for 61590 ms, from 21:28:53.21 to 21:29:54.80.

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

Exceptions occured during test work:

FB_MNEMONA CNT UNIT FB_GDSCODE DTS_BEG DTS_END
deadlock 7 sp_kill_cost_storno 335544336 2016-07-09 20:59 2016-07-09 21:25
deadlock 12 sp_lock_selected_doc 335544336 2016-07-09 20:59 2016-07-09 21:25
deadlock 1 sp_qd_handle_on_invoice_upd_sts 335544336 2016-07-09 21:17 2016-07-09 21:17
lock_conflict 1 sp_kill_cost_storno 335544345 2016-07-09 21:02 2016-07-09 21:02
lock_conflict 838 sp_lock_selected_doc 335544345 2016-07-09 20:46 2016-07-09 21:25
lock_conflict 42 sp_qd_handle_on_cancel_clo 335544345 2016-07-09 20:50 2016-07-09 21:25
lock_conflict 2 sp_qd_handle_on_invoice_upd_sts 335544345 2016-07-09 20:47 2016-07-09 20:52
lock_conflict 3 x_lock_depdocs_on_canc_invoice 335544345 2016-07-09 21:05 2016-07-09 21:23
lock_conflict 54 x_lock_depdocs_on_canc_sup_ord 335544345 2016-07-09 20:47 2016-07-09 21:25
Done for 3550 ms, from 21:29:56.14 to 21:29:59.69.

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 342038
MON$OLDEST_ACTIVE 342039
MON$OLDEST_SNAPSHOT 342039
MON$NEXT_TRANSACTION 342039
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 478649
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.5.26952 Firebird 2.5 HQbird #20160429
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160429"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160429/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160429/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 429946
Page size 8192
ODS version 11.2
Oldest transaction 342040
Oldest active 342041
Oldest snapshot 342041
Next transaction 342042
Bumped transaction 1
Sequence number 0
Next attachment ID 87653
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:
Database backup GUID: {67C91EA6-AB07-466B-EAAD-26BCA6D04031}
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: 42.88, total records: 982926
Average version length: 47.94, total versions: 88008, max versions: 1
Data pages: 10596, data page slots: 10596, average fill: 75%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 7
60 - 79% = 10112
80 - 99% = 476

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 4591, nodes: 982926
Average data length: 13.80, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 436
20 - 39% = 984
40 - 59% = 1722
60 - 79% = 410
80 - 99% = 1039

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 3328, nodes: 982926
Average data length: 5.66, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 1203
40 - 59% = 2110
60 - 79% = 15
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 3, leaf buckets: 1546, nodes: 982926
Average data length: 1.82, total dup: 689056, max dup: 49
Fill distribution:
0 - 19% = 108
20 - 39% = 384
40 - 59% = 472
60 - 79% = 159
80 - 99% = 423

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 57.80, total records: 289373
Average version length: 36.69, total versions: 32546, max versions: 4
Data pages: 3632, data page slots: 3632, average fill: 79%
Fill distribution:
0 - 19% = 1
20 - 39% = 2
40 - 59% = 10
60 - 79% = 2756
80 - 99% = 863

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

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 311, nodes: 289373
Average data length: 0.01, total dup: 289323, max dup: 31794
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 263
60 - 79% = 26
80 - 99% = 22

Index PK_DOC_LIST (0)
Depth: 3, leaf buckets: 781, nodes: 289373
Average data length: 6.07, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 107
20 - 39% = 170
40 - 59% = 166
60 - 79% = 133
80 - 99% = 205

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.80, total records: 400
Average version length: 14.57, total versions: 82136, max versions: 316
Data pages: 338, data page slots: 378, average fill: 96%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 337

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: 1.47, total records: 20717
Average version length: 71.19, total versions: 20288, max versions: 1
Data pages: 387, data page slots: 396, average fill: 70%
Fill distribution:
0 - 19% = 11
20 - 39% = 40
40 - 59% = 67
60 - 79% = 93
80 - 99% = 176

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 2, leaf buckets: 69, nodes: 20717
Average data length: 8.64, total dup: 1034, max dup: 1
Fill distribution:
0 - 19% = 0
20 - 39% = 11
40 - 59% = 38
60 - 79% = 20
80 - 99% = 0

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.67, total records: 49
Average version length: 9.02, total versions: 1251, max versions: 378
Data pages: 6, data page slots: 6, average fill: 72%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 2
80 - 99% = 3

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: 1.12, total records: 637
Average version length: 46.55, total versions: 622, max versions: 1
Data pages: 8, data page slots: 8, average fill: 79%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 3
80 - 99% = 4

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 1, nodes: 637
Average data length: 1.25, total dup: 579, max dup: 118
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
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: 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: 41.16, total records: 104300
Average version length: 29.61, total versions: 12321, max versions: 9
Data pages: 1264, data page slots: 1404, average fill: 66%
Fill distribution:
0 - 19% = 139
20 - 39% = 51
40 - 59% = 8
60 - 79% = 994
80 - 99% = 72

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 88, nodes: 104300
Average data length: 0.01, total dup: 104251, max dup: 4321
Fill distribution:
0 - 19% = 0
20 - 39% = 7
40 - 59% = 42
60 - 79% = 28
80 - 99% = 11

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 112, nodes: 104300
Average data length: 0.91, total dup: 93721, max dup: 25
Fill distribution:
0 - 19% = 1
20 - 39% = 19
40 - 59% = 43
60 - 79% = 28
80 - 99% = 21

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 110, nodes: 104300
Average data length: 0.91, total dup: 93721, max dup: 25
Fill distribution:
0 - 19% = 0
20 - 39% = 15
40 - 59% = 43
60 - 79% = 35
80 - 99% = 17

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 117, nodes: 104300
Average data length: 0.69, total dup: 93721, max dup: 25
Fill distribution:
0 - 19% = 1
20 - 39% = 28
40 - 59% = 47
60 - 79% = 32
80 - 99% = 9

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 28.72, total records: 24802
Average version length: 19.00, total versions: 104, max versions: 1
Data pages: 223, data page slots: 410, average fill: 63%
Fill distribution:
0 - 19% = 11
20 - 39% = 2
40 - 59% = 1
60 - 79% = 209
80 - 99% = 0

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

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

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

PERF_LOG (162)
Primary pointer page: 299, Index root page: 300
Average record length: 152.12, total records: 8411007
Average version length: 126.00, total versions: 1, max versions: 1
Data pages: 200051, data page slots: 200051, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 200050

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 8825, nodes: 8411007
Average data length: 0.27, total dup: 6744470, max dup: 76
Fill distribution:
0 - 19% = 7
20 - 39% = 0
40 - 59% = 3807
60 - 79% = 3204
80 - 99% = 1807

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 10102, nodes: 8411007
Average data length: 0.12, total dup: 8261175, max dup: 28679
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 8080
60 - 79% = 1074
80 - 99% = 948

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 10352, nodes: 8411007
Average data length: 0.12, total dup: 8343749, max dup: 1030958
Fill distribution:
0 - 19% = 11
20 - 39% = 1
40 - 59% = 9031
60 - 79% = 475
80 - 99% = 834

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.16, total records: 171998
Average version length: 56.89, total versions: 15625, max versions: 1
Data pages: 2044, data page slots: 2044, average fill: 77%
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 2
60 - 79% = 1809
80 - 99% = 231

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 221, nodes: 171998
Average data length: 1.11, total dup: 143168, max dup: 971
Fill distribution:
0 - 19% = 1
20 - 39% = 12
40 - 59% = 136
60 - 79% = 57
80 - 99% = 15

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 175, nodes: 171998
Average data length: 0.70, total dup: 154334, max dup: 104
Fill distribution:
0 - 19% = 0
20 - 39% = 2
40 - 59% = 78
60 - 79% = 72
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: 1139, max versions: 705
Data pages: 4, data page slots: 4, average fill: 91%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 4

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

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

SETTINGS (137)
Primary pointer page: 183, Index root page: 184
Average record length: 98.32, total records: 114
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 2, data page slots: 2, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 1

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

TMP$AUTOGEN$RAND$CALLS (136)
Primary pointer page: 180, Index root page: 181
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$AUTOGEN$SOURCE (135)
Primary pointer page: 178, Index root page: 179
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$DEP_DOCS (129)
Primary pointer page: 159, Index root page: 160
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

TMP$IDX_RECALC (132)
Primary pointer page: 169, Index root page: 170
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

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

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

TMP$PERF_LOG (163)
Primary pointer page: 301, Index root page: 302
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

TMP$PERF_MON (131)
Primary pointer page: 167, Index root page: 168
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

TMP$RESULT_SET (130)
Primary pointer page: 162, Index root page: 163
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

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

TMP$SHOPPING_CART (128)
Primary pointer page: 155, Index root page: 156
Average record length: 0.00, total records: 0
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 0, data page slots: 0, average fill: 0%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

TRACE_STAT (276)
Primary pointer page: 513, Index root page: 95177
Average record length: 59.63, total records: 4642
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 60, data page slots: 88, average fill: 73%
Fill distribution:
0 - 19% = 1
20 - 39% = 3
40 - 59% = 0
60 - 79% = 56
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: 3.28, total records: 20038
Average version length: 72.20, total versions: 19130, max versions: 1
Data pages: 278, data page slots: 282, average fill: 93%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 4
80 - 99% = 273

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 20, nodes: 20038
Average data length: 1.65, total dup: 17489, max dup: 14
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3
60 - 79% = 9
80 - 99% = 8

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 67.01, total records: 325543
Average version length: 71.42, total versions: 22947, max versions: 1
Data pages: 4725, data page slots: 4966, average fill: 77%
Fill distribution:
0 - 19% = 38
20 - 39% = 93
40 - 59% = 111
60 - 79% = 3710
80 - 99% = 773

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 331, nodes: 325549
Average data length: 0.29, total dup: 311560, max dup: 122
Fill distribution:
0 - 19% = 3
20 - 39% = 81
40 - 59% = 104
60 - 79% = 37
80 - 99% = 106

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 413, nodes: 325547
Average data length: 1.29, total dup: 281419, max dup: 21
Fill distribution:
0 - 19% = 3
20 - 39% = 16
40 - 59% = 181
60 - 79% = 169
80 - 99% = 44

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 33.56, total records: 109668
Average version length: 72.01, total versions: 58662, max versions: 1
Data pages: 1681, data page slots: 1860, average fill: 79%
Fill distribution:
0 - 19% = 66
20 - 39% = 84
40 - 59% = 60
60 - 79% = 106
80 - 99% = 1365

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 141, nodes: 109668
Average data length: 1.50, total dup: 93134, max dup: 51
Fill distribution:
0 - 19% = 0
20 - 39% = 10
40 - 59% = 71
60 - 79% = 51
80 - 99% = 9

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 27.18, total records: 1533229
Average version length: 72.01, total versions: 955526, max versions: 1
Data pages: 21415, data page slots: 26181, average fill: 87%
Fill distribution:
0 - 19% = 11
20 - 39% = 13
40 - 59% = 7
60 - 79% = 6747
80 - 99% = 14637

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1935, nodes: 1533229
Average data length: 0.50, total dup: 1456884, max dup: 99
Fill distribution:
0 - 19% = 9
20 - 39% = 236
40 - 59% = 1389
60 - 79% = 163
80 - 99% = 138

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 0.03, total records: 37706
Average version length: 71.89, total versions: 37690, max versions: 1
Data pages: 766, data page slots: 1280, average fill: 65%
Fill distribution:
0 - 19% = 95
20 - 39% = 106
40 - 59% = 98
60 - 79% = 96
80 - 99% = 371

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 60, nodes: 37706
Average data length: 0.88, total dup: 35455, max dup: 99
Fill distribution:
0 - 19% = 1
20 - 39% = 37
40 - 59% = 18
60 - 79% = 3
80 - 99% = 1

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 55.30, total records: 1458411
Average version length: 71.67, total versions: 328080, max versions: 1
Data pages: 20204, data page slots: 20275, average fill: 82%
Fill distribution:
0 - 19% = 2
20 - 39% = 13
40 - 59% = 10
60 - 79% = 7783
80 - 99% = 12396

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 2743, nodes: 1458411
Average data length: 1.67, total dup: 1188346, max dup: 29
Fill distribution:
0 - 19% = 7
20 - 39% = 1239
40 - 59% = 1209
60 - 79% = 147
80 - 99% = 141

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 81.68, total records: 1936515
Average version length: 85.18, total versions: 33018, max versions: 1
Data pages: 29348, data page slots: 29348, average fill: 81%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7602
80 - 99% = 21745

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 2239, nodes: 1936515
Average data length: 0.15, total dup: 1892650, max dup: 181
Fill distribution:
0 - 19% = 19
20 - 39% = 44
40 - 59% = 1649
60 - 79% = 462
80 - 99% = 65

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 1577, nodes: 1936515
Average data length: 0.68, total dup: 1701489, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 37
40 - 59% = 191
60 - 79% = 65
80 - 99% = 1283

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 2507, nodes: 1936515
Average data length: 0.71, total dup: 1695179, max dup: 29
Fill distribution:
0 - 19% = 21
20 - 39% = 52
40 - 59% = 1797
60 - 79% = 559
80 - 99% = 78

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 67.11, total records: 1405020
Average version length: 84.34, total versions: 272190, max versions: 1
Data pages: 21388, data page slots: 21388, average fill: 83%
Fill distribution:
0 - 19% = 5
20 - 39% = 8
40 - 59% = 6
60 - 79% = 1716
80 - 99% = 19653

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1526, nodes: 1405020
Average data length: 0.14, total dup: 1376511, max dup: 294
Fill distribution:
0 - 19% = 1
20 - 39% = 216
40 - 59% = 640
60 - 79% = 517
80 - 99% = 152

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1894, nodes: 1405020
Average data length: 1.08, total dup: 1151746, max dup: 14
Fill distribution:
0 - 19% = 78
20 - 39% = 416
40 - 59% = 654
60 - 79% = 305
80 - 99% = 441

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 1704, nodes: 1405020
Average data length: 0.61, total dup: 1255571, max dup: 64
Fill distribution:
0 - 19% = 18
20 - 39% = 227
40 - 59% = 724
60 - 79% = 561
80 - 99% = 174

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 62.04, total records: 2619422
Average version length: 85.52, total versions: 667605, max versions: 1
Data pages: 39882, data page slots: 39882, average fill: 85%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 6950
80 - 99% = 32932

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 2748, nodes: 2619422
Average data length: 0.04, total dup: 2607587, max dup: 1284
Fill distribution:
0 - 19% = 4
20 - 39% = 193
40 - 59% = 1468
60 - 79% = 770
80 - 99% = 313

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 2324, nodes: 2619422
Average data length: 0.41, total dup: 2431001, max dup: 49
Fill distribution:
0 - 19% = 35
20 - 39% = 200
40 - 59% = 538
60 - 79% = 269
80 - 99% = 1282

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 3108, nodes: 2619422
Average data length: 0.51, total dup: 2380279, max dup: 161
Fill distribution:
0 - 19% = 5
20 - 39% = 241
40 - 59% = 1701
60 - 79% = 843
80 - 99% = 318

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: 69.03, total records: 1658672
Average version length: 84.91, total versions: 284574, max versions: 1
Data pages: 25316, data page slots: 25316, average fill: 83%
Fill distribution:
0 - 19% = 1
20 - 39% = 5
40 - 59% = 38
60 - 79% = 2140
80 - 99% = 23132

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1905, nodes: 1658678
Average data length: 0.04, total dup: 1651629, max dup: 2229
Fill distribution:
0 - 19% = 11
20 - 39% = 329
40 - 59% = 1030
60 - 79% = 376
80 - 99% = 159

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 2286, nodes: 1658876
Average data length: 1.08, total dup: 1361533, max dup: 14
Fill distribution:
0 - 19% = 68
20 - 39% = 634
40 - 59% = 712
60 - 79% = 372
80 - 99% = 500

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 2098, nodes: 1658674
Average data length: 0.48, total dup: 1521784, max dup: 99
Fill distribution:
0 - 19% = 11
20 - 39% = 347
40 - 59% = 1123
60 - 79% = 466
80 - 99% = 151

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 62.39, total records: 269700
Average version length: 69.24, total versions: 25933, max versions: 1
Data pages: 4702, data page slots: 5248, average fill: 62%
Fill distribution:
0 - 19% = 444
20 - 39% = 606
40 - 59% = 556
60 - 79% = 2426
80 - 99% = 670

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 343, nodes: 269700
Average data length: 0.41, total dup: 253431, max dup: 114
Fill distribution:
0 - 19% = 1
20 - 39% = 112
40 - 59% = 130
60 - 79% = 78
80 - 99% = 22

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 377, nodes: 269700
Average data length: 0.92, total dup: 230733, max dup: 17
Fill distribution:
0 - 19% = 0
20 - 39% = 99
40 - 59% = 162
60 - 79% = 95
80 - 99% = 21

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 49890 ms, from 21:30:00.03 to 21:30:49.92.

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 982926 88008 8.9536
DOC_LIST 289373 32546 11.2470
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 82136 20534.0000
INVNT_TURNOVER_LOG 20717 20288 97.9292
MONEY_SALDO 49 1251 2553.0612
MONEY_TURNOVER_LOG 637 622 97.6452
OPTYPES 9 0 0.0000
PDISTR 104300 12321 11.8130
PERF_ESTIMATED 24802 104 0.4193
PERF_LOG 8411007 1 0.0000
PSTORNED 171998 15625 9.0844
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 1139 28475.0000
SETTINGS 114 0 0.0000
TRACE_STAT 4642 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 20038 19130 95.4686
XQD_1000_3300 325543 22947 7.0488
XQD_1200_2000 109668 58662 53.4905
XQD_2000_3300 1533229 955526 62.3211
XQD_2100_3300 37706 37690 99.9575
XQD_3300_3400 1458411 328080 22.4957
XQS_1000_1200 1936515 33018 1.7050
XQS_1000_3300 1405020 272190 19.3726
XQS_1200_2000 2619422 667605 25.4867
XQS_2100_3300 1658672 284574 17.1567
XQS_3300_3400 269700 25933 9.6154
Z_USED_VIEWS 32 0 0.0000
Done for 2380 ms, from 21:30:59.86 to 21:31:02.24.

Database validation

21:31:02.41 Validation started

21:31:02.41 Relation 140 (DOC_LIST)
21:31:02.41 process pointer page 0 of 2
21:31:02.52 process pointer page 1 of 2
21:31:02.63 Index 1 (PK_DOC_LIST)
21:31:02.68 Index 2 (DOC_LIST_ID_DESC)
21:31:02.73 Index 3 (FK_DOC_LIST_AGENTS)
21:31:02.84 Relation 140 (DOC_LIST) is ok

21:31:02.84 Relation 141 (DOC_DATA)
21:31:02.84 process pointer page 0 of 6
21:31:02.93 process pointer page 1 of 6
21:31:02.98 process pointer page 2 of 6
21:31:03.07 process pointer page 3 of 6
21:31:03.18 process pointer page 4 of 6
21:31:03.30 process pointer page 5 of 6
21:31:03.35 Index 2 (DOC_DATA_DOC_WARE_UNQ)
21:31:03.76 Index 3 (DOC_DATA_ID_DESC)
21:31:04.05 Index 4 (FK_DOC_DATA_DOC_LIST)
21:31:04.33 Relation 141 (DOC_DATA) is ok

21:31:04.33 Relation 147 (INVNT_SALDO)
21:31:04.33 process pointer page 0 of 1
21:31:04.44 Index 1 (PK_INVNT_SALDO)
21:31:04.44 Relation 147 (INVNT_SALDO) is ok

21:31:04.44 Relation 150 (PDISTR)
21:31:04.44 process pointer page 0 of 1
21:31:04.52 Index 2 (PDISTR_SND_ID)
21:31:04.55 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
21:31:04.58 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
21:31:04.60 Index 5 (PDISTR_AGENT_ID)
21:31:04.61 Relation 150 (PDISTR) is ok

21:31:04.61 Relation 151 (PSTORNED)
21:31:04.61 process pointer page 0 of 2
21:31:04.68 process pointer page 1 of 2
21:31:04.69 Index 2 (PSTORNED_SND_ID)
21:31:04.74 Index 3 (PSTORNED_RCV_ID)
21:31:04.77 Relation 151 (PSTORNED) is ok

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

21:31:04.79 Relation 157 (INVNT_TURNOVER_LOG)
21:31:04.79 process pointer page 0 of 2
21:31:04.82 process pointer page 1 of 2
21:31:04.82 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
21:31:04.82 Relation 157 (INVNT_TURNOVER_LOG) is ok

21:31:04.82 Relation 160 (PERF_ESTIMATED)
21:31:04.82 process pointer page 0 of 1
21:31:04.83 Index 1 (PERF_EST_MINUTE_SINCE_START)
21:31:04.83 Relation 160 (PERF_ESTIMATED) is ok

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

21:31:04.83 Relation 162 (PERF_LOG)
21:31:04.83 process pointer page 0 of 105
21:31:04.91 process pointer page 1 of 105
21:31:04.99 process pointer page 2 of 105
21:31:05.07 process pointer page 3 of 105
21:31:05.14 process pointer page 4 of 105
21:31:05.19 process pointer page 5 of 105
21:31:05.22 process pointer page 6 of 105
21:31:05.28 process pointer page 7 of 105
21:31:05.36 process pointer page 8 of 105
21:31:05.44 process pointer page 9 of 105
21:31:05.52 process pointer page 10 of 105
21:31:05.58 process pointer page 11 of 105
21:31:05.66 process pointer page 12 of 105
21:31:05.71 process pointer page 13 of 105
21:31:05.72 process pointer page 14 of 105
21:31:05.75 process pointer page 15 of 105
21:31:05.78 process pointer page 16 of 105
21:31:05.81 process pointer page 17 of 105
21:31:05.83 process pointer page 18 of 105
21:31:05.86 process pointer page 19 of 105
21:31:05.89 process pointer page 20 of 105
21:31:05.92 process pointer page 21 of 105
21:31:05.94 process pointer page 22 of 105
21:31:05.97 process pointer page 23 of 105
21:31:06.00 process pointer page 24 of 105
21:31:06.08 process pointer page 25 of 105
21:31:06.14 process pointer page 26 of 105
21:31:06.22 process pointer page 27 of 105
21:31:06.28 process pointer page 28 of 105
21:31:06.36 process pointer page 29 of 105
21:31:06.42 process pointer page 30 of 105
21:31:06.49 process pointer page 31 of 105
21:31:06.52 process pointer page 32 of 105
21:31:06.53 process pointer page 33 of 105
21:31:06.61 process pointer page 34 of 105
21:31:06.67 process pointer page 35 of 105
21:31:06.75 process pointer page 36 of 105
21:31:06.81 process pointer page 37 of 105
21:31:06.89 process pointer page 38 of 105
21:31:06.95 process pointer page 39 of 105
21:31:07.00 process pointer page 40 of 105
21:31:07.03 process pointer page 41 of 105
21:31:07.05 process pointer page 42 of 105
21:31:07.08 process pointer page 43 of 105
21:31:07.14 process pointer page 44 of 105
21:31:07.20 process pointer page 45 of 105
21:31:07.28 process pointer page 46 of 105
21:31:07.36 process pointer page 47 of 105
21:31:07.42 process pointer page 48 of 105
21:31:07.50 process pointer page 49 of 105
21:31:07.58 process pointer page 50 of 105
21:31:07.64 process pointer page 51 of 105
21:31:07.72 process pointer page 52 of 105
21:31:07.78 process pointer page 53 of 105
21:31:07.86 process pointer page 54 of 105
21:31:07.94 process pointer page 55 of 105
21:31:08.00 process pointer page 56 of 105
21:31:08.08 process pointer page 57 of 105
21:31:08.15 process pointer page 58 of 105
21:31:08.22 process pointer page 59 of 105
21:31:08.28 process pointer page 60 of 105
21:31:08.34 process pointer page 61 of 105
21:31:08.37 process pointer page 62 of 105
21:31:08.42 process pointer page 63 of 105
21:31:08.45 process pointer page 64 of 105
21:31:08.48 process pointer page 65 of 105
21:31:08.51 process pointer page 66 of 105
21:31:08.53 process pointer page 67 of 105
21:31:08.56 process pointer page 68 of 105
21:31:08.59 process pointer page 69 of 105
21:31:08.62 process pointer page 70 of 105
21:31:08.65 process pointer page 71 of 105
21:31:08.73 process pointer page 72 of 105
21:31:08.76 process pointer page 73 of 105
21:31:08.79 process pointer page 74 of 105
21:31:08.87 process pointer page 75 of 105
21:31:08.95 process pointer page 76 of 105
21:31:09.01 process pointer page 77 of 105
21:31:09.09 process pointer page 78 of 105
21:31:09.17 process pointer page 79 of 105
21:31:09.25 process pointer page 80 of 105
21:31:09.29 process pointer page 81 of 105
21:31:09.32 process pointer page 82 of 105
21:31:09.36 process pointer page 83 of 105
21:31:09.37 process pointer page 84 of 105
21:31:09.40 process pointer page 85 of 105
21:31:09.43 process pointer page 86 of 105
21:31:09.47 process pointer page 87 of 105
21:31:09.48 process pointer page 88 of 105
21:31:09.51 process pointer page 89 of 105
21:31:09.53 process pointer page 90 of 105
21:31:09.56 process pointer page 91 of 105
21:31:09.57 process pointer page 92 of 105
21:31:09.61 process pointer page 93 of 105
21:31:09.62 process pointer page 94 of 105
21:31:09.65 process pointer page 95 of 105
21:31:09.67 process pointer page 96 of 105
21:31:09.70 process pointer page 97 of 105
21:31:09.73 process pointer page 98 of 105
21:31:09.78 process pointer page 99 of 105
21:31:09.84 process pointer page 100 of 105
21:31:09.92 process pointer page 101 of 105
21:31:09.98 process pointer page 102 of 105
21:31:10.06 process pointer page 103 of 105
21:31:10.12 process pointer page 104 of 105
21:31:10.14 Index 1 (PERF_LOG_DTS_BEG_DESC)
21:31:12.57 Index 2 (PERF_LOG_UNIT)
21:31:15.95 Index 3 (PERF_LOG_TRN_DESC)
21:31:17.67 Index 4 (PERF_LOG_GDSCODE)
21:31:19.28 Relation 162 (PERF_LOG) is ok

21:31:19.28 Relation 166 (V_STOPTEST)
21:31:19.28 Relation 166 (V_STOPTEST) is ok

21:31:19.28 Relation 183 (V_QDISTR_SOURCE)
21:31:19.28 Relation 183 (V_QDISTR_SOURCE) is ok

21:31:19.28 Relation 184 (V_QSTORNED_SOURCE)
21:31:19.28 Relation 184 (V_QSTORNED_SOURCE) is ok

21:31:19.28 Relation 258 (XQD_1000_1200)
21:31:19.29 process pointer page 0 of 2
21:31:19.31 process pointer page 1 of 2
21:31:19.31 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
21:31:19.32 Relation 258 (XQD_1000_1200) is ok

21:31:19.32 Relation 259 (XQD_1200_2000)
21:31:19.34 process pointer page 0 of 2
21:31:19.43 process pointer page 1 of 2
21:31:19.43 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
21:31:19.46 Relation 259 (XQD_1200_2000) is ok

21:31:19.46 Relation 260 (XQD_1000_3300)
21:31:19.46 process pointer page 0 of 3
21:31:19.57 process pointer page 1 of 3
21:31:19.67 process pointer page 2 of 3
21:31:19.71 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
21:31:19.84 Index 2 (XQD_1000_3300_DOC)
21:31:19.96 Relation has 1 orphan backversions (22947 in use)
21:31:19.96 Relation 260 (XQD_1000_3300) : 1 ERRORS found

21:31:19.96 Relation 261 (XQD_2000_3300)
21:31:19.96 process pointer page 0 of 14
21:31:20.10 process pointer page 1 of 14
21:31:20.24 process pointer page 2 of 14
21:31:20.40 process pointer page 3 of 14
21:31:20.48 process pointer page 4 of 14
21:31:20.56 process pointer page 5 of 14
21:31:20.70 process pointer page 6 of 14
21:31:20.76 process pointer page 7 of 14
21:31:20.90 process pointer page 8 of 14
21:31:21.04 process pointer page 9 of 14
21:31:21.17 process pointer page 10 of 14
21:31:21.27 process pointer page 11 of 14
21:31:21.29 process pointer page 12 of 14
21:31:21.29 process pointer page 13 of 14
21:31:21.29 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
21:31:21.57 Relation 261 (XQD_2000_3300) is ok

21:31:21.57 Relation 262 (XQD_2100_3300)
21:31:21.57 process pointer page 0 of 3
21:31:21.62 process pointer page 1 of 3
21:31:21.62 process pointer page 2 of 3
21:31:21.62 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
21:31:21.63 Relation has 3 orphan backversions (37690 in use)
21:31:21.63 Relation 262 (XQD_2100_3300) : 1 ERRORS found

21:31:21.63 Relation 263 (XQD_3300_3400)
21:31:21.63 process pointer page 0 of 11
21:31:21.74 process pointer page 1 of 11
21:31:21.79 process pointer page 2 of 11
21:31:21.90 process pointer page 3 of 11
21:31:22.01 process pointer page 4 of 11
21:31:22.12 process pointer page 5 of 11
21:31:22.23 process pointer page 6 of 11
21:31:22.34 process pointer page 7 of 11
21:31:22.44 process pointer page 8 of 11
21:31:22.55 process pointer page 9 of 11
21:31:22.62 process pointer page 10 of 11
21:31:22.63 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
21:31:22.88 Relation 263 (XQD_3300_3400) is ok

21:31:22.88 Relation 264 (XQS_1000_1200)
21:31:22.88 process pointer page 0 of 16
21:31:22.94 process pointer page 1 of 16
21:31:22.97 process pointer page 2 of 16
21:31:23.05 process pointer page 3 of 16
21:31:23.15 process pointer page 4 of 16
21:31:23.18 process pointer page 5 of 16
21:31:23.21 process pointer page 6 of 16
21:31:23.26 process pointer page 7 of 16
21:31:23.35 process pointer page 8 of 16
21:31:23.43 process pointer page 9 of 16
21:31:23.52 process pointer page 10 of 16
21:31:23.61 process pointer page 11 of 16
21:31:23.69 process pointer page 12 of 16
21:31:23.72 process pointer page 13 of 16
21:31:23.77 process pointer page 14 of 16
21:31:23.83 process pointer page 15 of 16
21:31:23.86 Index 1 (XQS_1000_1200_DOC_ID)
21:31:24.43 Index 2 (XQS_1000_1200_SND_ID)
21:31:24.86 Index 3 (XQS_1000_1200_RCV_ID)
21:31:25.03 Relation 264 (XQS_1000_1200) is ok

21:31:25.03 Relation 265 (XQS_1200_2000)
21:31:25.03 process pointer page 0 of 21
21:31:25.07 process pointer page 1 of 21
21:31:25.10 process pointer page 2 of 21
21:31:25.13 process pointer page 3 of 21
21:31:25.21 process pointer page 4 of 21
21:31:25.30 process pointer page 5 of 21
21:31:25.39 process pointer page 6 of 21
21:31:25.50 process pointer page 7 of 21
21:31:25.56 process pointer page 8 of 21
21:31:25.61 process pointer page 9 of 21
21:31:25.69 process pointer page 10 of 21
21:31:25.75 process pointer page 11 of 21
21:31:25.81 process pointer page 12 of 21
21:31:25.88 process pointer page 13 of 21
21:31:25.95 process pointer page 14 of 21
21:31:26.03 process pointer page 15 of 21
21:31:26.14 process pointer page 16 of 21
21:31:26.19 process pointer page 17 of 21
21:31:26.25 process pointer page 18 of 21
21:31:26.38 process pointer page 19 of 21
21:31:26.47 process pointer page 20 of 21
21:31:26.55 Index 1 (XQS_1200_2000_DOC_ID)
21:31:27.16 Index 2 (XQS_1200_2000_SND_ID)
21:31:28.01 Index 3 (XQS_1200_2000_RCV_ID)
21:31:28.51 Relation 265 (XQS_1200_2000) is ok

21:31:28.51 Relation 266 (XQS_1000_3300)
21:31:28.51 process pointer page 0 of 12
21:31:28.56 process pointer page 1 of 12
21:31:28.61 process pointer page 2 of 12
21:31:28.64 process pointer page 3 of 12
21:31:28.68 process pointer page 4 of 12
21:31:28.79 process pointer page 5 of 12
21:31:28.89 process pointer page 6 of 12
21:31:29.00 process pointer page 7 of 12
21:31:29.11 process pointer page 8 of 12
21:31:29.17 process pointer page 9 of 12
21:31:29.20 process pointer page 10 of 12
21:31:29.25 process pointer page 11 of 12
21:31:29.25 Index 1 (XQS_1000_3300_DOC_ID)
21:31:29.53 Index 2 (XQS_1000_3300_SND_ID)
21:31:29.95 Index 3 (XQS_1000_3300_RCV_ID)
21:31:30.34 Relation 266 (XQS_1000_3300) is ok

21:31:30.34 Relation 267 (XQS_2000_3300)
21:31:30.34 process pointer page 0 of 1
21:31:30.34 Index 1 (XQS_2000_3300_DOC_ID)
21:31:30.35 Index 2 (XQS_2000_3300_SND_ID)
21:31:30.35 Index 3 (XQS_2000_3300_RCV_ID)
21:31:30.35 Relation 267 (XQS_2000_3300) is ok

21:31:30.35 Relation 268 (XQS_2100_3300)
21:31:30.35 process pointer page 0 of 14
21:31:30.45 process pointer page 1 of 14
21:31:30.56 process pointer page 2 of 14
21:31:30.65 process pointer page 3 of 14
21:31:30.76 process pointer page 4 of 14
21:31:30.85 process pointer page 5 of 14
21:31:30.95 process pointer page 6 of 14
21:31:30.98 process pointer page 7 of 14
21:31:31.09 process pointer page 8 of 14
21:31:31.20 process pointer page 9 of 14
21:31:31.31 process pointer page 10 of 14
21:31:31.40 process pointer page 11 of 14
21:31:31.49 process pointer page 12 of 14
21:31:31.54 process pointer page 13 of 14
21:31:31.54 Index 1 (XQS_2100_3300_DOC_ID)
21:31:31.54 Index 1 misses node on page 1166 level 1
21:31:31.94 Index 2 (XQS_2100_3300_SND_ID)
21:31:31.96 Index 2 has inconsistent left sibling pointer, page 215596 level 1
21:31:32.29 Index 3 (XQS_2100_3300_RCV_ID)
21:31:32.55 Relation 268 (XQS_2100_3300) : 2 ERRORS found

21:31:32.55 Relation 269 (XQS_3300_3400)
21:31:32.57 process pointer page 0 of 3
21:31:32.60 process pointer page 1 of 3
21:31:32.63 process pointer page 2 of 3
21:31:32.65 Index 1 (XQS_3300_3400_DOC_ID)
21:31:32.68 Index 2 (XQS_3300_3400_SND_ID)
21:31:32.74 Relation 269 (XQS_3300_3400) is ok

21:31:32.74 Relation 276 (TRACE_STAT)
21:31:32.74 process pointer page 0 of 1
21:31:32.74 Relation 276 (TRACE_STAT) is ok

21:31:32.74 Validation finished
Done for 30490 ms, from 21:31:02.27 to 21:31:32.76.

Differences between old and current firebird.log

21:31:33.49. Got:
STDOUT: ---------- E:\TEMP\LOGS.HQBIRD.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 52 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-07-09 21:31 1750 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
34: WIN-2BE1UI8LGDL Sat Jul 09 21:31:19 2016
35: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
36: Relation has 1 orphan backversions (22947 in use) in table XQD_1000_3300 (260)
37:
38:
39: WIN-2BE1UI8LGDL Sat Jul 09 21:31:21 2016
40: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
41: Relation has 3 orphan backversions (37690 in use) in table XQD_2100_3300 (262)
42:
43:
44: WIN-2BE1UI8LGDL Sat Jul 09 21:31:31 2016
45: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
46: Index 1 misses node on page 1166 level 1 in table XQS_2100_3300 (268)
47:
48:
49: WIN-2BE1UI8LGDL Sat Jul 09 21:31:31 2016
50: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
51: Index 2 has inconsistent left sibling pointer, page 215596 level 1 in table XQS_2100_3300 (268)
52:
53:
*****
+++ 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-07-09 21:31:35.97 - end of report, text file: e:\temp\logs.hqbird.oltp25\oltp25.report.txt, html: e:\temp\logs.hqbird.oltp25\oltp25.report.html