Execution Time25.55s

Test: roottest-root-tree-cache-TooSmall (Passed)
Build: master-x86_64-fedora29-gcc8-dbg (root-fedora29-2.cern.ch) on 2019-11-14 11:43:11

Test Timing: Passed
Processors1

Show Command Line
Display graphs:

Test output
-- TEST COMMAND -- 
cd /mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/roottest/root/tree/cache
/usr/bin/timeout -s USR2 270s /mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/bin/root.exe -e '#define ClingWorkAroundMissingDynamicScope' -e '#define ClingWorkAroundUnnamedInclude' -e '#define ClingWorkAroundMissingSmartInclude' -e '#define ClingWorkAroundNoDotInclude' -e '#define ClingWorkAroundMissingAutoLoadingForTemplates' -e '#define ClingWorkAroundAutoParseUsingNamespace' -e '#define ClingWorkAroundTClassUpdateDouble32' -e '#define ClingWorkAroundAutoParseDeclaration' -e '#define ClingWorkAroundMissingUnloading' -e '#define ClingWorkAroundBrokenUnnamedReturn' -e '#define ClingWorkAroundUnnamedDetection2' -e 'gSystem->SetBuildDir("/mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/roottest/root/tree/cache",true)' -e 'gSystem->AddDynamicPath("/mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/roottest/root/tree/cache")' -e 'gROOT->SetMacroPath("/mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/roottest/root/tree/cache")' -e 'gInterpreter->AddIncludePath("-I/mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/roottest/root/tree/cache")' -e 'gSystem->AddIncludePath("-I/mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/build/roottest/root/tree/cache")' -q -l -b /mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/roottest/root/tree/cache/assertTooSmall.C
-- BEGIN TEST OUTPUT --

