See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/351/changes
------------------------------------------
[...truncated 48796 lines...]
[junit] 2007-12-31 13:17:39,108 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(601): starting r2,,1199107058702/d (347143206/d) (no
reconstruction log)
[junit] 2007-12-31 13:17:39,111 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(629): maximum sequence id for hstore r2,,1199107058702/d
(347143206/d) is -1
[junit] 2007-12-31 13:17:39,258 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(601): starting r2,,1199107058702/e (347143206/e) (no
reconstruction log)
[junit] 2007-12-31 13:17:39,261 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(629): maximum sequence id for hstore r2,,1199107058702/e
(347143206/e) is -1
[junit] 2007-12-31 13:17:39,262 DEBUG [IPC Server handler 4 on 60000]
hbase.HRegion(300): Next sequence id for region r2,,1199107058702 is 0
[junit] 2007-12-31 13:17:39,264 INFO [IPC Server handler 4 on 60000]
hbase.HRegion(328): region r2,,1199107058702 available
[junit] 2007-12-31 13:17:39,266 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(880): closed r2,,1199107058702/e (347143206/e)
[junit] 2007-12-31 13:17:39,266 DEBUG [IPC Server handler 4 on 60000]
hbase.HStore(880): closed r2,,1199107058702/d (347143206/d)
[junit] 2007-12-31 13:17:39,267 INFO [IPC Server handler 4 on 60000]
hbase.HRegion(430): closed r2,,1199107058702
[junit] 2007-12-31 13:17:39,267 DEBUG [IPC Server handler 4 on 60000]
hbase.HLog(399): closing log writer in /hbase/hregion_347143206/log
[junit] 2007-12-31 13:17:39,734 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region -ROOT-,,0. Size 92.0
[junit] 2007-12-31 13:17:39,953 INFO [IPC Server handler 4 on 60000]
hbase.HMaster(2547): created table r2
[junit] 2007-12-31 13:17:39,954 DEBUG [main]
hbase.HConnectionManager$TableServers(308): No servers for r2. Doing a find...
[junit] 2007-12-31 13:17:39,958 DEBUG [main]
hbase.HConnectionManager$TableServers(778): no server address for regionname:
r2,,1199107058702, startKey: <>, encodedName(347143206) tableDesc: {name: r2,
families: {d:={name: d, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}, e:={name: e, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}}
[junit] 2007-12-31 13:17:39,959 DEBUG [main]
hbase.HConnectionManager$TableServers(676): Sleeping. Table r2 not currently
being served.
[junit] 2007-12-31 13:17:40,508 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 70236052/info/2321728754829859779 with 2 entries,
sequence id 23, and size 230.0 for -ROOT-,,0/info
[junit] 2007-12-31 13:17:40,509 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region -ROOT-,,0 in 775ms,
sequenceid=23
[junit] 2007-12-31 13:17:40,510 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore -ROOT-,,0/info not needed.
[junit] 2007-12-31 13:17:40,510 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region -ROOT-,,0 does not need compaction
[junit] 2007-12-31 13:17:40,784 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(211): HMaster.rootScanner scanning meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:17:40,785 INFO [IPC Server handler 1 on 60000]
hbase.HMaster(1858): assigning region r2,,1199107058702 to the only server
140.211.11.75:37011
[junit] 2007-12-31 13:17:40,786 INFO [RegionServer:0.worker]
hbase.HRegionServer$Worker(1153): MSG_REGION_OPEN : r2,,1199107058702
[junit] 2007-12-31 13:17:40,790 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting r2,,1199107058702/d (347143206/d) (no
reconstruction log)
[junit] 2007-12-31 13:17:40,793 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore r2,,1199107058702/d
(347143206/d) is -1
[junit] 2007-12-31 13:17:40,798 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting r2,,1199107058702/e (347143206/e) (no
reconstruction log)
[junit] 2007-12-31 13:17:40,801 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore r2,,1199107058702/e
(347143206/e) is -1
[junit] 2007-12-31 13:17:40,802 DEBUG [RegionServer:0.worker]
hbase.HRegion(300): Next sequence id for region r2,,1199107058702 is 0
[junit] 2007-12-31 13:17:40,805 INFO [RegionServer:0.worker]
hbase.HRegion(328): region r2,,1199107058702 available
[junit] 2007-12-31 13:17:40,813 DEBUG [HMaster.rootScanner]
hbase.HMaster$BaseScanner(247): HMaster.rootScanner regioninfo: {regionname:
.META.,,1, startKey: <>, encodedName(1028785192) tableDesc: {name: .META.,
families: {info:={name: info, max versions: 1, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}}}, server:
140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:17:40,819 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(293): HMaster.rootScanner scan of meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:17:41,714 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region .META.,,1. Size 364.0
[junit] 2007-12-31 13:17:41,795 DEBUG [IPC Server handler 2 on 60000]
hbase.HMaster(1516): Received MSG_REPORT_PROCESS_OPEN : r2,,1199107058702 from
140.211.11.75:37011
[junit] 2007-12-31 13:17:41,795 DEBUG [IPC Server handler 2 on 60000]
hbase.HMaster(1516): Received MSG_REPORT_OPEN : r2,,1199107058702 from
140.211.11.75:37011
[junit] 2007-12-31 13:17:41,796 INFO [IPC Server handler 2 on 60000]
hbase.HMaster(1577): 140.211.11.75:37011 serving r2,,1199107058702
[junit] 2007-12-31 13:17:41,796 DEBUG [HMaster] hbase.HMaster(1055): Main
processing loop: PendingOpenOperation from 140.211.11.75:37011
[junit] 2007-12-31 13:17:41,796 INFO [HMaster]
hbase.HMaster$ProcessRegionOpen(2458): regionname: r2,,1199107058702, startKey:
<>, encodedName(347143206) tableDesc: {name: r2, families: {d:={name: d, max
versions: 3, compression: NONE, in memory: false, max length: 2147483647, bloom
filter: none}, e:={name: e, max versions: 3, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}} open on 140.211.11.75:37011
[junit] 2007-12-31 13:17:41,797 DEBUG [HMaster]
hbase.HMaster$RegionServerOperation(1907): numberOfMetaRegions: 1,
onlineMetaRegions.size(): 1
[junit] 2007-12-31 13:17:41,797 INFO [HMaster]
hbase.HMaster$ProcessRegionOpen(2472): updating row r2,,1199107058702 in table
.META.,,1 with startcode 1199107049117 and server 140.211.11.75:37011
[junit] 2007-12-31 13:17:42,724 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(211): HMaster.metaScanner scanning meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:17:42,734 WARN [HMaster.metaScanner]
hbase.HMaster$BaseScanner(238): info:regioninfo is empty; has keys:
[r2,,1199107058702/info:serverstartcode/1199107061797,
r2,,1199107058702/info:server/1199107061797]
[junit] 2007-12-31 13:17:42,736 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(293): HMaster.metaScanner scan of meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:17:42,736 INFO [HMaster.metaScanner]
hbase.HMaster$MetaScanner(763): all meta regions scanned
[junit] 2007-12-31 13:17:43,669 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 1028785192/info/3231676785541596388 with 4 entries,
sequence id 24, and size 530.0 for .META.,,1/info
[junit] 2007-12-31 13:17:43,669 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region .META.,,1 in 1955ms,
sequenceid=24
[junit] 2007-12-31 13:17:43,670 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-31 13:17:43,670 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region .META.,,1 does not need compaction
[junit] 2007-12-31 13:17:43,753 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region r1,,1199107049137. Size
310.0
[junit] 2007-12-31 13:17:44,877 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 922550440/a/3056363259608155180 with 5 entries,
sequence id 27, and size 270.0 for r1,,1199107049137/a
[junit] 2007-12-31 13:17:44,963 DEBUG [main]
hbase.HConnectionManager$TableServers(685): Wake. Retry finding table r2
[junit] 2007-12-31 13:17:44,978 DEBUG [main]
hbase.HConnectionManager$TableServers(728): Found 1 region(s) for r2 at
address: 140.211.11.75:37011, regioninfo: regionname: .META.,,1, startKey: <>,
encodedName(1028785192) tableDesc: {name: .META., families: {info:={name: info,
max versions: 1, compression: NONE, in memory: false, max length: 2147483647,
bloom filter: none}}}
[junit] 2007-12-31 13:17:45,294 INFO [IPC Server handler 1 on 60000]
hbase.HLog(313): new log writer created at
/hbase/hregion_267448769/log/hlog.dat.000
[junit] 2007-12-31 13:17:45,585 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(601): starting result_table,,1199107064984/a (267448769/a) (no
reconstruction log)
[junit] 2007-12-31 13:17:45,587 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/a
(267448769/a) is -1
[junit] 2007-12-31 13:17:45,806 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(601): starting result_table,,1199107064984/b (267448769/b) (no
reconstruction log)
[junit] 2007-12-31 13:17:45,808 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/b
(267448769/b) is -1
[junit] 2007-12-31 13:17:45,869 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 922550440/b/4344510381853337059 with 5 entries,
sequence id 27, and size 270.0 for r1,,1199107049137/b
[junit] 2007-12-31 13:17:46,060 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(601): starting result_table,,1199107064984/c (267448769/c) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,062 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/c
(267448769/c) is -1
[junit] 2007-12-31 13:17:46,310 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(601): starting result_table,,1199107064984/d (267448769/d) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,312 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/d
(267448769/d) is -1
[junit] 2007-12-31 13:17:46,501 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(601): starting result_table,,1199107064984/e (267448769/e) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,504 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/e
(267448769/e) is -1
[junit] 2007-12-31 13:17:46,505 DEBUG [IPC Server handler 1 on 60000]
hbase.HRegion(300): Next sequence id for region result_table,,1199107064984 is 0
[junit] 2007-12-31 13:17:46,506 INFO [IPC Server handler 1 on 60000]
hbase.HRegion(328): region result_table,,1199107064984 available
[junit] 2007-12-31 13:17:46,509 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(880): closed result_table,,1199107064984/e (267448769/e)
[junit] 2007-12-31 13:17:46,509 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(880): closed result_table,,1199107064984/d (267448769/d)
[junit] 2007-12-31 13:17:46,509 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(880): closed result_table,,1199107064984/a (267448769/a)
[junit] 2007-12-31 13:17:46,510 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(880): closed result_table,,1199107064984/b (267448769/b)
[junit] 2007-12-31 13:17:46,510 DEBUG [IPC Server handler 1 on 60000]
hbase.HStore(880): closed result_table,,1199107064984/c (267448769/c)
[junit] 2007-12-31 13:17:46,510 INFO [IPC Server handler 1 on 60000]
hbase.HRegion(430): closed result_table,,1199107064984
[junit] 2007-12-31 13:17:46,511 DEBUG [IPC Server handler 1 on 60000]
hbase.HLog(399): closing log writer in /hbase/hregion_267448769/log
[junit] 2007-12-31 13:17:46,777 INFO [IPC Server handler 1 on 60000]
hbase.HMaster(2547): created table result_table
[junit] 2007-12-31 13:17:46,778 DEBUG [main]
hbase.HConnectionManager$TableServers(308): No servers for result_table. Doing
a find...
[junit] 2007-12-31 13:17:46,828 DEBUG [main]
hbase.HConnectionManager$TableServers(778): no server address for regionname:
result_table,,1199107064984, startKey: <>, encodedName(267448769) tableDesc:
{name: result_table, families: {a:={name: a, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, b:={name:
b, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, c:={name: c, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, d:={name:
d, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, e:={name: e, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}}}
[junit] 2007-12-31 13:17:46,829 DEBUG [main]
hbase.HConnectionManager$TableServers(676): Sleeping. Table result_table not
currently being served.
[junit] 2007-12-31 13:17:46,844 INFO [IPC Server handler 3 on 60000]
hbase.HMaster(1858): assigning region result_table,,1199107064984 to the only
server 140.211.11.75:37011
[junit] 2007-12-31 13:17:46,845 INFO [RegionServer:0.worker]
hbase.HRegionServer$Worker(1153): MSG_REGION_OPEN : result_table,,1199107064984
[junit] 2007-12-31 13:17:46,849 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting result_table,,1199107064984/a (267448769/a) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,851 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/a
(267448769/a) is -1
[junit] 2007-12-31 13:17:46,857 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting result_table,,1199107064984/b (267448769/b) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,859 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/b
(267448769/b) is -1
[junit] 2007-12-31 13:17:46,862 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting result_table,,1199107064984/c (267448769/c) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,864 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/c
(267448769/c) is -1
[junit] 2007-12-31 13:17:46,869 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting result_table,,1199107064984/d (267448769/d) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,871 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/d
(267448769/d) is -1
[junit] 2007-12-31 13:17:46,876 DEBUG [RegionServer:0.worker]
hbase.HStore(601): starting result_table,,1199107064984/e (267448769/e) (no
reconstruction log)
[junit] 2007-12-31 13:17:46,878 DEBUG [RegionServer:0.worker]
hbase.HStore(629): maximum sequence id for hstore result_table,,1199107064984/e
(267448769/e) is -1
[junit] 2007-12-31 13:17:46,879 DEBUG [RegionServer:0.worker]
hbase.HRegion(300): Next sequence id for region result_table,,1199107064984 is 0
[junit] 2007-12-31 13:17:46,880 INFO [RegionServer:0.worker]
hbase.HRegion(328): region result_table,,1199107064984 available
[junit] 2007-12-31 13:17:46,927 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 922550440/c/4747646899221343448 with 5 entries,
sequence id 27, and size 310.0 for r1,,1199107049137/c
[junit] 2007-12-31 13:17:46,928 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region r1,,1199107049137 in
3175ms, sequenceid=27
[junit] 2007-12-31 13:17:46,928 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore r1,,1199107049137/a not needed.
[junit] 2007-12-31 13:17:46,928 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore r1,,1199107049137/b not needed.
[junit] 2007-12-31 13:17:46,929 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore r1,,1199107049137/c not needed.
[junit] 2007-12-31 13:17:46,929 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region r1,,1199107049137 does not need compaction
[junit] 2007-12-31 13:17:47,854 DEBUG [IPC Server handler 0 on 60000]
hbase.HMaster(1516): Received MSG_REPORT_PROCESS_OPEN :
result_table,,1199107064984 from 140.211.11.75:37011
[junit] 2007-12-31 13:17:47,855 DEBUG [IPC Server handler 0 on 60000]
hbase.HMaster(1516): Received MSG_REPORT_OPEN : result_table,,1199107064984
from 140.211.11.75:37011
[junit] 2007-12-31 13:17:47,855 INFO [IPC Server handler 0 on 60000]
hbase.HMaster(1577): 140.211.11.75:37011 serving result_table,,1199107064984
[junit] 2007-12-31 13:17:47,856 DEBUG [HMaster] hbase.HMaster(1055): Main
processing loop: PendingOpenOperation from 140.211.11.75:37011
[junit] 2007-12-31 13:17:47,856 INFO [HMaster]
hbase.HMaster$ProcessRegionOpen(2458): regionname: result_table,,1199107064984,
startKey: <>, encodedName(267448769) tableDesc: {name: result_table, families:
{a:={name: a, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, b:={name: b, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, c:={name:
c, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, d:={name: d, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, e:={name:
e, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}}} open on 140.211.11.75:37011
[junit] 2007-12-31 13:17:47,857 DEBUG [HMaster]
hbase.HMaster$RegionServerOperation(1907): numberOfMetaRegions: 1,
onlineMetaRegions.size(): 1
[junit] 2007-12-31 13:17:47,857 INFO [HMaster]
hbase.HMaster$ProcessRegionOpen(2472): updating row result_table,,1199107064984
in table .META.,,1 with startcode 1199107049117 and server 140.211.11.75:37011
[junit] 2007-12-31 13:17:50,793 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(211): HMaster.rootScanner scanning meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:17:50,812 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region r2,,1199107058702. Size
132.0
[junit] 2007-12-31 13:17:50,826 DEBUG [HMaster.rootScanner]
hbase.HMaster$BaseScanner(247): HMaster.rootScanner regioninfo: {regionname:
.META.,,1, startKey: <>, encodedName(1028785192) tableDesc: {name: .META.,
families: {info:={name: info, max versions: 1, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}}}, server:
140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:17:50,829 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(293): HMaster.rootScanner scan of meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:17:51,832 DEBUG [main]
hbase.HConnectionManager$TableServers(685): Wake. Retry finding table
result_table
[junit] 2007-12-31 13:17:51,848 DEBUG [main]
hbase.HConnectionManager$TableServers(728): Found 1 region(s) for result_table
at address: 140.211.11.75:37011, regioninfo: regionname: .META.,,1, startKey:
<>, encodedName(1028785192) tableDesc: {name: .META., families: {info:={name:
info, max versions: 1, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}}}
[junit] 2007-12-31 13:17:52,236 WARN [IPC Server handler 1 on 36988]
dfs.FSDirectory(400): DIR* FSDirectory.unprotectedDelete: failed to remove
/user/hudson/build/contrib/hbase/test/system because it does not exist
[junit] 2007-12-31 13:17:52,562 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 347143206/e/6532525785356112226 with 3 entries,
sequence id 37, and size 218.0 for r2,,1199107058702/e
[junit] 2007-12-31 13:17:52,755 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(211): HMaster.metaScanner scanning meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:17:52,825 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
r1,,1199107049137, startKey: <>, encodedName(922550440) tableDesc: {name: r1,
families: {a:={name: a, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}, b:={name: b, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}, c:={name: c, max versions: 3, compression: NONE, in memory: false, max
length: 2147483647, bloom filter: none}}}}, server: 140.211.11.75:37011,
startCode: 1199107049117
[junit] 2007-12-31 13:17:52,829 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
r2,,1199107058702, startKey: <>, encodedName(347143206) tableDesc: {name: r2,
families: {d:={name: d, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}, e:={name: e, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}}}, server: 140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:17:52,831 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
result_table,,1199107064984, startKey: <>, encodedName(267448769) tableDesc:
{name: result_table, families: {a:={name: a, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, b:={name:
b, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, c:={name: c, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, d:={name:
d, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, e:={name: e, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}}}}, server:
140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:17:52,834 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(293): HMaster.metaScanner scan of meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:17:52,834 INFO [HMaster.metaScanner]
hbase.HMaster$MetaScanner(763): all meta regions scanned
[junit] 2007-12-31 13:17:54,123 WARN [IPC Server handler 3 on 36988]
dfs.FSDirectory(400): DIR* FSDirectory.unprotectedDelete: failed to remove
/user/hudson/build/contrib/hbase/test/system/job_local_1 because it does not
exist
[junit] 2007-12-31 13:17:54,125 WARN [main] mapred.JobClient(496): No job
jar file set. User classes may not be found. See JobConf(Class) or
JobConf#setJar(String).
[junit] 2007-12-31 13:17:54,168 DEBUG [main]
hbase.HConnectionManager$TableServers(308): No servers for r1. Doing a find...
[junit] 2007-12-31 13:17:54,219 DEBUG [main]
hbase.HConnectionManager$TableServers(759): Found 1 servers for table r1
[junit] 2007-12-31 13:17:54,249 DEBUG [main] mapred.TableInputFormat(175):
split: 0->r1,,
[junit] 2007-12-31 13:17:54,683 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 347143206/d/7348942903137327137 with 3 entries,
sequence id 37, and size 218.0 for r2,,1199107058702/d
[junit] 2007-12-31 13:17:54,684 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region r2,,1199107058702 in
3872ms, sequenceid=37
[junit] 2007-12-31 13:17:54,684 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore r2,,1199107058702/e not needed.
[junit] 2007-12-31 13:17:54,684 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region .META.,,1. Size 439.0
[junit] 2007-12-31 13:17:54,684 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore r2,,1199107058702/d not needed.
[junit] 2007-12-31 13:17:54,686 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region r2,,1199107058702 does not need compaction
[junit] 2007-12-31 13:17:55,296 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 1028785192/info/5956398320316659128 with 5 entries,
sequence id 38, and size 619.0 for .META.,,1/info
[junit] 2007-12-31 13:17:55,296 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region .META.,,1 in 612ms,
sequenceid=38
[junit] 2007-12-31 13:17:55,297 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-31 13:17:55,297 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region .META.,,1 does not need compaction
[junit] 2007-12-31 13:17:55,359 DEBUG [Thread-192]
mapred.TableInputFormat(175): split: 0->r1,,
[junit] 2007-12-31 13:17:55,643 DEBUG [Thread-192]
hbase.HConnectionManager$TableServers(308): No servers for r2. Doing a find...
[junit] 2007-12-31 13:17:55,666 DEBUG [Thread-192]
hbase.HConnectionManager$TableServers(759): Found 1 servers for table r2
[junit] 2007-12-31 13:17:57,086 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(837): Started memcache flush for region
result_table,,1199107064984. Size 306.0
[junit] 2007-12-31 13:17:57,443 WARN [Task Commit Thread]
mapred.JobTracker$TaskCommitQueue(2032): Task Commit Thread exiting...
[junit] 2007-12-31 13:17:58,960 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 267448769/e/6013730320729459657 with 3 entries,
sequence id 54, and size 212.0 for result_table,,1199107064984/e
[junit] 2007-12-31 13:17:59,709 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 267448769/d/2991612619063617492 with 3 entries,
sequence id 54, and size 212.0 for result_table,,1199107064984/d
[junit] 2007-12-31 13:18:00,378 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 267448769/a/7635498640604229061 with 3 entries,
sequence id 54, and size 206.0 for result_table,,1199107064984/a
[junit] 2007-12-31 13:18:00,801 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(211): HMaster.rootScanner scanning meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:18:00,840 DEBUG [HMaster.rootScanner]
hbase.HMaster$BaseScanner(247): HMaster.rootScanner regioninfo: {regionname:
.META.,,1, startKey: <>, encodedName(1028785192) tableDesc: {name: .META.,
families: {info:={name: info, max versions: 1, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}}}, server:
140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:18:00,842 INFO [HMaster.rootScanner]
hbase.HMaster$BaseScanner(293): HMaster.rootScanner scan of meta region
{regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:18:01,437 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 267448769/b/1651761746381397428 with 3 entries,
sequence id 54, and size 206.0 for result_table,,1199107064984/b
[junit] 2007-12-31 13:18:02,341 DEBUG [RegionServer:0.cacheFlusher]
hbase.HStore(972): Added 267448769/c/5200785515031915841 with 3 entries,
sequence id 54, and size 230.0 for result_table,,1199107064984/c
[junit] 2007-12-31 13:18:02,342 DEBUG [RegionServer:0.cacheFlusher]
hbase.HRegion(943): Finished memcache flush for region
result_table,,1199107064984 in 5366ms, sequenceid=54
[junit] 2007-12-31 13:18:02,342 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore result_table,,1199107064984/e not
needed.
[junit] 2007-12-31 13:18:02,343 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore result_table,,1199107064984/d not
needed.
[junit] 2007-12-31 13:18:02,343 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore result_table,,1199107064984/a not
needed.
[junit] 2007-12-31 13:18:02,343 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore result_table,,1199107064984/b not
needed.
[junit] 2007-12-31 13:18:02,343 DEBUG [RegionServer:0.compactor]
hbase.HStore(996): compaction for HStore result_table,,1199107064984/c not
needed.
[junit] 2007-12-31 13:18:02,344 DEBUG [RegionServer:0.compactor]
hbase.HRegion(707): region result_table,,1199107064984 does not need compaction
[junit] 2007-12-31 13:18:02,741 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(211): HMaster.metaScanner scanning meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011}
[junit] 2007-12-31 13:18:02,766 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
r1,,1199107049137, startKey: <>, encodedName(922550440) tableDesc: {name: r1,
families: {a:={name: a, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}, b:={name: b, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}, c:={name: c, max versions: 3, compression: NONE, in memory: false, max
length: 2147483647, bloom filter: none}}}}, server: 140.211.11.75:37011,
startCode: 1199107049117
[junit] 2007-12-31 13:18:02,768 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
r2,,1199107058702, startKey: <>, encodedName(347143206) tableDesc: {name: r2,
families: {d:={name: d, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}, e:={name: e, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}}}, server: 140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:18:02,770 DEBUG [HMaster.metaScanner]
hbase.HMaster$BaseScanner(247): HMaster.metaScanner regioninfo: {regionname:
result_table,,1199107064984, startKey: <>, encodedName(267448769) tableDesc:
{name: result_table, families: {a:={name: a, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, b:={name:
b, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, c:={name: c, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}, d:={name:
d, max versions: 3, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}, e:={name: e, max versions: 3, compression:
NONE, in memory: false, max length: 2147483647, bloom filter: none}}}}, server:
140.211.11.75:37011, startCode: 1199107049117
[junit] 2007-12-31 13:18:02,772 INFO [HMaster.metaScanner]
hbase.HMaster$BaseScanner(293): HMaster.metaScanner scan of meta region
{regionname: .META.,,1, startKey: <>, server: 140.211.11.75:37011} complete
[junit] 2007-12-31 13:18:02,772 INFO [HMaster.metaScanner]
hbase.HMaster$MetaScanner(763): all meta regions scanned
[junit] 2007-12-31 13:18:07,494 INFO [main]
algebra.TestTableJoinMapReduce(239): result_table.column.size: 5
[junit] 2007-12-31 13:18:07,497 INFO [main]
algebra.TestTableJoinMapReduce(239): result_table.column.size: 5
[junit] 2007-12-31 13:18:07,498 INFO [main]
algebra.TestTableJoinMapReduce(239): result_table.column.size: 5
[junit] 2007-12-31 13:18:07,500 INFO [main]
algebra.TestTableJoinMapReduce(244): result_table.row.count: 3
[junit] 2007-12-31 13:18:07,501 DEBUG [main] hbase.LocalHBaseCluster(212):
Shutting down HBase Cluster
[junit] 2007-12-31 13:18:07,502 INFO [main] hbase.HMaster(2526): Cluster
shutdown requested. Starting to quiesce servers
[junit] 2007-12-31 13:18:07,542 INFO [RegionServer:0]
hbase.HRegionServer(774): Got quiesce server message
[junit] 2007-12-31 13:18:07,542 INFO [RegionServer:0.worker]
hbase.HRegionServer$Worker(1153): MSG_REGIONSERVER_QUIESCE :
[junit] 2007-12-31 13:18:07,543 DEBUG [RegionServer:0.worker]
hbase.HRegionServer(1295): closing region r1,,1199107049137
[junit] 2007-12-31 13:18:07,543 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed r1,,1199107049137/a (922550440/a)
[junit] 2007-12-31 13:18:07,543 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed r1,,1199107049137/b (922550440/b)
[junit] 2007-12-31 13:18:07,544 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed r1,,1199107049137/c (922550440/c)
[junit] 2007-12-31 13:18:07,544 INFO [RegionServer:0.worker]
hbase.HRegion(430): closed r1,,1199107049137
[junit] 2007-12-31 13:18:07,544 DEBUG [RegionServer:0.worker]
hbase.HRegionServer(1295): closing region r2,,1199107058702
[junit] 2007-12-31 13:18:07,545 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed r2,,1199107058702/e (347143206/e)
[junit] 2007-12-31 13:18:07,545 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed r2,,1199107058702/d (347143206/d)
[junit] 2007-12-31 13:18:07,545 INFO [RegionServer:0.worker]
hbase.HRegion(430): closed r2,,1199107058702
[junit] 2007-12-31 13:18:07,545 DEBUG [RegionServer:0.worker]
hbase.HRegionServer(1295): closing region result_table,,1199107064984
[junit] 2007-12-31 13:18:07,546 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed result_table,,1199107064984/e (267448769/e)
[junit] 2007-12-31 13:18:07,546 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed result_table,,1199107064984/d (267448769/d)
[junit] 2007-12-31 13:18:07,546 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed result_table,,1199107064984/a (267448769/a)
[junit] 2007-12-31 13:18:07,547 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed result_table,,1199107064984/b (267448769/b)
[junit] 2007-12-31 13:18:07,547 DEBUG [RegionServer:0.worker]
hbase.HStore(880): closed result_table,,1199107064984/c (267448769/c)
[junit] 2007-12-31 13:18:07,547 INFO [RegionServer:0.worker]
hbase.HRegion(430): closed result_table,,1199107064984
[junit] 2007-12-31 13:18:08,551 INFO [IPC Server handler 0 on 60000]
hbase.HMaster(1372): Region server 140.211.11.75:37011 quiesced
[junit] 2007-12-31 13:18:08,551 INFO [IPC Server handler 0 on 60000]
hbase.HMaster(1380): All user tables quiesced. Proceeding with shutdown
[junit] 2007-12-31 13:18:08,552 DEBUG [IPC Server handler 0 on 60000]
hbase.HMaster(1206): telling root scanner to stop
[junit] 2007-12-31 13:18:08,552 DEBUG [IPC Server handler 0 on 60000]
hbase.HMaster(1214): telling meta scanner to stop
[junit] 2007-12-31 13:18:08,552 INFO [HMaster.rootScanner]
hbase.Chore(66): HMaster.rootScanner exiting
[junit] 2007-12-31 13:18:08,552 INFO [HMaster.metaScanner]
hbase.Chore(66): HMaster.metaScanner exiting
[junit] 2007-12-31 13:18:08,552 DEBUG [IPC Server handler 0 on 60000]
hbase.HMaster(1222): meta and root scanners notified
[junit] 2007-12-31 13:18:08,554 INFO [RegionServer:0]
hbase.HRegionServer(768): Got regionserver stop message
[junit] 2007-12-31 13:18:08,554 INFO [RegionServer:0] hbase.Leases(109):
RegionServer:0 closing leases
[junit] 2007-12-31 13:18:08,555 INFO [RegionServer:0.leaseChecker]
hbase.Chore(66): RegionServer:0.leaseChecker exiting
[junit] 2007-12-31 13:18:08,555 INFO [RegionServer:0] hbase.Leases(125):
RegionServer:0 closed leases
[junit] 2007-12-31 13:18:08,556 DEBUG [RegionServer:0]
hbase.HRegionServer(1261): closing region -ROOT-,,0
[junit] 2007-12-31 13:18:08,556 INFO [RegionServer:0.compactor]
hbase.HRegionServer$Compactor(425): RegionServer:0.compactor exiting
[junit] 2007-12-31 13:18:08,557 DEBUG [RegionServer:0] hbase.HStore(880):
closed -ROOT-,,0/info (70236052/info)
[junit] 2007-12-31 13:18:08,556 INFO [RegionServer:0.splitter]
hbase.HRegionServer$Splitter(302): RegionServer:0.splitter exiting
[junit] 2007-12-31 13:18:08,558 INFO [RegionServer:0] hbase.HRegion(430):
closed -ROOT-,,0
[junit] 2007-12-31 13:18:08,556 INFO [RegionServer:0.cacheFlusher]
hbase.HRegionServer$Flusher(535): RegionServer:0.cacheFlusher exiting
[junit] 2007-12-31 13:18:08,559 DEBUG [RegionServer:0]
hbase.HRegionServer(1261): closing region .META.,,1
[junit] 2007-12-31 13:18:08,560 DEBUG [RegionServer:0] hbase.HStore(880):
closed .META.,,1/info (1028785192/info)
[junit] 2007-12-31 13:18:08,560 INFO [RegionServer:0] hbase.HRegion(430):
closed .META.,,1
[junit] 2007-12-31 13:18:08,561 DEBUG [RegionServer:0] hbase.HLog(399):
closing log writer in /hbase/log_140.211.11.75_1199107049117_37011
[junit] 2007-12-31 13:18:09,119 INFO [RegionServer:0]
hbase.HRegionServer(888): telling master that region server is shutting down
at: 140.211.11.75:37011
[junit] 2007-12-31 13:18:09,120 DEBUG [IPC Server handler 4 on 60000]
hbase.HMaster(1339): Region server 140.211.11.75:37011: MSG_REPORT_EXITING --
cancelling lease
[junit] 2007-12-31 13:18:09,121 INFO [IPC Server handler 4 on 60000]
hbase.HMaster(1481): Cancelling lease for 140.211.11.75:37011
[junit] 2007-12-31 13:18:09,121 INFO [IPC Server handler 4 on 60000]
hbase.HMaster(1346): Region server 140.211.11.75:37011: MSG_REPORT_EXITING --
lease cancelled
[junit] 2007-12-31 13:18:09,122 INFO [RegionServer:0]
hbase.HRegionServer(895): stopping server at: 140.211.11.75:37011
[junit] 2007-12-31 13:18:09,200 DEBUG [HMaster] hbase.HMaster(1206):
telling root scanner to stop
[junit] 2007-12-31 13:18:09,201 DEBUG [HMaster] hbase.HMaster(1214):
telling meta scanner to stop
[junit] 2007-12-31 13:18:09,201 DEBUG [HMaster] hbase.HMaster(1222): meta
and root scanners notified
[junit] 2007-12-31 13:18:09,202 INFO [HMaster] hbase.Leases(109): HMaster
closing leases
[junit] 2007-12-31 13:18:09,202 INFO [HMaster.leaseChecker]
hbase.Chore(66): HMaster.leaseChecker exiting
[junit] 2007-12-31 13:18:09,203 INFO [HMaster] hbase.Leases(125): HMaster
closed leases
[junit] 2007-12-31 13:18:09,203 INFO [HMaster] hbase.HMaster(1139):
HMaster main thread exiting
[junit] 2007-12-31 13:18:09,560 INFO [RegionServer:0.worker]
hbase.HRegionServer$Worker(1202): worker thread exiting
[junit] 2007-12-31 13:18:09,560 INFO [RegionServer:0]
hbase.HRegionServer(900): RegionServer:0 exiting
[junit] 2007-12-31 13:18:09,561 INFO [main] hbase.LocalHBaseCluster(238):
Shutdown HMaster 1 region server(s)
[junit] 2007-12-31 13:18:09,885 INFO [main]
hbase.StaticTestEnvironment(133): Shutting down FileSystem
[junit] 2007-12-31 13:18:10,560 INFO [main]
hbase.StaticTestEnvironment(140): Shutting down Mini DFS
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 0
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 50.73 sec
[junit] 2007-12-31 13:18:11,909 INFO [main]
hbase.HRegionServer$ShutdownThread(151): Starting shutdown thread.
[junit] 2007-12-31 13:18:11,910 INFO [main]
hbase.HRegionServer$ShutdownThread(156): Shutdown thread complete
[junit] Running org.apache.hadoop.hbase.util.TestBase64
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.258 sec
[junit] Running org.apache.hadoop.hbase.util.TestKeying
[junit] Original url http://abc:[EMAIL
PROTECTED]/index.html?query=something#middle, Transformed url
r:http://abc:[EMAIL PROTECTED]/index.html?query=something#middle
[junit] Original url file:///usr/bin/java, Transformed url
file:///usr/bin/java
[junit] Original url dns:www.powerset.com, Transformed url
dns:www.powerset.com
[junit] Original url dns://dns.powerset.com/www.powerset.com, Transformed
url r:dns://com.powerset.dns/www.powerset.com
[junit] Original url http://one.two.three/index.html, Transformed url
r:http://three.two.one/index.html
[junit] Original url https://one.two.three:9443/index.html, Transformed url
r:https://three.two.one:9443/index.html
[junit] Original url ftp://one.two.three/index.html, Transformed url
r:ftp://three.two.one/index.html
[junit] Original url filename, Transformed url filename
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.054 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.056 sec
BUILD FAILED
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml
:515: The following error occurred while executing this line:
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/src/contrib/build.xml
:31: The following error occurred while executing this line:
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/src/contrib/build-contrib.xml
:206: Tests failed!
Total time: 114 minutes 20 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
