Make the html trace tools use colors to represent the round at
[tatoo.git] / tests / xmark_small.xml.summary
index b3daa4f..036dc7a 100644 (file)
@@ -1,11 +1,11 @@
 Query: A1 : /site/closed_auctions/closed_auction/annotation/description/text/keyword
-STATS: parsing xml document: 188.066959ms
-STATS: parsing XPath query: 0.082970ms
-STATS: compiling XPath query: 3.010988ms
+STATS: parsing xml document: 190.551996ms
+STATS: parsing XPath query: 0.097036ms
+STATS: compiling XPath query: 0.280142ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction/child::annotation/child::description/child::text/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 109.679937ms
-STATS: serializing results: 3.473043ms
+STATS: evaluating query: 108.064890ms
+STATS: serializing results: 3.912926ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 3149 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -13,13 +13,13 @@ STATS: cache4: length: 3464, used: 315, occupation: 0.090935
 Diff: ok
 -------------------------------------------
 Query: A2 : //closed_auction//keyword
-STATS: parsing xml document: 189.096928ms
-STATS: parsing XPath query: 0.035048ms
-STATS: compiling XPath query: 2.774000ms
+STATS: parsing xml document: 197.270155ms
+STATS: parsing XPath query: 0.055075ms
+STATS: compiling XPath query: 0.095129ms
 STATS: Query: /descendant-or-self::node()/child::closed_auction/descendant-or-self::node()/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 130.786896ms
-STATS: serializing results: 6.608963ms
+STATS: evaluating query: 123.884916ms
+STATS: serializing results: 6.531000ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 2681 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -27,13 +27,13 @@ STATS: cache4: length: 2915, used: 234, occupation: 0.080274
 Diff: ok
 -------------------------------------------
 Query: A3 : /site/closed_auctions/closed_auction//keyword
-STATS: parsing xml document: 185.206890ms
-STATS: parsing XPath query: 0.056028ms
-STATS: compiling XPath query: 2.818108ms
+STATS: parsing xml document: 192.286968ms
+STATS: parsing XPath query: 0.070095ms
+STATS: compiling XPath query: 0.154018ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction/descendant-or-self::node()/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 118.218184ms
-STATS: serializing results: 6.602049ms
+STATS: evaluating query: 122.761011ms
+STATS: serializing results: 6.680965ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 3277 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -41,13 +41,13 @@ 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: 183.023930ms
-STATS: parsing XPath query: 0.104189ms
-STATS: compiling XPath query: 2.968073ms
+STATS: parsing xml document: 190.771103ms
+STATS: parsing XPath query: 0.141859ms
+STATS: compiling XPath query: 0.144005ms
 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: 158.648968ms
-STATS: serializing results: 1.986980ms
+STATS: evaluating query: 164.588928ms
+STATS: serializing results: 2.087116ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1324 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -55,13 +55,13 @@ 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: 191.606045ms
-STATS: parsing XPath query: 0.076056ms
-STATS: compiling XPath query: 2.912998ms
+STATS: parsing xml document: 193.598032ms
+STATS: parsing XPath query: 0.081062ms
+STATS: compiling XPath query: 0.144958ms
 STATS: Query: /child::site/child::closed_auctions/child::closed_auction[ descendant::keyword ]/child::date 
 STATS: Automaton: 