Processing /mnt/build/wsincrmaster/LABEL/ROOT-fedora29/SPEC/rtcxxmod/roottest/root/tree/cache/assertTooSmall.C...
regular: Running test: skip=1 wrongOrder=1 uselarge=1
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.428571
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 9501060 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 79.175500 Kbytes
Number of blocks in current cache..: 7, total size: 158351
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 9.50106 MBytes
ReadUnZip = 9.50106 MBytes
ReadCalls = 120
ReadSize  =  79.175 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.019 seconds
CPU  Time =   0.010 seconds
Disk Time =   0.002 seconds
Disk IO   = 4649.438 MBytes/s
ReadUZRT  = 489.093 MBytes/s
ReadUZCP  = 950.106 MBytes/s
ReadRT    = 489.093 MBytes/s
ReadCP    = 950.106 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 4 5 6 7 12 13 14 15 20 21 22 23 28 29 30 31 36 37 38 39 44 45 46 47 52 53 54 55 60 61 62 63 68 69 70 71 76 77 78 79 84 85 86 87 92 93 94 95 100 101 102 103 108 109 110 111 116 117 118 119 124 125 126 127 132 133 134 135 140 141 142 143 148 149 150 151 156 157 158 159 164 165 166 167 172 173 174 175 180 181 182 183 188 189 190 191 196 197 198 199 204 205 206 207 212 213 214 215 220 221 222 223 228 229 230 231 236 237 238 239 244 245 246 247 252 253 254 255 260 261 262 263 268 269 270 271 276 277 278 279 284 285 286 287 292 293 294 295 300 301 302 303 308 309 310 311 316 317 318 319 324 325 326 327 332 333 334 335 340 341 342 343 348 349 350 351 356 357 358 359 364 365 366 367 372 373 374 375 380 381 382 383 388 389 390 391 396 397 398 399 404 405 406 407 412 413 414 415 420 421 422 423 428 429 430 431 436 437 438 439 444 445 446 447 452 453 454 455 460 461 462 463 468 469 470 471 476 477 478 479 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 v1 read not cached: 
  br=2 v1 cached more than once: 
  br=2 v1 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=1 wrongOrder=1 uselarge=0
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 2
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 2493000 bytes in 60 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 41.550000 Kbytes
Number of blocks in current cache..: 2, total size: 41550
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 2.493 MBytes
ReadUnZip = 2.493 MBytes
ReadCalls = 60
ReadSize  =  41.550 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.026 seconds
CPU  Time =   0.010 seconds
Disk Time =   0.014 seconds
Disk IO   = 182.177 MBytes/s
ReadUZRT  =  96.864 MBytes/s
ReadUZCP  = 249.300 MBytes/s
ReadRT    =  96.864 MBytes/s
ReadCP    = 249.300 MBytes/s
  br=0 v2 read not cached: 
  br=0 v2 cached more than once: 
  br=0 v2 cached but not used: 
  br=1 v1 read not cached: 
  br=1 v1 cached more than once: 
  br=1 v1 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=1 wrongOrder=0 uselarge=1
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.428571
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 9501060 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 79.175500 Kbytes
Number of blocks in current cache..: 7, total size: 158351
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 9.50106 MBytes
ReadUnZip = 9.50106 MBytes
ReadCalls = 120
ReadSize  =  79.175 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.059 seconds
CPU  Time =   0.030 seconds
Disk Time =   0.002 seconds
Disk IO   = 4387.837 MBytes/s
ReadUZRT  = 160.440 MBytes/s
ReadUZCP  = 316.702 MBytes/s
ReadRT    = 160.440 MBytes/s
ReadCP    = 316.702 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 vlarge read not cached: 
  br=2 vlarge cached more than once: 
  br=2 vlarge cached but not used: 4 5 6 7 12 13 14 15 20 21 22 23 28 29 30 31 36 37 38 39 44 45 46 47 52 53 54 55 60 61 62 63 68 69 70 71 76 77 78 79 84 85 86 87 92 93 94 95 100 101 102 103 108 109 110 111 116 117 118 119 124 125 126 127 132 133 134 135 140 141 142 143 148 149 150 151 156 157 158 159 164 165 166 167 172 173 174 175 180 181 182 183 188 189 190 191 196 197 198 199 204 205 206 207 212 213 214 215 220 221 222 223 228 229 230 231 236 237 238 239 244 245 246 247 252 253 254 255 260 261 262 263 268 269 270 271 276 277 278 279 284 285 286 287 292 293 294 295 300 301 302 303 308 309 310 311 316 317 318 319 324 325 326 327 332 333 334 335 340 341 342 343 348 349 350 351 356 357 358 359 364 365 366 367 372 373 374 375 380 381 382 383 388 389 390 391 396 397 398 399 404 405 406 407 412 413 414 415 420 421 422 423 428 429 430 431 436 437 438 439 444 445 446 447 452 453 454 455 460 461 462 463 468 469 470 471 476 477 478 479 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=1 wrongOrder=0 uselarge=0
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 2
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 2493000 bytes in 60 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 41.550000 Kbytes
Number of blocks in current cache..: 2, total size: 41550
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 2.493 MBytes
ReadUnZip = 2.493 MBytes
ReadCalls = 60
ReadSize  =  41.550 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.031 seconds
CPU  Time =   0.010 seconds
Disk Time =   0.001 seconds
Disk IO   = 4177.547 MBytes/s
ReadUZRT  =  79.878 MBytes/s
ReadUZCP  = 249.300 MBytes/s
ReadRT    =  79.878 MBytes/s
ReadCP    = 249.300 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=0 wrongOrder=1 uselarge=1
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 14572920 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 121.441000 Kbytes
Number of blocks in current cache..: 10, total size: 242882
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 14.5729 MBytes
ReadUnZip = 14.5729 MBytes
ReadCalls = 120
ReadSize  = 121.441 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.164 seconds
CPU  Time =   0.080 seconds
Disk Time =   0.004 seconds
Disk IO   = 4009.134 MBytes/s
ReadUZRT  =  88.687 MBytes/s
ReadUZCP  = 182.162 MBytes/s
ReadRT    =  88.687 MBytes/s
ReadCP    = 182.161 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 v1 read not cached: 
  br=2 v1 cached more than once: 
  br=2 v1 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=0 wrongOrder=1 uselarge=0
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 2
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 2493000 bytes in 60 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 41.550000 Kbytes
Number of blocks in current cache..: 2, total size: 41550
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 2.493 MBytes
ReadUnZip = 2.493 MBytes
ReadCalls = 60
ReadSize  =  41.550 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.026 seconds
CPU  Time =   0.030 seconds
Disk Time =   0.001 seconds
Disk IO   = 3887.137 MBytes/s
ReadUZRT  =  96.032 MBytes/s
ReadUZCP  =  83.100 MBytes/s
ReadRT    =  96.032 MBytes/s
ReadCP    =  83.100 MBytes/s
  br=0 v2 read not cached: 
  br=0 v2 cached more than once: 
  br=0 v2 cached but not used: 
  br=1 v1 read not cached: 
  br=1 v1 cached more than once: 
  br=1 v1 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=0 wrongOrder=0 uselarge=1
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 14572920 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 121.441000 Kbytes
Number of blocks in current cache..: 10, total size: 242882
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 14.5729 MBytes
ReadUnZip = 14.5729 MBytes
ReadCalls = 120
ReadSize  = 121.441 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.086 seconds
CPU  Time =   0.070 seconds
Disk Time =   0.003 seconds
Disk IO   = 4344.226 MBytes/s
ReadUZRT  = 168.932 MBytes/s
ReadUZCP  = 208.185 MBytes/s
ReadRT    = 168.932 MBytes/s
ReadCP    = 208.185 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 vlarge read not cached: 
  br=2 vlarge cached more than once: 
  br=2 vlarge cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
