Logs 2.5

Generated by E:\OLTP-HQBIRD\src\oltp_isql_run_worker.bat, ISQL session #1 of total launched 10. 2016-04-06 21:41:40.88.

Common	Performance	Final Results
Test configuration Test Finish details Test workload details Indices DDL for heavy-loaded table(s)	Performance, TOTAL score Performance, DYNAMIC, 10 intervals Performance, per MINUTE, since launch Performance, TRACE data for ISQL #1 Performance, DETAILS per units MON$-analysis, per business units Exceptions during test run	mon$database and 'show version' results Database Statistics, full Ratio "Versions / Records" for tables Database Validation Results New in firebird.log while test was run Final processing of ISQL logs

Server and database settings

Server version: WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215
Server implementation: Firebird/x86-64/Windows NT

FB_ARCHITECTURE	DB_NAME	FORCED_WRITES	SWEEP_INT	PAGE_BUFFERS	PAGE_SIZE
SuperClassic 2.5.5	D:\OLTP-HQBIRD\OLTP25-SMALL.FDB	ON	0	1024	8192

Test configuration settings

File: E:\OLTP-HQBIRD\src\oltp25_config.win

PARAM_NAME	PARAM_VALUE
fbc	C:\Firebird\fb25hqbird\bin
dbnm	D:\OLTP-HQBIRD\oltp25-small.fdb
host	localhost
port	3049
usr	SYSDBA
pwd	masterke
tmpdir	e:\temp\logs.hqbird.oltp25
working_mode	small_03
warm_time	3
test_time	6
idle_time	0
use_mtee	0
is_embed	0
remove_isql_logs	if_no_severe_errors
no_auto_undo	1
detailed_info	0
mon_unit_perf	0
trc_unit_perf	1
init_buff	32768
create_with_fw	sync
create_with_sweep	0
wait_if_not_exists	0
wait_after_create	0
init_docs	0
wait_for_copy	0
create_with_debug_objects	1
create_with_split_heavy_tabs	1
create_with_separate_qdistr_idx	0
create_with_compound_columns_order	most_selective_first
make_html	1
run_db_statistics	1
run_db_validation	1
file_name_with_test_params	regular
file_name_this_host_info	ak25
upload_report	1

Test finish info

FINISH_STATE	DTS_END	FB_GDSCODE	FB_MNEMONA	STACK	IP	TRN_ID	ATT_ID	EXC_UNIT
NORMAL: TEST_TIME EXPIRED.	2016-04-06 21:41:34.3990	-1	<null>		127.0.0.1	123872	5087	2

Current test settings

CATEGORY	SETTING	VAL
COMMON	TRACED_UNITS	,,
COMMON	LOG_PK_VIOLATION	0
COMMON	QMISM_VERIFY_BITSET	1
COMMON	RECALC_IDX_MIN_INTERVAL	15
COMMON	ENABLE_RESERVES_WHEN_ADD_INVOICE	1
COMMON	ORDER_FOR_OUR_FIRM_PERCENT	25
COMMON	ENABLE_FILL_PHRASES	0
COMMON	RANDOM_SEEK_VIA_ROWS_LIMIT	0
COMMON	C_INVOICE_MIN_PURCHASE	1000
COMMON	C_INVOICE_MAX_PURCHASE	2000
COMMON	C_INVOICE_MIN_PROFIT_PRC	35
COMMON	C_INVOICE_MAX_PROFIT_PRC	80
COMMON	C_MIN_COST_TO_BE_SPLITTED	1000
COMMON	C_ROWS_TO_MULTIPLY	10
COMMON	C_PAYMENT_FROM_CLIENT_MIN_TOTAL	1000
COMMON	C_PAYMENT_FROM_CLIENT_MAX_TOTAL	5000
COMMON	C_PAYMENT_TO_SUPPLIER_MIN_TOTAL	2000
COMMON	C_PAYMENT_TO_SUPPLIER_MAX_TOTAL	15000
COMMON	BUILD_WITH_SPLIT_HEAVY_TABS	1
COMMON	BUILD_WITH_SEPAR_QDISTR_IDX	0
COMMON	BUILD_WITH_QD_COMPOUND_ORDR	MOST_SELECTIVE_FIRST
COMMON	ENABLE_MON_QUERY	0
COMMON	HALT_TEST_ON_ERRORS	,CK,
SMALL_03	C_WARES_MAX_ID	400
SMALL_03	C_CUSTOMER_DOC_MAX_ROWS	10
SMALL_03	C_SUPPLIER_DOC_MAX_ROWS	50
SMALL_03	C_CUSTOMER_DOC_MAX_QTY	15
SMALL_03	C_SUPPLIER_DOC_MAX_QTY	50
SMALL_03	C_NUMBER_OF_AGENTS	50

Index(es) for heavy-loaded table(s)

TAB_NAME	IDX_NAME	IDX_KEY
XQD_1000_1200	XQD_1000_1200_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_1000_3300	XQD_1000_3300_DOC	DOC_ID
XQD_1000_3300	XQD_1000_3300_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_1200_2000	XQD_1200_2000_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_2000_3300	XQD_2000_3300_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_2100_3300	XQD_2100_3300_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID
XQD_3300_3400	XQD_3300_3400_WARE_SOP_ROP_SND	WARE_ID,SND_OPTYPE_ID,RCV_OPTYPE_ID,SND_ID

Performance reports

Performance in TOTAL:

ACTION	AVG_TIMES_PER_MINUTE	AVG_ELAPSED_MS	SUCCESSFUL_TIMES_DONE	JOB_BEG	JOB_END
* OVERALL * for 6 minutes:	801.00	8141	4806	2016-04-06 21:35	2016-04-06 21:41
customer order: creation	15.67	51	94	2016-04-06 21:35	2016-04-06 21:41
customer order: refuse	1.25	33	5	2016-04-06 21:35	2016-04-06 21:41
order to supplier: creation	4.00	212	24	2016-04-06 21:35	2016-04-06 21:41
order to supplier: removal	2.00	18736	2	2016-04-06 21:35	2016-04-06 21:41
invoice (draft): creation	8.25	254	33	2016-04-06 21:35	2016-04-06 21:41
invoice (draft): removal	56.00	72	56	2016-04-06 21:35	2016-04-06 21:41
invoice accept: apply	1.33	125927	8	2016-04-06 21:35	2016-04-06 21:41
invoice accept: cancel	6.00	291	6	2016-04-06 21:35	2016-04-06 21:41
customer reserve: creation	615.50	307	3693	2016-04-06 21:35	2016-04-06 21:41
customer reserve: removal	183.75	35	735	2016-04-06 21:35	2016-04-06 21:41
realization accept: apply	7.83	65	47	2016-04-06 21:35	2016-04-06 21:41
realization accept: cancel	2.00	76	8	2016-04-06 21:35	2016-04-06 21:41
payment from customer: creation	6.67	80	40	2016-04-06 21:35	2016-04-06 21:41
payment from customer: removal	2.00	20	2	2016-04-06 21:35	2016-04-06 21:41
payment to supplier: creation	5.17	99	31	2016-04-06 21:35	2016-04-06 21:41
payment to supplier: removal	1.00	16	1	2016-04-06 21:35	2016-04-06 21:41
service: total inventory turnovers	2.33	264	14	2016-04-06 21:35	2016-04-06 21:41
service: total monetary turnovers	1.17	7	7	2016-04-06 21:35	2016-04-06 21:41
service: refresh index statistics	<null>	<null>	<null>	2016-04-06 21:35	2016-04-06 21:41

