temp commit.
[tatoo.git] / tests / xmark_tiny.xml.summary
index 708638c..d98d07d 100644 (file)
@@ -1,11 +1,11 @@
 Query: A1 : /site/closed_auctions/closed_auction/annotation/description/text/keyword
-STATS: parsing xml document: 1.966953ms
-STATS: parsing XPath query: 0.097990ms
-STATS: compiling XPath query: 0.623941ms
+STATS: parsing xml document: 1.968861ms
+STATS: parsing XPath query: 0.094175ms
+STATS: compiling XPath query: 0.621080ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction/child::annotation/child::description/child::text/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 12.537956ms
-STATS: serializing results: 1.646042ms
+STATS: evaluating query: 9.465933ms
+STATS: serializing results: 1.741171ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 2831 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -13,13 +13,13 @@ STATS: cache4: length: 3099, used: 268, occupation: 0.086480
 Diff: ok
 -------------------------------------------
 Query: A2 : //closed_auction//keyword
-STATS: parsing xml document: 1.951933ms
-STATS: parsing XPath query: 0.050783ms
-STATS: compiling XPath query: 0.267982ms
+STATS: parsing xml document: 2.207041ms
+STATS: parsing XPath query: 0.052214ms
+STATS: compiling XPath query: 0.268936ms
 STATS: Query: /descendant-or-self::node()/child::closed_auction/descendant-or-self::node()/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 4.580975ms
-STATS: serializing results: 1.560926ms
+STATS: evaluating query: 6.950855ms
+STATS: serializing results: 1.599073ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 2253 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -27,13 +27,13 @@ STATS: cache4: length: 2452, used: 199, occupation: 0.081158
 Diff: ok
 -------------------------------------------
 Query: A3 : /site/closed_auctions/closed_auction//keyword
-STATS: parsing xml document: 1.996994ms
-STATS: parsing XPath query: 0.069141ms
-STATS: compiling XPath query: 0.376940ms
+STATS: parsing xml document: 1.912832ms
+STATS: parsing XPath query: 0.064850ms
+STATS: compiling XPath query: 0.347137ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction/descendant-or-self::node()/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 8.721828ms
-STATS: serializing results: 1.688957ms
+STATS: evaluating query: 8.553982ms
+STATS: serializing results: 1.499891ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 2969 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -41,13 +41,13 @@ STATS: cache4: length: 3212, used: 243, occupation: 0.075654
 Diff: ok
 -------------------------------------------
 Query: A4 : /site/closed_auctions/closed_auction[annotation/description/text/keyword]/date
-STATS: parsing xml document: 1.893997ms
-STATS: parsing XPath query: 0.159025ms
-STATS: compiling XPath query: 0.347853ms
+STATS: parsing xml document: 1.997948ms
+STATS: parsing XPath query: 0.099897ms
+STATS: compiling XPath query: 0.430822ms
 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: 10.576963ms
-STATS: serializing results: 1.627207ms
+STATS: evaluating query: 11.668921ms
+STATS: serializing results: 1.580954ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1056 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -55,13 +55,13 @@ STATS: cache4: length: 1197, used: 141, occupation: 0.117794
 Diff: ok
 -------------------------------------------
 Query: A5 : /site/closed_auctions/closed_auction[descendant::keyword]/date
-STATS: parsing xml document: 1.942873ms
-STATS: parsing XPath query: 0.073910ms
-STATS: compiling XPath query: 0.401020ms
+STATS: parsing xml document: 1.919031ms
+STATS: parsing XPath query: 0.072956ms
+STATS: compiling XPath query: 0.333786ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction[ descendant::keyword ]/child::date 
 STATS: Automaton: 
-STATS: evaluating query: 9.468079ms
-STATS: serializing results: 1.677036ms
+STATS: evaluating query: 8.996010ms
+STATS: serializing results: 1.481056ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 955 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -69,13 +69,13 @@ STATS: cache4: length: 1080, used: 125, occupation: 0.115741
 Diff: ok
 -------------------------------------------
 Query: A6 : /site/people/person[profile/gender and profile/age]/name