regular: Running test: skip=0 wrongOrder=0 uselarge=0
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t1: 62304
******TreeCache statistics for tree: t1 in file: f1.root ******
Number of branches in the cache ...: 2
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 2493000 bytes in 60 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 41.550000 Kbytes
Number of blocks in current cache..: 2, total size: 41550
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 2.493 MBytes
ReadUnZip = 2.493 MBytes
ReadCalls = 60
ReadSize  =  41.550 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.042 seconds
CPU  Time =   0.010 seconds
Disk Time =   0.001 seconds
Disk IO   = 4485.800 MBytes/s
ReadUZRT  =  59.560 MBytes/s
ReadUZCP  = 249.300 MBytes/s
ReadRT    =  59.560 MBytes/s
ReadCP    = 249.300 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
******************************************************************************
*Tree    :t1        :                                                        *
*Entries :     3000 : Total =        14588719 bytes  File  Size =   14588719 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12091757 bytes  File Size  =   12079920 *
*Baskets :      480 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t1: 62304
largeStandaloneBasket: Running test
******************************************************************************
*Tree    :largeStandaloneBasket:                                                        *
*Entries :     3000 : Total =         6274729 bytes  File  Size =    6274729 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1256461 bytes  File Size  =    1253280 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2a       : vector<int>                                            *
*Entries :     3000 : Total  Size=    1256585 bytes  File Size  =    1253400 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :v2b       : vector<int>                                            *
*Entries :     3000 : Total  Size=    1256585 bytes  File Size  =    1253400 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    3 :v2c       : vector<int>                                            *
*Entries :     3000 : Total  Size=    1256585 bytes  File Size  =    1253400 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    4 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=    1245977 bytes  File Size  =    1244940 *
*Baskets :       30 : Basket Size=      45000 bytes  Compression=   1.00     *
*............................................................................*
******TreeCache statistics for tree: largeStandaloneBasket in file: largeStandaloneBasket.root ******
Number of branches in the cache ...: 5
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 6258420 bytes in 150 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 41.722800 Kbytes
Number of blocks in current cache..: 5, total size: 42705
TreeCache = 0 MBytes
N leaves  = 5
ReadTotal = 6.25842 MBytes
ReadUnZip = 6.25842 MBytes
ReadCalls = 150
ReadSize  =  41.723 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.061 seconds
CPU  Time =   0.030 seconds
Disk Time =   0.002 seconds
Disk IO   = 4034.694 MBytes/s
ReadUZRT  = 102.000 MBytes/s
ReadUZCP  = 208.614 MBytes/s
ReadRT    = 102.000 MBytes/s
ReadCP    = 208.614 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 
  br=1 v1 read not cached: 
  br=1 v1 cached more than once: 
  br=1 v1 cached but not used: 
  br=2 v2a read not cached: 
  br=2 v2a cached more than once: 
  br=2 v2a cached but not used: 
  br=3 v2b read not cached: 
  br=3 v2b cached more than once: 
  br=3 v2b cached but not used: 
  br=4 v2c read not cached: 
  br=4 v2c cached more than once: 
  br=4 v2c cached but not used: 
