Hi John,
I've come across a problem with aggregation query. I've turned on debug
information and the log is attached. The data set contains only 4 rows and
10 columns, as you can see from the log. Similar queries of same type work
well.
If I can be of any further assistance when tracing this bug, please let me
know.
Thanks,
Petr
FastBit 2.0.2.1
Log started on Tue Apr 7 09:26:05 2015
fileManager::ctor found the physical memory size to be 8267825152 bytes
current data limit: 18446744073709551615 (soft), 18446744073709551615 (hard)
fileManager initialization complete -- maxBytes=4133912576, maxOpenFiles=768
part::readMetaData -- opened ./-part.txt for reading
Name = 259
Description = No description
Number_of_rows = 4
Number_of_columns = 10
Timestamp = 1424260508
END HEADER
read info about column 259.e0id1 @ 0x1232f20 (UINT)
part::readMetaData -- got column e0id1 from ./-part.txt
read info about column 259.e0id2 @ 0x1233a10 (UINT)
part::readMetaData -- got column e0id2 from ./-part.txt
read info about column 259.e0id11 @ 0x12330b0 (USHORT)
part::readMetaData -- got column e0id11 from ./-part.txt
read info about column 259.e0id27p0 @ 0x1233bb0 (ULONG)
part::readMetaData -- got column e0id27p0 from ./-part.txt
read info about column 259.e0id27p1 @ 0x1236830 (ULONG)
part::readMetaData -- got column e0id27p1 from ./-part.txt
read info about column 259.e0id28p0 @ 0x1236970 (ULONG)
part::readMetaData -- got column e0id28p0 from ./-part.txt
read info about column 259.e0id28p1 @ 0x1236b10 (ULONG)
part::readMetaData -- got column e0id28p1 from ./-part.txt
read info about column 259.e0id152 @ 0x1236cb0 (ULONG)
part::readMetaData -- got column e0id152 from ./-part.txt
read info about column 259.e0id153 @ 0x1236e50 (ULONG)
part::readMetaData -- got column e0id153 from ./-part.txt
read info about column 259.e007id1 @ 0x1236ff0 (TEXT)
part::readMetaData -- got column e007id1 from ./-part.txt
made a new copy of column 259.e007id1 @ 0x1237150 (TEXT)
clearing column 259.e007id1 @ 0x1236ff0
part[259]::readRIDs -- the file manager failed to read file "./-rids". There
is no RIDs.
Warning -- failed to read the content of ./-part.msk, fileManager::getFile
returned -101
part::init -- mask for partition 259 has 4 set bits out of 4
Constructed a part named 259
activeDir = "."
part: 259 (No description) with 4 rows, 10 columns
Column list:
e0id1: (UINT) [1.79769e+308, -1.79769e+308]
e0id11: (USHORT) [1.79769e+308, -1.79769e+308]
e0id152: (ULONG) [1.79769e+308, -1.79769e+308]
e0id153: (ULONG) [1.79769e+308, -1.79769e+308]
e0id2: (UINT) [1.79769e+308, -1.79769e+308]
e0id27p0: (ULONG) [1.79769e+308, -1.79769e+308]
e0id27p1: (ULONG) [1.79769e+308, -1.79769e+308]
e0id28p0: (ULONG) [1.79769e+308, -1.79769e+308]
e0id28p1: (ULONG) [1.79769e+308, -1.79769e+308]
e007id1: (STRING)
liga -- constructed table T-259 (a simple list of partition: 259) from a list
of 1 data partition, with 10 columns and 4 rows
Constructing selectClause @ 0x7fffb3795520
selectClause::parse cleared existing content before parsing "e0id11 as e0id11,
e0id27p0 as e0id27p0, e0id27p1 as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as
e0id28p1, e007id1 as e007id1, max(e0id153) as e0id153, min(e0id152) as e0id152,
sum(e0id1) as e0id1, sum(e0id2) as e0id2, count(*) as flows,"
selectClause::addRecursive -- adding term 0: e0id11
selectClause::addRecursive -- adding term 1: e0id27p0
selectClause::addRecursive -- adding term 2: e0id27p1
selectClause::addRecursive -- adding term 3: e0id28p0
selectClause::addRecursive -- adding term 4: e0id28p1
selectClause::addRecursive -- adding term 5: e007id1
selectClause::addAgregado -- adding term 6: MAX(e0id153)
selectClause::addAgregado -- adding term 7: MIN(e0id152)
selectClause::addAgregado -- adding term 8: SUM(e0id1)
selectClause::addAgregado -- adding term 9: SUM(e0id2)
selectClause::addAgregado -- adding term 10: COUNT(*)
selectClause::fillNames -- select clause internal details:
low-level expressions (names_[11], aggr_[11], atms_[11]):
0: e0id11, e0id11
1: e0id27p0, e0id27p0
2: e0id27p1, e0id27p1
3: e0id28p0, e0id28p0
4: e0id28p1, e0id28p1
5: e007id1, e007id1
6: __6, MAX(e0id153)
7: __7, MIN(e0id152)
8: __8, SUM(e0id1)
9: __9, SUM(e0id2)
10: __a, COUNT(*)
high-level expressions (xnames_[11], xtms_[11]):
0: e0id11, e0id11
1: e0id27p0, e0id27p0
2: e0id27p1, e0id27p1
3: e0id28p0, e0id28p0
4: e0id28p1, e0id28p1
5: e007id1, e007id1
6: e0id153, __6
7: e0id152, __7
8: e0id1, __8
9: e0id2, __9
10: flows, __a
whereClause::parse receives a new where clause "1 = 1"
qExpr::simplify -- input expression 1 == 1
qExpr::simplify -- output expression (@0x1239a40) 1 == 1
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) -- start timer ...
countQuery::setWhereClause accepted new query conditions "1 == 1"
initialized column MLvjW1.e0id11 @ 0x1239e10 (USHORT)
initialized bord::column MLvjW1.e0id11 @ 0x1239e10 (USHORT) from 0 value @ 0
initialized column MLvjW1.e0id27p0 @ 0x123a070 (ULONG)
initialized bord::column MLvjW1.e0id27p0 @ 0x123a070 (ULONG) from 0 value @ 0
initialized column MLvjW1.e0id27p1 @ 0x123a270 (ULONG)
initialized bord::column MLvjW1.e0id27p1 @ 0x123a270 (ULONG) from 0 value @ 0
initialized column MLvjW1.e0id28p0 @ 0x123a470 (ULONG)
initialized bord::column MLvjW1.e0id28p0 @ 0x123a470 (ULONG) from 0 value @ 0
initialized column MLvjW1.e0id28p1 @ 0x123a710 (ULONG)
initialized bord::column MLvjW1.e0id28p1 @ 0x123a710 (ULONG) from 0 value @ 0
initialized column MLvjW1.e007id1 @ 0x123a940 (TEXT)
initialized bord::column MLvjW1.e007id1 @ 0x123a940 (TEXT) from 0 value @ 0
initialized column MLvjW1.__6 @ 0x123ab40 (ULONG)
initialized bord::column MLvjW1.__6 @ 0x123ab40 (ULONG) from 0 value @ 0
initialized column MLvjW1.__7 @ 0x123ad70 (ULONG)
initialized bord::column MLvjW1.__7 @ 0x123ad70 (ULONG) from 0 value @ 0
initialized column MLvjW1.__8 @ 0x123afa0 (UINT)
initialized bord::column MLvjW1.__8 @ 0x123afa0 (UINT) from 0 value @ 0
initialized column MLvjW1.__9 @ 0x123b260 (UINT)
initialized bord::column MLvjW1.__9 @ 0x123b260 (UINT) from 0 value @ 0
initialized column MLvjW1.* @ 0x123b490 (UINT)
initialized bord::column MLvjW1.* @ 0x123b490 (UINT) from 0 value @ 0
Constructed in-memory data partition MLvjW1 -- filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1) -- with 11 columns
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) -- processing a select clause with 11 terms, 6 of which are plain
Temporary data will be stored in the following:
Table (in memory) MLvjW1 (filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1
data partition WHERE 1 == 1)) contsists of 11 columns and 0 row
e0id11 USHORT e0id11
e0id27p0 ULONG e0id27p0
e0id27p1 ULONG e0id27p1
e0id28p0 ULONG e0id28p0
e0id28p1 ULONG e0id28p1
e007id1 TEXT e007id1
__6 ULONG __6
__7 ULONG __7
__8 UINT __8
__9 UINT __9
* UINT count(*)
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) -- processing data partition 259
selectClause -- after simplification, select clause internal details:
low-level expressions (names_[11], aggr_[11], atms_[11]):
0: e0id11, e0id11
1: e0id27p0, e0id27p0
2: e0id27p1, e0id27p1
3: e0id28p0, e0id28p0
4: e0id28p1, e0id28p1
5: e007id1, e007id1
6: __6, MAX(e0id153)
7: __7, MIN(e0id152)
8: __8, SUM(e0id1)
9: __9, SUM(e0id2)
10: __a, COUNT(*)
high-level expressions (xnames_[11], xtms_[11]):
0: e0id11, e0id11
1: e0id27p0, e0id27p0
2: e0id27p1, e0id27p1
3: e0id28p0, e0id28p0
4: e0id28p1, e0id28p1
5: e007id1, e007id1
6: e0id153, __6
7: e0id152, __7
8: e0id1, __8
9: e0id2, __9
10: flows, __a
countQuery assigned data partition 259
countQuery::evaluate -- start timer ...
column[259.e0id11]::getNullMask -- get null mask (4, 4) [st.st_size=8, sz=4,
ierr=-101]
column[259.e0id11]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id27p0]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id27p0]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id27p1]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id27p1]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id28p0]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id28p0]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id28p1]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id28p1]::getNullMask -- mask size = 4, cnt = 4
column[259.e007id1]::getNullMask -- get null mask (4, 4) [st.st_size=35, sz=4,
ierr=-101]
column[259.e007id1]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id153]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id153]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id152]::getNullMask -- get null mask (4, 4) [st.st_size=32, sz=4,
ierr=-101]
column[259.e0id152]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id1]::getNullMask -- get null mask (4, 4) [st.st_size=16, sz=4,
ierr=-101]
column[259.e0id1]::getNullMask -- mask size = 4, cnt = 4
column[259.e0id2]::getNullMask -- get null mask (4, 4) [st.st_size=16, sz=4,
ierr=-101]
column[259.e0id2]::getNullMask -- mask size = 4, cnt = 4
countQuery::doEvaluate(1 == 1, mask.cnt()=4) --> 4, ierr = 4
From 259 Where 1 == 1 --> 4
countQuery::evaluate -- duration: 0 sec(CPU), 0.000316119 sec(elapsed)
bord[MLvjW1]::append -- to process 4 rows from partition 259, # of existing
rows = 0
colmap[16]
* --> 10 (*)
__6 --> 6 (e0id153)
__7 --> 7 (e0id152)
__8 --> 8 (e0id1)
__9 --> 9 (e0id2)
__a --> 10 (*)
e0id1 --> 8 (e0id1)
e0id11 --> 0 (e0id11)
e0id152 --> 7 (e0id152)
e0id153 --> 6 (e0id153)
e0id2 --> 9 (e0id2)
e0id27p0 --> 1 (e0id27p0)
e0id27p1 --> 2 (e0id27p1)
e0id28p0 --> 3 (e0id28p0)
e0id28p1 --> 4 (e0id28p1)
e007id1 --> 5 (e007id1)
bord[MLvjW1]::append is to add 4 elements to column "__6" from column "e0id153"
of partition 259
column[259.e0id153]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id153
fileManager::getFile(./e0id153) -- attempting to read ./e0id153 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id153" to 0x1236c10
fileManager::getFile(./e0id153) -- completed retrieving 32 bytes from ./e0id153
column[259.e0id153](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 9.31858e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "__7" from column "e0id152"
of partition 259
column[259.e0id152]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id152
fileManager::getFile(./e0id152) -- attempting to read ./e0id152 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id152" to 0x123b650
fileManager::getFile(./e0id152) -- completed retrieving 32 bytes from ./e0id152
column[259.e0id152](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 4.91422e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "__8" from column "e0id1"
of partition 259
column[259.e0id1]::selectValuesT<j> -- selecting 4 out of 4 values from ./e0id1
fileManager::getFile(./e0id1) -- attempting to read ./e0id1 (16 bytes)
roFile::doRead -- read 16 bytes from file "./e0id1" to 0x123baf0
fileManager::getFile(./e0id1) -- completed retrieving 16 bytes from ./e0id1
column[259.e0id1](UINT)::selectUInts -- retrieving 4 unsigned integers took
0.001 sec(CPU), 5.17778e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "__9" from column "e0id2"
of partition 259
column[259.e0id2]::selectValuesT<j> -- selecting 4 out of 4 values from ./e0id2
fileManager::getFile(./e0id2) -- attempting to read ./e0id2 (16 bytes)
roFile::doRead -- read 16 bytes from file "./e0id2" to 0x123bb50
fileManager::getFile(./e0id2) -- completed retrieving 16 bytes from ./e0id2
column[259.e0id2](UINT)::selectUInts -- retrieving 4 unsigned integers took 0
sec(CPU), 4.61382e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e0id11" from column
"e0id11" of partition 259
column[259.e0id11]::selectValuesT<t> -- selecting 4 out of 4 values from
./e0id11
fileManager::getFile(./e0id11) -- attempting to read ./e0id11 (8 bytes)
roFile::doRead -- read 8 bytes from file "./e0id11" to 0x123bc10
fileManager::getFile(./e0id11) -- completed retrieving 8 bytes from ./e0id11
column[259.e0id11](USHORT)::selectUShorts -- retrieving 4 integers took 0
sec(CPU), 6.69109e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e0id27p0" from column
"e0id27p0" of partition 259
column[259.e0id27p0]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id27p0
fileManager::getFile(./e0id27p0) -- attempting to read ./e0id27p0 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id27p0" to 0x123b160
fileManager::getFile(./e0id27p0) -- completed retrieving 32 bytes from
./e0id27p0
column[259.e0id27p0](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 8.26009e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e0id27p1" from column
"e0id27p1" of partition 259
column[259.e0id27p1]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id27p1
fileManager::getFile(./e0id27p1) -- attempting to read ./e0id27p1 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id27p1" to 0x1239f40
fileManager::getFile(./e0id27p1) -- completed retrieving 32 bytes from
./e0id27p1
column[259.e0id27p1](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 4.84963e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e0id28p0" from column
"e0id28p0" of partition 259
column[259.e0id28p0]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id28p0
fileManager::getFile(./e0id28p0) -- attempting to read ./e0id28p0 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id28p0" to 0x12401c0
fileManager::getFile(./e0id28p0) -- completed retrieving 32 bytes from
./e0id28p0
column[259.e0id28p0](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 5.59082e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e0id28p1" from column
"e0id28p1" of partition 259
column[259.e0id28p1]::selectValuesT<m> -- selecting 4 out of 4 values from
./e0id28p1
fileManager::getFile(./e0id28p1) -- attempting to read ./e0id28p1 (32 bytes)
roFile::doRead -- read 32 bytes from file "./e0id28p1" to 0x12399b0
fileManager::getFile(./e0id28p1) -- completed retrieving 32 bytes from
./e0id28p1
column[259.e0id28p1](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 5.38658e-05 sec(elapsed)
bord[MLvjW1]::append is to add 4 elements to column "e007id1" from column
"e007id1" of partition 259
text[259.e007id1]::startPositions -- start timer ...
text[259.e007id1]::startPositions located the starting positions of 4 new
strings, file ./e007id1.sp now has 5 64-bit integers (total 40 bytes)
text[259.e007id1]::startPositions -- duration: 0 sec(CPU), 9.3875e-05
sec(elapsed)
text[259.e007id1]::readStrings1 -- start timer ...
text[259.e007id1]::readStrings1 completed processing ./e007id1 to locate 4
string values, expected 4
text[259.e007id1]::readStrings1 -- duration: 0 sec(CPU), 4.33647e-05
sec(elapsed)
text[259.e007id1]::selectStrings read 4 strings, 4 expected
bord[MLvjW1]::append added 4 rows to make a total of 4
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) created an in-memory data partition with 4 rows and 11 columns
Table (in memory) MLvjW1 (filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1
data partition WHERE 1 == 1)) contsists of 11 columns and 4 rows
e0id11 USHORT e0id11
e0id27p0 ULONG e0id27p0
e0id27p1 ULONG e0id27p1
e0id28p0 ULONG e0id28p0
e0id28p1 ULONG e0id28p1
e007id1 TEXT e007id1
__6 ULONG __6
__7 ULONG __7
__8 UINT __8
__9 UINT __9
* UINT count(*)
43095, 2378471323237720321, 72340172859638073, 3099046060627202661,
72340172838076675, "", 1424260218205, 1424260217749, 14707, 13, 1
80, 3099046060627202661, 72340172838076675, 2378471323237720321,
72340172859638073, "www.google.com", 1424260217699, 1424260217592, 1033, 12, 1
42821, 2378471323237720321, 72340172859638073, 3099046060627202661,
72340172838076675, "", 1424260217699, 1424260217592, 32701, 25, 1
80, 3099046060627202661, 72340172838076675, 2378471323237720321,
72340172859638073, "www.wikipedia.org", 1424260218204, 1424260217749, 820, 9, 1
bord[MLvjW1]::evaluateTerms processing e0id11 as e0id11, e0id27p0 as e0id27p0,
e0id27p1 as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as
e007id1, max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows, on filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1) to produce an in-memory data
partition named MyRbs
bord[MLvjW1] -- evaluating "e0id11"
column[MLvjW1.e0id11]::selectValuesT<t> -- selecting 4 out of 4 values from
memory
bord[MLvjW1] -- evaluating "e0id27p0"
column[MLvjW1.e0id27p0]::selectValuesT<m> -- selecting 4 out of 4 values from
memory
bord[MLvjW1] -- evaluating "e0id27p1"
column[MLvjW1.e0id27p1]::selectValuesT<m> -- selecting 4 out of 4 values from
memory
bord[MLvjW1] -- evaluating "e0id28p0"
column[MLvjW1.e0id28p0]::selectValuesT<m> -- selecting 4 out of 4 values from
memory
bord[MLvjW1] -- evaluating "e0id28p1"
column[MLvjW1.e0id28p1]::selectValuesT<m> -- selecting 4 out of 4 values from
memory
bord[MLvjW1] -- evaluating "e007id1"
column[MLvjW1.e007id1](TEXT)::selectStrings -- retrieving 4 string values took
0 sec(CPU), 5.21122e-06 sec(elapsed)
bord[MLvjW1] -- evaluating "MAX(e0id153)"
Warning -- bord::evaluateTerms(e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1
as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1,
max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows, on filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1)) failed to find a column 6
named e0id153
bord[MLvjW1] -- evaluating "MIN(e0id152)"
Warning -- bord::evaluateTerms(e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1
as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1,
max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows, on filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1)) failed to find a column 7
named e0id152
bord[MLvjW1] -- evaluating "SUM(e0id1)"
Warning -- bord::evaluateTerms(e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1
as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1,
max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows, on filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1)) failed to find a column 8
named e0id1
bord[MLvjW1] -- evaluating "SUM(e0id2)"
Warning -- bord::evaluateTerms(e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1
as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1,
max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows, on filter::sift2(SELECT e0id11 as
e0id11, e0 ... FROM 1 data partition WHERE 1 == 1)) failed to find a column 9
named e0id2
bord[MLvjW1] -- evaluating "COUNT(*)"
initialized column MyRbs.e0id11 @ 0x123c940 (USHORT)
initialized bord::column MyRbs.e0id11 @ 0x123c940 (USHORT) from 4 values @
0x1239b00
initialized column MyRbs.e0id27p0 @ 0x123cb50 (ULONG)
initialized bord::column MyRbs.e0id27p0 @ 0x123cb50 (ULONG) from 4 values @
0x123c420
initialized column MyRbs.e0id27p1 @ 0x123cd30 (ULONG)
initialized bord::column MyRbs.e0id27p1 @ 0x123cd30 (ULONG) from 4 values @
0x1233290
initialized column MyRbs.e0id28p0 @ 0x123cef0 (ULONG)
initialized bord::column MyRbs.e0id28p0 @ 0x123cef0 (ULONG) from 4 values @
0x123c0a0
initialized column MyRbs.e0id28p1 @ 0x123d0e0 (ULONG)
initialized bord::column MyRbs.e0id28p1 @ 0x123d0e0 (ULONG) from 4 values @
0x123b740
initialized column MyRbs.e007id1 @ 0x123d2e0 (TEXT)
initialized bord::column MyRbs.e007id1 @ 0x123d2e0 (TEXT) from 4 values @
0x123b7b0
initialized column MyRbs.Q @ 0x123d480 (UINT)
initialized bord::column MyRbs.Q @ 0x123d480 (UINT) from 4 values @ 0x123c4a0
Constructed in-memory data partition MyRbs -- e0id11 as e0id11, e0id27p0 as
e0id27p0, e0id27p1 as e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1,
e007id1 as e007id1, max(e0id153) as e0id153, min(e0id152) as e0id152,
sum(e0id1) as e0id1, sum(e0id2) as e0id2, count(*) as flows, on
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) -- with 4 rows and 7 columns
e0id11, e0id27p0, e0id27p1, e0id28p0, e0id28p1,
e007id1, Q
43095, 2378471323237720321, 72340172859638073, 3099046060627202661,
72340172838076675, "", 1
80, 3099046060627202661, 72340172838076675, 2378471323237720321,
72340172859638073, "www.google.com", 1
42821, 2378471323237720321, 72340172859638073, 3099046060627202661,
72340172838076675, "", 1
80, 3099046060627202661, 72340172838076675, 2378471323237720321,
72340172859638073, "www.wikipedia.org", 1
bord::groupbya -- processing aggregations for "Select e0id11, e0id27p0,
e0id27p1, e0id28p0, e0id28p1, e007id1, MAX(e0id153), MIN(e0id152), SUM(e0id1),
SUM(e0id2), COUNT(*) From MyRbs"
bundles::ctor is to start a colValues for "e0id11" as cols[0] with data from
MyRbs.e0id11
column[MyRbs.e0id11](USHORT)::selectUShorts -- retrieving 4 unsigned integers
took 0 sec(CPU), 4.71622e-06 sec(elapsed)
bundles::ctor created a colValues for "e0id11" as cols[0] with size 4
bundles::ctor is to start a colValues for "e0id27p0" as cols[1] with data from
MyRbs.e0id27p0
column[MyRbs.e0id27p0](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 3.74904e-06 sec(elapsed)
bundles::ctor created a colValues for "e0id27p0" as cols[1] with size 4
bundles::ctor is to start a colValues for "e0id27p1" as cols[2] with data from
MyRbs.e0id27p1
column[MyRbs.e0id27p1](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 3.11481e-06 sec(elapsed)
bundles::ctor created a colValues for "e0id27p1" as cols[2] with size 4
bundles::ctor is to start a colValues for "e0id28p0" as cols[3] with data from
MyRbs.e0id28p0
column[MyRbs.e0id28p0](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 2.97884e-06 sec(elapsed)
bundles::ctor created a colValues for "e0id28p0" as cols[3] with size 4
bundles::ctor is to start a colValues for "e0id28p1" as cols[4] with data from
MyRbs.e0id28p1
column[MyRbs.e0id28p1](ULONG)::selectULongs -- retrieving 4 integers took 0
sec(CPU), 2.86894e-06 sec(elapsed)
bundles::ctor created a colValues for "e0id28p1" as cols[4] with size 4
bundles::ctor is to start a colValues for "e007id1" as cols[5] with data from
MyRbs.e007id1
column[MyRbs.e007id1](TEXT)::selectStrings -- retrieving 4 string values took 0
sec(CPU), 2.00188e-06 sec(elapsed)
bundles::ctor created a colValues for "e007id1" as cols[5] with size 4
bundles[MyRbs] -- clearing 6 colValue objects
Warning -- bundles(MyRbs, e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1 as
e0id27p1, e0id28p0 as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1,
max(e0id153) as e0id153, min(e0id152) as e0id152, sum(e0id1) as e0id1,
sum(e0id2) as e0id2, count(*) as flows,) can not find a column named __6
Error -- bundles::ctor received an exception, start cleaning up
bundles[MyRbs] -- clearing 0 colValue object
Warning -- bord::groupbya failed to create bundle for "Select e0id11, e0id27p0,
e0id27p1, e0id28p0, e0id28p1, e007id1, MAX(e0id153), MIN(e0id152), SUM(e0id1),
SUM(e0id2), COUNT(*) From MyRbs"
bord::clear -- clearing MyRbs
clearing data partition MyRbs
clearing column MyRbs.e0id11 @ 0x123c940
clearing column MyRbs.e0id27p0 @ 0x123cb50
clearing column MyRbs.e0id27p1 @ 0x123cd30
clearing column MyRbs.e0id28p0 @ 0x123cef0
clearing column MyRbs.e0id28p1 @ 0x123d0e0
clearing column MyRbs.e007id1 @ 0x123d2e0
clearing column MyRbs.Q @ 0x123d480
bord::clear -- clearing MLvjW1
clearing data partition MLvjW1
clearing column MLvjW1.* @ 0x123b490
clearing column MLvjW1.__6 @ 0x123ab40
clearing column MLvjW1.__7 @ 0x123ad70
clearing column MLvjW1.__8 @ 0x123afa0
clearing column MLvjW1.__9 @ 0x123b260
clearing column MLvjW1.e0id11 @ 0x1239e10
clearing column MLvjW1.e0id27p0 @ 0x123a070
clearing column MLvjW1.e0id27p1 @ 0x123a270
clearing column MLvjW1.e0id28p0 @ 0x123a470
clearing column MLvjW1.e0id28p1 @ 0x123a710
clearing column MLvjW1.e007id1 @ 0x123a940
filter::sift2(SELECT e0id11 as e0id11, e0 ... FROM 1 data partition WHERE 1 ==
1) -- duration: 0.003 sec(CPU), 0.00296491 sec(elapsed)
Freeing selectClause @ 0x7fffb3795520
clearing data partition 259
clearing column 259.e0id1 @ 0x1232f20
clearing column 259.e0id11 @ 0x12330b0
clearing column 259.e0id152 @ 0x1236cb0
clearing column 259.e0id153 @ 0x1236e50
clearing column 259.e0id2 @ 0x1233a10
clearing column 259.e0id27p0 @ 0x1233bb0
clearing column 259.e0id27p1 @ 0x1236830
clearing column 259.e0id28p0 @ 0x1236970
clearing column 259.e0id28p1 @ 0x1236b10
clearing column 259.e007id1 @ 0x1237150
Select 'e0id11 as e0id11, e0id27p0 as e0id27p0, e0id27p1 as e0id27p1, e0id28p0
as e0id28p0, e0id28p1 as e0id28p1, e007id1 as e007id1, max(e0id153) as e0id153,
min(e0id152) as e0id152, sum(e0id1) as e0id1, sum(e0id2) as e0id2, count(*) as
flows,' with filter '1 = 1' failed
fileManager::clear -- starting ...
--- Tue Apr 7 09:26:05 2015
The number of memory mapped files is 0. (max = 768)
Size of all mapped files is 0
The number of files read into memory is 9
file name: ./e0id1
storage @ 0x123be60, 0x123baf0, 1st 32 bits = 3973, 1st 64 bits = 40900003973
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 16 # of past acc 2 # of active acc 0
file name: ./e0id11
storage @ 0x123bb90, 0x123bc10, 1st 32 bits = 50a857, 1st 64 bits =
50a7450050a857
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 8 # of past acc 4 # of active acc 0
file name: ./e0id152
storage @ 0x123be00, 0x123b650, 1st 32 bits = 9c863b95, 1st 64 bits =
14b9c863b95
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 2 # of active acc 0
file name: ./e0id153
storage @ 0x123bda0, 0x1236c10, 1st 32 bits = 9c863d5d, 1st 64 bits =
14b9c863d5d
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 2 # of active acc 0
file name: ./e0id2
storage @ 0x123c0f0, 0x123bb50, 1st 32 bits = d, 1st 64 bits = c0000000d
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 16 # of past acc 2 # of active acc 0
file name: ./e0id27p0
storage @ 0x123bc50, 0x123b160, 1st 32 bits = 1a09a101, 1st 64 bits =
210207111a09a101
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 4 # of active acc 0
file name: ./e0id27p1
storage @ 0x123c150, 0x1239f40, 1st 32 bits = 24a0139, 1st 64 bits =
1010101024a0139
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 4 # of active acc 0
file name: ./e0id28p0
storage @ 0x123c1b0, 0x12401c0, 1st 32 bits = 2421265, 1st 64 bits =
2b0205f902421265
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 4 # of active acc 0
file name: ./e0id28p1
storage @ 0x123c440, 0x12399b0, 1st 32 bits = 1010103, 1st 64 bits =
101010101010103
mapped n opened at Tue Apr 7 09:26:05 2015 last
used at Tue Apr 7 09:26:05 2015
# of bytes 32 # of past acc 4 # of active acc 0
The total size of all files read into memory is 232
Size of all named storages is 232
Size of all unnamed storages is 0
The total size of all named and unnamed storages is 232
The prescribed maximum size is 4,133,912,576
Number of pages accessed (recorded so far) is 13 (page size = 4096)
fileManager::unload -- to free up all unused space (totalBytes=232,
maxBytes=4,133,912,576)
fileManager::unload -- to unload all (9) inactive files
fileManager::unload ./e0id27p1
fileManager::unload ./e0id27p0
fileManager::unload ./e0id28p1
fileManager::unload ./e0id28p0
fileManager::unload ./e0id11
fileManager::unload ./e0id152
fileManager::unload ./e0id153
fileManager::unload ./e0id1
fileManager::unload ./e0id2
fileManager::clear -- completed with 0 byte of storage remain in memory after
removing all managed objects
fileManager decommissioned
_______________________________________________
FastBit-users mailing list
[email protected]
https://hpcrdm.lbl.gov/cgi-bin/mailman/listinfo/fastbit-users