Done for 2810 ms, from 21:41:50.58 to 21:41:53.39.

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	1599	1599	1599	0	0.00	21:35:35	21:36:08
interval # 2, overall	2	<null>	615	615	0	0.00	21:36:09	21:36:42
interval # 3, overall	3	729	730	729	1	0.14	21:36:43	21:37:16
interval # 4, overall	4	<null>	420	418	2	0.48	21:37:17	21:37:50
interval # 5, overall	5	424	424	424	0	0.00	21:37:51	21:38:24
interval # 6, overall	6	<null>	369	369	0	0.00	21:38:25	21:38:58
interval # 7, overall	7	271	416	271	145	34.86	21:38:59	21:39:32
interval # 8, overall	8	226	440	226	214	48.64	21:39:33	21:40:06
interval # 9, overall	9	<null>	305	73	232	76.07	21:40:07	21:40:40
interval # 10, overall	10	82	82	82	0	0.00	21:40:41	21:41:14

Done for 3590 ms, from 21:41:53.78 to 21:41:57.37.

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	4052.80	0.1894	1.9189	493	10
WARM_TIME	2	6554.45	0.6169	1.2755	425	10
WARM_TIME	3	6653.36	0.8377	1.1419	229	10
TEST_TIME	4	6096.73	0.9777	1.0415	116	4
TEST_TIME	5	5151.68	0.9860	1.0033	61	3
TEST_TIME	6	4365.91	0.9996	1.0003	18	1
TEST_TIME	7	3867.57	0.9800	1.0120	36	3
TEST_TIME	8	3425.35	0.9998	1.0000	7	2
TEST_TIME	9	3105.53	0.9994	1.0001	41	10

Done for 2060 ms, from 21:41:57.50 to 21:41:59.56.

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	66933	<null>	103864	<null>	<null>	<null>	281969	<null>	<null>	<null>	94263	<null>	<null>	<null>	<null>	<null>	<null>	<null>	<null>	21:35:35	21:36:08
fetches per second	2	72404	<null>	120551	<null>	200868	<null>	18146	<null>	<null>	<null>	66142	<null>	92015	<null>	429066	<null>	968890	575571	<null>	21:36:09	21:36:42
fetches per second	3	<null>	<null>	208489	57090	125803	<null>	<null>	<null>	<null>	<null>	20378	<null>	169718	<null>	206110	<null>	904769	<null>	<null>	21:36:43	21:37:16
fetches per second	8	55261	51406	27406	<null>	141866	<null>	22120	<null>	15632	<null>	84492	<null>	112002	<null>	323108	<null>	898002	<null>	<null>	21:39:33	21:40:06
marks per second	1	11575	<null>	11420	<null>	<null>	<null>	1259	<null>	<null>	<null>	8121	<null>	<null>	<null>	<null>	<null>	<null>	<null>	<null>	21:35:35	21:36:08
marks per second	2	13455	<null>	13482	<null>	19144	<null>	1320	<null>	<null>	<null>	7251	<null>	3148	<null>	11467	<null>	9024	5000	<null>	21:36:09	21:36:42
marks per second	3	<null>	<null>	21288	6789	10578	<null>	<null>	<null>	<null>	<null>	3722	<null>	5169	<null>	5134	<null>	15693	<null>	<null>	21:36:43	21:37:16
marks per second	8	10458	4440	3126	<null>	12732	<null>	626	<null>	1064	<null>	4412	<null>	3313	<null>	9496	<null>	9042	<null>	<null>	21:39:33	21:40:06
reads/fetches*100	1	10	<null>	2	<null>	<null>	<null>	1	<null>	<null>	<null>	10	<null>	<null>	<null>	<null>	<null>	<null>	<null>	<null>	21:35:35	21:36:08
reads/fetches*100	2	7	<null>	3	<null>	3	<null>	6	<null>	<null>	<null>	9	<null>	6	<null>	3	<null>	0	1	<null>	21:36:09	21:36:42
reads/fetches*100	3	<null>	<null>	1	1	3	<null>	<null>	<null>	<null>	<null>	11	<null>	6	<null>	3	<null>	0	<null>	<null>	21:36:43	21:37:16
reads/fetches*100	8	7	8	2	<null>	3	<null>	3	<null>	9	<null>	9	<null>	6	<null>	3	<null>	1	<null>	<null>	21:39:33	21:40:06
writes/marks*100	1	13	<null>	5	<null>	<null>	<null>	2	<null>	<null>	<null>	7	<null>	<null>	<null>	<null>	<null>	<null>	<null>	<null>	21:35:35	21:36:08
writes/marks*100	2	12	<null>	10	<null>	9	<null>	2	<null>	<null>	<null>	8	<null>	0	<null>	0	<null>	17	0	<null>	21:36:09	21:36:42
writes/marks*100	3	<null>	<null>	6	3	11	<null>	<null>	<null>	<null>	<null>	9	<null>	0	<null>	0	<null>	13	<null>	<null>	21:36:43	21:37:16
writes/marks*100	8	11	15	8	<null>	8	<null>	1	<null>	1	<null>	8	<null>	0	<null>	0	<null>	16	<null>	<null>	21:39:33	21:40:06

