Firebird 2.5 Performance Logs

Generated by E:\OLTP-HQBIRD\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 10. 2016-06-25 22:15:53.66.
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 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-06-25 22:15:46.1120 -1 <null> 127.0.0.1 303604 82407 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: 10986.90 1620 439476 2016-06-25 21:35 2016-06-25 22:15
customer order: creation 166.78 73 6671 2016-06-25 21:35 2016-06-25 22:15
customer order: refuse 13.13 48 525 2016-06-25 21:35 2016-06-25 22:15
order to supplier: creation 42.80 228 1712 2016-06-25 21:35 2016-06-25 22:15
order to supplier: removal 1.46 10458 57 2016-06-25 21:35 2016-06-25 22:15
invoice (draft): creation 43.03 540 1721 2016-06-25 21:35 2016-06-25 22:15
invoice (draft): removal 24.65 142 986 2016-06-25 21:35 2016-06-25 22:15
invoice accept: apply 24.33 12915 973 2016-06-25 21:35 2016-06-25 22:15
invoice accept: cancel 8.23 713 329 2016-06-25 21:35 2016-06-25 22:15
customer reserve: creation 9733.00 25 389320 2016-06-25 21:35 2016-06-25 22:15
customer reserve: removal 697.78 16 27911 2016-06-25 21:35 2016-06-25 22:15
realization accept: apply 78.58 75 3143 2016-06-25 21:35 2016-06-25 22:15
realization accept: cancel 19.45 46 778 2016-06-25 21:35 2016-06-25 22:15
payment from customer: creation 54.95 99 2198 2016-06-25 21:35 2016-06-25 22:15
payment from customer: removal 4.72 38 184 2016-06-25 21:35 2016-06-25 22:15
payment to supplier: creation 44.60 118 1784 2016-06-25 21:35 2016-06-25 22:15
payment to supplier: removal 3.31 38 129 2016-06-25 21:35 2016-06-25 22:15
service: total inventory turnovers 15.73 137 629 2016-06-25 21:35 2016-06-25 22:15
service: total monetary turnovers 10.87 5 424 2016-06-25 21:35 2016-06-25 22:15
service: refresh index statistics 0.13 5069 2 2016-06-25 21:35 2016-06-25 22:15
Done for 24300 ms, from 22:16:26.11 to 22:16:50.41.

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 11131 44572 44523 49 0.11 21:35:47 21:39:47
interval # 2, overall 2 7437 29786 29749 37 0.12 21:39:48 21:43:48
interval # 3, overall 3 6215 28923 24860 4063 14.05 21:43:49 21:47:49
interval # 4, overall 4 12138 50467 48551 1916 3.80 21:47:50 21:51:50
interval # 5, overall 5 12999 52089 51994 95 0.18 21:51:51 21:55:51
interval # 6, overall 6 12206 49003 48825 178 0.36 21:55:52 21:59:52
interval # 7, overall 7 10565 43950 42261 1689 3.84 21:59:53 22:03:53
interval # 8, overall 8 12436 49871 49743 128 0.26 22:03:54 22:07:54
interval # 9, overall 9 12045 49307 48180 1127 2.29 22:07:55 22:11:55
interval # 10, overall 10 12698 50891 50790 101 0.20 22:11:56 22:15:56
Done for 37310 ms, from 22:17:23.42 to 22:18:00.73.

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 1192.85 0.0880 2.6222 223 8
WARM_TIME 2 4652.96 0.3362 1.6541 475 10
WARM_TIME 3 7722.08 0.6645 1.3055 564 10
TEST_TIME 4 8817.40 0.8575 1.1696 502 10
TEST_TIME 5 9251.38 0.8918 1.1486 537 10
TEST_TIME 6 9467.96 0.9353 1.0814 434 10
TEST_TIME 7 9554.00 0.9185 1.0792 372 10
TEST_TIME 8 9383.02 0.9616 1.0375 193 10
TEST_TIME 9 9082.81 0.9527 1.0500 523 10
TEST_TIME 10 8819.76 0.9732 1.0438 246 10
TEST_TIME 11 8959.73 0.9341 1.0546 497 10
TEST_TIME 12 8797.10 0.9846 1.0303 260 10
TEST_TIME 13 8532.08 0.9806 1.0171 155 7
TEST_TIME 14 8219.07 0.9804 1.0241 189 7
TEST_TIME 15 8224.69 0.9552 1.0382 549 9
TEST_TIME 16 8403.02 0.9527 1.0298 529 9
TEST_TIME 17 8377.53 0.9722 1.0313 443 10
TEST_TIME 18 8602.16 0.9486 1.0427 769 10
TEST_TIME 19 8910.64 0.9536 1.0448 720 10
TEST_TIME 20 9174.05 0.9641 1.0460 656 10
TEST_TIME 21 9414.63 0.9707 1.0314 741 10
TEST_TIME 22 9589.69 0.9671 1.0258 531 10
TEST_TIME 23 9737.27 0.9664 1.0241 814 10
TEST_TIME 24 9762.11 0.9789 1.0198 709 10
TEST_TIME 25 9786.85 0.9766 1.0214 563 10
TEST_TIME 26 9910.81 0.9698 1.0247 488 10
TEST_TIME 27 9983.70 0.9796 1.0266 565 10
TEST_TIME 28 10136.19 0.9751 1.0190 493 10
TEST_TIME 29 10178.22 0.9798 1.0176 549 10
TEST_TIME 30 10189.33 0.9826 1.0124 615 10
TEST_TIME 31 10115.25 0.9869 1.0101 247 7
TEST_TIME 32 10076.69 0.9823 1.0105 635 9
TEST_TIME 33 10125.16 0.9752 1.0212 762 10
TEST_TIME 34 10202.38 0.9837 1.0261 643 10
TEST_TIME 35 10340.45 0.9835 1.0148 852 10
TEST_TIME 36 10415.04 0.9795 1.0166 638 10
TEST_TIME 37 10387.61 0.9924 1.0124 396 10
TEST_TIME 38 10417.43 0.9830 1.0134 678 10
TEST_TIME 39 10466.57 0.9827 1.0187 611 10
TEST_TIME 40 10554.54 0.9850 1.0177 724 10
TEST_TIME 41 10659.77 0.9830 1.0169 690 10
TEST_TIME 42 10731.81 0.9866 1.0144 703 10
TEST_TIME 43 10761.14 0.9882 1.0132 756 10
Done for 7790 ms, from 22:18:01.32 to 22:18:09.11.

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 17244 26320 37005 66613 67480 <null> 149474 <null> 11800 22999 22374 20263 42566 10122 81931 34562 329573 <null> <null> 21:35:47 21:39:47
fetches per second 2 19238 72093 38081 <null> 74079 111029 149999 <null> 25868 <null> 24398 21203 45255 16706 149312 <null> 374168 59719 <null> 21:39:48 21:43:48
fetches per second 3 27848 13869 62389 <null> 95576 <null> 228215 <null> 5240 25670 40820 <null> 67378 <null> 97372 42172 379765 115660 <null> 21:43:49 21:47:49
fetches per second 4 29663 45652 40227 <null> 74185 41339 295987 22940 23838 <null> 39339 10485 62965 46178 120265 17644 776581 253596 <null> 21:47:50 21:51:50
fetches per second 5 30835 38751 45504 99370 79876 113746 252945 50928 28554 16857 29945 28544 62858 15680 125902 22227 515371 360885 <null> 21:51:51 21:55:51
fetches per second 6 22058 15417 39586 72174 62745 <null> 132386 44529 28200 32340 30517 19987 51115 21299 110088 11398 378734 93753 <null> 21:55:52 21:59:52
fetches per second 7 19949 39966 37225 <null> 52933 <null> 195664 45792 24765 42496 27128 13560 54735 <null> 144131 <null> 287236 68976 <null> 21:59:53 22:03:53
fetches per second 8 25247 44408 37442 <null> 64856 <null> 260270 58895 31480 26890 22793 31267 63114 <null> 120475 <null> 418738 135898 <null> 22:03:54 22:07:54
fetches per second 9 34019 42876 49122 107062 82818 93454 205595 <null> 19181 20235 30893 29281 74161 41807 126922 <null> 419917 158602 <null> 22:07:55 22:11:55
fetches per second 10 25012 13303 53103 101911 77931 <null> 208625 <null> 17350 25471 30852 22669 63433 20181 126986 20073 410776 151889 <null> 22:11:56 22:15:56
marks per second 1 3054 2533 6712 12100 11010 <null> 2595 <null> 1077 2299 2536 2096 2512 1139 1811 3218 22437 <null> <null> 21:35:47 21:39:47
marks per second 2 3571 6337 6240 <null> 11862 20319 2013 <null> 2301 <null> 2927 2525 1797 1689 3584 <null> 14527 2510 <null> 21:39:48 21:43:48
marks per second 3 5171 1465 10425 <null> 15430 <null> 2127 <null> 365 2959 4209 <null> 3159 <null> 2581 4965 33977 12392 <null> 21:43:49 21:47:49
marks per second 4 5310 4352 6454 <null> 11717 7630 2931 2126 2686 <null> 6119 1074 2766 5192 3670 2394 14870 7824 <null> 21:47:50 21:51:50
marks per second 5 5662 3887 8421 17084 13051 20826 2945 5301 1600 1908 3760 3161 4240 2070 2660 2504 21795 15306 <null> 21:51:51 21:55:51
marks per second 6 3975 1633 6834 9295 10432 <null> 2637 4415 2020 3262 3482 2205 2273 2473 2035 1252 15539 6625 <null> 21:55:52 21:59:52
marks per second 7 3593 3901 6641 <null> 8886 <null> 2671 4601 1962 4289 3438 1547 3626 <null> 4573 <null> 20222 4386 <null> 21:59:53 22:03:53
marks per second 8 4658 4379 5960 <null> 10500 <null> 2902 5926 3453 2697 3378 4056 4171 <null> 2988 <null> 14278 5232 <null> 22:03:54 22:07:54
marks per second 9 6158 4316 8932 9768 14758 17465 2852 <null> 1395 2169 3593 3449 3642 3692 3354 <null> 25048 7686 <null> 22:07:55 22:11:55
marks per second 10 4477 1746 9339 17249 13761 <null> 3711 <null> 1990 3165 3529 2620 3052 2236 2743 2025 13787 5921 <null> 22:11:56 22:15:56
reads/fetches*100 1 10 9 5 2 4 <null> 1 <null> 9 9 11 10 8 9 6 6 1 <null> <null> 21:35:47 21:39:47
reads/fetches*100 2 11 8 6 <null> 4 3 1 <null> 5 <null> 12 9 8 10 6 <null> 1 2 <null> 21:39:48 21:43:48
reads/fetches*100 3 9 8 4 <null> 5 <null> 1 <null> 7 9 9 <null> 7 <null> 6 5 0 1 <null> 21:43:49 21:47:49
reads/fetches*100 4 8 8 4 <null> 5 7 1 3 8 <null> 10 13 8 6 5 7 1 2 <null> 21:47:50 21:51:50
reads/fetches*100 5 9 8 5 2 4 3 1 3 6 9 11 9 7 8 6 8 1 1 <null> 21:51:51 21:55:51
reads/fetches*100 6 10 10 5 2 5 <null> 2 2 8 9 12 10 8 10 6 6 1 2 <null> 21:55:52 21:59:52
reads/fetches*100 7 10 7 6 <null> 5 <null> 1 3 6 7 12 11 8 <null> 6 <null> 1 2 <null> 21:59:53 22:03:53
reads/fetches*100 8 9 8 5 <null> 5 <null> 2 2 6 8 11 9 8 <null> 6 <null> 1 2 <null> 22:03:54 22:07:54
reads/fetches*100 9 10 8 5 1 5 3 2 <null> 9 10 12 9 7 6 6 <null> 1 2 <null> 22:07:55 22:11:55
reads/fetches*100 10 10 8 5 2 5 <null> 2 <null> 10 8 12 11 8 14 6 6 1 3 <null> 22:11:56 22:15:56
writes/marks*100 1 10 14 8 3 7 <null> 2 <null> 8 4 7 10 1 0 5 0 7 <null> <null> 21:35:47 21:39:47
writes/marks*100 2 11 16 9 <null> 7 2 3 <null> 7 <null> 7 10 4 0 5 <null> 11 0 <null> 21:39:48 21:43:48
writes/marks*100 3 11 14 8 <null> 8 <null> 2 <null> 9 6 7 <null> 5 <null> 4 0 8 0 <null> 21:43:49 21:47:49
writes/marks*100 4 11 16 7 <null> 8 3 2 1 7 <null> 7 10 3 0 5 0 8 1 <null> 21:47:50 21:51:50
writes/marks*100 5 10 15 7 3 8 1 2 3 9 6 7 14 4 0 6 0 9 1 <null> 21:51:51 21:55:51
writes/marks*100 6 10 12 7 3 8 <null> 3 2 12 7 7 11 4 1 5 0 12 4 <null> 21:55:52 21:59:52
writes/marks*100 7 11 14 7 <null> 8 <null> 2 2 10 6 7 10 4 <null> 5 <null> 10 3 <null> 21:59:53 22:03:53
writes/marks*100 8 10 12 8 <null> 9 <null> 3 1 6 4 7 7 4 <null> 5 <null> 11 0 <null> 22:03:54 22:07:54
writes/marks*100 9 11 14 7 3 8 1 3 <null> 13 6 7 9 5 0 4 <null> 9 0 <null> 22:07:55 22:11:55
writes/marks*100 10 11 12 8 3 7 <null> 3 <null> 6 5 8 14 5 0 4 0 13 1 <null> 22:11:56 22:15:56
Done for 22100 ms, from 22:18:09.75 to 22:18:31.85.

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 217040 208428 8612 3.96 0 1111 4 8612 2016-06-25 21:35 2016-06-25 22:15
doc_list_biud 217064 208427 8637 3.97 0 1509 3 8637 2016-06-25 21:35 2016-06-25 22:15
sp_add_invoice_to_stock 1571 973 598 38.06 169 142940 12915 598 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_adding_invoice 348 329 19 5.45 16 5814 713 19 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_client_order 553 525 28 5.06 0 336 48 28 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_customer_reserve 36186 27911 8275 22.86 0 525 16 8275 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_pay_from_customer 184 184 0 0.00 0 271 38 0 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_pay_to_supplier 129 129 0 0.00 0 210 38 0 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_supplier_invoice 1045 986 59 5.64 0 656 142 59 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_supplier_order 121 57 64 52.89 16 41297 10458 64 2016-06-25 21:35 2016-06-25 22:15
sp_cancel_write_off 1094 778 316 28.88 0 587 46 316 2016-06-25 21:35 2016-06-25 22:15
sp_client_order 6671 6671 0 0.00 0 681 73 0 2016-06-25 21:35 2016-06-25 22:15
sp_customer_reserve 389320 389320 0 0.00 0 1387 25 0 2016-06-25 21:35 2016-06-25 22:15
sp_fill_shopping_cart 10104 10104 0 0.00 0 406 12 0 2016-06-25 21:35 2016-06-25 22:15
sp_fill_shopping_cart_clo_res 389320 389320 0 0.00 0 385 2 0 2016-06-25 21:35 2016-06-25 22:15
sp_get_clo_for_invoice 973 973 0 0.00 0 839 161 0 2016-06-25 21:35 2016-06-25 22:15
sp_kill_cost_storno 1748 1420 328 18.76 0 239 9 328 2016-06-25 21:35 2016-06-25 22:15
sp_kill_qstorno_ret_qs2qd 74510 57644 16866 22.63 0 571 8 16866 2016-06-25 21:35 2016-06-25 22:15
sp_kill_qty_storno 43339 34703 8636 19.92 0 1509 20 8636 2016-06-25 21:35 2016-06-25 22:15
sp_lock_selected_doc 6550 5778 772 11.78 0 234 0 772 2016-06-25 21:35 2016-06-25 22:15
sp_make_cost_storno 8098 8098 0 0.00 0 636 33 0 2016-06-25 21:35 2016-06-25 22:15
sp_multiply_rows_for_pdistr 8098 8098 0 0.00 0 494 17 0 2016-06-25 21:35 2016-06-25 22:15
sp_multiply_rows_for_qdistr 6671 6671 0 0.00 0 593 26 0 2016-06-25 21:35 2016-06-25 22:15
sp_pay_from_customer 2198 2198 0 0.00 15 787 99 0 2016-06-25 21:35 2016-06-25 22:15
sp_pay_to_supplier 1784 1784 0 0.00 16 823 118 0 2016-06-25 21:35 2016-06-25 22:15
sp_payment_common 3982 3982 0 0.00 0 390 19 0 2016-06-25 21:35 2016-06-25 22:15
sp_qd_handle_on_cancel_clo 553 525 28 5.06 0 305 17 28 2016-06-25 21:35 2016-06-25 22:15
sp_qd_handle_on_invoice_upd_sts 1316 1302 14 1.06 0 1508 114 14 2016-06-25 21:35 2016-06-25 22:15
sp_qd_handle_on_reserve_upd_sts 3143 3143 0 0.00 0 362 11 0 2016-06-25 21:35 2016-06-25 22:15
sp_reserve_write_off 3167 3143 24 0.75 6 666 75 24 2016-06-25 21:35 2016-06-25 22:15
sp_supplier_invoice 1721 1721 0 0.00 15 2755 540 0 2016-06-25 21:35 2016-06-25 22:15
sp_supplier_order 1712 1712 0 0.00 15 1172 228 0 2016-06-25 21:35 2016-06-25 22:15
srv_find_qd_qs_mism 128029 119420 8609 6.72 0 1111 3 8609 2016-06-25 21:35 2016-06-25 22:15
srv_make_invnt_saldo 629 629 0 0.00 0 985 137 0 2016-06-25 21:35 2016-06-25 22:15
srv_make_money_saldo 424 424 0 0.00 0 156 5 0 2016-06-25 21:35 2016-06-25 22:15
srv_recalc_idx_stat 2 2 0 0.00 2456 7682 5069 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_add_invoice_to_stock 598 598 0 0.00 0 427 21 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_cancel_adding_invoice 5 5 0 0.00 0 44 17 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_cancel_client_order 28 28 0 0.00 0 378 42 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_cancel_customer_reserve 4 4 0 0.00 14 141 46 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_cancel_supplier_invoice 49 49 0 0.00 0 109 19 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_cancel_supplier_order 1021 1021 0 0.00 0 3016 159 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-abend:sp_reserve_write_off 24 24 0 0.00 0 125 19 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_add_invoice_to_stock 976 976 0 0.00 15 63564 2648 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_adding_invoice 121 121 0 0.00 16 7126 774 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_client_order 525 525 0 0.00 0 508 35 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_customer_reserve 234 234 0 0.00 0 254 38 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_pay_from_customer 184 184 0 0.00 0 368 29 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_pay_to_supplier 129 129 0 0.00 0 248 22 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_supplier_invoice 99 99 0 0.00 0 357 41 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_supplier_order 58 58 0 0.00 0 14514 3200 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_cancel_write_off 313 313 0 0.00 0 359 37 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_client_order 6671 6671 0 0.00 0 859 46 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_customer_reserve 306 306 0 0.00 0 284 25 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_pay_from_customer 2198 2198 0 0.00 0 554 33 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_pay_to_supplier 1784 1784 0 0.00 0 550 33 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_reserve_write_off 3143 3143 0 0.00 0 26185 48 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_supplier_invoice 1722 1722 0 0.00 0 47539 74 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:sp_supplier_order 1713 1713 0 0.00 0 827 45 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:srv_make_invnt_saldo 629 629 0 0.00 0 359 22 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:srv_make_money_saldo 424 424 0 0.00 0 509 15 0 2016-06-25 21:35 2016-06-25 22:15
t$perf-norm:srv_recalc_idx_stat 2 2 0 0.00 10 67 38 0 2016-06-25 21:35 2016-06-25 22:15
v_add_invoice_to_stock 3142 1946 1196 38.06 0 200 5 1196 2016-06-25 21:35 2016-06-25 22:15
v_all_customers 10090 10090 0 0.00 0 47 0 0 2016-06-25 21:35 2016-06-25 22:15
v_all_suppliers 6866 6866 0 0.00 0 61 0 0 2016-06-25 21:35 2016-06-25 22:15
v_all_wares 13342 13342 0 0.00 0 20 0 0 2016-06-25 21:35 2016-06-25 22:15
v_cancel_adding_invoice 252 242 10 3.96 0 231 12 10 2016-06-25 21:35 2016-06-25 22:15
v_cancel_client_order 1106 1050 56 5.06 0 151 1 56 2016-06-25 21:35 2016-06-25 22:15
v_cancel_customer_prepayment 368 368 0 0.00 0 63 2 0 2016-06-25 21:35 2016-06-25 22:15
v_cancel_customer_reserve 476 468 8 1.68 0 109 2 8 2016-06-25 21:35 2016-06-25 22:15
v_cancel_payment_to_supplier 258 258 0 0.00 0 47 1 0 2016-06-25 21:35 2016-06-25 22:15
v_cancel_supplier_invoice 296 198 98 33.10 0 37 4 98 2016-06-25 21:35 2016-06-25 22:15
v_cancel_supplier_order 242 114 128 52.89 0 51 2 128 2016-06-25 21:35 2016-06-25 22:15
v_cancel_write_off 626 626 0 0.00 0 281 9 0 2016-06-25 21:35 2016-06-25 22:15
v_max_id_clo_ord 1712 1712 0 0.00 0 157 1 0 2016-06-25 21:35 2016-06-25 22:15
v_max_id_clo_res 306 306 0 0.00 0 312 6 0 2016-06-25 21:35 2016-06-25 22:15
v_max_id_ord_sup 1721 1721 0 0.00 0 62 0 0 2016-06-25 21:35 2016-06-25 22:15
v_max_non_paid_invoice 1784 1784 0 0.00 0 230 1 0 2016-06-25 21:35 2016-06-25 22:15
v_max_non_paid_realizn 2198 2198 0 0.00 0 172 6 0 2016-06-25 21:35 2016-06-25 22:15
v_min_id_clo_ord 1712 1712 0 0.00 0 281 4 0 2016-06-25 21:35 2016-06-25 22:15
v_min_id_clo_res 306 306 0 0.00 0 31 1 0 2016-06-25 21:35 2016-06-25 22:15
v_min_id_ord_sup 1721 1721 0 0.00 0 250 2 0 2016-06-25 21:35 2016-06-25 22:15
v_min_non_paid_invoice 1784 1784 0 0.00 0 254 11 0 2016-06-25 21:35 2016-06-25 22:15
v_min_non_paid_realizn 2198 2198 0 0.00 0 375 10 0 2016-06-25 21:35 2016-06-25 22:15
v_our_firm 3252 3252 0 0.00 0 17 0 0 2016-06-25 21:35 2016-06-25 22:15
v_reserve_write_off 6334 6286 48 0.75 0 250 2 48 2016-06-25 21:35 2016-06-25 22:15
x_lock_depdocs_on_canc_invoice 1370 1210 160 11.67 0 103 5 160 2016-06-25 21:35 2016-06-25 22:15
x_lock_depdocs_on_canc_sup_ord 121 57 64 52.89 0 78 10 64 2016-06-25 21:35 2016-06-25 22:15
x_make_qstorno_1000_1200 1712 1712 0 0.00 0 1046 181 0 2016-06-25 21:35 2016-06-25 22:15
x_make_qstorno_1200_2000 1721 1721 0 0.00 0 2708 506 0 2016-06-25 21:35 2016-06-25 22:15
x_make_qstorno_2100_3300 389320 389320 0 0.00 0 1371 18 0 2016-06-25 21:35 2016-06-25 22:15
Done for 103430 ms, from 22:19:16.74 to 22:21:00.17.

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 2 sp_kill_cost_storno 335544336 2016-06-25 21:49 2016-06-25 22:00
deadlock 16 sp_lock_selected_doc 335544336 2016-06-25 21:37 2016-06-25 22:15
deadlock 1 sp_qd_handle_on_cancel_clo 335544336 2016-06-25 22:12 2016-06-25 22:12
deadlock 2 sp_qd_handle_on_invoice_upd_sts 335544336 2016-06-25 21:47 2016-06-25 22:10
deadlock 2 x_lock_depdocs_on_canc_sup_ord 335544336 2016-06-25 21:38 2016-06-25 21:41
lock_conflict 663 sp_lock_selected_doc 335544345 2016-06-25 21:35 2016-06-25 22:15
lock_conflict 27 sp_qd_handle_on_cancel_clo 335544345 2016-06-25 21:39 2016-06-25 22:13
lock_conflict 6 x_lock_depdocs_on_canc_invoice 335544345 2016-06-25 21:45 2016-06-25 22:10
lock_conflict 53 x_lock_depdocs_on_canc_sup_ord 335544345 2016-06-25 21:37 2016-06-25 22:14
Done for 3630 ms, from 22:21:01.51 to 22:21:05.14.

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 303742
MON$OLDEST_SNAPSHOT 303742
MON$NEXT_TRANSACTION 303742
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 380345
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 386458
Page size 8192
ODS version 11.2
Oldest transaction 100509
Oldest active 303744
Oldest snapshot 303744
Next transaction 303745
Bumped transaction 1
Sequence number 0
Next attachment ID 82468
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: 43.17, total records: 828549
Average version length: 48.01, total versions: 65906, max versions: 1
Data pages: 8893, data page slots: 8893, average fill: 75%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 8609
80 - 99% = 283

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 3728, nodes: 828549
Average data length: 13.56, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 359
20 - 39% = 721
40 - 59% = 1435
60 - 79% = 259
80 - 99% = 954

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 2764, nodes: 828549
Average data length: 5.71, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 870
40 - 59% = 1886
60 - 79% = 8
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 3, leaf buckets: 1243, nodes: 828549
Average data length: 1.71, total dup: 597351, max dup: 49
Fill distribution:
0 - 19% = 90
20 - 39% = 290
40 - 59% = 379
60 - 79% = 96
80 - 99% = 388

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 58.97, total records: 230984
Average version length: 36.95, total versions: 15901, max versions: 3
Data pages: 2884, data page slots: 2884, average fill: 78%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 2
60 - 79% = 2495
80 - 99% = 387

