2006-06-27 21:13:59,534 [http-8080-Processor22] DEBUG (Profiler.java [start]:165) - QUERY START 
2006-06-27 21:13:59,536 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - START		doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"])/descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,538 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - DEPENDENCIES	[CONTEXT_SET]		doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"])/descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,539 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 	START	[1,7]	doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"]) 
2006-06-27 21:13:59,541 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 	DEPENDENCIES	[CONTEXT_SET]	[1,7]	doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"]) 
2006-06-27 21:13:59,543 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 		START		dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"] 
2006-06-27 21:13:59,544 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 		DEPENDENCIES	NO_DEPENDENCY		dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"] 
2006-06-27 21:13:59,546 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 			START	[5,7]	"/db/home/tfi/TransFrance.Info/Localité.xml" 
2006-06-27 21:13:59,548 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 			DEPENDENCIES	NO_DEPENDENCY	[5,7]	"/db/home/tfi/TransFrance.Info/Localité.xml" 
2006-06-27 21:13:59,549 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 			RESULT	1 item(s)	[5,7]	"/db/home/tfi/TransFrance.Info/Localité.xml" 
2006-06-27 21:13:59,551 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 			TIME	3 ms	[5,7]	"/db/home/tfi/TransFrance.Info/Localité.xml" 
2006-06-27 21:13:59,552 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 			END	[5,7]	"/db/home/tfi/TransFrance.Info/Localité.xml" 
2006-06-27 21:13:59,554 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 		RESULT	1 item(s)		dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"] 
2006-06-27 21:13:59,556 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 		TIME	11 ms		dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"] 
2006-06-27 21:13:59,557 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 		END		dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"] 
2006-06-27 21:13:59,572 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 	RESULT	1 item(s)	[1,7]	doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"]) 
2006-06-27 21:13:59,574 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 	TIME	33 ms	[1,7]	doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"]) 
2006-06-27 21:13:59,575 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 	END	[1,7]	doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"]) 
2006-06-27 21:13:59,576 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 	START		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,578 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 	DEPENDENCIES	[CONTEXT_SET]		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,580 [http-8080-Processor22] DEBUG (Profiler.java [message]:301) - 	CONTEXT SEQUENCE	1 item(s)	descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,582 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 	OPTIMIZATION	using index 'org.exist.storage.NativeElementIndex at elements.dbx owned by org.exist.storage.NativeBroker_exist_2'		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,636 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 		START		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,638 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 		DEPENDENCIES	[CONTEXT_SET]		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,661 [http-8080-Processor22] DEBUG (Profiler.java [message]:301) - 		CONTEXT SEQUENCE	36570 item(s)	attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,663 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 		OPTIMIZATION CHOICE	Node selection		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,665 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 			START		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,667 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 			DEPENDENCIES	[CONTEXT_SET]		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,669 [http-8080-Processor22] DEBUG (Profiler.java [message]:301) - 			CONTEXT SEQUENCE	36570 item(s)	attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,671 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 				START		attribute::id 
2006-06-27 21:13:59,672 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 				DEPENDENCIES	[CONTEXT_SET]		attribute::id 
2006-06-27 21:13:59,674 [http-8080-Processor22] DEBUG (Profiler.java [message]:301) - 				CONTEXT SEQUENCE	36570 item(s)	attribute::id 
2006-06-27 21:13:59,676 [http-8080-Processor22] DEBUG (Profiler.java [start]:178) - 					START		attribute::id 
2006-06-27 21:13:59,679 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 					DEPENDENCIES	[CONTEXT_SET]		attribute::id 
2006-06-27 21:13:59,680 [http-8080-Processor22] DEBUG (Profiler.java [message]:301) - 					CONTEXT SEQUENCE	36570 item(s)	attribute::id 
2006-06-27 21:13:59,682 [http-8080-Processor22] DEBUG (Profiler.java [message]:324) - 					OPTIMIZATION	using index 'org.exist.storage.NativeElementIndex at elements.dbx owned by org.exist.storage.NativeBroker_exist_2'		attribute::id 
2006-06-27 21:13:59,818 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 					RESULT	36570 item(s)		attribute::id 
2006-06-27 21:13:59,819 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 					TIME	118 ms		attribute::id 
2006-06-27 21:13:59,821 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 					END		attribute::id 
2006-06-27 21:13:59,823 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 				RESULT	36570 item(s)		attribute::id 
2006-06-27 21:13:59,824 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 				TIME	152 ms		attribute::id 
2006-06-27 21:13:59,827 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 				END		attribute::id 
2006-06-27 21:13:59,829 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 			RESULT	1 item(s)		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,831 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 			TIME	164 ms		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,832 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 			END		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,834 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 		RESULT	1 item(s)		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,835 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 		TIME	198 ms		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,837 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 		END		attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f" 
2006-06-27 21:13:59,839 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - 	RESULT	1 item(s)		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,840 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - 	TIME	263 ms		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,843 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - 	END		descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,844 [http-8080-Processor22] DEBUG (Profiler.java [end]:241) - RESULT	1 item(s)		doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"])/descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,847 [http-8080-Processor22] DEBUG (Profiler.java [end]:253) - TIME	309 ms		doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"])/descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,849 [http-8080-Processor22] DEBUG (Profiler.java [end]:262) - END		doc(dynamic-cardinality-check[zero or one, "/db/home/tfi/TransFrance.Info/Localité.xml"])/descendant-or-self::Localité[attribute::id &= "id:a51f2fa2-df97-4a21-ba50-9ba0dc9b318f"] 
2006-06-27 21:13:59,869 [http-8080-Processor22] DEBUG (Profiler.java [end]:265) - QUERY END