Cache size 2 for t2: 45000 zipbytes=6258420
largeWithSkip: Running test: skip=1 split=1 wrongOrder=1
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t2: 0
******TreeCache statistics for tree: t2 in file: f2.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.463918
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 8762296 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 73.019133 Kbytes
Number of blocks in current cache..: 7, total size: 141665
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 8.7623 MBytes
ReadUnZip = 8.7623 MBytes
ReadCalls = 120
ReadSize  =  73.019 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.021 seconds
CPU  Time =   0.020 seconds
Disk Time =   0.002 seconds
Disk IO   = 4400.878 MBytes/s
ReadUZRT  = 411.858 MBytes/s
ReadUZCP  = 438.115 MBytes/s
ReadRT    = 411.858 MBytes/s
ReadCP    = 438.115 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 4 5 6 7 11 12 13 14 18 19 20 21 26 27 28 33 34 35 40 41 42 47 48 49 54 55 56 57 61 62 63 64 68 69 70 71 76 77 78 83 84 85 90 91 92 97 98 99 104 105 106 107 111 112 113 114 118 119 120 121 126 127 128 133 134 135 140 141 142 147 148 149 154 155 156 157 161 162 163 164 168 169 170 171 176 177 178 183 184 185 190 191 192 197 198 199 204 205 206 207 211 212 213 214 219 220 221 222 226 227 228 229 233 234 235 236 241 242 243 248 249 250 255 256 257 262 263 264 269 270 271 272 276 277 278 279 283 284 285 286 291 292 293 298 299 300 305 306 307 312 313 314 319 320 321 322 326 327 328 329 333 334 335 336 341 342 343 348 349 350 355 356 357 362 363 364 369 370 371 372 376 377 378 379 383 384 385 386 391 392 393 398 399 400 405 406 407 412 413 414 419 420 421 422 426 427 428 429 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 v1 read not cached: 
  br=2 v1 cached more than once: 
  br=2 v1 cached but not used: 
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t2: 45000 zipbytes=14577970
largeWithSkip: Running test: skip=1 split=1 wrongOrder=0
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t2: 0
******TreeCache statistics for tree: t2 in file: f2.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.463918
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 8762296 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 73.019133 Kbytes
Number of blocks in current cache..: 7, total size: 141665
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 8.7623 MBytes
ReadUnZip = 8.7623 MBytes
ReadCalls = 120
ReadSize  =  73.019 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.033 seconds
CPU  Time =   0.020 seconds
Disk Time =   0.002 seconds
Disk IO   = 4016.583 MBytes/s
ReadUZRT  = 263.242 MBytes/s
ReadUZCP  = 438.115 MBytes/s
ReadRT    = 263.242 MBytes/s
ReadCP    = 438.115 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 vlarge read not cached: 
  br=2 vlarge cached more than once: 
  br=2 vlarge cached but not used: 4 5 6 7 11 12 13 14 18 19 20 21 26 27 28 33 34 35 40 41 42 47 48 49 54 55 56 57 61 62 63 64 68 69 70 71 76 77 78 83 84 85 90 91 92 97 98 99 104 105 106 107 111 112 113 114 118 119 120 121 126 127 128 133 134 135 140 141 142 147 148 149 154 155 156 157 161 162 163 164 168 169 170 171 176 177 178 183 184 185 190 191 192 197 198 199 204 205 206 207 211 212 213 214 219 220 221 222 226 227 228 229 233 234 235 236 241 242 243 248 249 250 255 256 257 262 263 264 269 270 271 272 276 277 278 279 283 284 285 286 291 292 293 298 299 300 305 306 307 312 313 314 319 320 321 322 326 327 328 329 333 334 335 336 341 342 343 348 349 350 355 356 357 362 363 364 369 370 371 372 376 377 378 379 383 384 385 386 391 392 393 398 399 400 405 406 407 412 413 414 419 420 421 422 426 427 428 429 
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t2: 45000 zipbytes=14577970
largeWithSkip: Running test: skip=1 split=0 wrongOrder=1
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14583569 bytes  File  Size =   14583569 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t2: 0
******TreeCache statistics for tree: t2 in file: f2.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.463918
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 10004296 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 83.369133 Kbytes
Number of blocks in current cache..: 7, total size: 162365
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 10.0043 MBytes
ReadUnZip = 10.0043 MBytes
ReadCalls = 120
ReadSize  =  83.369 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.060 seconds
CPU  Time =   0.010 seconds
Disk Time =   0.012 seconds
Disk IO   = 861.393 MBytes/s
ReadUZRT  = 166.024 MBytes/s
ReadUZCP  = 1000.430 MBytes/s
ReadRT    = 166.024 MBytes/s
ReadCP    = 1000.430 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 4 5 6 7 11 12 13 14 18 19 20 21 26 27 28 33 34 35 40 41 42 47 48 49 54 55 56 57 61 62 63 64 68 69 70 71 76 77 78 83 84 85 90 91 92 97 98 99 104 105 106 107 111 112 113 114 118 119 120 121 126 127 128 133 134 135 140 141 142 147 148 149 154 155 156 157 161 162 163 164 168 169 170 171 176 177 178 183 184 185 190 191 192 197 198 199 204 205 206 207 211 212 213 214 219 220 221 222 226 227 228 229 233 234 235 236 241 242 243 248 249 250 255 256 257 262 263 264 269 270 271 272 276 277 278 279 283 284 285 286 291 292 293 298 299 300 305 306 307 312 313 314 319 320 321 322 326 327 328 329 333 334 335 336 341 342 343 348 349 350 355 356 357 362 363 364 369 370 371 372 376 377 378 379 383 384 385 386 391 392 393 398 399 400 405 406 407 412 413 414 419 420 421 422 426 427 428 429 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 v1 read not cached: 
  br=2 v1 cached more than once: 
  br=2 v1 cached but not used: 
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14583569 bytes  File  Size =   14583569 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t2: 90000 zipbytes=14568970
largeWithSkip: Running test: skip=1 split=0 wrongOrder=0
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14583569 bytes  File  Size =   14583569 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t2: 0
******TreeCache statistics for tree: t2 in file: f2.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 0.463918
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 10004296 bytes in 120 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 83.369133 Kbytes
Number of blocks in current cache..: 7, total size: 162365
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 10.0043 MBytes
ReadUnZip = 10.0043 MBytes
ReadCalls = 120
ReadSize  =  83.369 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.052 seconds
CPU  Time =   0.020 seconds
Disk Time =   0.002 seconds
Disk IO   = 4360.497 MBytes/s
ReadUZRT  = 190.947 MBytes/s
ReadUZCP  = 500.215 MBytes/s
ReadRT    = 190.947 MBytes/s
ReadCP    = 500.215 MBytes/s
  br=0 v1 read not cached: 
  br=0 v1 cached more than once: 
  br=0 v1 cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 vlarge read not cached: 
  br=2 vlarge cached more than once: 
  br=2 vlarge cached but not used: 4 5 6 7 11 12 13 14 18 19 20 21 26 27 28 33 34 35 40 41 42 47 48 49 54 55 56 57 61 62 63 64 68 69 70 71 76 77 78 83 84 85 90 91 92 97 98 99 104 105 106 107 111 112 113 114 118 119 120 121 126 127 128 133 134 135 140 141 142 147 148 149 154 155 156 157 161 162 163 164 168 169 170 171 176 177 178 183 184 185 190 191 192 197 198 199 204 205 206 207 211 212 213 214 219 220 221 222 226 227 228 229 233 234 235 236 241 242 243 248 249 250 255 256 257 262 263 264 269 270 271 272 276 277 278 279 283 284 285 286 291 292 293 298 299 300 305 306 307 312 313 314 319 320 321 322 326 327 328 329 333 334 335 336 341 342 343 348 349 350 355 356 357 362 363 364 369 370 371 372 376 377 378 379 383 384 385 386 391 392 393 398 399 400 405 406 407 412 413 414 419 420 421 422 426 427 428 429 
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14583569 bytes  File  Size =   14583569 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1248241 bytes  File Size  =    1246500 *
*Baskets :       60 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t2: 90000 zipbytes=14568970
largeWithSkip: Running test: skip=0 split=1 wrongOrder=1
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 1 for t2: 0
******TreeCache statistics for tree: t2 in file: f2.root ******
Number of branches in the cache ...: 3
Cache Efficiency ..................: 1.000000
Cache Efficiency Rel...............: 1.000000
Secondary Efficiency ..............: 0.000000
Secondary Efficiency Rel ..........: 0.000000
Learn entries......................: 100
Cached Reading.....................: 14577970 bytes in 240 transactions
Reading............................: 0 bytes in 0 uncached transactions
Readahead..........................: 256000 bytes with overhead = 0 bytes
Average transaction................: 60.741542 Kbytes
Number of blocks in current cache..: 6, total size: 113488
TreeCache = 0 MBytes
N leaves  = 3
ReadTotal = 14.578 MBytes
ReadUnZip = 14.578 MBytes
ReadCalls = 240
ReadSize  =  60.742 KBytes/read
Readahead = 256 KBytes
Readextra =  0.00 per cent
Real Time =   0.184 seconds
CPU  Time =   0.070 seconds
Disk Time =   0.014 seconds
Disk IO   = 1076.752 MBytes/s
ReadUZRT  =  79.023 MBytes/s
ReadUZCP  = 208.257 MBytes/s
ReadRT    =  79.023 MBytes/s
ReadCP    = 208.257 MBytes/s
  br=0 vlarge read not cached: 
  br=0 vlarge cached more than once: 
  br=0 vlarge cached but not used: 
  br=1 v2 read not cached: 
  br=1 v2 cached more than once: 
  br=1 v2 cached but not used: 
  br=2 v1 read not cached: 
  br=2 v1 cached more than once: 
  br=2 v1 cached but not used: 
******************************************************************************
*Tree    :t2        :                                                        *
*Entries :     3000 : Total =        14597369 bytes  File  Size =   14597369 *
*        :          : Tree compression factor =   1.00                       *
******************************************************************************
*Br    0 :v1        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    1 :v2        : vector<int>                                            *
*Entries :     3000 : Total  Size=    1254181 bytes  File Size  =    1251000 *
*Baskets :      120 : Basket Size=      21504 bytes  Compression=   1.00     *
*............................................................................*
*Br    2 :vlarge    : vector<int>                                            *
*Entries :     3000 : Total  Size=   12086607 bytes  File Size  =   12075970 *
*Baskets :      430 : Basket Size=      32000 bytes  Compression=   1.00     *
*............................................................................*
Cache size 2 for t2: 45000 zipbytes=14577970
largeWithSkip: Running test: skip=0 spl...
The rest of the test output was removed since it exceeds the threshold of 64000 bytes.