Index DOC_LIST_ID_DESC (1)
Depth: 3, leaf buckets: 814, nodes: 230984
Average data length: 6.11, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 341
40 - 59% = 460
60 - 79% = 12
80 - 99% = 1

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 238, nodes: 230984
Average data length: 0.01, total dup: 230934, max dup: 27130
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 193
60 - 79% = 23
80 - 99% = 21

Index PK_DOC_LIST (0)
Depth: 3, leaf buckets: 603, nodes: 230984
Average data length: 6.10, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 79
20 - 39% = 124
40 - 59% = 116
60 - 79% = 105
80 - 99% = 179

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

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: 7.99, total records: 10709
Average version length: 71.20, total versions: 9506, max versions: 1
Data pages: 163, data page slots: 175, average fill: 84%
Fill distribution:
0 - 19% = 2
20 - 39% = 5
40 - 59% = 2
60 - 79% = 35
80 - 99% = 119

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 2, leaf buckets: 45, nodes: 10709
Average data length: 9.29, total dup: 37, max dup: 1
Fill distribution:
0 - 19% = 1
20 - 39% = 25
40 - 59% = 13
60 - 79% = 5
80 - 99% = 1

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.76, total records: 49
Average version length: 9.00, total versions: 913, max versions: 304
Data pages: 5, data page slots: 5, average fill: 63%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
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: 2.18, total records: 407
Average version length: 46.07, total versions: 388, max versions: 1
Data pages: 5, data page slots: 5, average fill: 79%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 4

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 1, nodes: 407
Average data length: 1.95, total dup: 350, max dup: 88
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.68, total records: 90407
Average version length: 35.54, total versions: 6125, max versions: 8
Data pages: 1281, data page slots: 1404, average fill: 56%
Fill distribution:
0 - 19% = 290
20 - 39% = 114
40 - 59% = 5
60 - 79% = 855
80 - 99% = 17

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 80, nodes: 90407
Average data length: 0.01, total dup: 90358, max dup: 7331
Fill distribution:
0 - 19% = 0
20 - 39% = 15
40 - 59% = 35
60 - 79% = 18
80 - 99% = 12

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 103, nodes: 90407
Average data length: 0.89, total dup: 81461, max dup: 25
Fill distribution:
0 - 19% = 1
20 - 39% = 22
40 - 59% = 39
60 - 79% = 32
80 - 99% = 9

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 102, nodes: 90407
Average data length: 0.90, total dup: 81461, max dup: 25
Fill distribution:
0 - 19% = 0
20 - 39% = 24
40 - 59% = 36
60 - 79% = 32
80 - 99% = 10

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 102, nodes: 90407
Average data length: 0.68, total dup: 81461, max dup: 25
Fill distribution:
0 - 19% = 2
20 - 39% = 26
40 - 59% = 39
60 - 79% = 27
80 - 99% = 8

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 28.60, total records: 23625
Average version length: 18.00, total versions: 282, max versions: 1
Data pages: 209, data page slots: 214, average fill: 64%
Fill distribution:
0 - 19% = 3
20 - 39% = 5
40 - 59% = 2
60 - 79% = 199
80 - 99% = 0

Index PERF_EST_MINUTE_SINCE_START (0)
Depth: 2, leaf buckets: 26, nodes: 23625
Average data length: 0.00, total dup: 23581, max dup: 851
Fill distribution:
0 - 19% = 7
20 - 39% = 2
40 - 59% = 10
60 - 79% = 3
80 - 99% = 4

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: 151.48, total records: 6029678
Average version length: 125.00, total versions: 1, max versions: 1
Data pages: 142998, data page slots: 142998, average fill: 87%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 142997

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 6194, nodes: 6029678
Average data length: 0.33, total dup: 4504055, max dup: 66
Fill distribution:
0 - 19% = 4
20 - 39% = 0
40 - 59% = 2952
60 - 79% = 2060
80 - 99% = 1178

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 6834, nodes: 6029678
Average data length: 0.14, total dup: 5904454, max dup: 28679
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 5335
60 - 79% = 796
80 - 99% = 703

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 6986, nodes: 6029678
Average data length: 0.15, total dup: 5963664, max dup: 664105
Fill distribution:
0 - 19% = 10
20 - 39% = 1
40 - 59% = 5913
60 - 79% = 434
80 - 99% = 628

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: 53.37, total records: 139348
Average version length: 57.11, total versions: 6032, max versions: 1
Data pages: 1649, data page slots: 1649, average fill: 76%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1591
80 - 99% = 57

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 189, nodes: 139348
Average data length: 1.12, total dup: 115796, max dup: 379
Fill distribution:
0 - 19% = 1
20 - 39% = 13
40 - 59% = 141
60 - 79% = 33
80 - 99% = 1

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 139, nodes: 139348
Average data length: 0.69, total dup: 125279, max dup: 98
Fill distribution:
0 - 19% = 0
20 - 39% = 3
40 - 59% = 59
60 - 79% = 58
80 - 99% = 19

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: 1004, max versions: 659
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 PK_SEMAPHORES (0)
Depth: 1, leaf buckets: 1, nodes: 4
Average data length: 8.50, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