-STATS: parsing xml document: 2.070189ms
-STATS: parsing XPath query: 0.130177ms
-STATS: compiling XPath query: 0.447989ms
+STATS: parsing xml document: 1.996994ms
+STATS: parsing XPath query: 0.092030ms
+STATS: compiling XPath query: 0.415087ms
 STATS: Query: /child::site/child::people/child::person[ child::profile/child::gender and child::profile/child::age ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 10.710001ms
-STATS: serializing results: 1.626015ms
+STATS: evaluating query: 8.347034ms
+STATS: serializing results: 1.531124ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 224 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -83,13 +83,13 @@ STATS: cache4: length: 277, used: 53, occupation: 0.191336
 Diff: ok
 -------------------------------------------
 Query: A7 : /site/people/person[phone or homepage]/name
-STATS: parsing xml document: 1.904011ms
-STATS: parsing XPath query: 0.080109ms
-STATS: compiling XPath query: 0.352859ms
+STATS: parsing xml document: 1.926184ms
+STATS: parsing XPath query: 0.077963ms
+STATS: compiling XPath query: 0.349045ms
 STATS: Query: /child::site/child::people/child::person[ child::phone or child::homepage ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 9.690046ms
-STATS: serializing results: 1.545191ms
+STATS: evaluating query: 8.936882ms
+STATS: serializing results: 1.462936ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 390 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -97,13 +97,13 @@ STATS: cache4: length: 476, used: 86, occupation: 0.180672
 Diff: ok
 -------------------------------------------
 Query: A8 : /site/people/person[address and (phone or homepage) and (creditcard or profile)]/name
-STATS: parsing xml document: 2.023935ms
-STATS: parsing XPath query: 0.114202ms
-STATS: compiling XPath query: 0.465155ms
+STATS: parsing xml document: 1.953840ms
+STATS: parsing XPath query: 0.122070ms
+STATS: compiling XPath query: 0.619173ms
 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: 12.446880ms
-STATS: serializing results: 1.468897ms
+STATS: evaluating query: 8.347034ms
+STATS: serializing results: 1.598835ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 447 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -111,13 +111,13 @@ STATS: cache4: length: 524, used: 77, occupation: 0.146947
 Diff: ok
 -------------------------------------------
 Query: B1 : /site/regions/*/item[parent::namerica or parent::samerica]/name
-STATS: parsing xml document: 1.977921ms
-STATS: parsing XPath query: 0.088215ms
-STATS: compiling XPath query: 0.484943ms
+STATS: parsing xml document: 1.950026ms
+STATS: parsing XPath query: 0.125170ms
+STATS: compiling XPath query: 0.662088ms
 STATS: Query: /child::site/child::regions/child::*/child::item[ parent::namerica or parent::samerica ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 12.034893ms
-STATS: serializing results: 1.737118ms
+STATS: evaluating query: 11.601925ms
+STATS: serializing results: 1.575947ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 2553 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -125,13 +125,13 @@ STATS: cache4: length: 2784, used: 231, occupation: 0.082974
 Diff: ok
 -------------------------------------------
 Query: B2 : //keyword/ancestor::listitem/text/keyword
-STATS: parsing xml document: 1.939058ms
-STATS: parsing XPath query: 0.074148ms
-STATS: compiling XPath query: 0.350237ms
+STATS: parsing xml document: 1.987934ms
+STATS: parsing XPath query: 0.077963ms
+STATS: compiling XPath query: 0.348806ms
 STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::listitem/child::text/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 7.805109ms
-STATS: serializing results: 1.803875ms
+STATS: evaluating query: 11.922836ms
+STATS: serializing results: 1.748085ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1419 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -139,13 +139,13 @@ STATS: cache4: length: 1595, used: 176, occupation: 0.110345
 Diff: ok
 -------------------------------------------
 Query: B3 : /site/open_auctions/open_auction/bidder[following-sibling::bidder]
-STATS: parsing xml document: 1.926184ms
-STATS: parsing XPath query: 0.070095ms
-STATS: compiling XPath query: 0.368118ms
+STATS: parsing xml document: 1.918077ms
+STATS: parsing XPath query: 0.067949ms
+STATS: compiling XPath query: 0.304937ms
 STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ following-sibling::bidder ] 
 STATS: Automaton: 
-STATS: evaluating query: 7.315159ms
-STATS: serializing results: 2.036095ms
+STATS: evaluating query: 7.230997ms
+STATS: serializing results: 1.948118ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 2328 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -153,13 +153,13 @@ STATS: cache4: length: 2549, used: 221, occupation: 0.086701
 Diff: ok
 -------------------------------------------
 Query: B4 : /site/open_auctions/open_auction/bidder[preceding-sibling::bidder]
-STATS: parsing xml document: 2.146959ms
-STATS: parsing XPath query: 0.077963ms
-STATS: compiling XPath query: 0.306129ms
+STATS: parsing xml document: 1.932859ms
+STATS: parsing XPath query: 0.074863ms
+STATS: compiling XPath query: 0.307083ms
 STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ preceding-sibling::bidder ] 
 STATS: Automaton: 
-STATS: evaluating query: 6.942987ms
-STATS: serializing results: 1.972914ms
+STATS: evaluating query: 7.750034ms
+STATS: serializing results: 2.097130ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 1951 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -167,13 +167,13 @@ STATS: cache4: length: 2138, used: 187, occupation: 0.087465
 Diff: ok
 -------------------------------------------
 Query: B5 : /site/regions/*/item[following::item]/name
-STATS: parsing xml document: 2.192020ms
-STATS: parsing XPath query: 0.087023ms
-STATS: compiling XPath query: 0.604153ms
+STATS: parsing xml document: 1.893044ms
+STATS: parsing XPath query: 0.069857ms
+STATS: compiling XPath query: 0.560999ms
 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: 13.622046ms
-STATS: serializing results: 1.582861ms
+STATS: evaluating query: 15.329838ms
+STATS: serializing results: 1.600027ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1374 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -181,13 +181,13 @@ STATS: cache4: length: 1627, used: 253, occupation: 0.155501
 Diff: ok
 -------------------------------------------
 Query: B6 : /site/regions/*/item[preceding::item]/name
-STATS: parsing xml document: 1.945019ms
-STATS: parsing XPath query: 0.077963ms
-STATS: compiling XPath query: 0.524998ms
+STATS: parsing xml document: 1.949072ms
+STATS: parsing XPath query: 0.104189ms
+STATS: compiling XPath query: 0.522137ms
 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: 14.191866ms
-STATS: serializing results: 1.636028ms
+STATS: evaluating query: 12.756824ms
+STATS: serializing results: 1.522064ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 140 entries, cache6: 3069 entries
 STATS: cache2: length: 210, used: 70, occupation: 0.333333
@@ -195,13 +195,13 @@ STATS: cache4: length: 3392, used: 323, occupation: 0.095224
 Diff: ok
 -------------------------------------------
 Query: B7 : //person[profile/@income]/name
-STATS: parsing xml document: 1.955032ms
-STATS: parsing XPath query: 0.075102ms
-STATS: compiling XPath query: 0.281096ms
+STATS: parsing xml document: 2.023935ms
+STATS: parsing XPath query: 0.070095ms
+STATS: compiling XPath query: 0.383854ms
 STATS: Query: /descendant-or-self::node()/child::person[ child::profile/attribute::@income ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 7.355928ms
-STATS: serializing results: 1.435995ms
+STATS: evaluating query: 7.132053ms
+STATS: serializing results: 1.590967ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 284 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -209,13 +209,13 @@ STATS: cache4: length: 328, used: 44, occupation: 0.134146
 Diff: ok
 -------------------------------------------
 Query: B8 : /site/open_auctions/open_auction[bidder and not(bidder/preceding-sibling::bidder)]/interval
-STATS: parsing xml document: 1.937151ms
+STATS: parsing xml document: 2.041101ms
 STATS: parsing XPath query: 0.100136ms
-STATS: compiling XPath query: 0.396013ms
+STATS: compiling XPath query: 0.408888ms
 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: 10.786057ms
-STATS: serializing results: 1.598120ms
+STATS: evaluating query: 10.506868ms
+STATS: serializing results: 1.502991ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 566 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -223,13 +223,13 @@ STATS: cache4: length: 660, used: 94, occupation: 0.142424
 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: 2.006054ms
-STATS: parsing XPath query: 0.141144ms
-STATS: compiling XPath query: 1.159906ms
+STATS: parsing xml document: 2.124786ms
+STATS: parsing XPath query: 0.147104ms
+STATS: compiling XPath query: 1.192093ms
 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: 18.238068ms
-STATS: serializing results: 1.686096ms
+STATS: evaluating query: 21.920919ms
+STATS: serializing results: 1.502991ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 979 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -237,13 +237,13 @@ STATS: cache4: length: 1253, used: 274, occupation: 0.218675
 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: 1.948833ms
-STATS: parsing XPath query: 0.134945ms
-STATS: compiling XPath query: 1.168966ms
+STATS: parsing xml document: 1.946926ms
+STATS: parsing XPath query: 0.142097ms
+STATS: compiling XPath query: 1.147032ms
 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: 21.468163ms
-STATS: serializing results: 1.615047ms
+STATS: evaluating query: 22.176027ms
+STATS: serializing results: 1.529932ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 980 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -251,13 +251,13 @@ STATS: cache4: length: 1250, used: 270, occupation: 0.216000
 Diff: ok
 -------------------------------------------
 Query: B11 : //open_auction/bidder/../bidder/../bidder/../interval
-STATS: parsing xml document: 1.931906ms
+STATS: parsing xml document: 1.973867ms
 STATS: parsing XPath query: 0.066042ms
-STATS: compiling XPath query: 0.644922ms
+STATS: compiling XPath query: 0.635862ms
 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: 15.552044ms
-STATS: serializing results: 1.615047ms
+STATS: evaluating query: 14.349937ms
+STATS: serializing results: 1.570940ms
 STATS: 4 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 479 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -265,13 +265,13 @@ STATS: cache4: length: 563, used: 84, occupation: 0.149201
 Diff: ok
 -------------------------------------------
 Query: B12 : //item/@id/../@id/../@id/../@id/../name
-STATS: parsing xml document: 1.978874ms
-STATS: parsing XPath query: 0.072956ms
-STATS: compiling XPath query: 0.880957ms
+STATS: parsing xml document: 2.254009ms
+STATS: parsing XPath query: 0.074863ms
+STATS: compiling XPath query: 0.828981ms
 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: 19.575119ms
-STATS: serializing results: 1.701117ms
+STATS: evaluating query: 18.256903ms
+STATS: serializing results: 1.621962ms
 STATS: 5 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 725 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -279,13 +279,13 @@ STATS: cache4: length: 820, used: 95, occupation: 0.115854
 Diff: ok
 -------------------------------------------
 Query: B13 : //keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword
-STATS: parsing xml document: 1.997948ms
-STATS: parsing XPath query: 0.092983ms
-STATS: compiling XPath query: 0.646114ms
+STATS: parsing xml document: 1.988888ms
+STATS: parsing XPath query: 0.113010ms
+STATS: compiling XPath query: 0.640869ms
 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: 16.010046ms
-STATS: serializing results: 1.931906ms
+STATS: evaluating query: 22.742033ms
+STATS: serializing results: 1.921892ms
 STATS: 4 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1491 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan