Query: A1 : /site/closed_auctions/closed_auction/annotation/description/text/keyword
-STATS: parsing xml document: 195.340157ms
-STATS: parsing XPath query: 0.084162ms
-STATS: compiling XPath query: 0.221014ms
+STATS: parsing xml document: 634.769201ms
+STATS: parsing XPath query: 0.095844ms
+STATS: compiling XPath query: 0.281096ms
STATS: Query: /child::site/child::closed_auctions/child::closed_auction/child::annotation/child::description/child::text/child::keyword
STATS: Automaton:
-STATS: evaluating query: 122.359991ms
-STATS: serializing results: 3.302097ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 119.843006ms
+STATS: serializing results: 3.608942ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 3149 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: A2 : //closed_auction//keyword
-STATS: parsing xml document: 190.065861ms
-STATS: parsing XPath query: 0.062227ms
-STATS: compiling XPath query: 0.133991ms
+STATS: parsing xml document: 191.257000ms
+STATS: parsing XPath query: 0.056028ms
+STATS: compiling XPath query: 0.144005ms
STATS: Query: /descendant-or-self::node()/child::closed_auction/descendant-or-self::node()/child::keyword
STATS: Automaton:
-STATS: evaluating query: 136.409998ms
-STATS: serializing results: 6.726027ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 130.471945ms
+STATS: serializing results: 6.496906ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 2681 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: A3 : /site/closed_auctions/closed_auction//keyword
-STATS: parsing xml document: 194.837809ms
-STATS: parsing XPath query: 0.064850ms
-STATS: compiling XPath query: 0.159979ms
+STATS: parsing xml document: 189.831018ms
+STATS: parsing XPath query: 0.063896ms
+STATS: compiling XPath query: 0.157118ms
STATS: Query: /child::site/child::closed_auctions/child::closed_auction/descendant-or-self::node()/child::keyword
STATS: Automaton:
-STATS: evaluating query: 126.852036ms
-STATS: serializing results: 6.720066ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 139.882088ms
+STATS: serializing results: 6.744862ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 3277 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: A4 : /site/closed_auctions/closed_auction[annotation/description/text/keyword]/date
-STATS: parsing xml document: 194.200039ms
-STATS: parsing XPath query: 0.106812ms
-STATS: compiling XPath query: 0.149012ms
+STATS: parsing xml document: 189.064026ms
+STATS: parsing XPath query: 0.106096ms
+STATS: compiling XPath query: 0.199080ms
STATS: Query: /child::site/child::closed_auctions/child::closed_auction[ child::annotation/child::description/child::text/child::keyword ]/child::date
STATS: Automaton:
-STATS: evaluating query: 181.638002ms
-STATS: serializing results: 2.104998ms
+STATS: 245034 nodes over 254301 were skipped in iteration 0 (96.36 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 135.497093ms
+STATS: serializing results: 2.182007ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1324 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 282 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1501, used: 177, occupation: 0.117921
+STATS: cache4: length: 355, used: 73, occupation: 0.205634
Diff: ok
-------------------------------------------
Query: A5 : /site/closed_auctions/closed_auction[descendant::keyword]/date
-STATS: parsing xml document: 190.989017ms
-STATS: parsing XPath query: 0.068903ms
-STATS: compiling XPath query: 0.144958ms
+STATS: parsing xml document: 190.711021ms
+STATS: parsing XPath query: 0.084162ms
+STATS: compiling XPath query: 0.134945ms
STATS: Query: /child::site/child::closed_auctions/child::closed_auction[ descendant::keyword ]/child::date
STATS: Automaton:
-STATS: evaluating query: 182.102919ms
-STATS: serializing results: 2.466917ms
+STATS: 245034 nodes over 254301 were skipped in iteration 0 (96.36 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 138.205051ms
+STATS: serializing results: 2.486944ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1170 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 259 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1328, used: 158, occupation: 0.118976
+STATS: cache4: length: 342, used: 83, occupation: 0.242690
Diff: ok
-------------------------------------------
Query: A6 : /site/people/person[profile/gender and profile/age]/name
-STATS: parsing xml document: 187.790871ms
-STATS: parsing XPath query: 0.055075ms
-STATS: compiling XPath query: 0.154972ms
+STATS: parsing xml document: 185.791016ms
+STATS: parsing XPath query: 0.102043ms
+STATS: compiling XPath query: 0.155210ms
STATS: Query: /child::site/child::people/child::person[ child::profile/child::gender and child::profile/child::age ]/child::name
STATS: Automaton:
-STATS: evaluating query: 172.993898ms
-STATS: serializing results: 2.465010ms
+STATS: 236309 nodes over 254301 were skipped in iteration 0 (92.92 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 149.569035ms
+STATS: serializing results: 2.363920ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 2174 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 1570 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 2385, used: 211, occupation: 0.088470
+STATS: cache4: length: 1719, used: 149, occupation: 0.086678
Diff: ok
-------------------------------------------
Query: A7 : /site/people/person[phone or homepage]/name
-STATS: parsing xml document: 193.610907ms
-STATS: parsing XPath query: 0.076056ms
-STATS: compiling XPath query: 0.150919ms
+STATS: parsing xml document: 187.725067ms
+STATS: parsing XPath query: 0.087023ms
+STATS: compiling XPath query: 0.158072ms
STATS: Query: /child::site/child::people/child::person[ child::phone or child::homepage ]/child::name
STATS: Automaton:
-STATS: evaluating query: 173.998833ms
-STATS: serializing results: 5.010128ms
+STATS: 236309 nodes over 254301 were skipped in iteration 0 (92.92 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 140.325069ms
+STATS: serializing results: 4.892111ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1728 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 1257 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1927, used: 199, occupation: 0.103269
+STATS: cache4: length: 1420, used: 163, occupation: 0.114789
Diff: ok
-------------------------------------------
Query: A8 : /site/people/person[address and (phone or homepage) and (creditcard or profile)]/name
-STATS: parsing xml document: 187.579155ms
-STATS: parsing XPath query: 0.128984ms
-STATS: compiling XPath query: 0.154018ms
+STATS: parsing xml document: 186.979055ms
+STATS: parsing XPath query: 0.118971ms
+STATS: compiling XPath query: 0.159979ms
STATS: Query: /child::site/child::people/child::person[ child::address and (child::phone or child::homepage) and (child::creditcard or child::profile) ]/child::name
STATS: Automaton:
-STATS: evaluating query: 184.761047ms
-STATS: serializing results: 2.974033ms
+STATS: 236309 nodes over 254301 were skipped in iteration 0 (92.92 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 150.840998ms
+STATS: serializing results: 3.206968ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 9331 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 7979 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 10253, used: 922, occupation: 0.089925
+STATS: cache4: length: 8812, used: 833, occupation: 0.094530
Diff: ok
-------------------------------------------
Query: B1 : /site/regions/*/item[parent::namerica or parent::samerica]/name
-STATS: parsing xml document: 185.950041ms
+STATS: parsing xml document: 191.373110ms
STATS: parsing XPath query: 0.096083ms
-STATS: compiling XPath query: 0.181913ms
+STATS: compiling XPath query: 0.161171ms
STATS: Query: /child::site/child::regions/child::*/child::item[ parent::namerica or parent::samerica ]/child::name
STATS: Automaton:
-STATS: evaluating query: 120.198965ms
-STATS: serializing results: 3.969908ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 119.151115ms
+STATS: serializing results: 3.636837ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 3466 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: B2 : //keyword/ancestor::listitem/text/keyword
-STATS: parsing xml document: 194.061995ms
-STATS: parsing XPath query: 0.072956ms
-STATS: compiling XPath query: 0.154972ms
+STATS: parsing xml document: 191.718102ms
+STATS: parsing XPath query: 0.073195ms
+STATS: compiling XPath query: 0.213861ms
STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::listitem/child::text/child::keyword
STATS: Automaton:
-STATS: evaluating query: 195.713997ms
-STATS: serializing results: 13.200998ms
+STATS: 210583 nodes over 254301 were skipped in iteration 0 (82.81 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 166.561127ms
+STATS: serializing results: 13.072968ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 2331 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 1811 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 2619, used: 288, occupation: 0.109966
+STATS: cache4: length: 2050, used: 239, occupation: 0.116585
Diff: ok
-------------------------------------------
Query: B3 : /site/open_auctions/open_auction/bidder[following-sibling::bidder]
-STATS: parsing xml document: 186.101913ms
-STATS: parsing XPath query: 0.073910ms
-STATS: compiling XPath query: 0.119925ms
+STATS: parsing xml document: 191.766024ms
+STATS: parsing XPath query: 0.077009ms
+STATS: compiling XPath query: 0.133991ms
STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ following-sibling::bidder ]
STATS: Automaton:
-STATS: evaluating query: 126.576900ms
-STATS: serializing results: 31.543016ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 130.250931ms
+STATS: serializing results: 31.550884ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 2871 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: B4 : /site/open_auctions/open_auction/bidder[preceding-sibling::bidder]
-STATS: parsing xml document: 194.361925ms
-STATS: parsing XPath query: 0.109196ms
-STATS: compiling XPath query: 0.155210ms
+STATS: parsing xml document: 189.858913ms
+STATS: parsing XPath query: 0.082970ms
+STATS: compiling XPath query: 0.122070ms
STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ preceding-sibling::bidder ]
STATS: Automaton:
-STATS: evaluating query: 125.017166ms
-STATS: serializing results: 31.688929ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 117.531061ms
+STATS: serializing results: 31.703949ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 2282 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: B5 : /site/regions/*/item[following::item]/name
-STATS: parsing xml document: 186.882973ms
-STATS: parsing XPath query: 0.083208ms
-STATS: compiling XPath query: 0.190973ms
+STATS: parsing xml document: 186.423779ms
+STATS: parsing XPath query: 0.076056ms
+STATS: compiling XPath query: 0.211000ms
STATS: Query: /child::site/child::regions/child::*/child::item[ ancestor-or-self::node()/following-sibling::node()/descendant-or-self::item ]/child::name
STATS: Automaton:
-STATS: evaluating query: 191.325903ms
-STATS: serializing results: 5.614042ms
+STATS: 1 nodes over 254301 were skipped in iteration 0 (0.00 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 200.829983ms
+STATS: serializing results: 5.727053ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1992 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 1990 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 2302, used: 310, occupation: 0.134666
+STATS: cache4: length: 2299, used: 309, occupation: 0.134406
Diff: ok
-------------------------------------------
Query: B6 : /site/regions/*/item[preceding::item]/name
-STATS: parsing xml document: 188.734055ms
-STATS: parsing XPath query: 0.086069ms
-STATS: compiling XPath query: 0.185966ms
+STATS: parsing xml document: 187.946081ms
+STATS: parsing XPath query: 0.046968ms
+STATS: compiling XPath query: 0.171900ms
STATS: Query: /child::site/child::regions/child::*/child::item[ ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::item ]/child::name
STATS: Automaton:
-STATS: evaluating query: 142.535925ms
-STATS: serializing results: 5.680084ms
+STATS: 254301 nodes over 254301 were skipped in iteration 0 (100.00 %), redo is: false
+STATS: evaluating query: 140.237093ms
+STATS: serializing results: 5.573988ms
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
STATS: 1 iterations
STATS: automaton 0, cache2: 170 entries, cache6: 4419 entries
STATS: cache2: length: 255, used: 85, occupation: 0.333333
Diff: ok
-------------------------------------------
Query: B7 : //person[profile/@income]/name
-STATS: parsing xml document: 188.699961ms
-STATS: parsing XPath query: 0.071049ms
-STATS: compiling XPath query: 0.110149ms
+STATS: parsing xml document: 192.195177ms
+STATS: parsing XPath query: 0.074148ms
+STATS: compiling XPath query: 0.116110ms
STATS: Query: /descendant-or-self::node()/child::person[ child::profile/attribute::@income ]/child::name
STATS: Automaton:
-STATS: evaluating query: 186.697960ms
-STATS: serializing results: 3.955126ms
+STATS: 236309 nodes over 254301 were skipped in iteration 0 (92.92 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 145.928860ms
+STATS: serializing results: 4.064083ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1238 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 624 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1349, used: 111, occupation: 0.082283
+STATS: cache4: length: 705, used: 81, occupation: 0.114894
Diff: ok
-------------------------------------------
Query: B8 : /site/open_auctions/open_auction[bidder and not(bidder/preceding-sibling::bidder)]/interval
-STATS: parsing xml document: 189.706087ms
-STATS: parsing XPath query: 0.092983ms
-STATS: compiling XPath query: 0.133991ms
+STATS: parsing xml document: 189.630985ms
+STATS: parsing XPath query: 0.108004ms
+STATS: compiling XPath query: 0.137091ms
STATS: Query: /child::site/child::open_auctions/child::open_auction[ child::bidder and not(child::bidder/preceding-sibling::bidder) ]/child::interval
STATS: Automaton:
-STATS: evaluating query: 180.305958ms
-STATS: serializing results: 2.574921ms
+STATS: 235063 nodes over 254301 were skipped in iteration 0 (92.43 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 1 (100.00 %), redo is: false
+STATS: evaluating query: 140.723944ms
+STATS: serializing results: 2.576828ms
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
STATS: 2 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 1052 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 368 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1229, used: 177, occupation: 0.144020
+STATS: cache4: length: 506, used: 138, occupation: 0.272727
Diff: ok
-------------------------------------------
Query: B9 : /site/open_auctions/open_auction[(not(bidder/following::bidder) or not(bidder/preceding::bidder)) or (bidder/following::bidder and bidder/preceding::bidder)]/interval
-STATS: parsing xml document: 187.867165ms
-STATS: parsing XPath query: 0.136137ms
-STATS: compiling XPath query: 0.380993ms
+STATS: parsing xml document: 180.969000ms
+STATS: parsing XPath query: 0.151157ms
+STATS: compiling XPath query: 0.355959ms
STATS: Query: /child::site/child::open_auctions/child::open_auction[ not(child::bidder/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::bidder) or not(child::bidder/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::bidder) or child::bidder/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::bidder and child::bidder/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::bidder ]/child::interval
STATS: Automaton:
-STATS: evaluating query: 265.134096ms
-STATS: serializing results: 6.505966ms
+STATS: 1 nodes over 254301 were skipped in iteration 0 (0.00 %), redo is: true
+STATS: 251143 nodes over 254301 were skipped in iteration 1 (98.76 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
+STATS: evaluating query: 224.873066ms
+STATS: serializing results: 6.433010ms
+STATS: 254301 nodes over 254301 were skipped in iteration 3 (100.00 %), redo is: false
STATS: 3 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 786 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 157 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 976, used: 190, occupation: 0.194672
+STATS: cache4: length: 213, used: 56, occupation: 0.262911
Diff: ok
-------------------------------------------
Query: B10 : /site/open_auctions/open_auction[(not(bidder/following::bidder) or not(bidder/preceding::bidder)) and (bidder/following::bidder and bidder/preceding::bidder)]/interval
-STATS: parsing xml document: 188.634157ms
-STATS: parsing XPath query: 0.128031ms
-STATS: compiling XPath query: 0.365973ms
+STATS: parsing xml document: 183.919191ms
+STATS: parsing XPath query: 0.127792ms
+STATS: compiling XPath query: 0.363827ms
STATS: Query: /child::site/child::open_auctions/child::open_auction[ (not(child::bidder/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::bidder) or not(child::bidder/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::bidder)) and child::bidder/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::bidder and child::bidder/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::bidder ]/child::interval
STATS: Automaton:
-STATS: evaluating query: 254.701853ms
-STATS: serializing results: 1.600981ms
+STATS: 1 nodes over 254301 were skipped in iteration 0 (0.00 %), redo is: true
+STATS: 251143 nodes over 254301 were skipped in iteration 1 (98.76 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 2 (100.00 %), redo is: false
+STATS: evaluating query: 221.321106ms
+STATS: serializing results: 1.529217ms
+STATS: 254301 nodes over 254301 were skipped in iteration 3 (100.00 %), redo is: false
STATS: 3 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 827 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 153 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 1000, used: 173, occupation: 0.173000
+STATS: cache4: length: 208, used: 55, occupation: 0.264423
Diff: ok
-------------------------------------------
Query: B11 : //open_auction/bidder/../bidder/../bidder/../interval
-STATS: parsing xml document: 189.094067ms
-STATS: parsing XPath query: 0.064850ms
-STATS: compiling XPath query: 0.294924ms
+STATS: parsing xml document: 190.995932ms
+STATS: parsing XPath query: 0.072956ms
+STATS: compiling XPath query: 0.244856ms
STATS: Query: /descendant-or-self::node()/child::open_auction/child::bidder/parent::node()/child::bidder/parent::node()/child::bidder/parent::node()/child::interval
STATS: Automaton:
-STATS: evaluating query: 303.856134ms
-STATS: serializing results: 6.079912ms
+STATS: 0 nodes over 254301 were skipped in iteration 0 (0.00 %), redo is: true
+STATS: 236211 nodes over 254301 were skipped in iteration 1 (92.89 %), redo is: true
+STATS: 236211 nodes over 254301 were skipped in iteration 2 (92.89 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 3 (100.00 %), redo is: false
+STATS: evaluating query: 225.605011ms
+STATS: serializing results: 6.007910ms
+STATS: 254301 nodes over 254301 were skipped in iteration 4 (100.00 %), redo is: false
STATS: 4 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 598 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 144 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 708, used: 110, occupation: 0.155367
+STATS: cache4: length: 209, used: 65, occupation: 0.311005
Diff: ok
-------------------------------------------
Query: B12 : //item/@id/../@id/../@id/../@id/../name
-STATS: parsing xml document: 190.536976ms
-STATS: parsing XPath query: 0.071049ms
+STATS: parsing xml document: 194.081068ms
+STATS: parsing XPath query: 0.083923ms
STATS: compiling XPath query: 0.293016ms
STATS: Query: /descendant-or-self::node()/child::item/attribute::@id/parent::node()/attribute::@id/parent::node()/attribute::@id/parent::node()/attribute::@id/parent::node()/child::name
STATS: Automaton:
-STATS: evaluating query: 360.573053ms
-STATS: serializing results: 5.623817ms
+STATS: 0 nodes over 254301 were skipped in iteration 0 (0.00 %), redo is: true
+STATS: 188718 nodes over 254301 were skipped in iteration 1 (74.21 %), redo is: true
+STATS: 188718 nodes over 254301 were skipped in iteration 2 (74.21 %), redo is: true
+STATS: 188718 nodes over 254301 were skipped in iteration 3 (74.21 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 4 (100.00 %), redo is: false
+STATS: evaluating query: 266.115189ms
+STATS: serializing results: 5.604982ms
+STATS: 254301 nodes over 254301 were skipped in iteration 5 (100.00 %), redo is: false
STATS: 5 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 870 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 416 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 993, used: 123, occupation: 0.123867
+STATS: cache4: length: 524, used: 108, occupation: 0.206107
Diff: ok
-------------------------------------------
Query: B13 : //keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword
-STATS: parsing xml document: 190.907001ms
-STATS: parsing XPath query: 0.097990ms
-STATS: compiling XPath query: 0.226021ms
+STATS: parsing xml document: 183.907986ms
+STATS: parsing XPath query: 0.083923ms
+STATS: compiling XPath query: 0.251055ms
STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword
STATS: Automaton:
-STATS: evaluating query: 307.029963ms
-STATS: serializing results: 14.356136ms
+STATS: 203073 nodes over 254301 were skipped in iteration 0 (79.86 %), redo is: true
+STATS: 208107 nodes over 254301 were skipped in iteration 1 (81.83 %), redo is: true
+STATS: 208107 nodes over 254301 were skipped in iteration 2 (81.83 %), redo is: true
+STATS: 254301 nodes over 254301 were skipped in iteration 3 (100.00 %), redo is: false
+STATS: evaluating query: 197.850943ms
+STATS: serializing results: 14.370203ms
+STATS: 254301 nodes over 254301 were skipped in iteration 4 (100.00 %), redo is: false
STATS: 4 iterations
-STATS: automaton 0, cache2: 0 entries, cache6: 2671 entries
+STATS: automaton 0, cache2: 0 entries, cache6: 981 entries
STATS: cache2: length: 0, used: 0, occupation: -nan
-STATS: cache4: length: 2984, used: 313, occupation: 0.104893
+STATS: cache4: length: 1198, used: 217, occupation: 0.181135
Diff: ok
-------------------------------------------