TRACE_STAT (276)
Primary pointer page: 513, Index root page: 95177
Average record length: 59.59, total records: 2441
Average version length: 0.00, total versions: 0, max versions: 0
Data pages: 31, data page slots: 36, average fill: 74%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 2
60 - 79% = 29
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: 2.94, total records: 13493
Average version length: 72.19, total versions: 12947, max versions: 1
Data pages: 188, data page slots: 188, average fill: 93%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 187

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 15, nodes: 13493
Average data length: 1.89, total dup: 11759, max dup: 14
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 4
60 - 79% = 9
80 - 99% = 2

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 66.55, total records: 222997
Average version length: 71.36, total versions: 17094, max versions: 1
Data pages: 3506, data page slots: 4284, average fill: 71%
Fill distribution:
0 - 19% = 286
20 - 39% = 105
40 - 59% = 57
60 - 79% = 2472
80 - 99% = 586

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 237, nodes: 223003
Average data length: 0.29, total dup: 213391, max dup: 116
Fill distribution:
0 - 19% = 0
20 - 39% = 70
40 - 59% = 74
60 - 79% = 35
80 - 99% = 58

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 328, nodes: 223001
Average data length: 1.29, total dup: 193210, max dup: 19
Fill distribution:
0 - 19% = 0
20 - 39% = 70
40 - 59% = 177
60 - 79% = 66
80 - 99% = 15

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 28.71, total records: 69191
Average version length: 71.97, total versions: 41668, max versions: 1
Data pages: 1164, data page slots: 2522, average fill: 73%
Fill distribution:
0 - 19% = 39
20 - 39% = 90
40 - 59% = 131
60 - 79% = 187
80 - 99% = 717

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 100, nodes: 69191
Average data length: 1.49, total dup: 59224, max dup: 45
Fill distribution:
0 - 19% = 1
20 - 39% = 23
40 - 59% = 53
60 - 79% = 20
80 - 99% = 3

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 22.28, total records: 1392518
Average version length: 71.99, total versions: 961331, max versions: 1
Data pages: 19435, data page slots: 26554, average fill: 88%
Fill distribution:
0 - 19% = 15
20 - 39% = 9
40 - 59% = 5
60 - 79% = 5000
80 - 99% = 14406

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1658, nodes: 1392518
Average data length: 0.49, total dup: 1325020, max dup: 99
Fill distribution:
0 - 19% = 13
20 - 39% = 43
40 - 59% = 1303
60 - 79% = 159
80 - 99% = 140

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 0.01, total records: 11529
Average version length: 71.93, total versions: 11529, max versions: 1
Data pages: 208, data page slots: 1280, average fill: 73%
Fill distribution:
0 - 19% = 14
20 - 39% = 23
40 - 59% = 21
60 - 79% = 17
80 - 99% = 133

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 17, nodes: 11529
Average data length: 1.16, total dup: 10941, max dup: 79
Fill distribution:
0 - 19% = 0
20 - 39% = 7
40 - 59% = 6
60 - 79% = 4
80 - 99% = 0

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 58.03, total records: 1195117
Average version length: 71.63, total versions: 219959, max versions: 1
Data pages: 17174, data page slots: 20271, average fill: 78%
Fill distribution:
0 - 19% = 112
20 - 39% = 338
40 - 59% = 625
60 - 79% = 8116
80 - 99% = 7983

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 2169, nodes: 1195117
Average data length: 1.65, total dup: 979024, max dup: 27
Fill distribution:
0 - 19% = 11
20 - 39% = 976
40 - 59% = 896
60 - 79% = 146
80 - 99% = 140

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 80.93, total records: 1634052
Average version length: 84.90, total versions: 31125, max versions: 1
Data pages: 24686, data page slots: 24686, average fill: 81%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 7523
80 - 99% = 17162

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1868, nodes: 1634052
Average data length: 0.15, total dup: 1597096, max dup: 143
Fill distribution:
0 - 19% = 12
20 - 39% = 16
40 - 59% = 1378
60 - 79% = 404
80 - 99% = 58

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 1325, nodes: 1634052
Average data length: 0.68, total dup: 1436317, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 23
40 - 59% = 175
60 - 79% = 41
80 - 99% = 1085

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 2094, nodes: 1634052
Average data length: 0.71, total dup: 1430686, max dup: 32
Fill distribution:
0 - 19% = 14
20 - 39% = 19
40 - 59% = 1514
60 - 79% = 476
80 - 99% = 71

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 70.65, total records: 1175838
Average version length: 84.29, total versions: 171737, max versions: 1
Data pages: 17836, data page slots: 19004, average fill: 83%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 2003
80 - 99% = 15833

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1343, nodes: 1175838
Average data length: 0.15, total dup: 1150784, max dup: 252
Fill distribution:
0 - 19% = 0
20 - 39% = 242
40 - 59% = 645
60 - 79% = 344
80 - 99% = 112

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1552, nodes: 1175838
Average data length: 1.06, total dup: 969916, max dup: 14
Fill distribution:
0 - 19% = 67
20 - 39% = 321
40 - 59% = 543
60 - 79% = 238
80 - 99% = 383

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 1505, nodes: 1175838
Average data length: 0.65, total dup: 1045136, max dup: 71
Fill distribution:
0 - 19% = 16
20 - 39% = 251
40 - 59% = 734
60 - 79% = 387
80 - 99% = 117

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 59.22, total records: 2303002
Average version length: 85.50, total versions: 653501, max versions: 1
Data pages: 34986, data page slots: 34986, average fill: 85%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 7022
80 - 99% = 27963

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 2351, nodes: 2303002
Average data length: 0.04, total dup: 2293004, max dup: 1624
Fill distribution:
0 - 19% = 5
20 - 39% = 128
40 - 59% = 1210
60 - 79% = 711
80 - 99% = 297

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 1975, nodes: 2303002
Average data length: 0.42, total dup: 2133168, max dup: 49
Fill distribution:
0 - 19% = 23
20 - 39% = 133
40 - 59% = 428
60 - 79% = 193
80 - 99% = 1198

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 2625, nodes: 2303002
Average data length: 0.50, total dup: 2102856, max dup: 180
Fill distribution:
0 - 19% = 6
20 - 39% = 146
40 - 59% = 1388
60 - 79% = 761
80 - 99% = 324

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: 72.74, total records: 1387768
Average version length: 85.09, total versions: 169454, max versions: 1
Data pages: 21289, data page slots: 22309, average fill: 82%
Fill distribution:
0 - 19% = 42
20 - 39% = 88
40 - 59% = 154
60 - 79% = 2504
80 - 99% = 18501

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1626, nodes: 1387774
Average data length: 0.04, total dup: 1381363, max dup: 2587
Fill distribution:
0 - 19% = 7
20 - 39% = 341
40 - 59% = 846
60 - 79% = 307
80 - 99% = 125

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1926, nodes: 1387972
Average data length: 1.05, total dup: 1146501, max dup: 14
Fill distribution:
0 - 19% = 61
20 - 39% = 545
40 - 59% = 613
60 - 79% = 312
80 - 99% = 395

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 1804, nodes: 1387770
Average data length: 0.53, total dup: 1263444, max dup: 99
Fill distribution:
0 - 19% = 8
20 - 39% = 341
40 - 59% = 961
60 - 79% = 369
80 - 99% = 125

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 66.01, total records: 253508
Average version length: 69.93, total versions: 10352, max versions: 1
Data pages: 4733, data page slots: 5248, average fill: 57%
Fill distribution:
0 - 19% = 577
20 - 39% = 747
40 - 59% = 683
60 - 79% = 2485
80 - 99% = 241

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 329, nodes: 253508
Average data length: 0.37, total dup: 239921, max dup: 114
Fill distribution:
0 - 19% = 1
20 - 39% = 112
40 - 59% = 135
60 - 79% = 63
80 - 99% = 18

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 365, nodes: 253508
Average data length: 0.91, total dup: 217704, max dup: 17
Fill distribution:
0 - 19% = 0
20 - 39% = 103
40 - 59% = 168
60 - 79% = 78
80 - 99% = 16

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 36750 ms, from 22:21:05.70 to 22:21:42.45.

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 828549 65906 7.9543
DOC_LIST 230984 15901 6.8840
DOC_STATES 4 0 0.0000
FB_ERRORS 758 0 0.0000
INVNT_SALDO 400 92296 23074.0000
INVNT_TURNOVER_LOG 10709 9506 88.7664
MONEY_SALDO 49 913 1863.2653
MONEY_TURNOVER_LOG 407 388 95.3316
OPTYPES 9 0 0.0000
PDISTR 90407 6125 6.7749
PERF_ESTIMATED 23625 282 1.1936
PERF_LOG 6029678 1 0.0000
PSTORNED 139348 6032 4.3287
RULES_FOR_PDISTR 4 0 0.0000
RULES_FOR_QDISTR 7 0 0.0000
SEMAPHORES 4 1004 25100.0000
SETTINGS 114 0 0.0000
TRACE_STAT 2441 0 0.0000
WARES 400 0 0.0000
WARE_GROUPS 8 0 0.0000
XQD_1000_1200 13493 12947 95.9534
XQD_1000_3300 222997 17094 7.6655
XQD_1200_2000 69191 41668 60.2217
XQD_2000_3300 1392518 961331 69.0354
XQD_2100_3300 11529 11529 100.0000
XQD_3300_3400 1195117 219959 18.4048
XQS_1000_1200 1634052 31125 1.9047
XQS_1000_3300 1175838 171737 14.6054
XQS_1200_2000 2303002 653501 28.3760
XQS_2100_3300 1387768 169454 12.2105
XQS_3300_3400 253508 10352 4.0835
Z_USED_VIEWS 32 0 0.0000
Done for 3990 ms, from 22:21:54.12 to 22:21:58.11.

Database validation

22:21:58.34 Validation started

22:21:58.34 Relation 140 (DOC_LIST)
22:21:58.34 process pointer page 0 of 2
22:21:58.90 process pointer page 1 of 2
22:21:59.44 Index 1 (PK_DOC_LIST)
22:21:59.47 Index 2 (DOC_LIST_ID_DESC)
22:21:59.54 Index 3 (FK_DOC_LIST_AGENTS)
22:21:59.62 Relation 140 (DOC_LIST) is ok

22:21:59.62 Relation 141 (DOC_DATA)
22:21:59.62 process pointer page 0 of 5
22:21:59.89 process pointer page 1 of 5
22:22:00.19 process pointer page 2 of 5
22:22:00.62 process pointer page 3 of 5
22:22:02.25 process pointer page 4 of 5
22:22:02.97 Index 2 (DOC_DATA_DOC_WARE_UNQ)
22:22:03.37 Index 3 (DOC_DATA_ID_DESC)
22:22:03.62 Index 4 (FK_DOC_DATA_DOC_LIST)
22:22:03.86 Relation 141 (DOC_DATA) is ok

22:22:03.86 Relation 147 (INVNT_SALDO)
22:22:03.86 process pointer page 0 of 1
22:22:03.92 Index 1 (PK_INVNT_SALDO)
22:22:03.92 Relation 147 (INVNT_SALDO) is ok