Done for 5470 ms, from 21:41:59.67 to 21:42:05.14.

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	3210	2621	589	18.34	0	253	5	589	2016-04-06 21:35	2016-04-06 21:41
doc_list_biud	3211	2621	590	18.37	0	1170	13	590	2016-04-06 21:35	2016-04-06 21:41
sp_add_invoice_to_stock	9	8	1	11.11	2127	204253	125927	1	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_adding_invoice	15	6	9	60.00	87	483	291	9	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_client_order	5	5	0	0.00	22	63	33	0	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_customer_reserve	1211	735	476	39.30	3	296	35	476	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_pay_from_customer	2	2	0	0.00	13	27	20	0	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_pay_to_supplier	1	1	0	0.00	16	16	16	0	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_supplier_invoice	66	56	10	15.15	4	204	72	10	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_supplier_order	3	2	1	33.33	9098	28375	18736	1	2016-04-06 21:35	2016-04-06 21:41
sp_cancel_write_off	105	8	97	92.38	9	271	76	97	2016-04-06 21:35	2016-04-06 21:41
sp_client_order	94	94	0	0.00	12	307	51	0	2016-04-06 21:35	2016-04-06 21:41
sp_customer_reserve	3693	3693	0	0.00	3	2552	307	0	2016-04-06 21:35	2016-04-06 21:41
sp_fill_shopping_cart	151	151	0	0.00	1	712	28	0	2016-04-06 21:35	2016-04-06 21:41
sp_fill_shopping_cart_clo_res	3694	3694	0	0.00	0	51	1	0	2016-04-06 21:35	2016-04-06 21:41
sp_get_clo_for_invoice	8	8	0	0.00	3	248	108	0	2016-04-06 21:35	2016-04-06 21:41
sp_kill_cost_storno	120	17	103	85.83	0	18	2	103	2016-04-06 21:35	2016-04-06 21:41
sp_kill_qstorno_ret_qs2qd	2593	1536	1057	40.76	0	286	17	1057	2016-04-06 21:35	2016-04-06 21:41
sp_kill_qty_storno	1457	867	590	40.49	1	1168	38	590	2016-04-06 21:35	2016-04-06 21:41
sp_lock_selected_doc	79	75	4	5.06	0	7	0	4	2016-04-06 21:35	2016-04-06 21:41
sp_make_cost_storno	126	126	0	0.00	1	238	36	0	2016-04-06 21:35	2016-04-06 21:41
sp_multiply_rows_for_pdistr	126	126	0	0.00	1	127	5	0	2016-04-06 21:35	2016-04-06 21:41
sp_multiply_rows_for_qdistr	94	94	0	0.00	0	160	14	0	2016-04-06 21:35	2016-04-06 21:41
sp_pay_from_customer	40	40	0	0.00	34	273	80	0	2016-04-06 21:35	2016-04-06 21:41
sp_pay_to_supplier	31	31	0	0.00	45	260	99	0	2016-04-06 21:35	2016-04-06 21:41
sp_payment_common	71	71	0	0.00	7	200	28	0	2016-04-06 21:35	2016-04-06 21:41
sp_qd_handle_on_cancel_clo	5	5	0	0.00	5	13	7	0	2016-04-06 21:35	2016-04-06 21:41
sp_qd_handle_on_invoice_upd_sts	23	14	9	39.13	23	1167	414	9	2016-04-06 21:35	2016-04-06 21:41
sp_qd_handle_on_reserve_upd_sts	47	47	0	0.00	1	116	10	0	2016-04-06 21:35	2016-04-06 21:41
sp_reserve_write_off	47	47	0	0.00	15	227	65	0	2016-04-06 21:35	2016-04-06 21:41
sp_supplier_invoice	33	33	0	0.00	22	598	254	0	2016-04-06 21:35	2016-04-06 21:41
sp_supplier_order	24	24	0	0.00	23	968	212	0	2016-04-06 21:35	2016-04-06 21:41
srv_find_qd_qs_mism	2296	1707	589	25.65	0	163	3	589	2016-04-06 21:35	2016-04-06 21:41
srv_make_invnt_saldo	14	14	0	0.00	113	415	264	0	2016-04-06 21:35	2016-04-06 21:41
srv_make_money_saldo	7	7	0	0.00	2	13	7	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-abend:sp_add_invoice_to_stock	1	1	0	0.00	1	1	1	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-abend:sp_cancel_supplier_invoice	2	2	0	0.00	2	3	2	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-abend:sp_cancel_supplier_order	66	66	0	0.00	8	53	13	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_add_invoice_to_stock	13	13	0	0.00	23	2285	417	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_client_order	5	5	0	0.00	2	29	9	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_customer_reserve	2	2	0	0.00	1	5	3	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_pay_from_customer	2	2	0	0.00	1	2	1	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_pay_to_supplier	1	1	0	0.00	1	1	1	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_supplier_invoice	1	1	0	0.00	2	2	2	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_supplier_order	2	2	0	0.00	164	498	331	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_cancel_write_off	7	7	0	0.00	1	20	6	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_client_order	94	94	0	0.00	1	206	11	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_customer_reserve	3	3	0	0.00	1	12	5	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_pay_from_customer	40	40	0	0.00	0	65	5	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_pay_to_supplier	31	31	0	0.00	1	7	1	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_reserve_write_off	47	47	0	0.00	1	16	3	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_supplier_invoice	33	33	0	0.00	1	109	11	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:sp_supplier_order	24	24	0	0.00	2	177	12	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:srv_make_invnt_saldo	14	14	0	0.00	0	39	6	0	2016-04-06 21:35	2016-04-06 21:41
t$perf-norm:srv_make_money_saldo	7	7	0	0.00	0	3	1	0	2016-04-06 21:35	2016-04-06 21:41
v_add_invoice_to_stock	18	16	2	11.11	1	22	5	2	2016-04-06 21:35	2016-04-06 21:41
v_all_customers	142	142	0	0.00	0	7	0	0	2016-04-06 21:35	2016-04-06 21:41
v_all_suppliers	114	114	0	0.00	0	2	0	0	2016-04-06 21:35	2016-04-06 21:41
v_all_wares	188	188	0	0.00	0	6	0	0	2016-04-06 21:35	2016-04-06 21:41
v_cancel_client_order	10	10	0	0.00	0	3	1	0	2016-04-06 21:35	2016-04-06 21:41
v_cancel_customer_prepayment	4	4	0	0.00	1	2	1	0	2016-04-06 21:35	2016-04-06 21:41
v_cancel_customer_reserve	4	4	0	0.00	0	3	1	0	2016-04-06 21:35	2016-04-06 21:41
v_cancel_payment_to_supplier	2	2	0	0.00	1	1	1	0	2016-04-06 21:35	2016-04-06 21:41
v_cancel_supplier_invoice	6	2	4	66.66	7	15	11	4	2016-04-06 21:35	2016-04-06 21:41
v_cancel_supplier_order	6	4	2	33.33	0	1	0	2	2016-04-06 21:35	2016-04-06 21:41
v_cancel_write_off	14	14	0	0.00	0	20	7	0	2016-04-06 21:35	2016-04-06 21:41
v_max_id_clo_ord	24	24	0	0.00	0	3	1	0	2016-04-06 21:35	2016-04-06 21:41
v_max_id_clo_res	3	3	0	0.00	1	2	1	0	2016-04-06 21:35	2016-04-06 21:41
v_max_id_ord_sup	33	33	0	0.00	1	9	2	0	2016-04-06 21:35	2016-04-06 21:41
v_max_non_paid_invoice	31	31	0	0.00	0	5	1	0	2016-04-06 21:35	2016-04-06 21:41
v_max_non_paid_realizn	40	40	0	0.00	3	20	9	0	2016-04-06 21:35	2016-04-06 21:41
v_min_id_clo_ord	24	24	0	0.00	1	47	6	0	2016-04-06 21:35	2016-04-06 21:41
v_min_id_clo_res	3	3	0	0.00	0	1	0	0	2016-04-06 21:35	2016-04-06 21:41
v_min_id_ord_sup	33	33	0	0.00	1	8	2	0	2016-04-06 21:35	2016-04-06 21:41
v_min_non_paid_invoice	31	31	0	0.00	5	104	15	0	2016-04-06 21:35	2016-04-06 21:41
v_min_non_paid_realizn	40	40	0	0.00	5	185	16	0	2016-04-06 21:35	2016-04-06 21:41
v_our_firm	46	46	0	0.00	0	1	0	0	2016-04-06 21:35	2016-04-06 21:41
v_reserve_write_off	94	94	0	0.00	0	7	1	0	2016-04-06 21:35	2016-04-06 21:41
x_lock_depdocs_on_canc_invoice	81	61	20	24.69	0	11	1	20	2016-04-06 21:35	2016-04-06 21:41
x_lock_depdocs_on_canc_sup_ord	3	2	1	33.33	2	5	3	1	2016-04-06 21:35	2016-04-06 21:41
x_make_qstorno_1000_1200	24	24	0	0.00	13	248	90	0	2016-04-06 21:35	2016-04-06 21:41
x_make_qstorno_1200_2000	33	33	0	0.00	14	564	212	0	2016-04-06 21:35	2016-04-06 21:41
x_make_qstorno_2100_3300	3696	3696	0	0.00	2	2543	300	0	2016-04-06 21:35	2016-04-06 21:41

Done for 8150 ms, from 21:42:06.00 to 21:42:14.15.

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

Exceptions occured during test work:

FB_MNEMONA	CNT	UNIT	FB_GDSCODE	DTS_BEG	DTS_END
lock_conflict	3	sp_lock_selected_doc	335544345	2016-04-06 21:37	2016-04-06 21:37
lock_conflict	1	sp_qd_handle_on_invoice_upd_sts	335544345	2016-04-06 21:40	2016-04-06 21:40

Done for 1380 ms, from 21:42:14.25 to 21:42:15.63.

MON$DATABASE and FB VERSION info

MON$DATABASE_NAME D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
MON$PAGE_SIZE 8192
MON$ODS_MAJOR 11
MON$ODS_MINOR 2
MON$OLDEST_TRANSACTION 100509
MON$OLDEST_ACTIVE 119025
MON$OLDEST_SNAPSHOT 119025
MON$NEXT_TRANSACTION 124022
MON$PAGE_BUFFERS 1024
MON$SQL_DIALECT 3
MON$SHUTDOWN_MODE 0
MON$SWEEP_INTERVAL 0
MON$READ_ONLY 0
MON$FORCED_WRITES 1
MON$RESERVE_SPACE 1
MON$CREATION_DATE 2015-12-11 10:02:47.3010
MON$PAGES 314809
MON$STAT_ID 1
MON$BACKUP_STATE 0
ISQL Version: WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215
Server version:
Firebird/x86-64/Windows NT (access method), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215"
Firebird/x86-64/Windows NT (remote server), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215/tcp (WIN-2BE1UI8LGDL)/P12"
Firebird/x86-64/Windows NT (remote interface), version "WI-V2.5.5.26952 Firebird 2.5 HQbird #20160215/tcp (WIN-2BE1UI8LGDL)/P12
on disk structure version 11.2

Database statistics, full

Database "D:\OLTP-HQBIRD\oltp25-small.fdb"
Database header page information:
Flags 0
Checksum 12345
Generation 129215
Page size 8192
ODS version 11.2
Oldest transaction 100509
Oldest active 119025
Oldest snapshot 119025
Next transaction 124025
Bumped transaction 1
Sequence number 0
Next attachment ID 5145
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: {6E843B5A-8748-4DD3-E69C-390A36C13F9F}
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: 45.14, total records: 638134
Average version length: 47.78, total versions: 20015, max versions: 1
Data pages: 7938, data page slots: 7938, average fill: 64%
Fill distribution:
0 - 19% = 26
20 - 39% = 468
40 - 59% = 1880
60 - 79% = 5489
80 - 99% = 75

Index DOC_DATA_DOC_WARE_UNQ (1)
Depth: 3, leaf buckets: 2820, nodes: 638134
Average data length: 12.96, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 260
20 - 39% = 598
40 - 59% = 1018
60 - 79% = 221
80 - 99% = 723

Index DOC_DATA_ID_DESC (2)
Depth: 3, leaf buckets: 2184, nodes: 638134
Average data length: 5.80, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 0
20 - 39% = 753
40 - 59% = 1426
60 - 79% = 5
80 - 99% = 0

Index FK_DOC_DATA_DOC_LIST (3)
Depth: 3, leaf buckets: 915, nodes: 638134
Average data length: 1.44, total dup: 490160, max dup: 49
Fill distribution:
0 - 19% = 51
20 - 39% = 250
40 - 59% = 242
60 - 79% = 87
80 - 99% = 285

DOC_LIST (140)
Primary pointer page: 195, Index root page: 196
Average record length: 57.73, total records: 167009
Average version length: 37.64, total versions: 16458, max versions: 3
Data pages: 2098, data page slots: 2098, average fill: 78%
Fill distribution:
0 - 19% = 3
20 - 39% = 3
40 - 59% = 13
60 - 79% = 1705
80 - 99% = 374

Index DOC_LIST_ID_DESC (1)
Depth: 3, leaf buckets: 577, nodes: 167009
Average data length: 6.16, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 1
20 - 39% = 220
40 - 59% = 352
60 - 79% = 4
80 - 99% = 0

Index FK_DOC_LIST_AGENTS (2)
Depth: 2, leaf buckets: 162, nodes: 167009
Average data length: 0.01, total dup: 166959, max dup: 22980
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 122
60 - 79% = 25
80 - 99% = 15

Index PK_DOC_LIST (0)
Depth: 2, leaf buckets: 417, nodes: 167009
Average data length: 6.15, total dup: 0, max dup: 0
Fill distribution:
0 - 19% = 48
20 - 39% = 80
40 - 59% = 83
60 - 79% = 67
80 - 99% = 139

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: 66.21, total records: 400
Average version length: 15.31, total versions: 21458, max versions: 68
Data pages: 95, data page slots: 95, average fill: 96%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 94

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

INVNT_TURNOVER_LOG (157)
Primary pointer page: 278, Index root page: 279
Average record length: 0.01, total records: 69986
Average version length: 71.05, total versions: 69974, max versions: 1
Data pages: 998, data page slots: 1023, average fill: 90%
Fill distribution:
0 - 19% = 19
20 - 39% = 6
40 - 59% = 24
60 - 79% = 32
80 - 99% = 917

Index INVNT_TURNOVER_LOG_WARE_DD_ID (0)
Depth: 2, leaf buckets: 166, nodes: 69986
Average data length: 7.84, total dup: 9117, max dup: 3
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 65
60 - 79% = 59
80 - 99% = 42

MONEY_SALDO (143)
Primary pointer page: 208, Index root page: 209
Average record length: 15.84, total records: 49
Average version length: 9.00, total versions: 787, max versions: 65
Data pages: 3, data page slots: 3, average fill: 90%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
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: 0.23, total records: 1994
Average version length: 46.33, total versions: 1984, max versions: 1
Data pages: 22, data page slots: 22, average fill: 89%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 1
80 - 99% = 20

Index MONEY_TURNOVER_LOG_AGENT_OPTYPE (0)
Depth: 2, leaf buckets: 3, nodes: 1994
Average data length: 0.44, total dup: 1922, max dup: 360
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 2
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: 58
Average version length: 58.19, total versions: 58, max versions: 1
Data pages: 2, data page slots: 5, average fill: 35%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 1
60 - 79% = 0
80 - 99% = 0

Index MON_LOG_TABLE_STATS_DTS (4)
Depth: 1, leaf buckets: 1, nodes: 58
Average data length: 1.09, total dup: 3, max dup: 1
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: 58
Average data length: 0.00, total dup: 57, max dup: 57
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 0

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

Index MON_LOG_TABLE_STATS_TN_UNIT (3)
Depth: 1, leaf buckets: 1, nodes: 58
Average data length: 12.33, 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: 58
Average data length: 5.12, 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: 33.41, total records: 92079
Average version length: 31.70, total versions: 34808, max versions: 6
Data pages: 1340, data page slots: 1405, average fill: 59%
Fill distribution:
0 - 19% = 257
20 - 39% = 217
40 - 59% = 13
60 - 79% = 393
80 - 99% = 460

Index PDISTR_AGENT_ID (4)
Depth: 2, leaf buckets: 84, nodes: 92079
Average data length: 0.01, total dup: 92030, max dup: 11999
Fill distribution:
0 - 19% = 1
20 - 39% = 10
40 - 59% = 44
60 - 79% = 22
80 - 99% = 7

Index PDISTR_SNDOP_RCVOP_SNDID_ASC (2)
Depth: 2, leaf buckets: 110, nodes: 92079
Average data length: 0.95, total dup: 82411, max dup: 30
Fill distribution:
0 - 19% = 1
20 - 39% = 27
40 - 59% = 46
60 - 79% = 25
80 - 99% = 11

Index PDISTR_SNDOP_RCVOP_SNDID_DESC (3)
Depth: 2, leaf buckets: 113, nodes: 92079
Average data length: 0.95, total dup: 82411, max dup: 30
Fill distribution:
0 - 19% = 0
20 - 39% = 29
40 - 59% = 53
60 - 79% = 23
80 - 99% = 8

Index PDISTR_SND_ID (1)
Depth: 2, leaf buckets: 111, nodes: 92079
Average data length: 0.72, total dup: 82411, max dup: 30
Fill distribution:
0 - 19% = 2
20 - 39% = 31
40 - 59% = 53
60 - 79% = 17
80 - 99% = 8

PERF_ESTIMATED (160)
Primary pointer page: 289, Index root page: 290
Average record length: 8.01, total records: 5618
Average version length: 26.50, total versions: 3910, max versions: 1
Data pages: 47, data page slots: 311, average fill: 81%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 1
60 - 79% = 13
80 - 99% = 33

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

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

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

PERF_LOG (162)
Primary pointer page: 299, Index root page: 300
Average record length: 149.88, total records: 3845107
Average version length: 75.50, total versions: 12, max versions: 4
Data pages: 90511, data page slots: 90511, average fill: 87%
Fill distribution:
0 - 19% = 1
20 - 39% = 0
40 - 59% = 0
60 - 79% = 0
80 - 99% = 90510

Index PERF_LOG_DTS_BEG_DESC (0)
Depth: 3, leaf buckets: 4067, nodes: 3845107
Average data length: 0.38, total dup: 2753124, max dup: 66
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 2158
60 - 79% = 1207
80 - 99% = 700

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

Index PERF_LOG_TRN_DESC (2)
Depth: 3, leaf buckets: 4365, nodes: 3845107
Average data length: 0.17, total dup: 3743127, max dup: 16262
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 3392
60 - 79% = 522
80 - 99% = 451

Index PERF_LOG_UNIT (1)
Depth: 3, leaf buckets: 4396, nodes: 3845107
Average data length: 0.18, total dup: 3785599, max dup: 381986
Fill distribution:
0 - 19% = 7
20 - 39% = 1
40 - 59% = 3570
60 - 79% = 353
80 - 99% = 465

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: 54.57, total records: 113578
Average version length: 56.93, total versions: 1695, max versions: 1
Data pages: 1526, data page slots: 1528, average fill: 67%
Fill distribution:
0 - 19% = 5
20 - 39% = 59
40 - 59% = 273
60 - 79% = 1180
80 - 99% = 9

Index PSTORNED_RCV_ID (2)
Depth: 2, leaf buckets: 157, nodes: 113578
Average data length: 1.07, total dup: 95349, max dup: 379
Fill distribution:
0 - 19% = 0
20 - 39% = 14
40 - 59% = 131
60 - 79% = 10
80 - 99% = 2

Index PSTORNED_SND_ID (1)
Depth: 2, leaf buckets: 120, nodes: 113578
Average data length: 0.71, total dup: 101750, max dup: 77
Fill distribution:
0 - 19% = 0
20 - 39% = 7
40 - 59% = 65
60 - 79% = 39
80 - 99% = 9

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

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

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

SETTINGS (137)
Primary pointer page: 183, Index root page: 184
Average record length: 98.32, total records: 114
Average version length: 9.00, total versions: 4, max versions: 2
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: 20.80, total records: 1340
Average version length: 59.12, total versions: 868, max versions: 1
Data pages: 17, data page slots: 17, average fill: 84%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 5
80 - 99% = 11

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

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

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

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

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

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

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

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

XQD_1000_1200 (258)
Primary pointer page: 645, Index root page: 646
Average record length: 0.36, total records: 60207
Average version length: 72.16, total versions: 59909, max versions: 1
Data pages: 838, data page slots: 838, average fill: 93%
Fill distribution:
0 - 19% = 1
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3
80 - 99% = 833

Index XQD_1000_1200_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 64, nodes: 60207
Average data length: 1.35, total dup: 52595, max dup: 14
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 21
60 - 79% = 25
80 - 99% = 15

XQD_1000_3300 (260)
Primary pointer page: 653, Index root page: 654
Average record length: 51.45, total records: 303528
Average version length: 69.96, total versions: 84674, max versions: 1
Data pages: 4176, data page slots: 4291, average fill: 83%
Fill distribution:
0 - 19% = 5
20 - 39% = 4
40 - 59% = 1
60 - 79% = 753
80 - 99% = 3413

Index XQD_1000_3300_DOC (1)
Depth: 2, leaf buckets: 296, nodes: 303534
Average data length: 0.25, total dup: 292206, max dup: 193
Fill distribution:
0 - 19% = 4
20 - 39% = 36
40 - 59% = 114
60 - 79% = 55
80 - 99% = 87

Index XQD_1000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 390, nodes: 303532
Average data length: 1.28, total dup: 264217, max dup: 35
Fill distribution:
0 - 19% = 3
20 - 39% = 0
40 - 59% = 218
60 - 79% = 152
80 - 99% = 17

XQD_1200_2000 (259)
Primary pointer page: 648, Index root page: 649
Average record length: 27.52, total records: 257704
Average version length: 71.13, total versions: 158819, max versions: 1
Data pages: 3550, data page slots: 3550, average fill: 88%
Fill distribution:
0 - 19% = 0
20 - 39% = 0
40 - 59% = 0
60 - 79% = 526
80 - 99% = 3024

Index XQD_1200_2000_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 278, nodes: 257704
Average data length: 1.13, total dup: 228276, max dup: 87
Fill distribution:
0 - 19% = 2
20 - 39% = 0
40 - 59% = 93
60 - 79% = 107
80 - 99% = 76

XQD_2000_3300 (261)
Primary pointer page: 657, Index root page: 658
Average record length: 38.91, total records: 553277
Average version length: 71.85, total versions: 251724, max versions: 1
Data pages: 7680, data page slots: 24606, average fill: 85%
Fill distribution:
0 - 19% = 0
20 - 39% = 1
40 - 59% = 0
60 - 79% = 3535
80 - 99% = 4144

Index XQD_2000_3300_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 628, nodes: 553277
Average data length: 0.58, total dup: 521698, max dup: 99
Fill distribution:
0 - 19% = 24
20 - 39% = 156
40 - 59% = 89
60 - 79% = 150
80 - 99% = 209

XQD_2100_3300 (262)
Primary pointer page: 661, Index root page: 662
Average record length: 2.83, total records: 141154
Average version length: 71.13, total versions: 135381, max versions: 1
Data pages: 2435, data page slots: 2640, average fill: 74%
Fill distribution:
0 - 19% = 429
20 - 39% = 55
40 - 59% = 83
60 - 79% = 63
80 - 99% = 1805

Index XQD_2100_3300_WARE_SOP_ROP_SND (0)
Depth: 2, leaf buckets: 181, nodes: 141154
Average data length: 0.96, total dup: 128642, max dup: 99
Fill distribution:
0 - 19% = 0
20 - 39% = 17
40 - 59% = 99
60 - 79% = 61
80 - 99% = 4

XQD_3300_3400 (263)
Primary pointer page: 664, Index root page: 665
Average record length: 64.41, total records: 806046
Average version length: 71.04, total versions: 70926, max versions: 1
Data pages: 17377, data page slots: 20271, average fill: 52%
Fill distribution:
0 - 19% = 2011
20 - 39% = 3661
40 - 59% = 4463
60 - 79% = 5806
80 - 99% = 1436

Index XQD_3300_3400_WARE_SOP_ROP_SND (0)
Depth: 3, leaf buckets: 1586, nodes: 806046
Average data length: 1.63, total dup: 665796, max dup: 29
Fill distribution:
0 - 19% = 11
20 - 39% = 1043
40 - 59% = 206
60 - 79% = 195
80 - 99% = 131

XQS_1000_1200 (264)
Primary pointer page: 667, Index root page: 668
Average record length: 81.29, total records: 1320890
Average version length: 84.78, total versions: 6133, max versions: 1
Data pages: 20350, data page slots: 20463, average fill: 79%
Fill distribution:
0 - 19% = 60
20 - 39% = 96
40 - 59% = 370
60 - 79% = 9538
80 - 99% = 10286

Index XQS_1000_1200_DOC_ID (0)
Depth: 3, leaf buckets: 1526, nodes: 1320890
Average data length: 0.16, total dup: 1290894, max dup: 138
Fill distribution:
0 - 19% = 11
20 - 39% = 14
40 - 59% = 1151
60 - 79% = 310
80 - 99% = 40

Index XQS_1000_1200_RCV_ID (2)
Depth: 3, leaf buckets: 1083, nodes: 1320890
Average data length: 0.70, total dup: 1161068, max dup: 49
Fill distribution:
0 - 19% = 1
20 - 39% = 23
40 - 59% = 149
60 - 79% = 34
80 - 99% = 876

