tests/alphabet.xml.summary

   1 Query: A1 : //L/*
   2 STATS: parsing xml document: 0.378132ms
   3 STATS: parsing XPath query: 0.042200ms
   4 STATS: compiling XPath query: 0.200033ms
   5 STATS: Query: /descendant-or-self::node()/child::L/child::*
   6 STATS: Automaton:
   7 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
   8 STATS: evaluating query: 2.099991ms
   9 STATS: serializing results: 1.550913ms
  10 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  11 STATS: 1 iterations
  12 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
  13 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  14 STATS: cache4: length: 933, used: 124, occupation: 0.132905
  15 Diff: ok
  16 -------------------------------------------
  17 Query: A2 : //L/parent::*
  18 STATS: parsing xml document: 0.357151ms
  19 STATS: parsing XPath query: 0.052929ms
  20 STATS: compiling XPath query: 0.162125ms
  21 STATS: Query: /descendant-or-self::node()/child::L/parent::*
  22 STATS: Automaton:
  23 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
  24 STATS: evaluating query: 2.071857ms
  25 STATS: serializing results: 1.896143ms
  26 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  27 STATS: 1 iterations
  28 STATS: automaton 0, cache2: 70 entries, cache6: 1310 entries
  29 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  30 STATS: cache4: length: 1464, used: 154, occupation: 0.105191
  31 Diff: ok
  32 -------------------------------------------
  33 Query: A3 : //L/descendant::*
  34 STATS: parsing xml document: 0.369072ms
  35 STATS: parsing XPath query: 0.044823ms
  36 STATS: compiling XPath query: 0.216961ms
  37 STATS: Query: /descendant-or-self::node()/child::L/descendant::*
  38 STATS: Automaton:
  39 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
  40 STATS: evaluating query: 2.236843ms
  41 STATS: serializing results: 1.821041ms
  42 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  43 STATS: 1 iterations
  44 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
  45 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  46 STATS: cache4: length: 1060, used: 142, occupation: 0.133962
  47 Diff: ok
  48 -------------------------------------------
  49 Query: A4 : //L/descendant-or-self::*
  50 STATS: parsing xml document: 0.360012ms
  51 STATS: parsing XPath query: 0.048876ms
  52 STATS: compiling XPath query: 0.190020ms
  53 STATS: Query: /descendant-or-self::node()/child::L/descendant-or-self::*
  54 STATS: Automaton:
  55 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
  56 STATS: evaluating query: 2.301931ms
  57 STATS: serializing results: 1.735926ms
  58 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  59 STATS: 1 iterations
  60 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
  61 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  62 STATS: cache4: length: 1060, used: 142, occupation: 0.133962
  63 Diff: ok
  64 -------------------------------------------
  65 Query: A5 : //L/ancestor::*
  66 STATS: parsing xml document: 0.365973ms
  67 STATS: parsing XPath query: 0.046968ms
  68 STATS: compiling XPath query: 0.174046ms
  69 STATS: Query: /descendant-or-self::node()/child::L/ancestor::*
  70 STATS: Automaton:
  71 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
  72 STATS: evaluating query: 2.151966ms
  73 STATS: serializing results: 2.042055ms
  74 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  75 STATS: 1 iterations
  76 STATS: automaton 0, cache2: 70 entries, cache6: 1320 entries
  77 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  78 STATS: cache4: length: 1476, used: 156, occupation: 0.105691
  79 Diff: ok
  80 -------------------------------------------
  81 Query: A6 : //L/ancestor-or-self::*
  82 STATS: parsing xml document: 0.365973ms
  83 STATS: parsing XPath query: 0.045061ms
  84 STATS: compiling XPath query: 0.201941ms
  85 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::*
  86 STATS: Automaton:
  87 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
  88 STATS: evaluating query: 2.483130ms
  89 STATS: serializing results: 2.204895ms
  90 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
  91 STATS: 1 iterations
  92 STATS: automaton 0, cache2: 70 entries, cache6: 1242 entries
  93 STATS: cache2: length: 105, used: 35, occupation: 0.333333
  94 STATS: cache4: length: 1397, used: 155, occupation: 0.110952
  95 Diff: ok
  96 -------------------------------------------
  97 Query: A7 : //L/following-sibling::*
  98 STATS: parsing xml document: 0.365019ms
  99 STATS: parsing XPath query: 0.051975ms
 100 STATS: compiling XPath query: 0.164032ms
 101 STATS: Query: /descendant-or-self::node()/child::L/following-sibling::*
 102 STATS: Automaton:
 103 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 104 STATS: evaluating query: 1.899004ms
 105 STATS: serializing results: 1.600981ms
 106 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 107 STATS: 1 iterations
 108 STATS: automaton 0, cache2: 70 entries, cache6: 1051 entries
 109 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 110 STATS: cache4: length: 1173, used: 122, occupation: 0.104007
 111 Diff: ok
 112 -------------------------------------------
 113 Query: A8 : //L/preceding-sibling::*
 114 STATS: parsing xml document: 0.366926ms
 115 STATS: parsing XPath query: 0.055075ms
 116 STATS: compiling XPath query: 0.163078ms
 117 STATS: Query: /descendant-or-self::node()/child::L/preceding-sibling::*
 118 STATS: Automaton:
 119 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 120 STATS: evaluating query: 2.027035ms
 121 STATS: serializing results: 1.585960ms
 122 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 123 STATS: 1 iterations
 124 STATS: automaton 0, cache2: 70 entries, cache6: 1174 entries
 125 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 126 STATS: cache4: length: 1314, used: 140, occupation: 0.106545
 127 Diff: ok
 128 -------------------------------------------
 129 Query: A9 : //L/following::*
 130 STATS: parsing xml document: 0.361919ms
 131 STATS: parsing XPath query: 0.051022ms
 132 STATS: compiling XPath query: 0.282049ms
 133 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::node()/following-sibling::node()/descendant-or-self::*
 134 STATS: Automaton:
 135 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 136 STATS: evaluating query: 6.561041ms
 137 STATS: serializing results: 1.834869ms
 138 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 139 STATS: 1 iterations
 140 STATS: automaton 0, cache2: 70 entries, cache6: 2104 entries
 141 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 142 STATS: cache4: length: 2334, used: 230, occupation: 0.098543
 143 Diff: ok
 144 -------------------------------------------
 145 Query: A10 : //L/preceding::*
 146 STATS: parsing xml document: 0.365973ms
 147 STATS: parsing XPath query: 0.056982ms
 148 STATS: compiling XPath query: 0.277996ms
 149 STATS: Query: /descendant-or-self::node()/child::L/ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::*
 150 STATS: Automaton:
 151 STATS: 7 nodes over 129 were skipped in iteration 0 (5.43 %), redo is: true
 152 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 153 STATS: evaluating query: 8.136034ms
 154 STATS: serializing results: 2.127886ms
 155 STATS: 129 nodes over 129 were skipped in iteration 2 (100.00 %), redo is: false
 156 STATS: 2 iterations
 157 STATS: automaton 0, cache2: 0 entries, cache6: 942 entries
 158 STATS: cache2: length: 0, used: 0, occupation: -nan
 159 STATS: cache4: length: 1077, used: 135, occupation: 0.125348
 160 Diff: ok
 161 -------------------------------------------
 162 Query: A11 : //L/self::*
 163 STATS: parsing xml document: 0.369787ms
 164 STATS: parsing XPath query: 0.046968ms
 165 STATS: compiling XPath query: 0.160933ms
 166 STATS: Query: /descendant-or-self::node()/child::L/self::*
 167 STATS: Automaton:
 168 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 169 STATS: evaluating query: 1.785040ms
 170 STATS: serializing results: 1.600981ms
 171 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 172 STATS: 1 iterations
 173 STATS: automaton 0, cache2: 70 entries, cache6: 837 entries
 174 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 175 STATS: cache4: length: 946, used: 109, occupation: 0.115222
 176 Diff: ok
 177 -------------------------------------------
 178 Query: A12 : //L/@id/parent::*
 179 STATS: parsing xml document: 0.363111ms
 180 STATS: parsing XPath query: 0.061035ms
 181 STATS: compiling XPath query: 0.235796ms
 182 STATS: Query: /descendant-or-self::node()/child::L/attribute::@id/parent::*
 183 STATS: Automaton:
 184 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 185 STATS: evaluating query: 3.045082ms
 186 STATS: serializing results: 1.613855ms
 187 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 188 STATS: 1 iterations
 189 STATS: automaton 0, cache2: 70 entries, cache6: 1594 entries
 190 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 191 STATS: cache4: length: 1750, used: 156, occupation: 0.089143
 192 Diff: ok
 193 -------------------------------------------
 194 Query: P1 : //*[L]
 195 STATS: parsing xml document: 0.360966ms
 196 STATS: parsing XPath query: 0.049114ms
 197 STATS: compiling XPath query: 0.162125ms
 198 STATS: Query: /descendant-or-self::node()/child::*[ child::L ]
 199 STATS: Automaton:
 200 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 201 STATS: evaluating query: 1.814127ms
 202 STATS: serializing results: 1.966953ms
 203 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 204 STATS: 1 iterations
 205 STATS: automaton 0, cache2: 70 entries, cache6: 1326 entries
 206 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 207 STATS: cache4: length: 1480, used: 154, occupation: 0.104054
 208 Diff: ok
 209 -------------------------------------------
 210 Query: P2 : //*[parent::L]
 211 STATS: parsing xml document: 0.390053ms
 212 STATS: parsing XPath query: 0.052929ms
 213 STATS: compiling XPath query: 0.167131ms
 214 STATS: Query: /descendant-or-self::node()/child::*[ parent::L ]
 215 STATS: Automaton:
 216 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 217 STATS: evaluating query: 1.857996ms
 218 STATS: serializing results: 2.467155ms
 219 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 220 STATS: 1 iterations
 221 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 222 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 223 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 224 Diff: ok
 225 -------------------------------------------
 226 Query: P3 : //*[descendant::L]
 227 STATS: parsing xml document: 0.428915ms
 228 STATS: parsing XPath query: 0.049114ms
 229 STATS: compiling XPath query: 0.166178ms
 230 STATS: Query: /descendant-or-self::node()/child::*[ descendant::L ]
 231 STATS: Automaton:
 232 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 233 STATS: evaluating query: 2.492189ms
 234 STATS: serializing results: 2.094984ms
 235 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 236 STATS: 1 iterations
 237 STATS: automaton 0, cache2: 70 entries, cache6: 1336 entries
 238 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 239 STATS: cache4: length: 1492, used: 156, occupation: 0.104558
 240 Diff: ok
 241 -------------------------------------------
 242 Query: P4 : //*[descendant-or-self::L]
 243 STATS: parsing xml document: 0.363111ms
 244 STATS: parsing XPath query: 0.050068ms
 245 STATS: compiling XPath query: 0.177860ms
 246 STATS: Query: /descendant-or-self::node()/child::*[ descendant-or-self::L ]
 247 STATS: Automaton:
 248 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 249 STATS: evaluating query: 2.146959ms
 250 STATS: serializing results: 2.099037ms
 251 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 252 STATS: 1 iterations
 253 STATS: automaton 0, cache2: 70 entries, cache6: 1242 entries
 254 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 255 STATS: cache4: length: 1397, used: 155, occupation: 0.110952
 256 Diff: ok
 257 -------------------------------------------
 258 Query: P5 : //*[ancestor::L]
 259 STATS: parsing xml document: 0.357151ms
 260 STATS: parsing XPath query: 0.049114ms
 261 STATS: compiling XPath query: 0.241995ms
 262 STATS: Query: /descendant-or-self::node()/child::*[ ancestor::L ]
 263 STATS: Automaton:
 264 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 265 STATS: evaluating query: 1.984835ms
 266 STATS: serializing results: 1.695156ms
 267 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 268 STATS: 1 iterations
 269 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 270 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 271 STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 272 Diff: ok
 273 -------------------------------------------
 274 Query: P6 : //*[ancestor-or-self::L]
 275 STATS: parsing xml document: 0.168085ms
 276 STATS: parsing XPath query: 0.026941ms
 277 STATS: compiling XPath query: 0.084162ms
 278 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::L ]
 279 STATS: Automaton:
 280 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 281 STATS: evaluating query: 1.060963ms
 282 STATS: serializing results: 1.700878ms
 283 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 284 STATS: 1 iterations
 285 STATS: automaton 0, cache2: 70 entries, cache6: 918 entries
 286 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 287 STATS: cache4: length: 1060, used: 142, occupation: 0.133962
 288 Diff: ok
 289 -------------------------------------------
 290 Query: P7 : //*[following-sibling::L]
 291 STATS: parsing xml document: 0.364065ms
 292 STATS: parsing XPath query: 0.046968ms
 293 STATS: compiling XPath query: 0.156879ms
 294 STATS: Query: /descendant-or-self::node()/child::*[ following-sibling::L ]
 295 STATS: Automaton:
 296 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 297 STATS: evaluating query: 1.662016ms
 298 STATS: serializing results: 1.580000ms
 299 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 300 STATS: 1 iterations
 301 STATS: automaton 0, cache2: 70 entries, cache6: 1174 entries
 302 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 303 STATS: cache4: length: 1314, used: 140, occupation: 0.106545
 304 Diff: ok
 305 -------------------------------------------
 306 Query: P8 : //*[preceding-sibling::L]
 307 STATS: parsing xml document: 0.401974ms
 308 STATS: parsing XPath query: 0.056982ms
 309 STATS: compiling XPath query: 0.160933ms
 310 STATS: Query: /descendant-or-self::node()/child::*[ preceding-sibling::L ]
 311 STATS: Automaton:
 312 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 313 STATS: evaluating query: 1.548767ms
 314 STATS: serializing results: 1.600027ms
 315 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 316 STATS: 1 iterations
 317 STATS: automaton 0, cache2: 70 entries, cache6: 1051 entries
 318 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 319 STATS: cache4: length: 1173, used: 122, occupation: 0.104007
 320 Diff: ok
 321 -------------------------------------------
 322 Query: P9 : //*[following::L]
 323 STATS: parsing xml document: 0.368118ms
 324 STATS: parsing XPath query: 0.047922ms
 325 STATS: compiling XPath query: 0.231981ms
 326 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::node()/following-sibling::node()/descendant-or-self::L ]
 327 STATS: Automaton:
 328 STATS: 7 nodes over 129 were skipped in iteration 0 (5.43 %), redo is: true
 329 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 330 STATS: evaluating query: 6.533861ms
 331 STATS: serializing results: 1.817942ms
 332 STATS: 129 nodes over 129 were skipped in iteration 2 (100.00 %), redo is: false
 333 STATS: 2 iterations
 334 STATS: automaton 0, cache2: 0 entries, cache6: 780 entries
 335 STATS: cache2: length: 0, used: 0, occupation: -nan
 336 STATS: cache4: length: 915, used: 135, occupation: 0.147541
 337 Diff: ok
 338 -------------------------------------------
 339 Query: P10 : //*[preceding::L]
 340 STATS: parsing xml document: 0.369072ms
 341 STATS: parsing XPath query: 0.057936ms
 342 STATS: compiling XPath query: 0.245810ms
 343 STATS: Query: /descendant-or-self::node()/child::*[ ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::L ]
 344 STATS: Automaton:
 345 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 346 STATS: evaluating query: 3.724098ms
 347 STATS: serializing results: 1.777172ms
 348 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 349 STATS: 1 iterations
 350 STATS: automaton 0, cache2: 70 entries, cache6: 1767 entries
 351 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 352 STATS: cache4: length: 1980, used: 213, occupation: 0.107576
 353 Diff: ok
 354 -------------------------------------------
 355 Query: P11 : //*[self::L]
 356 STATS: parsing xml document: 0.367880ms
 357 STATS: parsing XPath query: 0.048161ms
 358 STATS: compiling XPath query: 0.149965ms
 359 STATS: Query: /descendant-or-self::node()/child::*[ self::L ]
 360 STATS: Automaton:
 361 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 362 STATS: evaluating query: 1.435041ms
 363 STATS: serializing results: 1.670837ms
 364 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 365 STATS: 1 iterations
 366 STATS: automaton 0, cache2: 70 entries, cache6: 837 entries
 367 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 368 STATS: cache4: length: 946, used: 109, occupation: 0.115222
 369 Diff: ok
 370 -------------------------------------------
 371 Query: P12 : //*[@id]
 372 STATS: parsing xml document: 0.365019ms
 373 STATS: parsing XPath query: 0.042915ms
 374 STATS: compiling XPath query: 0.182867ms
 375 STATS: Query: /descendant-or-self::node()/child::*[ attribute::@id ]
 376 STATS: Automaton:
 377 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 378 STATS: evaluating query: 1.521111ms
 379 STATS: serializing results: 2.558947ms
 380 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 381 STATS: 1 iterations
 382 STATS: automaton 0, cache2: 70 entries, cache6: 907 entries
 383 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 384 STATS: cache4: length: 1022, used: 115, occupation: 0.112524
 385 Diff: ok
 386 -------------------------------------------
 387 Query: T1 : //L/text()
 388 STATS: parsing xml document: 0.377893ms
 389 STATS: parsing XPath query: 0.059128ms
 390 STATS: compiling XPath query: 0.205994ms
 391 STATS: Query: /descendant-or-self::node()/child::L/child::text()
 392 STATS: Automaton:
 393 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 394 STATS: evaluating query: 2.229929ms
 395 STATS: serializing results: 1.520872ms
 396 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 397 STATS: 1 iterations
 398 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 399 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 400 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 401 Diff: ok
 402 -------------------------------------------
 403 Query: T2 : //L/comment()
 404 STATS: parsing xml document: 0.365973ms
 405 STATS: parsing XPath query: 0.068903ms
 406 STATS: compiling XPath query: 0.198841ms
 407 STATS: Query: /descendant-or-self::node()/child::L/child::comment()
 408 STATS: Automaton:
 409 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 410 STATS: evaluating query: 2.146959ms
 411 STATS: serializing results: 1.429081ms
 412 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 413 STATS: 1 iterations
 414 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 415 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 416 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 417 Diff: ok
 418 -------------------------------------------
 419 Query: T3 : //L/processing-instruction()
 420 STATS: parsing xml document: 0.365019ms
 421 STATS: parsing XPath query: 0.082016ms
 422 STATS: compiling XPath query: 0.207186ms
 423 STATS: Query: /descendant-or-self::node()/child::L/child::processing-instruction()
 424 STATS: Automaton:
 425 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 426 STATS: evaluating query: 2.242804ms
 427 STATS: serializing results: 1.472950ms
 428 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 429 STATS: 1 iterations
 430 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 431 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 432 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 433 Diff: ok
 434 -------------------------------------------
 435 Query: T4 : //L/processing-instruction("myPI")
 436 STATS: parsing xml document: 0.367880ms
 437 STATS: parsing XPath query: 0.077009ms
 438 STATS: compiling XPath query: 0.201941ms
 439 STATS: Query: /descendant-or-self::node()/child::L/child::processing-instruction('?myPI')
 440 STATS: Automaton:
 441 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 442 STATS: evaluating query: 2.152920ms
 443 STATS: serializing results: 1.482964ms
 444 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 445 STATS: 1 iterations
 446 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 447 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 448 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 449 Diff: ok
 450 -------------------------------------------
 451 Query: T5 : //L/node()
 452 STATS: parsing xml document: 0.361919ms
 453 STATS: parsing XPath query: 0.064850ms
 454 STATS: compiling XPath query: 0.202179ms
 455 STATS: Query: /descendant-or-self::node()/child::L/child::node()
 456 STATS: Automaton:
 457 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 458 STATS: evaluating query: 2.159119ms
 459 STATS: serializing results: 1.833200ms
 460 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 461 STATS: 1 iterations
 462 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 463 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 464 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 465 Diff: ok
 466 -------------------------------------------
 467 Query: T6 : //L/N
 468 STATS: parsing xml document: 0.365973ms
 469 STATS: parsing XPath query: 0.048161ms
 470 STATS: compiling XPath query: 0.202894ms
 471 STATS: Query: /descendant-or-self::node()/child::L/child::N
 472 STATS: Automaton:
 473 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 474 STATS: evaluating query: 2.237082ms
 475 STATS: serializing results: 1.518011ms
 476 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 477 STATS: 1 iterations
 478 STATS: automaton 0, cache2: 70 entries, cache6: 819 entries
 479 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 480 STATS: cache4: length: 952, used: 133, occupation: 0.139706
 481 Diff: ok
 482 -------------------------------------------
 483 Query: T7 : //L/*
 484 STATS: parsing xml document: 0.368834ms
 485 STATS: parsing XPath query: 0.044107ms
 486 STATS: compiling XPath query: 0.208139ms
 487 STATS: Query: /descendant-or-self::node()/child::L/child::*
 488 STATS: Automaton:
 489 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 490 STATS: evaluating query: 2.174854ms
 491 STATS: serializing results: 1.671076ms
 492 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 493 STATS: 1 iterations
 494 STATS: automaton 0, cache2: 70 entries, cache6: 809 entries
 495 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 496 STATS: cache4: length: 933, used: 124, occupation: 0.132905
 497 Diff: ok
 498 -------------------------------------------
 499 Query: O1 : //*[child::* and preceding::Q]
 500 STATS: parsing xml document: 0.364065ms
 501 STATS: parsing XPath query: 0.056982ms
 502 STATS: compiling XPath query: 0.263929ms
 503 STATS: Query: /descendant-or-self::node()/child::*[ child::* and ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::Q ]
 504 STATS: Automaton:
 505 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 506 STATS: evaluating query: 5.656004ms
 507 STATS: serializing results: 1.590014ms
 508 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 509 STATS: 1 iterations
 510 STATS: automaton 0, cache2: 70 entries, cache6: 1873 entries
 511 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 512 STATS: cache4: length: 2090, used: 217, occupation: 0.103828
 513 Diff: ok
 514 -------------------------------------------
 515 Query: O2 : //*[not(child::*) and preceding::Q]
 516 STATS: parsing xml document: 0.366926ms
 517 STATS: parsing XPath query: 0.066996ms
 518 STATS: compiling XPath query: 0.342131ms
 519 STATS: Query: /descendant-or-self::node()/child::*[ not(child::*) and ancestor-or-self::node()/preceding-sibling::node()/descendant-or-self::Q ]
 520 STATS: Automaton:
 521 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 522 STATS: evaluating query: 5.630016ms
 523 STATS: serializing results: 1.742125ms
 524 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 525 STATS: 1 iterations
 526 STATS: automaton 0, cache2: 70 entries, cache6: 1873 entries
 527 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 528 STATS: cache4: length: 2090, used: 217, occupation: 0.103828
 529 Diff: ok
 530 -------------------------------------------
 531 Query: O3 : //*[preceding::L or following::L]
 532 STATS: parsing xml document: 0.363111ms
 533 STATS: parsing XPath query: 0.063896ms
 534 STATS: compiling XPath query: 0.329971ms
 535 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 ]
 536 STATS: Automaton:
 537 STATS: 7 nodes over 129 were skipped in iteration 0 (5.43 %), redo is: true
 538 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 539 STATS: evaluating query: 10.987997ms
 540 STATS: serializing results: 2.089977ms
 541 STATS: 129 nodes over 129 were skipped in iteration 2 (100.00 %), redo is: false
 542 STATS: 2 iterations
 543 STATS: automaton 0, cache2: 0 entries, cache6: 610 entries
 544 STATS: cache2: length: 0, used: 0, occupation: -nan
 545 STATS: cache4: length: 777, used: 167, occupation: 0.214929
 546 Diff: ok
 547 -------------------------------------------
 548 Query: O4 : //L/ancestor::* | //L/descendant::*
 549 STATS: parsing xml document: 0.373125ms
 550 STATS: parsing XPath query: 0.052214ms
 551 STATS: compiling XPath query: 0.380039ms
 552 STATS: Query: /descendant-or-self::node()/child::L/ancestor::* | /descendant-or-self::node()/child::L/descendant::*
 553 STATS: Automaton:
 554 STATS: 129 nodes over 129 were skipped in iteration 0 (100.00 %), redo is: false
 555 STATS: evaluating query: 7.322073ms
 556 STATS: serializing results: 2.199173ms
 557 STATS: 129 nodes over 129 were skipped in iteration 1 (100.00 %), redo is: false
 558 STATS: 1 iterations
 559 STATS: automaton 0, cache2: 70 entries, cache6: 2345 entries
 560 STATS: cache2: length: 105, used: 35, occupation: 0.333333
 561 STATS: cache4: length: 2543, used: 198, occupation: 0.077861
 562 Diff: ok
 563 -------------------------------------------