22:22:03.92 Relation 150 (PDISTR)
22:22:03.92 process pointer page 0 of 1
22:22:04.50 Index 2 (PDISTR_SND_ID)
22:22:04.50 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
22:22:04.52 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
22:22:04.52 Index 5 (PDISTR_AGENT_ID)
22:22:04.53 Relation 150 (PDISTR) is ok

22:22:04.53 Relation 151 (PSTORNED)
22:22:04.53 process pointer page 0 of 1
22:22:05.11 Index 2 (PSTORNED_SND_ID)
22:22:05.12 Index 3 (PSTORNED_RCV_ID)
22:22:05.14 Relation 151 (PSTORNED) is ok

22:22:05.14 Relation 156 (SEMAPHORES)
22:22:05.14 process pointer page 0 of 1
22:22:05.14 Index 1 (PK_SEMAPHORES)
22:22:05.14 Index 2 (SEMAPHORES_TASK_UNQ)
22:22:05.14 Relation 156 (SEMAPHORES) is ok

22:22:05.14 Relation 157 (INVNT_TURNOVER_LOG)
22:22:05.14 process pointer page 0 of 2
22:22:05.14 process pointer page 1 of 2
22:22:05.14 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
22:22:05.15 Relation 157 (INVNT_TURNOVER_LOG) is ok