-STATS: evaluating query: 161.002159ms
-STATS: serializing results: 2.372026ms
+STATS: evaluating query: 162.427902ms
+STATS: serializing results: 2.307177ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1170 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -69,13 +69,13 @@ 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: 184.432983ms
-STATS: parsing XPath query: 0.099897ms
-STATS: compiling XPath query: 2.846003ms
+STATS: parsing xml document: 191.087008ms
+STATS: parsing XPath query: 0.101089ms
+STATS: compiling XPath query: 0.145912ms
 STATS: Query: /child::site/child::people/child::person[ child::profile/child::gender and child::profile/child::age ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 158.978224ms
-STATS: serializing results: 2.426863ms
+STATS: evaluating query: 161.004066ms
+STATS: serializing results: 2.367020ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 2174 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -83,13 +83,13 @@ STATS: cache4: length: 2385, used: 211, occupation: 0.088470
 Diff: ok
 -------------------------------------------
 Query: A7 : /site/people/person[phone or homepage]/name
-STATS: parsing xml document: 191.473007ms
-STATS: parsing XPath query: 0.087023ms
-STATS: compiling XPath query: 3.005981ms
+STATS: parsing xml document: 188.372850ms
+STATS: parsing XPath query: 0.087976ms
+STATS: compiling XPath query: 0.148058ms
 STATS: Query: /child::site/child::people/child::person[ child::phone or child::homepage ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 155.133009ms
-STATS: serializing results: 4.827976ms
+STATS: evaluating query: 160.624027ms
+STATS: serializing results: 4.969120ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1728 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -97,13 +97,13 @@ 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: 182.379961ms
-STATS: parsing XPath query: 0.100136ms
-STATS: compiling XPath query: 2.874136ms
+STATS: parsing xml document: 194.225073ms
+STATS: parsing XPath query: 0.120163ms
+STATS: compiling XPath query: 0.150919ms
 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: 164.626122ms
-STATS: serializing results: 3.145933ms
+STATS: evaluating query: 170.377016ms
+STATS: serializing results: 3.077030ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 9331 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -111,13 +111,13 @@ 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: 193.360090ms
-STATS: parsing XPath query: 0.061989ms
-STATS: compiling XPath query: 3.045082ms
+STATS: parsing xml document: 195.889950ms
+STATS: parsing XPath query: 0.098944ms
+STATS: compiling XPath query: 0.180960ms
 STATS: Query: /child::site/child::regions/child::*/child::item[ parent::namerica or parent::samerica ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 117.424965ms
-STATS: serializing results: 3.699064ms
+STATS: evaluating query: 109.380960ms
+STATS: serializing results: 3.566980ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 3466 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -125,13 +125,13 @@ STATS: cache4: length: 3760, used: 294, occupation: 0.078191
 Diff: ok
 -------------------------------------------
 Query: B2 : //keyword/ancestor::listitem/text/keyword
-STATS: parsing xml document: 194.656134ms
-STATS: parsing XPath query: 0.077963ms
-STATS: compiling XPath query: 2.819061ms
+STATS: parsing xml document: 193.809032ms
+STATS: parsing XPath query: 0.082970ms
+STATS: compiling XPath query: 0.152111ms
 STATS: Query: /descendant-or-self::node()/child::keyword/ancestor::listitem/child::text/child::keyword 
 STATS: Automaton: 
-STATS: evaluating query: 185.279131ms
-STATS: serializing results: 13.365030ms
+STATS: evaluating query: 181.705952ms
+STATS: serializing results: 13.277054ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 2331 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -139,13 +139,13 @@ 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: 188.459873ms
-STATS: parsing XPath query: 0.063896ms
-STATS: compiling XPath query: 2.804995ms
+STATS: parsing xml document: 189.718962ms
+STATS: parsing XPath query: 0.041008ms
+STATS: compiling XPath query: 0.104904ms
 STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ following-sibling::bidder ] 
 STATS: Automaton: 
-STATS: evaluating query: 116.722822ms
-STATS: serializing results: 31.981945ms
+STATS: evaluating query: 121.159077ms
+STATS: serializing results: 31.509876ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 2871 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -153,13 +153,13 @@ 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: 193.113804ms
-STATS: parsing XPath query: 0.078917ms
-STATS: compiling XPath query: 2.804041ms
+STATS: parsing xml document: 192.174911ms
+STATS: parsing XPath query: 0.063896ms
+STATS: compiling XPath query: 0.113964ms
 STATS: Query: /child::site/child::open_auctions/child::open_auction/child::bidder[ preceding-sibling::bidder ] 
 STATS: Automaton: 
-STATS: evaluating query: 109.422922ms
-STATS: serializing results: 31.900167ms
+STATS: evaluating query: 114.510059ms
+STATS: serializing results: 31.508923ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 2282 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -167,13 +167,13 @@ STATS: cache4: length: 2507, used: 225, occupation: 0.089749
 Diff: ok
 -------------------------------------------
 Query: B5 : /site/regions/*/item[following::item]/name
-STATS: parsing xml document: 186.527967ms
-STATS: parsing XPath query: 0.079870ms
-STATS: compiling XPath query: 3.057957ms
+STATS: parsing xml document: 188.220024ms
+STATS: parsing XPath query: 0.044107ms
+STATS: compiling XPath query: 0.168085ms
 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: 173.794985ms
-STATS: serializing results: 5.778074ms
+STATS: evaluating query: 177.798986ms
+STATS: serializing results: 5.649805ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1992 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -181,13 +181,13 @@ STATS: cache4: length: 2302, used: 310, occupation: 0.134666
 Diff: ok
 -------------------------------------------
 Query: B6 : /site/regions/*/item[preceding::item]/name
-STATS: parsing xml document: 187.946796ms
-STATS: parsing XPath query: 0.082970ms
-STATS: compiling XPath query: 2.902031ms
+STATS: parsing xml document: 178.910017ms
+STATS: parsing XPath query: 0.083923ms
+STATS: compiling XPath query: 0.180960ms
 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: 127.434969ms
-STATS: serializing results: 5.630016ms
+STATS: evaluating query: 128.618956ms
+STATS: serializing results: 6.258965ms
 STATS: 1 iterations
 STATS: automaton 0, cache2: 170 entries, cache6: 4419 entries
 STATS: cache2: length: 255, used: 85, occupation: 0.333333
@@ -195,13 +195,13 @@ STATS: cache4: length: 4800, used: 381, occupation: 0.079375
 Diff: ok
 -------------------------------------------
 Query: B7 : //person[profile/@income]/name
-STATS: parsing xml document: 184.038877ms
-STATS: parsing XPath query: 0.066042ms
-STATS: compiling XPath query: 2.686024ms
+STATS: parsing xml document: 189.343929ms
+STATS: parsing XPath query: 0.080824ms
+STATS: compiling XPath query: 0.107050ms
 STATS: Query: /descendant-or-self::node()/child::person[ child::profile/attribute::@income ]/child::name 
 STATS: Automaton: 
-STATS: evaluating query: 165.220976ms
-STATS: serializing results: 3.939152ms
+STATS: evaluating query: 169.734955ms
+STATS: serializing results: 3.911018ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1238 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -209,13 +209,13 @@ 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: 187.812090ms
-STATS: parsing XPath query: 0.101089ms
-STATS: compiling XPath query: 2.710104ms
+STATS: parsing xml document: 190.890074ms
+STATS: parsing XPath query: 0.103951ms
+STATS: compiling XPath query: 0.152826ms
 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: 157.864809ms
-STATS: serializing results: 2.645969ms
+STATS: evaluating query: 163.990021ms
+STATS: serializing results: 2.565861ms
 STATS: 2 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 1052 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -223,13 +223,13 @@ 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: 190.474033ms
-STATS: parsing XPath query: 0.148058ms
-STATS: compiling XPath query: 3.069878ms
+STATS: parsing xml document: 190.903187ms
+STATS: parsing XPath query: 0.133038ms
+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: 242.839098ms
-STATS: serializing results: 6.402969ms
+STATS: evaluating query: 245.428085ms
+STATS: serializing results: 6.310940ms
 STATS: 3 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 786 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -237,13 +237,13 @@ 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: 187.290192ms
-STATS: parsing XPath query: 0.123024ms
-STATS: compiling XPath query: 3.057957ms
+STATS: parsing xml document: 192.868948ms
+STATS: parsing XPath query: 0.150204ms
+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)) 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: 238.831997ms
-STATS: serializing results: 1.582861ms
+STATS: evaluating query: 248.049021ms
+STATS: serializing results: 1.506090ms
 STATS: 3 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 827 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -251,13 +251,13 @@ STATS: cache4: length: 1000, used: 173, occupation: 0.173000
 Diff: ok
 -------------------------------------------
 Query: B11 : //open_auction/bidder/../bidder/../bidder/../interval
-STATS: parsing xml document: 184.998989ms
-STATS: parsing XPath query: 0.063181ms
-STATS: compiling XPath query: 2.854109ms
+STATS: parsing xml document: 187.057972ms
+STATS: parsing XPath query: 0.074148ms
+STATS: compiling XPath query: 0.242949ms
 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: 264.686108ms
-STATS: serializing results: 5.999088ms
+STATS: evaluating query: 284.152985ms
+STATS: serializing results: 5.913019ms
 STATS: 4 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 598 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -265,13 +265,13 @@ STATS: cache4: length: 708, used: 110, occupation: 0.155367
 Diff: ok
 -------------------------------------------
 Query: B12 : //item/@id/../@id/../@id/../@id/../name
-STATS: parsing xml document: 181.235075ms
-STATS: parsing XPath query: 0.097990ms
-STATS: compiling XPath query: 3.005028ms
+STATS: parsing xml document: 189.946890ms
+STATS: parsing XPath query: 0.078917ms
+STATS: compiling XPath query: 0.353098ms
 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: 324.455023ms
-STATS: serializing results: 5.921125ms
+STATS: evaluating query: 339.267015ms
+STATS: serializing results: 5.449057ms
 STATS: 5 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 870 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan
@@ -279,13 +279,13 @@ 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: 185.913086ms
-STATS: parsing XPath query: 0.092030ms
-STATS: compiling XPath query: 3.149986ms
+STATS: parsing xml document: 193.133831ms
+STATS: parsing XPath query: 0.099897ms
+STATS: compiling XPath query: 0.231981ms
 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: 278.827190ms
-STATS: serializing results: 14.353991ms
+STATS: evaluating query: 285.151958ms
+STATS: serializing results: 14.261007ms
 STATS: 4 iterations
 STATS: automaton 0, cache2: 0 entries, cache6: 2671 entries
 STATS: cache2: length: 0, used: 0, occupation: -nan