Index XQS_1000_1200_SND_ID (1)
Depth: 3, leaf buckets: 1711, nodes: 1320890
Average data length: 0.73, total dup: 1156103, max dup: 29
Fill distribution:
0 - 19% = 12
20 - 39% = 18
40 - 59% = 1265
60 - 79% = 364
80 - 99% = 52

XQS_1000_3300 (266)
Primary pointer page: 678, Index root page: 679
Average record length: 76.28, total records: 829082
Average version length: 82.79, total versions: 56122, max versions: 1
Data pages: 17334, data page slots: 19003, average fill: 59%
Fill distribution:
0 - 19% = 1301
20 - 39% = 2684
40 - 59% = 3683
60 - 79% = 5406
80 - 99% = 4260

Index XQS_1000_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1102, nodes: 829082
Average data length: 0.16, total dup: 809492, max dup: 205
Fill distribution:
0 - 19% = 0
20 - 39% = 324
40 - 59% = 604
60 - 79% = 166
80 - 99% = 8

Index XQS_1000_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1171, nodes: 829082
Average data length: 1.02, total dup: 690662, max dup: 14
Fill distribution:
0 - 19% = 46
20 - 39% = 302
40 - 59% = 404
60 - 79% = 225
80 - 99% = 194

Index XQS_1000_3300_SND_ID (1)
Depth: 3, leaf buckets: 1243, nodes: 829082
Average data length: 0.74, total dup: 726730, max dup: 41
Fill distribution:
0 - 19% = 16
20 - 39% = 328
40 - 59% = 686
60 - 79% = 206
80 - 99% = 7

XQS_1200_2000 (265)
Primary pointer page: 673, Index root page: 674
Average record length: 71.52, total records: 1445870
Average version length: 84.87, total versions: 179131, max versions: 1
Data pages: 22904, data page slots: 29661, average fill: 78%
Fill distribution:
0 - 19% = 751
20 - 39% = 361
40 - 59% = 326
60 - 79% = 7343
80 - 99% = 14123

Index XQS_1200_2000_DOC_ID (0)
Depth: 3, leaf buckets: 1736, nodes: 1445870
Average data length: 0.05, total dup: 1437707, max dup: 720
Fill distribution:
0 - 19% = 3
20 - 39% = 373
40 - 59% = 988
60 - 79% = 297
80 - 99% = 75

Index XQS_1200_2000_RCV_ID (2)
Depth: 3, leaf buckets: 1255, nodes: 1445870
Average data length: 0.54, total dup: 1312890, max dup: 49
Fill distribution:
0 - 19% = 24
20 - 39% = 110
40 - 59% = 193
60 - 79% = 132
80 - 99% = 796

Index XQS_1200_2000_SND_ID (1)
Depth: 3, leaf buckets: 1987, nodes: 1445870
Average data length: 0.65, total dup: 1285014, max dup: 110
Fill distribution:
0 - 19% = 4
20 - 39% = 442
40 - 59% = 1113
60 - 79% = 344
80 - 99% = 84

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: 76.85, total records: 1023988
Average version length: 83.82, total versions: 64575, max versions: 1
Data pages: 21429, data page slots: 22309, average fill: 60%
Fill distribution:
0 - 19% = 1504
20 - 39% = 2995
40 - 59% = 5085
60 - 79% = 6808
80 - 99% = 5037

Index XQS_2100_3300_DOC_ID (0)
Depth: 3, leaf buckets: 1272, nodes: 1023994
Average data length: 0.05, total dup: 1018444, max dup: 1357
Fill distribution:
0 - 19% = 2
20 - 39% = 367
40 - 59% = 619
60 - 79% = 233
80 - 99% = 51

Index XQS_2100_3300_RCV_ID (2)
Depth: 3, leaf buckets: 1514, nodes: 1024192
Average data length: 1.02, total dup: 854081, max dup: 14
Fill distribution:
0 - 19% = 48
20 - 39% = 488
40 - 59% = 496
60 - 79% = 266
80 - 99% = 216

Index XQS_2100_3300_SND_ID (1)
Depth: 3, leaf buckets: 1417, nodes: 1023990
Average data length: 0.63, total dup: 916889, max dup: 97
Fill distribution:
0 - 19% = 6
20 - 39% = 384
40 - 59% = 661
60 - 79% = 294
80 - 99% = 72

XQS_3300_3400 (269)
Primary pointer page: 697, Index root page: 698
Average record length: 66.51, total records: 231439
Average version length: 69.15, total versions: 7146, max versions: 1
Data pages: 4769, data page slots: 5248, average fill: 52%
Fill distribution:
0 - 19% = 721
20 - 39% = 915
40 - 59% = 923
60 - 79% = 2093
80 - 99% = 117

Index XQS_3300_3400_DOC_ID (0)
Depth: 2, leaf buckets: 314, nodes: 231439
Average data length: 0.32, total dup: 220836, max dup: 197
Fill distribution:
0 - 19% = 1
20 - 39% = 108
40 - 59% = 148
60 - 79% = 45
80 - 99% = 12

Index XQS_3300_3400_SND_ID (1)
Depth: 2, leaf buckets: 348, nodes: 231439
Average data length: 0.88, total dup: 199692, max dup: 29
Fill distribution:
0 - 19% = 0
20 - 39% = 109
40 - 59% = 166
60 - 79% = 64
80 - 99% = 9

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 8410 ms, from 21:42:16.19 to 21:42:24.60.

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	638134	20015	3.1364
DOC_LIST	167009	16458	9.8545
DOC_STATES	4	0	0.0000
FB_ERRORS	758	0	0.0000
INVNT_SALDO	400	21458	5364.5000
INVNT_TURNOVER_LOG	69986	69974	99.9828
MONEY_SALDO	49	787	1606.1224
MONEY_TURNOVER_LOG	1994	1984	99.4984
MON_LOG_TABLE_STATS	58	58	100.0000
OPTYPES	9	0	0.0000
PDISTR	92079	34808	37.8023
PERF_ESTIMATED	5618	3910	69.5977
PERF_LOG	3845107	12	0.0003
PSTORNED	113578	1695	1.4923
RULES_FOR_PDISTR	4	0	0.0000
RULES_FOR_QDISTR	7	0	0.0000
SEMAPHORES	4	193	4825.0000
SETTINGS	114	4	3.5087
TRACE_STAT	1340	868	64.7761
WARES	400	0	0.0000
WARE_GROUPS	8	0	0.0000
XQD_1000_1200	60207	59909	99.5050
XQD_1000_3300	303528	84674	27.8966
XQD_1200_2000	257704	158819	61.6284
XQD_2000_3300	553277	251724	45.4969
XQD_2100_3300	141154	135381	95.9101
XQD_3300_3400	806046	70926	8.7992
XQS_1000_1200	1320890	6133	0.4643
XQS_1000_3300	829082	56122	6.7691
XQS_1200_2000	1445870	179131	12.3891
XQS_2100_3300	1023988	64575	6.3062
XQS_3300_3400	231439	7146	3.0876
Z_USED_VIEWS	32	0	0.0000

Done for 2620 ms, from 21:42:35.81 to 21:42:38.43.

Database validation

21:42:38.50 Validation started

21:42:38.50 Relation 140 (DOC_LIST)
21:42:38.50 process pointer page 0 of 2
21:42:39.43 process pointer page 1 of 2
21:42:39.53 Index 1 (PK_DOC_LIST)
21:42:39.59 Index 2 (DOC_LIST_ID_DESC)
21:42:39.66 Index 3 (FK_DOC_LIST_AGENTS)
21:42:39.69 Relation 140 (DOC_LIST) is ok