22:22:05.15 Relation 160 (PERF_ESTIMATED)
22:22:05.15 process pointer page 0 of 1
22:22:05.31 Index 1 (PERF_EST_MINUTE_SINCE_START)
22:22:05.31 Relation 160 (PERF_ESTIMATED) is ok

22:22:05.31 Relation 161 (PERF_ISQL_STAT)
22:22:05.31 process pointer page 0 of 1
22:22:05.31 Index 1 (PERF_ISQL_STAT_TRN)
22:22:05.31 Relation 161 (PERF_ISQL_STAT) is ok

22:22:05.31 Relation 162 (PERF_LOG)
22:22:05.31 process pointer page 0 of 75
22:22:05.34 process pointer page 1 of 75
22:22:05.37 process pointer page 2 of 75
22:22:05.40 process pointer page 3 of 75
22:22:05.44 process pointer page 4 of 75
22:22:05.45 process pointer page 5 of 75
22:22:05.49 process pointer page 6 of 75
22:22:05.51 process pointer page 7 of 75
22:22:05.53 process pointer page 8 of 75
22:22:05.59 process pointer page 9 of 75
22:22:05.66 process pointer page 10 of 75
22:22:05.73 process pointer page 11 of 75
22:22:05.75 process pointer page 12 of 75
22:22:05.78 process pointer page 13 of 75
22:22:05.81 process pointer page 14 of 75
22:22:05.84 process pointer page 15 of 75
22:22:05.86 process pointer page 16 of 75
22:22:05.89 process pointer page 17 of 75
22:22:05.92 process pointer page 18 of 75
22:22:05.94 process pointer page 19 of 75
22:22:05.97 process pointer page 20 of 75
22:22:05.98 process pointer page 21 of 75
22:22:06.05 process pointer page 22 of 75
22:22:06.11 process pointer page 23 of 75
22:22:06.19 process pointer page 24 of 75
22:22:07.06 process pointer page 25 of 75
22:22:07.77 process pointer page 26 of 75
22:22:08.53 process pointer page 27 of 75
22:22:09.37 process pointer page 28 of 75
22:22:09.86 process pointer page 29 of 75
22:22:10.11 process pointer page 30 of 75
22:22:10.80 process pointer page 31 of 75
22:22:11.47 process pointer page 32 of 75
22:22:11.88 process pointer page 33 of 75
22:22:12.66 process pointer page 34 of 75
22:22:13.52 process pointer page 35 of 75
22:22:13.96 process pointer page 36 of 75
22:22:14.24 process pointer page 37 of 75
22:22:14.50 process pointer page 38 of 75
22:22:15.00 process pointer page 39 of 75
22:22:15.60 process pointer page 40 of 75
22:22:15.86 process pointer page 41 of 75
22:22:16.11 process pointer page 42 of 75
22:22:16.69 process pointer page 43 of 75
22:22:17.08 process pointer page 44 of 75
22:22:17.83 process pointer page 45 of 75
22:22:18.55 process pointer page 46 of 75
22:22:18.93 process pointer page 47 of 75
22:22:19.46 process pointer page 48 of 75
22:22:19.90 process pointer page 49 of 75
22:22:20.66 process pointer page 50 of 75
22:22:21.41 process pointer page 51 of 75
22:22:21.89 process pointer page 52 of 75
22:22:22.75 process pointer page 53 of 75
22:22:23.25 process pointer page 54 of 75
22:22:24.24 process pointer page 55 of 75
22:22:25.07 process pointer page 56 of 75
22:22:26.10 process pointer page 57 of 75
22:22:26.91 process pointer page 58 of 75
22:22:27.51 process pointer page 59 of 75
22:22:28.57 process pointer page 60 of 75
22:22:29.15 process pointer page 61 of 75
22:22:29.44 process pointer page 62 of 75
22:22:30.16 process pointer page 63 of 75
22:22:31.13 process pointer page 64 of 75
22:22:31.79 process pointer page 65 of 75
22:22:32.66 process pointer page 66 of 75
22:22:33.45 process pointer page 67 of 75
22:22:34.37 process pointer page 68 of 75
22:22:34.96 process pointer page 69 of 75
22:22:35.37 process pointer page 70 of 75
22:22:35.93 process pointer page 71 of 75
22:22:36.76 process pointer page 72 of 75
22:22:37.18 process pointer page 73 of 75
22:22:37.85 process pointer page 74 of 75
22:22:38.10 Index 1 (PERF_LOG_DTS_BEG_DESC)
22:22:39.62 Index 2 (PERF_LOG_UNIT)
22:22:41.70 Index 3 (PERF_LOG_TRN_DESC)
22:22:42.65 Index 4 (PERF_LOG_GDSCODE)
22:22:43.62 Relation 162 (PERF_LOG) is ok

22:22:43.62 Relation 166 (V_STOPTEST)
22:22:43.62 Relation 166 (V_STOPTEST) is ok

22:22:43.62 Relation 183 (V_QDISTR_SOURCE)
22:22:43.62 Relation 183 (V_QDISTR_SOURCE) is ok

22:22:43.62 Relation 184 (V_QSTORNED_SOURCE)
22:22:43.62 Relation 184 (V_QSTORNED_SOURCE) is ok

22:22:43.62 Relation 258 (XQD_1000_1200)
22:22:43.62 process pointer page 0 of 2
22:22:43.64 process pointer page 1 of 2
22:22:43.64 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
22:22:43.65 Relation 258 (XQD_1000_1200) is ok

22:22:43.65 Relation 259 (XQD_1200_2000)
22:22:43.65 process pointer page 0 of 2
22:22:44.12 process pointer page 1 of 2
22:22:44.12 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
22:22:44.14 Relation 259 (XQD_1200_2000) is ok

22:22:44.14 Relation 260 (XQD_1000_3300)
22:22:44.14 process pointer page 0 of 3
22:22:45.28 process pointer page 1 of 3
22:22:46.14 process pointer page 2 of 3
22:22:46.15 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
22:22:46.18 Index 2 (XQD_1000_3300_DOC)
22:22:46.22 Relation has 1 orphan backversions (17094 in use)
22:22:46.22 Relation 260 (XQD_1000_3300) : 1 ERRORS found

22:22:46.22 Relation 261 (XQD_2000_3300)
22:22:46.22 process pointer page 0 of 14
22:22:46.34 process pointer page 1 of 14
22:22:46.59 process pointer page 2 of 14
22:22:46.75 process pointer page 3 of 14
22:22:47.32 process pointer page 4 of 14
22:22:48.06 process pointer page 5 of 14
22:22:48.55 process pointer page 6 of 14
22:22:48.76 process pointer page 7 of 14
22:22:49.54 process pointer page 8 of 14
22:22:50.42 process pointer page 9 of 14
22:22:50.42 process pointer page 10 of 14
22:22:50.45 process pointer page 11 of 14
22:22:50.47 process pointer page 12 of 14
22:22:50.50 process pointer page 13 of 14
22:22:50.53 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
22:22:50.73 Relation 261 (XQD_2000_3300) is ok

