See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/318/changes
Changes:
[stack] HADOOP-2297 System.exit() Handling in hbase shell jar command
Forgot to add new files in last commit
[stack] HADOOP-2297 System.exit() Handling in hbase shell jar command
[stack] HADOOP-2296 hbase shell: phantom columns show up from select command
[stack] HADOOP-2234 TableInputFormat erroneously aggregates map values
[dhruba] HADOOP-2209. SecondaryNamenode process exits if it encounters
exceptions
that it cannot handle. (Dhruba Borthakur via dhruba)
[jimk] HADOOP-2295 Fix assigning a region to multiple servers
[stack] HADOOP-2198 HTable should have method to return table metadata
[dhruba] HADOOP-2256. Fix a buf in the namenode that could cause it to encounter
an infinite loop while deleting excess replicas that were created by
block rebalancing. (Hairong Kuang via dhruba)
[dhruba] HADOOP-2275. Fix erroneous detection of corrupted file when namenode
fails to allocate any datanodes for newly allocated block.
(Dhruba Borthakur via dhruba)
[ddas] HADOOP-2245. Fixes LocalJobRunner to include a jobId in the mapId. Also,
adds a testcase for JobControl. Contributed by Adrian Woodhead.
------------------------------------------
[...truncated 190226 lines...]
[junit] 2007-11-30 12:14:04,223 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:750):
Sleeping. Table r2 not currently being served.
[junit] 2007-11-30 12:14:04,836 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region -ROOT-,,0
[junit] 2007-11-30 12:14:04,837 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region -ROOT-,,0. Size 92.0
[junit] 2007-11-30 12:14:04,953 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1778):
assigning region r2,,1196424843887 to the only server 140.211.11.75:58654
[junit] 2007-11-30 12:14:04,954 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1105):
MSG_REGION_OPEN : regionname: r2,,1196424843887, startKey: <>, 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-11-30 12:14:04,960 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting -1352987749/d
(no reconstruction log)
[junit] 2007-11-30 12:14:04,964 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore -1352987749/d is -1
[junit] 2007-11-30 12:14:04,975 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting -1352987749/e
(no reconstruction log)
[junit] 2007-11-30 12:14:04,978 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore -1352987749/e is -1
[junit] 2007-11-30 12:14:04,979 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:300): Next sequence id for
region r2,,1196424843887 is 0
[junit] 2007-11-30 12:14:04,984 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:328): region
r2,,1196424843887 available
[junit] 2007-11-30 12:14:05,045 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
-70236052/info/7111822477529572407 with sequence id 23 and size 230.0
[junit] 2007-11-30 12:14:05,046 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region -ROOT-,,0 in 209ms, sequenceid=23
[junit] 2007-11-30 12:14:05,047 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore -ROOT-,,0/info not needed.
[junit] 2007-11-30 12:14:05,058 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
-ROOT-,,0 does not need compaction
[junit] 2007-11-30 12:14:05,956 DEBUG [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1468): Received
MSG_REPORT_PROCESS_OPEN : regionname: r2,,1196424843887, startKey: <>,
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}}}from 140.211.11.75:58654
[junit] 2007-11-30 12:14:05,957 DEBUG [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1468): Received
MSG_REPORT_OPEN : regionname: r2,,1196424843887, startKey: <>, 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}}}from 140.211.11.75:58654
[junit] 2007-11-30 12:14:05,957 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1504):
140.211.11.75:58654 serving r2,,1196424843887
[junit] 2007-11-30 12:14:05,958 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1068): Main processing loop:
PendingOpenOperation from 140.211.11.75:58654
[junit] 2007-11-30 12:14:05,959 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2349):
regionname: r2,,1196424843887, startKey: <>, 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:58654
[junit] 2007-11-30 12:14:05,959 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2395):
updating row r2,,1196424843887 in table .META.,,1 with startcode 1196424834611
and server 140.211.11.75:58654
[junit] 2007-11-30 12:14:06,954 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212):
HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:58654}
[junit] 2007-11-30 12:14:07,014 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.rootScanner scanner: -1060083694846721804 regioninfo: {regionname:
.META.,,1, startKey: <>, 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:58654, startCode:
1196424834611
[junit] 2007-11-30 12:14:07,014 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking .META.,,1 is assigned
[junit] 2007-11-30 12:14:07,017 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:289):
HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:58654} complete
[junit] 2007-11-30 12:14:07,834 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region .META.,,1
[junit] 2007-11-30 12:14:07,835 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region .META.,,1. Size 468.0
[junit] 2007-11-30 12:14:08,074 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1028785192/info/1054079002541423930 with sequence id 26 and size 662.0
[junit] 2007-11-30 12:14:08,075 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region .META.,,1 in 240ms, sequenceid=26
[junit] 2007-11-30 12:14:08,076 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore .META.,,1/info not needed.
[junit] 2007-11-30 12:14:08,076 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
.META.,,1 does not need compaction
[junit] 2007-11-30 12:14:08,764 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212):
HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:58654}
[junit] 2007-11-30 12:14:08,779 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.metaScanner scanner: 3546818334206960770 regioninfo: {regionname:
r1,,1196424834637, startKey: <>, 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:58654, startCode: 1196424834611
[junit] 2007-11-30 12:14:08,779 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking r1,,1196424834637 is assigned
[junit] 2007-11-30 12:14:08,782 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.metaScanner scanner: 3546818334206960770 regioninfo: {regionname:
r2,,1196424843887, startKey: <>, 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:58654, startCode: 1196424834611
[junit] 2007-11-30 12:14:08,783 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking r2,,1196424843887 is assigned
[junit] 2007-11-30 12:14:08,805 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:289):
HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:58654} complete
[junit] 2007-11-30 12:14:08,806 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:772):
all meta regions scanned
[junit] 2007-11-30 12:14:09,234 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:759):
Wake. Retry finding table r2
[junit] 2007-11-30 12:14:09,356 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:664):
Found 1 region(s) for r2 at address: 140.211.11.75:58654, regioninfo:
regionname: .META.,,1, startKey: <>, tableDesc: {name: .META., families:
{info:={name: info, max versions: 1, compression: NONE, in memory: false, max
length: 2147483647, bloom filter: none}}}
[junit] 2007-11-30 12:14:09,644 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:296): new log writer created
at /hbase/hregion_1956167080/log/hlog.dat.000
[junit] 2007-11-30 12:14:09,655 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/a
(no reconstruction log)
[junit] 2007-11-30 12:14:09,658 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/a is -1
[junit] 2007-11-30 12:14:09,668 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/b
(no reconstruction log)
[junit] 2007-11-30 12:14:09,671 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/b is -1
[junit] 2007-11-30 12:14:09,679 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/c
(no reconstruction log)
[junit] 2007-11-30 12:14:09,706 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/c is -1
[junit] 2007-11-30 12:14:09,716 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/d
(no reconstruction log)
[junit] 2007-11-30 12:14:09,720 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/d is -1
[junit] 2007-11-30 12:14:09,729 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/e
(no reconstruction log)
[junit] 2007-11-30 12:14:09,732 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/e is -1
[junit] 2007-11-30 12:14:09,733 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:300): Next sequence id for
region result_table,,1196424849362 is 0
[junit] 2007-11-30 12:14:09,736 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:328): region
result_table,,1196424849362 available
[junit] 2007-11-30 12:14:09,738 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region result_table,,1196424849362: snapshotMemcaches()
determined that there was nothing to do
[junit] 2007-11-30 12:14:09,738 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/d
[junit] 2007-11-30 12:14:09,739 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/a
[junit] 2007-11-30 12:14:09,739 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/b
[junit] 2007-11-30 12:14:09,739 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/e
[junit] 2007-11-30 12:14:09,739 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/c
[junit] 2007-11-30 12:14:09,740 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed
result_table,,1196424849362
[junit] 2007-11-30 12:14:09,740 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.close(HLog.java:382): closing log writer in
/hbase/hregion_1956167080/log
[junit] 2007-11-30 12:14:09,792 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2481): created table
result_table
[junit] 2007-11-30 12:14:09,793 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:296):
No servers for result_table. Doing a find...
[junit] 2007-11-30 12:14:09,817 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:714):
no server address for regionname: result_table,,1196424849362, startKey: <>,
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-11-30 12:14:09,819 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:750):
Sleeping. Table result_table not currently being served.
[junit] 2007-11-30 12:14:09,995 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1778):
assigning region result_table,,1196424849362 to the only server
140.211.11.75:58654
[junit] 2007-11-30 12:14:09,999 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1105):
MSG_REGION_OPEN : regionname: result_table,,1196424849362, startKey: <>,
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-11-30 12:14:10,029 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/a
(no reconstruction log)
[junit] 2007-11-30 12:14:10,031 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/a is -1
[junit] 2007-11-30 12:14:10,035 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region r1,,1196424834637
[junit] 2007-11-30 12:14:10,035 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region r1,,1196424834637. Size 310.0
[junit] 2007-11-30 12:14:10,039 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/b
(no reconstruction log)
[junit] 2007-11-30 12:14:10,042 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/b is -1
[junit] 2007-11-30 12:14:10,049 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/c
(no reconstruction log)
[junit] 2007-11-30 12:14:10,051 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/c is -1
[junit] 2007-11-30 12:14:10,069 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/d
(no reconstruction log)
[junit] 2007-11-30 12:14:10,071 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/d is -1
[junit] 2007-11-30 12:14:10,085 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:566): starting 1956167080/e
(no reconstruction log)
[junit] 2007-11-30 12:14:10,089 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:602): maximum sequence id for
hstore 1956167080/e is -1
[junit] 2007-11-30 12:14:10,090 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:300): Next sequence id for
region result_table,,1196424849362 is 0
[junit] 2007-11-30 12:14:10,095 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:328): region
result_table,,1196424849362 available
[junit] 2007-11-30 12:14:10,116 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1258550012/a/6522338463372397815 with sequence id 34 and size 270.0
[junit] 2007-11-30 12:14:10,777 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1258550012/b/5014958020747366818 with sequence id 34 and size 270.0
[junit] 2007-11-30 12:14:11,043 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1468): Received
MSG_REPORT_PROCESS_OPEN : regionname: result_table,,1196424849362, startKey:
<>, 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}}}from 140.211.11.75:58654
[junit] 2007-11-30 12:14:11,044 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1468): Received
MSG_REPORT_OPEN : regionname: result_table,,1196424849362, startKey: <>,
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}}}from 140.211.11.75:58654
[junit] 2007-11-30 12:14:11,044 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1504):
140.211.11.75:58654 serving result_table,,1196424849362
[junit] 2007-11-30 12:14:11,045 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1068): Main processing loop:
PendingOpenOperation from 140.211.11.75:58654
[junit] 2007-11-30 12:14:11,045 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2349):
regionname: result_table,,1196424849362, startKey: <>, 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:58654
[junit] 2007-11-30 12:14:11,046 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2395):
updating row result_table,,1196424849362 in table .META.,,1 with startcode
1196424834611 and server 140.211.11.75:58654
[junit] 2007-11-30 12:14:11,350 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1258550012/c/6215948469568770051 with sequence id 34 and size 310.0
[junit] 2007-11-30 12:14:11,351 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region r1,,1196424834637 in 1316ms, sequenceid=34
[junit] 2007-11-30 12:14:11,351 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore r1,,1196424834637/a not needed.
[junit] 2007-11-30 12:14:11,352 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore r1,,1196424834637/b not needed.
[junit] 2007-11-30 12:14:11,352 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore r1,,1196424834637/c not needed.
[junit] 2007-11-30 12:14:11,352 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
r1,,1196424834637 does not need compaction
[junit] 2007-11-30 12:14:14,822 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:759):
Wake. Retry finding table result_table
[junit] 2007-11-30 12:14:14,848 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:664):
Found 1 region(s) for result_table at address: 140.211.11.75:58654,
regioninfo: regionname: .META.,,1, startKey: <>, tableDesc: {name: .META.,
families: {info:={name: info, max versions: 1, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}}
[junit] 2007-11-30 12:14:14,999 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region r2,,1196424843887
[junit] 2007-11-30 12:14:15,000 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region r2,,1196424843887. Size 132.0
[junit] 2007-11-30 12:14:15,163 WARN [IPC Server handler 0 on 58475]
org.apache.hadoop.dfs.FSDirectory.unprotectedDelete(FSDirectory.java:400): DIR*
FSDirectory.unprotectedDelete: failed to remove
/user/hudson/build/contrib/hbase/test/system because it does not exist
[junit] 2007-11-30 12:14:15,777 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
-1352987749/d/9154438453750221309 with sequence id 37 and size 218.0
[junit] 2007-11-30 12:14:16,210 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
-1352987749/e/8610614126761563062 with sequence id 37 and size 218.0
[junit] 2007-11-30 12:14:16,235 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region r2,,1196424843887 in 1235ms, sequenceid=37
[junit] 2007-11-30 12:14:16,253 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region -ROOT-,,0
[junit] 2007-11-30 12:14:16,254 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region -ROOT-,,0: snapshotMemcaches() determined that there
was nothing to do
[junit] 2007-11-30 12:14:16,262 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore r2,,1196424843887/d not needed.
[junit] 2007-11-30 12:14:16,262 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore r2,,1196424843887/e not needed.
[junit] 2007-11-30 12:14:16,263 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
r2,,1196424843887 does not need compaction
[junit] 2007-11-30 12:14:16,586 WARN [Thread-147]
org.mortbay.util.ThreadedServer.start(ThreadedServer.java:518): Failed to
start: [EMAIL PROTECTED]:50060
[junit] 2007-11-30 12:14:16,962 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212):
HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:58654}
[junit] 2007-11-30 12:14:17,025 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.rootScanner scanner: -4659680968713140743 regioninfo: {regionname:
.META.,,1, startKey: <>, 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:58654, startCode:
1196424834611
[junit] 2007-11-30 12:14:17,033 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking .META.,,1 is assigned
[junit] 2007-11-30 12:14:17,103 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:289):
HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:58654} complete
[junit] 2007-11-30 12:14:17,404 WARN [IPC Server handler 6 on 58475]
org.apache.hadoop.dfs.FSDirectory.unprotectedDelete(FSDirectory.java:400): DIR*
FSDirectory.unprotectedDelete: failed to remove
/user/hudson/build/contrib/hbase/test/system/job_local_1 because it does not
exist
[junit] 2007-11-30 12:14:17,438 WARN [main]
org.apache.hadoop.mapred.JobClient.submitJob(JobClient.java:496): No job jar
file set. User classes may not be found. See JobConf(Class) or
JobConf#setJar(String).
[junit] 2007-11-30 12:14:17,564 DEBUG [main]
org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175):
split: 0->r1,,
[junit] 2007-11-30 12:14:17,738 DEBUG [Thread-168]
org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175):
split: 0->r1,,
[junit] 2007-11-30 12:14:18,089 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region .META.,,1
[junit] 2007-11-30 12:14:18,091 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region .META.,,1. Size 329.0
[junit] 2007-11-30 12:14:18,456 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1028785192/info/7742779424041650867 with sequence id 38 and size 481.0
[junit] 2007-11-30 12:14:18,457 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region .META.,,1 in 366ms, sequenceid=38
[junit] 2007-11-30 12:14:18,458 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore .META.,,1/info not needed.
[junit] 2007-11-30 12:14:18,458 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
.META.,,1 does not need compaction
[junit] 2007-11-30 12:14:18,877 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212):
HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:58654}
[junit] 2007-11-30 12:14:19,939 ERROR [expireTrackers]
org.apache.hadoop.mapred.JobTracker$ExpireTrackers.run(JobTracker.java:308):
Tracker Expiry Thread got exception: java.lang.InterruptedException: sleep
interrupted
[junit] at java.lang.Thread.sleep(Native Method)
[junit] at
org.apache.hadoop.mapred.JobTracker$ExpireTrackers.run(JobTracker.java:263)
[junit] at java.lang.Thread.run(Thread.java:595)
[junit] 2007-11-30 12:14:19,942 WARN [Task Commit Thread]
org.apache.hadoop.mapred.JobTracker$TaskCommitQueue.run(JobTracker.java:2017):
Task Commit Thread exiting, got interrupted: java.lang.InterruptedException
[junit] at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:1815)
[junit] at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1850)
[junit] at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:359)
[junit] at
org.apache.hadoop.mapred.JobTracker$TaskCommitQueue.run(JobTracker.java:1919)
[junit] 2007-11-30 12:14:19,955 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228):
result_table.column.size: 5
[junit] 2007-11-30 12:14:19,961 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228):
result_table.column.size: 5
[junit] 2007-11-30 12:14:19,963 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228):
result_table.column.size: 5
[junit] 2007-11-30 12:14:19,965 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:232):
result_table.row.count: 3
[junit] 2007-11-30 12:14:19,966 DEBUG [main]
org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:206):
Shutting down HBase Cluster
[junit] 2007-11-30 12:14:19,971 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.metaScanner scanner: -6512634130928894443 regioninfo: {regionname:
r1,,1196424834637, startKey: <>, 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:58654, startCode: 1196424834611
[junit] 2007-11-30 12:14:19,971 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking r1,,1196424834637 is assigned
[junit] 2007-11-30 12:14:19,974 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.metaScanner scanner: -6512634130928894443 regioninfo: {regionname:
r2,,1196424843887, startKey: <>, 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:58654, startCode: 1196424834611
[junit] 2007-11-30 12:14:19,974 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking r2,,1196424843887 is assigned
[junit] 2007-11-30 12:14:19,976 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:243):
HMaster.metaScanner scanner: -6512634130928894443 regioninfo: {regionname:
result_table,,1196424849362, startKey: <>, 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:58654,
startCode: 1196424834611
[junit] 2007-11-30 12:14:19,977 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:446):
Checking result_table,,1196424849362 is assigned
[junit] 2007-11-30 12:14:19,980 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:289):
HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:58654} complete
[junit] 2007-11-30 12:14:19,981 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:772):
all meta regions scanned
[junit] 2007-11-30 12:14:19,982 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-11-30 12:14:20,102 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:449):
flushing region result_table,,1196424849362
[junit] 2007-11-30 12:14:20,103 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:829): Started
memcache flush for region result_table,,1196424849362. Size 306.0
[junit] 2007-11-30 12:14:20,213 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1956167080/d/202413973855086721 with sequence id 54 and size 212.0
[junit] 2007-11-30 12:14:20,333 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1956167080/a/7125077936477156774 with sequence id 54 and size 206.0
[junit] 2007-11-30 12:14:20,432 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1212):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:58654, startcode:
1196424834611, load: (requests: 4 regions: 5)]
[junit] 2007-11-30 12:14:20,536 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1956167080/b/3657602805584282084 with sequence id 54 and size 206.0
[junit] 2007-11-30 12:14:20,618 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1956167080/e/7166823302371316173 with sequence id 54 and size 212.0
[junit] 2007-11-30 12:14:20,803 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:915): Added
1956167080/c/1941054189777182989 with sequence id 54 and size 230.0
[junit] 2007-11-30 12:14:20,804 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:939): Finished
memcache flush for region result_table,,1196424849362 in 702ms, sequenceid=54
[junit] 2007-11-30 12:14:20,805 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore result_table,,1196424849362/d not needed.
[junit] 2007-11-30 12:14:20,805 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore result_table,,1196424849362/a not needed.
[junit] 2007-11-30 12:14:20,806 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore result_table,,1196424849362/b not needed.
[junit] 2007-11-30 12:14:20,806 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore result_table,,1196424849362/e not needed.
[junit] 2007-11-30 12:14:20,806 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:938): compaction for
HStore result_table,,1196424849362/c not needed.
[junit] 2007-11-30 12:14:20,806 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:699): region
result_table,,1196424849362 does not need compaction
[junit] 2007-11-30 12:14:20,964 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:732): Got
regionserver stop message
[junit] 2007-11-30 12:14:20,965 INFO [RegionServer:0]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): RegionServer:0 closing
leases
[junit] 2007-11-30 12:14:20,965 INFO [RegionServer:0.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): RegionServer:0.leaseChecker
exiting
[junit] 2007-11-30 12:14:20,965 INFO [RegionServer:0]
org.apache.hadoop.hbase.Leases.close(Leases.java:125): RegionServer:0 closed
leases
[junit] 2007-11-30 12:14:20,966 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1202):
closing region -ROOT-,,0
[junit] 2007-11-30 12:14:20,967 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region -ROOT-,,0: snapshotMemcaches() determined that there
was nothing to do
[junit] 2007-11-30 12:14:20,967 INFO [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegionServer$Compactor.run(HRegionServer.java:398):
RegionServer:0.compactor exiting
[junit] 2007-11-30 12:14:20,967 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed -70236052/info
[junit] 2007-11-30 12:14:20,968 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed -ROOT-,,0
[junit] 2007-11-30 12:14:20,968 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1202):
closing region .META.,,1
[junit] 2007-11-30 12:14:20,968 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region .META.,,1: snapshotMemcaches() determined that there
was nothing to do
[junit] 2007-11-30 12:14:20,968 INFO [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:511):
RegionServer:0.cacheFlusher exiting
[junit] 2007-11-30 12:14:20,968 INFO [RegionServer:0.splitter]
org.apache.hadoop.hbase.HRegionServer$Splitter.run(HRegionServer.java:275):
RegionServer:0.splitter exiting
[junit] 2007-11-30 12:14:20,968 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1028785192/info
[junit] 2007-11-30 12:14:20,969 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed .META.,,1
[junit] 2007-11-30 12:14:20,969 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1202):
closing region r1,,1196424834637
[junit] 2007-11-30 12:14:20,969 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region r1,,1196424834637: snapshotMemcaches() determined
that there was nothing to do
[junit] 2007-11-30 12:14:20,970 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1258550012/a
[junit] 2007-11-30 12:14:20,970 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1258550012/b
[junit] 2007-11-30 12:14:20,970 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1258550012/c
[junit] 2007-11-30 12:14:20,971 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed
r1,,1196424834637
[junit] 2007-11-30 12:14:20,971 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1202):
closing region r2,,1196424843887
[junit] 2007-11-30 12:14:20,971 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region r2,,1196424843887: snapshotMemcaches() determined
that there was nothing to do
[junit] 2007-11-30 12:14:20,972 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed -1352987749/d
[junit] 2007-11-30 12:14:20,972 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed -1352987749/e
[junit] 2007-11-30 12:14:20,972 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed
r2,,1196424843887
[junit] 2007-11-30 12:14:20,972 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1202):
closing region result_table,,1196424849362
[junit] 2007-11-30 12:14:20,973 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:883): Not
flushing cache for region result_table,,1196424849362: snapshotMemcaches()
determined that there was nothing to do
[junit] 2007-11-30 12:14:20,973 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/d
[junit] 2007-11-30 12:14:20,974 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/a
[junit] 2007-11-30 12:14:20,974 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/b
[junit] 2007-11-30 12:14:20,975 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/e
[junit] 2007-11-30 12:14:20,975 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:825): closed 1956167080/c
[junit] 2007-11-30 12:14:20,975 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:429): closed
result_table,,1196424849362
[junit] 2007-11-30 12:14:20,975 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HLog.close(HLog.java:382): closing log writer in
/hbase/log_140.211.11.75_1196424834611_58654
[junit] 2007-11-30 12:14:21,051 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:840): telling
master that region server is shutting down at: 140.211.11.75:58654
[junit] 2007-11-30 12:14:21,053 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1309): Region
server 140.211.11.75:58654: MSG_REPORT_EXITING -- cancelling lease
[junit] 2007-11-30 12:14:21,054 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.cancelLease(HMaster.java:1433): Cancelling
lease for 140.211.11.75:58654
[junit] 2007-11-30 12:14:21,054 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1316): Region
server 140.211.11.75:58654: MSG_REPORT_EXITING -- lease cancelled
[junit] 2007-11-30 12:14:21,055 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:847): stopping
server at: 140.211.11.75:58654
[junit] 2007-11-30 12:14:21,056 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-11-30 12:14:21,056 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-11-30 12:14:21,056 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] 2007-11-30 12:14:21,057 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:125): HMaster closed leases
[junit] 2007-11-30 12:14:21,057 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1152): HMaster main thread
exiting
[junit] 2007-11-30 12:14:21,551 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1150):
worker thread exiting
[junit] 2007-11-30 12:14:21,552 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:852):
RegionServer:0 exiting
[junit] 2007-11-30 12:14:21,552 INFO [main]
org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:232):
Shutdown HMaster 1 region server(s)
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 0
[junit] 2007-11-30 12:14:21,925 WARN [EMAIL PROTECTED]
org.apache.hadoop.dfs.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:187):
PendingReplicationMonitor thread received exception.
java.lang.InterruptedException: sleep interrupted
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 37.199 sec
[junit] Running org.apache.hadoop.hbase.util.TestBase64
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.282 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.076 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.065 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: 55 minutes 9 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-2209
Updating HADOOP-2275
Updating HADOOP-2198
Updating HADOOP-2296
Updating HADOOP-2295
Updating HADOOP-2234
Updating HADOOP-2245
Updating HADOOP-2297
Updating HADOOP-2256