21:42:39.69 Relation 141 (DOC_DATA)
21:42:39.69 process pointer page 0 of 5
21:42:39.81 process pointer page 1 of 5
21:42:39.89 process pointer page 2 of 5
21:42:39.99 process pointer page 3 of 5
21:42:41.68 process pointer page 4 of 5
21:42:41.88 Index 2 (DOC_DATA_DOC_WARE_UNQ)
21:42:42.15 Index 3 (DOC_DATA_ID_DESC)
21:42:42.36 Index 4 (FK_DOC_DATA_DOC_LIST)
21:42:42.42 Relation 141 (DOC_DATA) is ok

21:42:42.42 Relation 147 (INVNT_SALDO)
21:42:42.43 process pointer page 0 of 1
21:42:42.43 Index 1 (PK_INVNT_SALDO)
21:42:42.44 Relation 147 (INVNT_SALDO) is ok

21:42:42.44 Relation 150 (PDISTR)
21:42:42.44 process pointer page 0 of 1
21:42:42.69 Index 2 (PDISTR_SND_ID)
21:42:42.70 Index 3 (PDISTR_SNDOP_RCVOP_SNDID_ASC)
21:42:42.71 Index 4 (PDISTR_SNDOP_RCVOP_SNDID_DESC)
21:42:42.73 Index 5 (PDISTR_AGENT_ID)
21:42:42.75 Relation 150 (PDISTR) is ok

21:42:42.75 Relation 151 (PSTORNED)
21:42:42.75 process pointer page 0 of 1
21:42:43.11 Index 2 (PSTORNED_SND_ID)
21:42:43.14 Index 3 (PSTORNED_RCV_ID)
21:42:43.17 Relation 151 (PSTORNED) is ok

21:42:43.17 Relation 156 (SEMAPHORES)
21:42:43.17 process pointer page 0 of 1
21:42:43.18 Index 1 (PK_SEMAPHORES)
21:42:43.18 Index 2 (SEMAPHORES_TASK_UNQ)
21:42:43.18 Relation 156 (SEMAPHORES) is ok

21:42:43.18 Relation 157 (INVNT_TURNOVER_LOG)
21:42:43.18 process pointer page 0 of 2
21:42:43.27 process pointer page 1 of 2
21:42:43.27 Index 1 (INVNT_TURNOVER_LOG_WARE_DD_ID)
21:42:43.31 Relation 157 (INVNT_TURNOVER_LOG) is ok

21:42:43.31 Relation 160 (PERF_ESTIMATED)
21:42:43.31 process pointer page 0 of 1
21:42:43.34 Index 1 (PERF_EST_MINUTE_SINCE_START)
21:42:43.34 Relation 160 (PERF_ESTIMATED) is ok

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

21:42:43.34 Relation 162 (PERF_LOG)
21:42:43.34 process pointer page 0 of 48
21:42:43.42 process pointer page 1 of 48
21:42:43.50 process pointer page 2 of 48
21:42:43.59 process pointer page 3 of 48
21:42:43.68 process pointer page 4 of 48
21:42:43.72 process pointer page 5 of 48
21:42:43.78 process pointer page 6 of 48
21:42:43.81 process pointer page 7 of 48
21:42:43.85 process pointer page 8 of 48
21:42:43.89 process pointer page 9 of 48
21:42:43.97 process pointer page 10 of 48
21:42:44.01 process pointer page 11 of 48
21:42:44.05 process pointer page 12 of 48
21:42:44.13 process pointer page 13 of 48
21:42:44.21 process pointer page 14 of 48
21:42:44.29 process pointer page 15 of 48
21:42:44.37 process pointer page 16 of 48
21:42:44.45 process pointer page 17 of 48
21:42:44.53 process pointer page 18 of 48
21:42:44.61 process pointer page 19 of 48
21:42:44.68 process pointer page 20 of 48
21:42:44.76 process pointer page 21 of 48
21:42:44.84 process pointer page 22 of 48
21:42:44.92 process pointer page 23 of 48
21:42:44.99 process pointer page 24 of 48
21:42:46.22 process pointer page 25 of 48
21:42:47.51 process pointer page 26 of 48
21:42:48.36 process pointer page 27 of 48
21:42:48.92 process pointer page 28 of 48
21:42:50.13 process pointer page 29 of 48
21:42:51.42 process pointer page 30 of 48
21:42:52.52 process pointer page 31 of 48
21:42:53.41 process pointer page 32 of 48
21:42:54.42 process pointer page 33 of 48
21:42:55.56 process pointer page 34 of 48
21:42:56.36 process pointer page 35 of 48
21:42:57.57 process pointer page 36 of 48
21:42:58.86 process pointer page 37 of 48
21:43:00.16 process pointer page 38 of 48
21:43:01.29 process pointer page 39 of 48
21:43:02.49 process pointer page 40 of 48
21:43:03.13 process pointer page 41 of 48
21:43:03.98 process pointer page 42 of 48
21:43:04.55 process pointer page 43 of 48
21:43:05.54 process pointer page 44 of 48
21:43:06.48 process pointer page 45 of 48
21:43:07.17 process pointer page 46 of 48
21:43:07.90 process pointer page 47 of 48
21:43:08.00 Index 1 (PERF_LOG_DTS_BEG_DESC)
21:43:09.20 Index 2 (PERF_LOG_UNIT)
21:43:10.95 Index 3 (PERF_LOG_TRN_DESC)
21:43:11.85 Index 4 (PERF_LOG_GDSCODE)
21:43:12.16 Relation 162 (PERF_LOG) is ok

21:43:12.16 Relation 166 (V_STOPTEST)
21:43:12.16 Relation 166 (V_STOPTEST) is ok

21:43:12.16 Relation 183 (V_QDISTR_SOURCE)
21:43:12.16 Relation 183 (V_QDISTR_SOURCE) is ok

21:43:12.16 Relation 184 (V_QSTORNED_SOURCE)
21:43:12.16 Relation 184 (V_QSTORNED_SOURCE) is ok

21:43:12.16 Relation 258 (XQD_1000_1200)
21:43:12.16 process pointer page 0 of 2
21:43:12.18 process pointer page 1 of 2
21:43:12.18 Index 1 (XQD_1000_1200_WARE_SOP_ROP_SND)
21:43:12.19 Relation 258 (XQD_1000_1200) is ok

21:43:12.19 Relation 259 (XQD_1200_2000)
21:43:12.19 process pointer page 0 of 2
21:43:12.45 process pointer page 1 of 2
21:43:13.22 Index 1 (XQD_1200_2000_WARE_SOP_ROP_SND)
21:43:13.30 Relation 259 (XQD_1200_2000) is ok

21:43:13.30 Relation 260 (XQD_1000_3300)
21:43:13.30 process pointer page 0 of 3
21:43:14.66 process pointer page 1 of 3
21:43:15.59 process pointer page 2 of 3
21:43:15.91 Index 1 (XQD_1000_3300_WARE_SOP_ROP_SND)
21:43:16.02 Index 2 (XQD_1000_3300_DOC)
21:43:16.12 Relation has 1 orphan backversions (84674 in use)
21:43:16.12 Relation 260 (XQD_1000_3300) : 1 ERRORS found

21:43:16.12 Relation 261 (XQD_2000_3300)
21:43:16.12 process pointer page 0 of 14
21:43:16.40 process pointer page 1 of 14
21:43:16.40 process pointer page 2 of 14
21:43:16.42 process pointer page 3 of 14
21:43:16.43 process pointer page 4 of 14
21:43:16.45 process pointer page 5 of 14
21:43:16.57 process pointer page 6 of 14
21:43:16.70 process pointer page 7 of 14
21:43:16.74 process pointer page 8 of 14
21:43:16.81 process pointer page 9 of 14
21:43:16.95 process pointer page 10 of 14
21:43:17.44 process pointer page 11 of 14
21:43:18.07 process pointer page 12 of 14
21:43:18.89 process pointer page 13 of 14
21:43:19.83 Index 1 (XQD_2000_3300_WARE_SOP_ROP_SND)
21:43:19.98 Relation 261 (XQD_2000_3300) is ok

