Tune the Remakefile to re-run tests when the binary changes.
[tatoo.git] / tests / xmark_small.xml.summary
index 15df64b..e837f9d 100644 (file)
@@ -1,8 +1,291 @@
+Query: A1 : /site/closed_auctions/closed_auction/annotation/description/text/keyword
+STATS: parsing xml document: 189.342976ms
+STATS: parsing XPath query: 0.099182ms
+STATS: compiling XPath query: 3.221035ms
+STATS: Query: /child::site/child::closed_auctions/child::closed_auction/child::annotation/child::description/child::text/child::keyword 
+STATS: Automaton: 
+STATS: evaluating query: 118.613005ms
+STATS: serializing results: 3.257036ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 3149 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 3464, used: 315, occupation: 0.090935
+Diff: ok
+-------------------------------------------
+Query: A2 : //closed_auction//keyword
+STATS: parsing xml document: 186.474085ms
+STATS: parsing XPath query: 0.053883ms
+STATS: compiling XPath query: 2.933979ms
+STATS: Query: /descendant-or-self::node()/child::closed_auction/descendant-or-self::node()/child::keyword 
+STATS: Automaton: 
+STATS: evaluating query: 137.715101ms
+STATS: serializing results: 6.551981ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 2681 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 2915, used: 234, occupation: 0.080274
+Diff: ok
+-------------------------------------------
+Query: A3 : /site/closed_auctions/closed_auction//keyword
+STATS: parsing xml document: 181.292057ms
+STATS: parsing XPath query: 0.066996ms
+STATS: compiling XPath query: 2.920151ms
+STATS: Query: /child::site/child::closed_auctions/child::closed_auction/descendant-or-self::node()/child::keyword 
+STATS: Automaton: 
+STATS: evaluating query: 132.193089ms
+STATS: serializing results: 6.663799ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 3277 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 3555, used: 278, occupation: 0.078200
+Diff: ok
+-------------------------------------------
+Query: A4 : /site/closed_auctions/closed_auction[annotation/description/text/keyword]/date
+STATS: parsing xml document: 197.504044ms
+STATS: parsing XPath query: 0.107050ms
+STATS: compiling XPath query: 2.917767ms
+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: 177.830935ms
+STATS: serializing results: 2.011061ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1324 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1501, used: 177, occupation: 0.117921
+Diff: ok
+-------------------------------------------
+Query: A5 : /site/closed_auctions/closed_auction[descendant::keyword]/date
+STATS: parsing xml document: 187.441826ms
+STATS: parsing XPath query: 0.078917ms
+STATS: compiling XPath query: 2.928019ms
+STATS: Query: /child::site/child::closed_auctions/child::closed_auction[ descendant::keyword ]/child::date 
+STATS: Automaton: 
+STATS: evaluating query: 176.529169ms
+STATS: serializing results: 2.455950ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1170 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1328, used: 158, occupation: 0.118976
+Diff: ok
+-------------------------------------------
+Query: A6 : /site/people/person[profile/gender and profile/age]/name
+STATS: parsing xml document: 185.663939ms
+STATS: parsing XPath query: 0.100136ms
+STATS: compiling XPath query: 3.006935ms
+STATS: Query: /child::site/child::people/child::person[ child::profile/child::gender and child::profile/child::age ]/child::name 
+STATS: Automaton: 
+STATS: evaluating query: 173.422098ms
+STATS: serializing results: 2.562046ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 2174 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 2385, used: 211, occupation: 0.088470
+Diff: ok
+-------------------------------------------
+Query: A7 : /site/people/person[phone or homepage]/name
+STATS: parsing xml document: 187.916040ms
+STATS: parsing XPath query: 0.087976ms
+STATS: compiling XPath query: 6.510973ms
+STATS: Query: /child::site/child::people/child::person[ child::phone or child::homepage ]/child::name 
+STATS: Automaton: 
+STATS: evaluating query: 171.716928ms
+STATS: serializing results: 4.863977ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1728 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1927, used: 199, occupation: 0.103269
+Diff: ok
+-------------------------------------------
+Query: A8 : /site/people/person[address and (phone or homepage) and (creditcard or profile)]/name
+STATS: parsing xml document: 188.562870ms
+STATS: parsing XPath query: 0.117064ms
+STATS: compiling XPath query: 2.850771ms
+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: 181.411982ms
+STATS: serializing results: 3.045082ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 9331 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 10253, used: 922, occupation: 0.089925
+Diff: ok
+-------------------------------------------
+Query: B1 : /site/regions/*/item[parent::namerica or parent::samerica]/name
+STATS: parsing xml document: 194.905043ms
+STATS: parsing XPath query: 0.095844ms
+STATS: compiling XPath query: 3.118992ms
+STATS: Query: /child::site/child::regions/child::*/child::item[ parent::namerica or parent::samerica ]/child::name 
+STATS: Automaton: 
+STATS: evaluating query: 132.170916ms
+STATS: serializing results: 3.645182ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 3466 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 3760, used: 294, occupation: 0.078191
+Diff: ok
+-------------------------------------------
+Query: B2 : //keyword/ancestor::listitem/text/keyword
+STATS: parsing xml document: 185.543060ms
+STATS: parsing XPath query: 0.046015ms
+STATS: compiling XPath query: 2.823830ms
+STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::listitem/child::text/child::keyword 
+STATS: Automaton: 
+STATS: evaluating query: 205.960035ms
+STATS: serializing results: 13.362885ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 2331 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 2619, used: 288, occupation: 0.109966
+Diff: ok
+-------------------------------------------
+Query: B3 : /site/open_auctions/open_auction/bidder[following-sibling::bidder]
+STATS: parsing xml document: 195.019007ms
+STATS: parsing XPath query: 0.078917ms
+STATS: compiling XPath query: 6.683826ms
+STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ following-sibling::bidder ] 
+STATS: Automaton: 
+STATS: evaluating query: 129.492044ms
+STATS: serializing results: 31.605959ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 2871 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 3131, used: 260, occupation: 0.083041
+Diff: ok
+-------------------------------------------
+Query: B4 : /site/open_auctions/open_auction/bidder[preceding-sibling::bidder]
+STATS: parsing xml document: 189.008951ms
+STATS: parsing XPath query: 0.082016ms
+STATS: compiling XPath query: 2.869129ms
+STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ preceding-sibling::bidder ] 
+STATS: Automaton: 
+STATS: evaluating query: 122.668982ms
+STATS: serializing results: 31.919956ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 2282 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 2507, used: 225, occupation: 0.089749
+Diff: ok
+-------------------------------------------
+Query: B5 : /site/regions/*/item[following::item]/name
+STATS: parsing xml document: 188.519955ms
+STATS: parsing XPath query: 0.054121ms
+STATS: compiling XPath query: 2.942085ms
+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: 199.170113ms
+STATS: serializing results: 5.816936ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1992 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 2302, used: 310, occupation: 0.134666
+Diff: ok
+-------------------------------------------
+Query: B6 : /site/regions/*/item[preceding::item]/name
+STATS: parsing xml document: 185.217857ms
+STATS: parsing XPath query: 0.087023ms
+STATS: compiling XPath query: 2.945900ms
+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: 138.599873ms
+STATS: serializing results: 5.795002ms
+STATS: 1 iterations
+STATS: automaton 0, cache2: 170 entries, cache6: 4419 entries
+STATS: cache2: length: 255, used: 85, occupation: 0.333333
+STATS: cache4: length: 4800, used: 381, occupation: 0.079375
+Diff: ok
+-------------------------------------------
+Query: B7 : //person[profile/@income]/name
+STATS: parsing xml document: 186.985970ms
+STATS: parsing XPath query: 0.077009ms
+STATS: compiling XPath query: 2.740145ms
+STATS: Query: /descendant-or-self::node()/child::person[ child::profile/attribute::@income ]/child::name 
+STATS: Automaton: 
+STATS: evaluating query: 182.914972ms
+STATS: serializing results: 3.901958ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1238 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1349, used: 111, occupation: 0.082283
+Diff: ok
+-------------------------------------------
+Query: B8 : /site/open_auctions/open_auction[bidder and not(bidder/preceding-sibling::bidder)]/interval
+STATS: parsing xml document: 205.939054ms
+STATS: parsing XPath query: 0.105858ms
+STATS: compiling XPath query: 2.954006ms
+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: 174.728155ms
+STATS: serializing results: 2.571106ms
+STATS: 2 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 1052 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1229, used: 177, occupation: 0.144020
+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: 176.476002ms
+STATS: parsing XPath query: 0.150919ms
+STATS: compiling XPath query: 9.018898ms
+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: 264.751196ms
+STATS: serializing results: 6.420135ms
+STATS: 3 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 786 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 976, used: 190, occupation: 0.194672
+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.203096ms
+STATS: parsing XPath query: 0.151873ms
+STATS: compiling XPath query: 3.212929ms
+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: 265.222073ms
+STATS: serializing results: 1.528025ms
+STATS: 3 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 827 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 1000, used: 173, occupation: 0.173000
+Diff: ok
+-------------------------------------------
+Query: B11 : //open_auction/bidder/../bidder/../bidder/../interval
+STATS: parsing xml document: 186.342955ms
+STATS: parsing XPath query: 0.068903ms
+STATS: compiling XPath query: 3.041029ms
+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: 295.202971ms
+STATS: serializing results: 6.148815ms
+STATS: 4 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 598 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 708, used: 110, occupation: 0.155367
+Diff: ok
+-------------------------------------------
+Query: B12 : //item/@id/../@id/../@id/../@id/../name
+STATS: parsing xml document: 192.172050ms
+STATS: parsing XPath query: 0.123024ms
+STATS: compiling XPath query: 2.965927ms
+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: 366.529942ms
+STATS: serializing results: 5.742073ms
+STATS: 5 iterations
+STATS: automaton 0, cache2: 0 entries, cache6: 870 entries
+STATS: cache2: length: 0, used: 0, occupation: -nan
+STATS: cache4: length: 993, used: 123, occupation: 0.123867
+Diff: ok
+-------------------------------------------
 Query: B13 : //keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword
+STATS: parsing xml document: 194.238186ms
+STATS: parsing XPath query: 0.097990ms
+STATS: compiling XPath query: 2.928972ms
 STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword/ancestor::parlist/descendant::keyword 
 STATS: Automaton: 
-STATS: evaluation time: 294.135094ms
-STATS: serialization time: 1.837015ms
+STATS: evaluating query: 291.106939ms
+STATS: serializing results: 14.529943ms
 STATS: 4 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 2671 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan