temp
[tatoo.git] / tests / alphabet.xml.summary
index a4af0dc..93c5e64 100644 (file)
@@ -1,11 +1,11 @@
 Query: A1 : //L/*
-STATS: parsing xml document: 0.273943ms
-STATS: parsing XPath query: 0.031948ms
-STATS: compiling XPath query: 0.142813ms
+STATS: parsing xml document: 0.548840ms
+STATS: parsing XPath query: 0.056982ms
+STATS: compiling XPath query: 0.301838ms
 STATS: Query: /descendant-or-self::node()/child::L/child::* 
 STATS: Automaton: 
-STATS: evaluating query: 1.357079ms
-STATS: serializing results: 1.687050ms
+STATS: evaluating query: 143.815994ms
+STATS: serializing results: 0.126839ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -13,13 +13,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: A2 : //L/parent::*
-STATS: parsing xml document: 0.386000ms
-STATS: parsing XPath query: 0.052929ms
-STATS: compiling XPath query: 0.163078ms
+STATS: parsing xml document: 0.554085ms
+STATS: parsing XPath query: 0.067949ms
+STATS: compiling XPath query: 0.243902ms
 STATS: Query: /descendant-or-self::node()/child::L/parent::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.043962ms
-STATS: serializing results: 1.892090ms
+STATS: evaluating query: 138.197899ms
+STATS: serializing results: 0.321150ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1310 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -27,13 +27,13 @@ STATS: cache4: length: 1464, used: 154, occupation: 0.105191
 Diff: ok
 -------------------------------------------
 Query: A3 : //L/descendant::*
-STATS: parsing xml document: 0.469923ms
-STATS: parsing XPath query: 0.049114ms
-STATS: compiling XPath query: 0.212193ms
+STATS: parsing xml document: 0.555992ms
+STATS: parsing XPath query: 0.060081ms
+STATS: compiling XPath query: 0.320196ms
 STATS: Query: /descendant-or-self::node()/child::L/descendant::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.212048ms
-STATS: serializing results: 1.559973ms
+STATS: evaluating query: 139.024973ms
+STATS: serializing results: 0.113010ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -41,13 +41,13 @@ STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 Diff: ok
 -------------------------------------------
 Query: A4 : //L/descendant-or-self::*
-STATS: parsing xml document: 0.365973ms
-STATS: parsing XPath query: 0.047922ms
-STATS: compiling XPath query: 0.175953ms
+STATS: parsing xml document: 0.549078ms
+STATS: parsing XPath query: 0.061989ms
+STATS: compiling XPath query: 0.271082ms
 STATS: Query: /descendant-or-self::node()/child::L/descendant-or-self::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.229929ms
-STATS: serializing results: 1.845121ms
+STATS: evaluating query: 135.263920ms
+STATS: serializing results: 0.138998ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -55,13 +55,13 @@ STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 Diff: ok
 -------------------------------------------
 Query: A5 : //L/ancestor::*
-STATS: parsing xml document: 0.375032ms
-STATS: parsing XPath query: 0.045061ms
-STATS: compiling XPath query: 0.174046ms
+STATS: parsing xml document: 0.556946ms
+STATS: parsing XPath query: 0.063181ms
+STATS: compiling XPath query: 0.370979ms
 STATS: Query: /descendant-or-self::node()/child::L/ancestor::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.063036ms
-STATS: serializing results: 2.068996ms
+STATS: evaluating query: 136.641979ms
+STATS: serializing results: 0.174046ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1320 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -69,13 +69,13 @@ STATS: cache4: length: 1476, used: 156, occupation: 0.105691
 Diff: ok
 -------------------------------------------
 Query: A6 : //L/ancestor-or-self::*
-STATS: parsing xml document: 0.373840ms
-STATS: parsing XPath query: 0.046015ms
-STATS: compiling XPath query: 0.215054ms
+STATS: parsing xml document: 0.530958ms
+STATS: parsing XPath query: 0.047922ms
+STATS: compiling XPath query: 0.225067ms
 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.351999ms
-STATS: serializing results: 2.168894ms
+STATS: evaluating query: 142.638922ms
+STATS: serializing results: 0.296831ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1242 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -83,13 +83,13 @@ STATS: cache4: length: 1397, used: 155, occupation: 0.110952
 Diff: ok
 -------------------------------------------
 Query: A7 : //L/following-sibling::*
-STATS: parsing xml document: 0.376940ms
-STATS: parsing XPath query: 0.045061ms
-STATS: compiling XPath query: 0.172138ms
+STATS: parsing xml document: 0.547886ms
+STATS: parsing XPath query: 0.061989ms
+STATS: compiling XPath query: 0.241995ms
 STATS: Query: /descendant-or-self::node()/child::L/following-sibling::* 
 STATS: Automaton: 
-STATS: evaluating query: 1.918077ms
-STATS: serializing results: 1.551867ms
+STATS: evaluating query: 128.535032ms
+STATS: serializing results: 0.105858ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1051 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -97,13 +97,13 @@ STATS: cache4: length: 1173, used: 122, occupation: 0.104007
 Diff: ok
 -------------------------------------------
 Query: A8 : //L/preceding-sibling::*
-STATS: parsing xml document: 0.365973ms
-STATS: parsing XPath query: 0.070810ms
-STATS: compiling XPath query: 0.162125ms
+STATS: parsing xml document: 0.547886ms
+STATS: parsing XPath query: 0.072956ms
+STATS: compiling XPath query: 0.293016ms
 STATS: Query: /descendant-or-self::node()/child::L/preceding-sibling::* 
 STATS: Automaton: 
-STATS: evaluating query: 1.935959ms
-STATS: serializing results: 1.722097ms
+STATS: evaluating query: 135.153055ms
+STATS: serializing results: 0.109911ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1174 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -111,13 +111,13 @@ STATS: cache4: length: 1314, used: 140, occupation: 0.106545
 Diff: ok
 -------------------------------------------
 Query: A9 : //L/following::*
-STATS: parsing xml document: 0.371933ms
-STATS: parsing XPath query: 0.046968ms
-STATS: compiling XPath query: 0.277042ms
+STATS: parsing xml document: 0.552177ms
+STATS: parsing XPath query: 0.063896ms
+STATS: compiling XPath query: 0.425100ms
 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::* 
 STATS: Automaton: 
-STATS: evaluating query: 6.926060ms
-STATS: serializing results: 1.893997ms
+STATS: evaluating query: 163.617134ms
+STATS: serializing results: 0.147104ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 2104 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -125,27 +125,27 @@ STATS: cache4: length: 2334, used: 230, occupation: 0.098543
 Diff: ok
 -------------------------------------------
 Query: A10 : //L/preceding::*
-STATS: parsing xml document: 0.372887ms
-STATS: parsing XPath query: 0.053883ms
-STATS: compiling XPath query: 0.284910ms
+STATS: parsing xml document: 0.637054ms
+STATS: parsing XPath query: 0.074148ms
+STATS: compiling XPath query: 0.427008ms
 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::* 
 STATS: Automaton: 
-STATS: evaluating query: 7.807970ms
-STATS: serializing results: 1.873016ms
+STATS: evaluating query: 201.319218ms
+STATS: serializing results: 0.159025ms
 STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 942 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 941 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1077, used: 135, occupation: 0.125348
+STATS: cache4: length: 1074, used: 133, occupation: 0.123836
 Diff: ok
 -------------------------------------------
 Query: A11 : //L/self::*
-STATS: parsing xml document: 0.367165ms
-STATS: parsing XPath query: 0.047207ms
-STATS: compiling XPath query: 0.145912ms
+STATS: parsing xml document: 0.553846ms
+STATS: parsing XPath query: 0.060081ms
+STATS: compiling XPath query: 0.231981ms
 STATS: Query: /descendant-or-self::node()/child::L/self::* 
 STATS: Automaton: 
-STATS: evaluating query: 1.688957ms
-STATS: serializing results: 1.632929ms
+STATS: evaluating query: 131.052017ms
+STATS: serializing results: 0.113964ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 837 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -153,13 +153,13 @@ STATS: cache4: length: 946, used: 109, occupation: 0.115222
 Diff: ok
 -------------------------------------------
 Query: A12 : //L/@id/parent::*
-STATS: parsing xml document: 0.365019ms
-STATS: parsing XPath query: 0.062943ms
-STATS: compiling XPath query: 0.230074ms
+STATS: parsing xml document: 0.632048ms
+STATS: parsing XPath query: 0.077009ms
+STATS: compiling XPath query: 0.351191ms
 STATS: Query: /descendant-or-self::node()/child::L/attribute::@id/parent::* 
 STATS: Automaton: 
-STATS: evaluating query: 2.954006ms
-STATS: serializing results: 1.592875ms
+STATS: evaluating query: 144.134045ms
+STATS: serializing results: 0.113964ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1594 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -167,13 +167,13 @@ STATS: cache4: length: 1750, used: 156, occupation: 0.089143
 Diff: ok
 -------------------------------------------
 Query: P1 : //*[L]
-STATS: parsing xml document: 0.375032ms
-STATS: parsing XPath query: 0.041962ms
-STATS: compiling XPath query: 0.159979ms
+STATS: parsing xml document: 0.560999ms
+STATS: parsing XPath query: 0.059128ms
+STATS: compiling XPath query: 0.232935ms
 STATS: Query: /descendant-or-self::node()/child::*[ child::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.675844ms
-STATS: serializing results: 1.981974ms
+STATS: evaluating query: 139.696121ms
+STATS: serializing results: 0.160933ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1326 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -181,13 +181,13 @@ STATS: cache4: length: 1480, used: 154, occupation: 0.104054
 Diff: ok
 -------------------------------------------
 Query: P2 : //*[parent::L]
-STATS: parsing xml document: 0.432968ms
-STATS: parsing XPath query: 0.052929ms
-STATS: compiling XPath query: 0.165939ms
+STATS: parsing xml document: 0.554085ms
+STATS: parsing XPath query: 0.067949ms
+STATS: compiling XPath query: 0.285864ms
 STATS: Query: /descendant-or-self::node()/child::*[ parent::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.738071ms
-STATS: serializing results: 1.655102ms
+STATS: evaluating query: 141.451120ms
+STATS: serializing results: 0.101805ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -195,13 +195,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: P3 : //*[descendant::L]
-STATS: parsing xml document: 0.375032ms
-STATS: parsing XPath query: 0.046968ms
-STATS: compiling XPath query: 0.176907ms
+STATS: parsing xml document: 0.563145ms
+STATS: parsing XPath query: 0.065088ms
+STATS: compiling XPath query: 0.247955ms
 STATS: Query: /descendant-or-self::node()/child::*[ descendant::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 2.294064ms
-STATS: serializing results: 2.086878ms
+STATS: evaluating query: 133.634090ms
+STATS: serializing results: 0.274181ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1336 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -209,13 +209,13 @@ STATS: cache4: length: 1492, used: 156, occupation: 0.104558
 Diff: ok
 -------------------------------------------
 Query: P4 : //*[descendant-or-self::L]
-STATS: parsing xml document: 0.414133ms
-STATS: parsing XPath query: 0.047922ms
-STATS: compiling XPath query: 0.169992ms
+STATS: parsing xml document: 0.655890ms
+STATS: parsing XPath query: 0.062943ms
+STATS: compiling XPath query: 0.263929ms
 STATS: Query: /descendant-or-self::node()/child::*[ descendant-or-self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 2.105951ms
-STATS: serializing results: 2.239943ms
+STATS: evaluating query: 146.183014ms
+STATS: serializing results: 0.303984ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1242 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -223,13 +223,13 @@ STATS: cache4: length: 1397, used: 155, occupation: 0.110952
 Diff: ok
 -------------------------------------------
 Query: P5 : //*[ancestor::L]
-STATS: parsing xml document: 0.371933ms
-STATS: parsing XPath query: 0.048876ms
-STATS: compiling XPath query: 0.190020ms
+STATS: parsing xml document: 0.551939ms
+STATS: parsing XPath query: 0.062943ms
+STATS: compiling XPath query: 0.285864ms
 STATS: Query: /descendant-or-self::node()/child::*[ ancestor::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 2.069950ms
-STATS: serializing results: 1.581192ms
+STATS: evaluating query: 146.598816ms
+STATS: serializing results: 0.114918ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -237,13 +237,13 @@ STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 Diff: ok
 -------------------------------------------
 Query: P6 : //*[ancestor-or-self::L]
-STATS: parsing xml document: 0.371933ms
-STATS: parsing XPath query: 0.046968ms
-STATS: compiling XPath query: 0.189066ms
+STATS: parsing xml document: 0.544071ms
+STATS: parsing XPath query: 0.064135ms
+STATS: compiling XPath query: 0.274897ms
 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.805067ms
-STATS: serializing results: 1.686096ms
+STATS: evaluating query: 138.018131ms
+STATS: serializing results: 0.143051ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -251,13 +251,13 @@ STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 Diff: ok
 -------------------------------------------
 Query: P7 : //*[following-sibling::L]
-STATS: parsing xml document: 0.369072ms
-STATS: parsing XPath query: 0.047922ms
-STATS: compiling XPath query: 0.158787ms
+STATS: parsing xml document: 0.545979ms
+STATS: parsing XPath query: 0.064135ms
+STATS: compiling XPath query: 0.231028ms
 STATS: Query: /descendant-or-self::node()/child::*[ following-sibling::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.772881ms
-STATS: serializing results: 1.531124ms
+STATS: evaluating query: 134.088993ms
+STATS: serializing results: 0.110149ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1174 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -265,13 +265,13 @@ STATS: cache4: length: 1314, used: 140, occupation: 0.106545
 Diff: ok
 -------------------------------------------
 Query: P8 : //*[preceding-sibling::L]
-STATS: parsing xml document: 0.367165ms
-STATS: parsing XPath query: 0.058889ms
-STATS: compiling XPath query: 0.153065ms
+STATS: parsing xml document: 0.558138ms
+STATS: parsing XPath query: 0.073910ms
+STATS: compiling XPath query: 0.233173ms
 STATS: Query: /descendant-or-self::node()/child::*[ preceding-sibling::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.419067ms
-STATS: serializing results: 1.618147ms
+STATS: evaluating query: 137.306929ms
+STATS: serializing results: 0.104904ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1051 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -279,27 +279,27 @@ STATS: cache4: length: 1173, used: 122, occupation: 0.104007
 Diff: ok
 -------------------------------------------
 Query: P9 : //*[following::L]
-STATS: parsing xml document: 0.360012ms
-STATS: parsing XPath query: 0.047922ms
-STATS: compiling XPath query: 0.232935ms
+STATS: parsing xml document: 0.558138ms
+STATS: parsing XPath query: 0.063896ms
+STATS: compiling XPath query: 0.343800ms
 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::node()/following-sibling::node()/descendant-or-self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 6.263018ms
-STATS: serializing results: 1.722097ms
+STATS: evaluating query: 186.290979ms
+STATS: serializing results: 0.090122ms
 STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 780 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 779 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 915, used: 135, occupation: 0.147541
+STATS: cache4: length: 912, used: 133, occupation: 0.145833
 Diff: ok
 -------------------------------------------
 Query: P10 : //*[preceding::L]
-STATS: parsing xml document: 0.365973ms
-STATS: parsing XPath query: 0.061989ms
-STATS: compiling XPath query: 0.229120ms
+STATS: parsing xml document: 0.553846ms
+STATS: parsing XPath query: 0.076056ms
+STATS: compiling XPath query: 0.351191ms
 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 3.866911ms
-STATS: serializing results: 1.757860ms
+STATS: evaluating query: 151.458025ms
+STATS: serializing results: 0.101089ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1767 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -307,13 +307,13 @@ STATS: cache4: length: 1980, used: 213, occupation: 0.107576
 Diff: ok
 -------------------------------------------
 Query: P11 : //*[self::L]
-STATS: parsing xml document: 0.379086ms
-STATS: parsing XPath query: 0.041962ms
-STATS: compiling XPath query: 0.138044ms
+STATS: parsing xml document: 0.576019ms
+STATS: parsing XPath query: 0.061989ms
+STATS: compiling XPath query: 0.214815ms
 STATS: Query: /descendant-or-self::node()/child::*[ self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.396179ms
-STATS: serializing results: 1.624823ms
+STATS: evaluating query: 131.872892ms
+STATS: serializing results: 0.112057ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 837 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -321,13 +321,13 @@ STATS: cache4: length: 946, used: 109, occupation: 0.115222
 Diff: ok
 -------------------------------------------
 Query: P12 : //*[@id]
-STATS: parsing xml document: 0.368834ms
-STATS: parsing XPath query: 0.042915ms
-STATS: compiling XPath query: 0.159025ms
+STATS: parsing xml document: 0.578880ms
+STATS: parsing XPath query: 0.060081ms
+STATS: compiling XPath query: 0.235081ms
 STATS: Query: /descendant-or-self::node()/child::*[ attribute::@id ] 
 STATS: Automaton: 
-STATS: evaluating query: 1.451969ms
-STATS: serializing results: 2.529860ms
+STATS: evaluating query: 136.634827ms
+STATS: serializing results: 0.459909ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 907 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -335,13 +335,13 @@ STATS: cache4: length: 1022, used: 115, occupation: 0.112524
 Diff: ok
 -------------------------------------------
 Query: T1 : //L/text()
-STATS: parsing xml document: 0.361919ms
-STATS: parsing XPath query: 0.056028ms
-STATS: compiling XPath query: 0.310183ms
+STATS: parsing xml document: 0.551939ms
+STATS: parsing XPath query: 0.077963ms
+STATS: compiling XPath query: 0.298023ms
 STATS: Query: /descendant-or-self::node()/child::L/child::text() 
 STATS: Automaton: 
-STATS: evaluating query: 2.119064ms
-STATS: serializing results: 1.483917ms
+STATS: evaluating query: 136.301994ms
+STATS: serializing results: 0.074863ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -349,13 +349,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: T2 : //L/comment()
-STATS: parsing xml document: 0.418901ms
-STATS: parsing XPath query: 0.066042ms
-STATS: compiling XPath query: 0.249863ms
+STATS: parsing xml document: 0.564098ms
+STATS: parsing XPath query: 0.091076ms
+STATS: compiling XPath query: 0.303030ms
 STATS: Query: /descendant-or-self::node()/child::L/child::comment() 
 STATS: Automaton: 
-STATS: evaluating query: 2.057076ms
-STATS: serializing results: 1.518011ms
+STATS: evaluating query: 133.058071ms
+STATS: serializing results: 0.067949ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -363,13 +363,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: T3 : //L/processing-instruction()
-STATS: parsing xml document: 0.372887ms
-STATS: parsing XPath query: 0.066996ms
-STATS: compiling XPath query: 0.199080ms
+STATS: parsing xml document: 0.547171ms
+STATS: parsing XPath query: 0.099182ms
+STATS: compiling XPath query: 0.407934ms
 STATS: Query: /descendant-or-self::node()/child::L/child::processing-instruction() 
 STATS: Automaton: 
-STATS: evaluating query: 2.147913ms
-STATS: serializing results: 1.501799ms
+STATS: evaluating query: 137.789965ms
+STATS: serializing results: 0.077963ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -377,13 +377,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: T4 : //L/processing-instruction("myPI")
-STATS: parsing xml document: 0.376940ms
-STATS: parsing XPath query: 0.077963ms
-STATS: compiling XPath query: 0.203133ms
+STATS: parsing xml document: 0.540972ms
+STATS: parsing XPath query: 0.108004ms
+STATS: compiling XPath query: 0.409126ms
 STATS: Query: /descendant-or-self::node()/child::L/child::processing-instruction('?myPI') 
 STATS: Automaton: 
-STATS: evaluating query: 2.029896ms
-STATS: serializing results: 1.441956ms
+STATS: evaluating query: 132.414818ms
+STATS: serializing results: 0.075817ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -391,13 +391,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: T5 : //L/node()
-STATS: parsing xml document: 0.370026ms
-STATS: parsing XPath query: 0.055790ms
-STATS: compiling XPath query: 0.197887ms
+STATS: parsing xml document: 0.549078ms
+STATS: parsing XPath query: 0.076056ms
+STATS: compiling XPath query: 0.291109ms
 STATS: Query: /descendant-or-self::node()/child::L/child::node() 
 STATS: Automaton: 
-STATS: evaluating query: 1.987934ms
-STATS: serializing results: 1.667023ms
+STATS: evaluating query: 139.785051ms
+STATS: serializing results: 0.116825ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -405,13 +405,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: T6 : //L/N
-STATS: parsing xml document: 0.372887ms
-STATS: parsing XPath query: 0.044823ms
-STATS: compiling XPath query: 0.205994ms
+STATS: parsing xml document: 0.553846ms
+STATS: parsing XPath query: 0.061035ms
+STATS: compiling XPath query: 0.307083ms
 STATS: Query: /descendant-or-self::node()/child::L/child::N 
 STATS: Automaton: 
-STATS: evaluating query: 2.081871ms
-STATS: serializing results: 1.513004ms
+STATS: evaluating query: 135.293007ms
+STATS: serializing results: 0.109911ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 819 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -419,13 +419,13 @@ STATS: cache4: length: 952, used: 133, occupation: 0.139706
 Diff: ok
 -------------------------------------------
 Query: T7 : //L/*
-STATS: parsing xml document: 0.377893ms
-STATS: parsing XPath query: 0.046015ms
-STATS: compiling XPath query: 0.201941ms
+STATS: parsing xml document: 0.647068ms
+STATS: parsing XPath query: 0.056028ms
+STATS: compiling XPath query: 0.302076ms
 STATS: Query: /descendant-or-self::node()/child::L/child::* 
 STATS: Automaton: 
-STATS: evaluating query: 1.969099ms
-STATS: serializing results: 1.557112ms
+STATS: evaluating query: 136.944771ms
+STATS: serializing results: 0.104904ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -433,13 +433,13 @@ STATS: cache4: length: 933, used: 124, occupation: 0.132905
 Diff: ok
 -------------------------------------------
 Query: O1 : //*[child::* and preceding::Q]
-STATS: parsing xml document: 0.375986ms
-STATS: parsing XPath query: 0.054121ms
-STATS: compiling XPath query: 0.251055ms
+STATS: parsing xml document: 0.321865ms
+STATS: parsing XPath query: 0.101089ms
+STATS: compiling XPath query: 0.393867ms
 STATS: Query: /descendant-or-self::node()/child::*[ child::* and ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::Q ] 
 STATS: Automaton: 
-STATS: evaluating query: 5.450010ms
-STATS: serializing results: 1.646042ms
+STATS: evaluating query: 154.838085ms
+STATS: serializing results: 0.120878ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1873 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -447,13 +447,13 @@ STATS: cache4: length: 2090, used: 217, occupation: 0.103828
 Diff: ok
 -------------------------------------------
 Query: O2 : //*[not(child::*) and preceding::Q]
-STATS: parsing xml document: 0.358105ms
-STATS: parsing XPath query: 0.061035ms
-STATS: compiling XPath query: 0.333786ms
+STATS: parsing xml document: 0.550032ms
+STATS: parsing XPath query: 0.091076ms
+STATS: compiling XPath query: 0.397921ms
 STATS: Query: /descendant-or-self::node()/child::*[ not(child::*) and ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::Q ] 
 STATS: Automaton: 
-STATS: evaluating query: 5.686045ms
-STATS: serializing results: 1.607180ms
+STATS: evaluating query: 160.339832ms
+STATS: serializing results: 0.063896ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 1873 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333
@@ -461,27 +461,27 @@ STATS: cache4: length: 2090, used: 217, occupation: 0.103828
 Diff: ok
 -------------------------------------------
 Query: O3 : //*[preceding::L or following::L]
-STATS: parsing xml document: 0.378132ms
-STATS: parsing XPath query: 0.060797ms
-STATS: compiling XPath query: 0.334024ms
+STATS: parsing xml document: 0.547886ms
+STATS: parsing XPath query: 0.087023ms
+STATS: compiling XPath query: 0.487089ms
 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::L or ancestor-or-self::node()/following-sibling::node()/descendant-or-self::L ] 
 STATS: Automaton: 
-STATS: evaluating query: 10.611057ms
-STATS: serializing results: 1.986027ms
+STATS: evaluating query: 224.081993ms
+STATS: serializing results: 0.215054ms
 STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 610 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 582 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 778, used: 168, occupation: 0.215938
+STATS: cache4: length: 747, used: 165, occupation: 0.220884
 Diff: ok
 -------------------------------------------
 Query: O4 : //L/ancestor::* | //L/descendant::*
-STATS: parsing xml document: 0.406981ms
-STATS: parsing XPath query: 0.067949ms
-STATS: compiling XPath query: 0.372887ms
+STATS: parsing xml document: 0.553131ms
+STATS: parsing XPath query: 0.068903ms
+STATS: compiling XPath query: 0.566006ms
 STATS: Query: /descendant-or-self::node()/child::L/ancestor::* | /descendant-or-self::node()/child::L/descendant::* 
 STATS: Automaton: 
-STATS: evaluating query: 7.152081ms
-STATS: serializing results: 2.159119ms
+STATS: evaluating query: 178.429842ms
+STATS: serializing results: 0.290155ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 70 entries, cache6: 2345 entries
 STATS: cache2: length: 105, used: 35, occupation: 0.333333