22:22:50.73 Relation 262 (XQD_2100_3300)
22:22:50.73 process pointer page 0 of 3
22:22:50.75 process pointer page 1 of 3
22:22:50.75 process pointer page 2 of 3
22:22:50.75 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
22:22:50.76 Relation has 3 orphan backversions (11529 in use)
22:22:50.76 Relation 262 (XQD_2100_3300) : 1 ERRORS found

22:22:50.76 Relation 263 (XQD_3300_3400)
22:22:50.76 process pointer page 0 of 11
22:22:51.11 process pointer page 1 of 11
22:22:51.55 process pointer page 2 of 11
22:22:52.02 process pointer page 3 of 11
22:22:52.50 process pointer page 4 of 11
22:22:52.83 process pointer page 5 of 11
22:22:53.34 process pointer page 6 of 11
22:22:54.05 process pointer page 7 of 11
22:22:55.39 process pointer page 8 of 11
22:22:56.72 process pointer page 9 of 11
22:22:58.02 process pointer page 10 of 11
22:22:58.31 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
22:22:58.66 Relation 263 (XQD_3300_3400) is ok

22:22:58.66 Relation 264 (XQS_1000_1200)
22:22:58.66 process pointer page 0 of 13
22:22:58.78 process pointer page 1 of 13
22:22:58.85 process pointer page 2 of 13
22:22:58.89 process pointer page 3 of 13
22:22:58.95 process pointer page 4 of 13
22:22:59.00 process pointer page 5 of 13
22:22:59.10 process pointer page 6 of 13
22:22:59.16 process pointer page 7 of 13
22:22:59.24 process pointer page 8 of 13
22:22:59.61 process pointer page 9 of 13
22:23:00.88 process pointer page 10 of 13
22:23:01.66 process pointer page 11 of 13
22:23:02.49 process pointer page 12 of 13
22:23:03.74 Index 1 (XQS_1000_1200_DOC_ID)
22:23:03.93 Index 2 (XQS_1000_1200_SND_ID)
22:23:04.33 Index 3 (XQS_1000_1200_RCV_ID)
22:23:04.55 Relation 264 (XQS_1000_1200) is ok

22:23:04.55 Relation 265 (XQS_1200_2000)
22:23:04.55 process pointer page 0 of 19
22:23:04.60 process pointer page 1 of 19
22:23:04.63 process pointer page 2 of 19
22:23:04.68 process pointer page 3 of 19
22:23:04.79 process pointer page 4 of 19
22:23:04.83 process pointer page 5 of 19
22:23:05.13 process pointer page 6 of 19
22:23:05.30 process pointer page 7 of 19
22:23:05.44 process pointer page 8 of 19
22:23:06.04 process pointer page 9 of 19
22:23:06.49 process pointer page 10 of 19
22:23:06.85 process pointer page 11 of 19
22:23:07.30 process pointer page 12 of 19
22:23:07.96 process pointer page 13 of 19
22:23:08.91 process pointer page 14 of 19
22:23:09.49 process pointer page 15 of 19
22:23:10.10 process pointer page 16 of 19
22:23:11.26 process pointer page 17 of 19
22:23:12.57 process pointer page 18 of 19
22:23:12.74 Index 1 (XQS_1200_2000_DOC_ID)
22:23:13.51 Index 2 (XQS_1200_2000_SND_ID)
22:23:14.13 Index 3 (XQS_1200_2000_RCV_ID)
22:23:14.41 Relation 265 (XQS_1200_2000) is ok

22:23:14.41 Relation 266 (XQS_1000_3300)
22:23:14.41 process pointer page 0 of 10
22:23:14.59 process pointer page 1 of 10
22:23:14.82 process pointer page 2 of 10
22:23:15.29 process pointer page 3 of 10
22:23:15.66 process pointer page 4 of 10
22:23:16.21 process pointer page 5 of 10
22:23:16.54 process pointer page 6 of 10
22:23:17.07 process pointer page 7 of 10
22:23:17.95 process pointer page 8 of 10
22:23:18.60 process pointer page 9 of 10
22:23:19.51 Index 1 (XQS_1000_3300_DOC_ID)
22:23:19.76 Index 2 (XQS_1000_3300_SND_ID)
22:23:19.98 Index 3 (XQS_1000_3300_RCV_ID)
22:23:20.32 Relation 266 (XQS_1000_3300) is ok

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

22:23:20.32 Relation 268 (XQS_2100_3300)
22:23:20.32 process pointer page 0 of 12
22:23:20.68 process pointer page 1 of 12
22:23:20.95 process pointer page 2 of 12
22:23:21.26 process pointer page 3 of 12
22:23:21.71 process pointer page 4 of 12
22:23:21.91 process pointer page 5 of 12
22:23:22.46 process pointer page 6 of 12
22:23:22.84 process pointer page 7 of 12
22:23:23.29 process pointer page 8 of 12
22:23:24.60 process pointer page 9 of 12
22:23:25.81 process pointer page 10 of 12
22:23:26.24 process pointer page 11 of 12
22:23:26.92 Index 1 (XQS_2100_3300_DOC_ID)
22:23:26.93 Index 1 misses node on page 1166 level 1
22:23:27.28 Index 2 (XQS_2100_3300_SND_ID)
22:23:27.29 Index 2 has inconsistent left sibling pointer, page 215596 level 1
22:23:27.53 Index 3 (XQS_2100_3300_RCV_ID)
22:23:27.87 Relation 268 (XQS_2100_3300) : 2 ERRORS found

22:23:27.87 Relation 269 (XQS_3300_3400)
22:23:27.87 process pointer page 0 of 3
22:23:28.23 process pointer page 1 of 3
22:23:28.26 process pointer page 2 of 3
22:23:28.62 Index 1 (XQS_3300_3400_DOC_ID)
22:23:28.65 Index 2 (XQS_3300_3400_SND_ID)
22:23:28.67 Relation 269 (XQS_3300_3400) is ok

22:23:28.67 Relation 276 (TRACE_STAT)
22:23:28.67 process pointer page 0 of 1
22:23:28.68 Relation 276 (TRACE_STAT) is ok

22:23:28.68 Validation finished
Done for 90520 ms, from 22:21:58.18 to 22:23:28.70.

Differences between old and current firebird.log

22:23:29.65. Got:
STDOUT: ---------- E:\TEMP\LOGS.HQBIRD.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 32 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-06-25 22:23 1078 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
14: WIN-2BE1UI8LGDL Sat Jun 25 22:22:46 2016
15: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
16: Relation has 1 orphan backversions (17094 in use) in table XQD_1000_3300 (260)
17:
18:
19: WIN-2BE1UI8LGDL Sat Jun 25 22:22:50 2016
20: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
21: Relation has 3 orphan backversions (11529 in use) in table XQD_2100_3300 (262)
22:
23:
24: WIN-2BE1UI8LGDL Sat Jun 25 22:23:26 2016
25: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
26: Index 1 misses node on page 1166 level 1 in table XQS_2100_3300 (268)
27:
28:
29: WIN-2BE1UI8LGDL Sat Jun 25 22:23:27 2016
30: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
31: Index 2 has inconsistent left sibling pointer, page 215596 level 1 in table XQS_2100_3300 (268)
32:
33:
*****
+++ 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-06-25 22:23:32.20 - end of report, text file: e:\temp\logs.hqbird.oltp25\oltp25.report.txt, html: e:\temp\logs.hqbird.oltp25\oltp25.report.html