21:43:19.98 Relation 262 (XQD_2100_3300)
21:43:19.98 process pointer page 0 of 3
21:43:20.13 process pointer page 1 of 3
21:43:20.27 process pointer page 2 of 3
21:43:20.27 Index 1 (XQD_2100_3300_WARE_SOP_ROP_SND)
21:43:20.31 Relation has 3 orphan backversions (135381 in use)
21:43:20.31 Relation 262 (XQD_2100_3300) : 1 ERRORS found

21:43:20.31 Relation 263 (XQD_3300_3400)
21:43:20.31 process pointer page 0 of 11
21:43:20.59 process pointer page 1 of 11
21:43:20.61 process pointer page 2 of 11
21:43:20.64 process pointer page 3 of 11
21:43:20.76 process pointer page 4 of 11
21:43:20.87 process pointer page 5 of 11
21:43:20.96 process pointer page 6 of 11
21:43:21.05 process pointer page 7 of 11
21:43:22.28 process pointer page 8 of 11
21:43:23.63 process pointer page 9 of 11
21:43:24.89 process pointer page 10 of 11
21:43:25.70 Index 1 (XQD_3300_3400_WARE_SOP_ROP_SND)
21:43:26.05 Relation 263 (XQD_3300_3400) is ok

21:43:26.05 Relation 264 (XQS_1000_1200)
21:43:26.05 process pointer page 0 of 11
21:43:26.20 process pointer page 1 of 11
21:43:26.34 process pointer page 2 of 11
21:43:26.48 process pointer page 3 of 11
21:43:26.64 process pointer page 4 of 11
21:43:26.78 process pointer page 5 of 11
21:43:27.02 process pointer page 6 of 11
21:43:27.11 process pointer page 7 of 11
21:43:27.21 process pointer page 8 of 11
21:43:27.92 process pointer page 9 of 11
21:43:29.41 process pointer page 10 of 11
21:43:30.47 Index 1 (XQS_1000_1200_DOC_ID)
21:43:30.89 Index 2 (XQS_1000_1200_SND_ID)
21:43:31.31 Index 3 (XQS_1000_1200_RCV_ID)
21:43:31.64 Relation 264 (XQS_1000_1200) is ok

21:43:31.64 Relation 265 (XQS_1200_2000)
21:43:31.64 process pointer page 0 of 16
21:43:31.74 process pointer page 1 of 16
21:43:31.84 process pointer page 2 of 16
21:43:31.96 process pointer page 3 of 16
21:43:32.06 process pointer page 4 of 16
21:43:32.16 process pointer page 5 of 16
21:43:32.37 process pointer page 6 of 16
21:43:32.48 process pointer page 7 of 16
21:43:32.70 process pointer page 8 of 16
21:43:33.09 process pointer page 9 of 16
21:43:33.30 process pointer page 10 of 16
21:43:33.59 process pointer page 11 of 16
21:43:34.29 process pointer page 12 of 16
21:43:34.80 process pointer page 13 of 16
21:43:35.55 process pointer page 14 of 16
21:43:35.94 process pointer page 15 of 16
21:43:36.18 Index 1 (XQS_1200_2000_DOC_ID)
21:43:36.45 Index 2 (XQS_1200_2000_SND_ID)
21:43:36.63 Index 3 (XQS_1200_2000_RCV_ID)
21:43:36.74 Relation 265 (XQS_1200_2000) is ok

21:43:36.74 Relation 266 (XQS_1000_3300)
21:43:36.74 process pointer page 0 of 10
21:43:36.86 process pointer page 1 of 10
21:43:36.89 process pointer page 2 of 10
21:43:36.90 process pointer page 3 of 10
21:43:36.93 process pointer page 4 of 10
21:43:36.96 process pointer page 5 of 10
21:43:37.00 process pointer page 6 of 10
21:43:37.31 process pointer page 7 of 10
21:43:38.31 process pointer page 8 of 10
21:43:39.24 process pointer page 9 of 10
21:43:40.13 Index 1 (XQS_1000_3300_DOC_ID)
21:43:40.22 Index 2 (XQS_1000_3300_SND_ID)
21:43:40.41 Index 3 (XQS_1000_3300_RCV_ID)
21:43:40.67 Relation 266 (XQS_1000_3300) is ok

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

21:43:40.67 Relation 268 (XQS_2100_3300)
21:43:40.67 process pointer page 0 of 12
21:43:41.15 process pointer page 1 of 12
21:43:41.28 process pointer page 2 of 12
21:43:41.38 process pointer page 3 of 12
21:43:41.49 process pointer page 4 of 12
21:43:41.60 process pointer page 5 of 12
21:43:41.71 process pointer page 6 of 12
21:43:41.83 process pointer page 7 of 12
21:43:42.02 process pointer page 8 of 12
21:43:42.81 process pointer page 9 of 12
21:43:44.18 process pointer page 10 of 12
21:43:44.96 process pointer page 11 of 12
21:43:45.67 Index 1 (XQS_2100_3300_DOC_ID)
21:43:45.67 Index 1 misses node on page 1166 level 1
21:43:45.98 Index 2 (XQS_2100_3300_SND_ID)
21:43:46.01 Index 2 has inconsistent left sibling pointer, page 215596 level 1
21:43:46.35 Index 3 (XQS_2100_3300_RCV_ID)
21:43:46.50 Relation 268 (XQS_2100_3300) : 2 ERRORS found

21:43:46.50 Relation 269 (XQS_3300_3400)
21:43:46.50 process pointer page 0 of 3
21:43:46.55 process pointer page 1 of 3
21:43:46.63 process pointer page 2 of 3
21:43:46.82 Index 1 (XQS_3300_3400_DOC_ID)
21:43:46.84 Index 2 (XQS_3300_3400_SND_ID)
21:43:46.86 Relation 269 (XQS_3300_3400) is ok

21:43:46.86 Relation 276 (TRACE_STAT)
21:43:46.86 process pointer page 0 of 1
21:43:46.87 Relation 276 (TRACE_STAT) is ok

21:43:46.87 Validation finished
Done for 68420 ms, from 21:42:38.45 to 21:43:46.87.

Differences between old and current firebird.log

21:43:47.64. Got:
STDOUT: ---------- E:\TEMP\LOGS.HQBIRD.OLTP25\OLTP25_FB_LOG_WHEN_TEST_FINISHED.LOG: 61341 (number of rows in extracted log)
Obtained firebird.log info:
Result of DIR command for firebird.log AFTER test finish:
2016-04-06 21:43 4455426 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
73575: WIN-2BE1UI8LGDL Wed Apr 06 21:43:16 2016
73576: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73577: Relation has 1 orphan backversions (84674 in use) in table XQD_1000_3300 (260)
73578:
73579:
73580: WIN-2BE1UI8LGDL Wed Apr 06 21:43:20 2016
73581: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73582: Relation has 3 orphan backversions (135381 in use) in table XQD_2100_3300 (262)
73583:
73584:
73585: WIN-2BE1UI8LGDL Wed Apr 06 21:43:45 2016
73586: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73587: Index 1 misses node on page 1166 level 1 in table XQS_2100_3300 (268)
73588:
73589:
73590: WIN-2BE1UI8LGDL Wed Apr 06 21:43:46 2016
73591: Database: D:\OLTP-HQBIRD\OLTP25-SMALL.FDB
73592: Index 2 has inconsistent left sibling pointer, page 215596 level 1 in table XQS_2100_3300 (268)
73593:
73594:
*****
+++ End of comparison +++

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

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

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

ERRORS_CHECKING_RESULT
NO_SEVERE_ERRORS_FOUND

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

Test configuration settings

Performance reports

Differences between old and current firebird.log

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

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