See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/328/changes
Changes:
[jimk] HADOOP-2392 TestRegionServerExit has new failure mode since HADOOP-2338
------------------------------------------
[...truncated 47467 lines...]
[junit] 2007-12-10 12:25:31,754 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region
r1,,1197289526392 available
[junit] 2007-12-10 12:25:32,541 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_PROCESS_OPEN : regionname: r1,,1197289526392, 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}}}from
140.211.11.75:42725
[junit] 2007-12-10 12:25:32,541 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_OPEN : regionname: r1,,1197289526392, 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}}}from 140.211.11.75:42725
[junit] 2007-12-10 12:25:32,542 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1566):
140.211.11.75:42725 serving r1,,1197289526392
[junit] 2007-12-10 12:25:32,542 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop:
PendingOpenOperation from 140.211.11.75:42725
[junit] 2007-12-10 12:25:32,543 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2447):
regionname: r1,,1197289526392, 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}}} open on 140.211.11.75:42725
[junit] 2007-12-10 12:25:32,543 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1896):
numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-10 12:25:32,544 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2461):
updating row r1,,1197289526392 in table .META.,,1 with startcode 1197289526331
and server 140.211.11.75:42725
[junit] 2007-12-10 12:25:36,139 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689):
Wake. Retry finding table r1
[junit] 2007-12-10 12:25:36,146 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732):
Found 1 region(s) for r1 at address: 140.211.11.75:42725, 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-12-10 12:25:36,174 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created
at /hbase/hregion_-592010069/log/hlog.dat.000
[junit] 2007-12-10 12:25:36,181 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -592010069/d
(no reconstruction log)
[junit] 2007-12-10 12:25:36,183 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -592010069/d is -1
[junit] 2007-12-10 12:25:36,191 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -592010069/e
(no reconstruction log)
[junit] 2007-12-10 12:25:36,194 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -592010069/e is -1
[junit] 2007-12-10 12:25:36,195 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for
region r2,,1197289536158 is 0
[junit] 2007-12-10 12:25:36,198 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region
r2,,1197289536158 available
[junit] 2007-12-10 12:25:36,200 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -592010069/e
[junit] 2007-12-10 12:25:36,201 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -592010069/d
[junit] 2007-12-10 12:25:36,202 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed
r2,,1197289536158
[junit] 2007-12-10 12:25:36,202 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in
/hbase/hregion_-592010069/log
[junit] 2007-12-10 12:25:36,569 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region -ROOT-,,0. Size 92.0
[junit] 2007-12-10 12:25:36,628 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2536): created table r2
[junit] 2007-12-10 12:25:36,635 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308):
No servers for r2. Doing a find...
[junit] 2007-12-10 12:25:36,639 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782):
no server address for regionname: r2,,1197289536158, 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-12-10 12:25:36,641 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680):
Sleeping. Table r2 not currently being served.
[junit] 2007-12-10 12:25:37,448 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-70236052/info/4276951840217028282 with sequence id 23 and size 230.0
[junit] 2007-12-10 12:25:37,449 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region -ROOT-,,0 in 880ms, sequenceid=23
[junit] 2007-12-10 12:25:37,451 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore -ROOT-,,0/info not needed.
[junit] 2007-12-10 12:25:37,452 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region
-ROOT-,,0 does not need compaction
[junit] 2007-12-10 12:25:37,569 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:213):
HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:42725}
[junit] 2007-12-10 12:25:37,590 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1847):
assigning region r2,,1197289536158 to the only server 140.211.11.75:42725
[junit] 2007-12-10 12:25:37,591 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1124):
MSG_REGION_OPEN : regionname: r2,,1197289536158, 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-12-10 12:25:37,602 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -592010069/d
(no reconstruction log)
[junit] 2007-12-10 12:25:37,607 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -592010069/d is -1
[junit] 2007-12-10 12:25:37,613 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.rootScanner 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:42725, startCode: 1197289526331
[junit] 2007-12-10 12:25:37,615 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -592010069/e
(no reconstruction log)
[junit] 2007-12-10 12:25:37,618 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:295):
HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:42725} complete
[junit] 2007-12-10 12:25:37,620 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -592010069/e is -1
[junit] 2007-12-10 12:25:37,622 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for
region r2,,1197289536158 is 0
[junit] 2007-12-10 12:25:37,625 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region
r2,,1197289536158 available
[junit] 2007-12-10 12:25:38,600 DEBUG [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_PROCESS_OPEN : regionname: r2,,1197289536158, 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:42725
[junit] 2007-12-10 12:25:38,601 DEBUG [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_OPEN : regionname: r2,,1197289536158, 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:42725
[junit] 2007-12-10 12:25:38,602 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1566):
140.211.11.75:42725 serving r2,,1197289536158
[junit] 2007-12-10 12:25:38,603 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop:
PendingOpenOperation from 140.211.11.75:42725
[junit] 2007-12-10 12:25:38,603 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2447):
regionname: r2,,1197289536158, 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:42725
[junit] 2007-12-10 12:25:38,604 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1896):
numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-10 12:25:38,604 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2461):
updating row r2,,1197289536158 in table .META.,,1 with startcode 1197289526331
and server 140.211.11.75:42725
[junit] 2007-12-10 12:25:38,879 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region .META.,,1. Size 472.0
[junit] 2007-12-10 12:25:38,963 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
1028785192/info/4228776625461354241 with sequence id 26 and size 666.0
[junit] 2007-12-10 12:25:38,963 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region .META.,,1 in 85ms, sequenceid=26
[junit] 2007-12-10 12:25:38,964 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore .META.,,1/info not needed.
[junit] 2007-12-10 12:25:38,964 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region
.META.,,1 does not need compaction
[junit] 2007-12-10 12:25:40,629 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:213):
HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:42725}
[junit] 2007-12-10 12:25:40,654 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.metaScanner regioninfo: {regionname: r1,,1197289526392, 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:42725, startCode: 1197289526331
[junit] 2007-12-10 12:25:40,658 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.metaScanner regioninfo: {regionname: r2,,1197289536158, 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:42725, startCode:
1197289526331
[junit] 2007-12-10 12:25:40,660 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:295):
HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:42725} complete
[junit] 2007-12-10 12:25:40,661 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:774):
all meta regions scanned
[junit] 2007-12-10 12:25:41,648 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689):
Wake. Retry finding table r2
[junit] 2007-12-10 12:25:41,665 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732):
Found 1 region(s) for r2 at address: 140.211.11.75:42725, 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-12-10 12:25:41,694 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created
at /hbase/hregion_-1815541752/log/hlog.dat.000
[junit] 2007-12-10 12:25:41,704 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/a
(no reconstruction log)
[junit] 2007-12-10 12:25:41,707 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/a is -1
[junit] 2007-12-10 12:25:41,715 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/b
(no reconstruction log)
[junit] 2007-12-10 12:25:41,719 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/b is -1
[junit] 2007-12-10 12:25:41,727 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/c
(no reconstruction log)
[junit] 2007-12-10 12:25:41,731 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/c is -1
[junit] 2007-12-10 12:25:41,739 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/d
(no reconstruction log)
[junit] 2007-12-10 12:25:41,743 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/d is -1
[junit] 2007-12-10 12:25:41,752 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/e
(no reconstruction log)
[junit] 2007-12-10 12:25:41,755 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/e is -1
[junit] 2007-12-10 12:25:41,757 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for
region result_table,,1197289541672 is 0
[junit] 2007-12-10 12:25:41,759 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region r1,,1197289526392. Size 310.0
[junit] 2007-12-10 12:25:41,767 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region
result_table,,1197289541672 available
[junit] 2007-12-10 12:25:41,770 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/e
[junit] 2007-12-10 12:25:41,771 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/d
[junit] 2007-12-10 12:25:41,772 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/a
[junit] 2007-12-10 12:25:41,773 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/b
[junit] 2007-12-10 12:25:41,774 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/c
[junit] 2007-12-10 12:25:41,775 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed
result_table,,1197289541672
[junit] 2007-12-10 12:25:41,776 DEBUG [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in
/hbase/hregion_-1815541752/log
[junit] 2007-12-10 12:25:41,876 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
174246503/a/4856595318002037272 with sequence id 33 and size 270.0
[junit] 2007-12-10 12:25:42,234 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2536): created table
result_table
[junit] 2007-12-10 12:25:42,236 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308):
No servers for result_table. Doing a find...
[junit] 2007-12-10 12:25:42,373 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782):
no server address for regionname: result_table,,1197289541672, 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-12-10 12:25:42,475 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680):
Sleeping. Table result_table not currently being served.
[junit] 2007-12-10 12:25:42,701 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1847):
assigning region result_table,,1197289541672 to the only server
140.211.11.75:42725
[junit] 2007-12-10 12:25:42,704 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1124):
MSG_REGION_OPEN : regionname: result_table,,1197289541672, 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-12-10 12:25:42,877 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/a
(no reconstruction log)
[junit] 2007-12-10 12:25:42,882 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/a is -1
[junit] 2007-12-10 12:25:42,888 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/b
(no reconstruction log)
[junit] 2007-12-10 12:25:42,900 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/b is -1
[junit] 2007-12-10 12:25:42,936 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/c
(no reconstruction log)
[junit] 2007-12-10 12:25:42,939 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/c is -1
[junit] 2007-12-10 12:25:42,944 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/d
(no reconstruction log)
[junit] 2007-12-10 12:25:43,029 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/d is -1
[junit] 2007-12-10 12:25:43,035 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1815541752/e
(no reconstruction log)
[junit] 2007-12-10 12:25:43,039 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for
hstore -1815541752/e is -1
[junit] 2007-12-10 12:25:43,041 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for
region result_table,,1197289541672 is 0
[junit] 2007-12-10 12:25:43,043 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region
result_table,,1197289541672 available
[junit] 2007-12-10 12:25:43,292 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
174246503/b/4605134171416878846 with sequence id 33 and size 270.0
[junit] 2007-12-10 12:25:43,342 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
174246503/c/3429815153894188524 with sequence id 33 and size 310.0
[junit] 2007-12-10 12:25:43,343 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region r1,,1197289526392 in 1585ms, sequenceid=33
[junit] 2007-12-10 12:25:43,343 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore r1,,1197289526392/a not needed.
[junit] 2007-12-10 12:25:43,344 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore r1,,1197289526392/b not needed.
[junit] 2007-12-10 12:25:43,345 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore r1,,1197289526392/c not needed.
[junit] 2007-12-10 12:25:43,345 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region
r1,,1197289526392 does not need compaction
[junit] 2007-12-10 12:25:43,710 DEBUG [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_PROCESS_OPEN : regionname: result_table,,1197289541672, 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:42725
[junit] 2007-12-10 12:25:43,711 DEBUG [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1505): Received
MSG_REPORT_OPEN : regionname: result_table,,1197289541672, 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:42725
[junit] 2007-12-10 12:25:43,711 INFO [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1566):
140.211.11.75:42725 serving result_table,,1197289541672
[junit] 2007-12-10 12:25:43,711 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop:
PendingOpenOperation from 140.211.11.75:42725
[junit] 2007-12-10 12:25:43,712 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2447):
regionname: result_table,,1197289541672, 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:42725
[junit] 2007-12-10 12:25:43,712 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1896):
numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-10 12:25:43,712 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2461):
updating row result_table,,1197289541672 in table .META.,,1 with startcode
1197289526331 and server 140.211.11.75:42725
[junit] 2007-12-10 12:25:47,478 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689):
Wake. Retry finding table result_table
[junit] 2007-12-10 12:25:47,498 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732):
Found 1 region(s) for result_table at address: 140.211.11.75:42725,
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-12-10 12:25:47,578 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:213):
HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:42725}
[junit] 2007-12-10 12:25:47,611 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.rootScanner 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:42725, startCode: 1197289526331
[junit] 2007-12-10 12:25:47,615 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:295):
HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:42725} complete
[junit] 2007-12-10 12:25:47,627 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region r2,,1197289536158. Size 132.0
[junit] 2007-12-10 12:25:47,692 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-592010069/e/7500395390334508220 with sequence id 37 and size 218.0
[junit] 2007-12-10 12:25:47,944 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-592010069/d/5701861818350837291 with sequence id 37 and size 218.0
[junit] 2007-12-10 12:25:47,945 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region r2,,1197289536158 in 318ms, sequenceid=37
[junit] 2007-12-10 12:25:47,945 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore r2,,1197289536158/e not needed.
[junit] 2007-12-10 12:25:47,946 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore r2,,1197289536158/d not needed.
[junit] 2007-12-10 12:25:47,946 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region
r2,,1197289536158 does not need compaction
[junit] 2007-12-10 12:25:47,952 WARN [IPC Server handler 6 on 42517]
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-12-10 12:25:48,967 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region .META.,,1. Size 331.0
[junit] 2007-12-10 12:25:49,641 WARN [IPC Server handler 1 on 42517]
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-12-10 12:25:49,642 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-12-10 12:25:49,673 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308):
No servers for r1. Doing a find...
[junit] 2007-12-10 12:25:49,698 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:763):
Found 1 servers for table r1
[junit] 2007-12-10 12:25:49,731 DEBUG [main]
org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175):
split: 0->r1,,
[junit] 2007-12-10 12:25:49,882 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
1028785192/info/2730822003961007528 with sequence id 38 and size 483.0
[junit] 2007-12-10 12:25:49,883 DEBUG [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region .META.,,1 in 916ms, sequenceid=38
[junit] 2007-12-10 12:25:49,884 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for
HStore .META.,,1/info not needed.
[junit] 2007-12-10 12:25:49,884 DEBUG [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region
.META.,,1 does not need compaction
[junit] 2007-12-10 12:25:49,933 DEBUG [Thread-183]
org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175):
split: 0->r1,,
[junit] 2007-12-10 12:25:50,149 DEBUG [Thread-183]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308):
No servers for r2. Doing a find...
[junit] 2007-12-10 12:25:50,231 DEBUG [Thread-183]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:763):
Found 1 servers for table r2
[junit] 2007-12-10 12:25:50,638 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:213):
HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:42725}
[junit] 2007-12-10 12:25:50,688 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.metaScanner regioninfo: {regionname: r1,,1197289526392, 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:42725, startCode: 1197289526331
[junit] 2007-12-10 12:25:50,691 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.metaScanner regioninfo: {regionname: r2,,1197289536158, 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:42725, startCode:
1197289526331
[junit] 2007-12-10 12:25:50,694 DEBUG [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249):
HMaster.metaScanner regioninfo: {regionname: result_table,,1197289541672,
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:42725, startCode: 1197289526331
[junit] 2007-12-10 12:25:50,700 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:295):
HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:42725} complete
[junit] 2007-12-10 12:25:50,700 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:774):
all meta regions scanned
[junit] 2007-12-10 12:25:51,800 ERROR [expireTrackers]
org.apache.hadoop.mapred.JobTracker$ExpireTrackers.run(JobTracker.java:309):
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:264)
[junit] at java.lang.Thread.run(Thread.java:595)
[junit] 2007-12-10 12:25:51,802 WARN [Task Commit Thread]
org.apache.hadoop.mapred.JobTracker$TaskCommitQueue.run(JobTracker.java:2035):
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:1937)
[junit] 2007-12-10 12:25:51,811 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:226):
result_table.column.size: 5
[junit] 2007-12-10 12:25:51,814 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:226):
result_table.column.size: 5
[junit] 2007-12-10 12:25:51,816 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:226):
result_table.column.size: 5
[junit] 2007-12-10 12:25:51,818 INFO [main]
org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:230):
result_table.row.count: 3
[junit] 2007-12-10 12:25:51,819 DEBUG [main]
org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:212):
Shutting down HBase Cluster
[junit] 2007-12-10 12:25:51,819 INFO [main]
org.apache.hadoop.hbase.HMaster.shutdown(HMaster.java:2515): Cluster shutdown
requested. Starting to quiesce servers
[junit] 2007-12-10 12:25:52,479 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:745): Got quiesce
server message
[junit] 2007-12-10 12:25:52,480 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1124):
MSG_REGIONSERVER_QUIESCE : regionname: , startKey: <>, tableDesc: {name: ,
families: {}}
[junit] 2007-12-10 12:25:52,481 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266):
closing region r1,,1197289526392
[junit] 2007-12-10 12:25:52,481 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 174246503/a
[junit] 2007-12-10 12:25:52,482 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 174246503/b
[junit] 2007-12-10 12:25:52,482 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 174246503/c
[junit] 2007-12-10 12:25:52,482 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed
r1,,1197289526392
[junit] 2007-12-10 12:25:52,483 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266):
closing region r2,,1197289536158
[junit] 2007-12-10 12:25:52,483 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -592010069/e
[junit] 2007-12-10 12:25:52,483 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -592010069/d
[junit] 2007-12-10 12:25:52,483 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed
r2,,1197289536158
[junit] 2007-12-10 12:25:52,484 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266):
closing region result_table,,1197289541672
[junit] 2007-12-10 12:25:52,484 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started
memcache flush for region result_table,,1197289541672. Size 306.0
[junit] 2007-12-10 12:25:52,952 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-1815541752/e/5543070408604458497 with sequence id 54 and size 212.0
[junit] 2007-12-10 12:25:53,007 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-1815541752/d/4262724526573872575 with sequence id 54 and size 212.0
[junit] 2007-12-10 12:25:53,464 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-1815541752/a/213011177863129867 with sequence id 54 and size 206.0
[junit] 2007-12-10 12:25:53,923 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-1815541752/b/3180343026610310564 with sequence id 54 and size 206.0
[junit] 2007-12-10 12:25:53,984 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added
-1815541752/c/7818224104138842699 with sequence id 54 and size 230.0
[junit] 2007-12-10 12:25:53,985 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished
memcache flush for region result_table,,1197289541672 in 1501ms, sequenceid=54
[junit] 2007-12-10 12:25:53,986 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/e
[junit] 2007-12-10 12:25:53,986 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/d
[junit] 2007-12-10 12:25:53,987 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/a
[junit] 2007-12-10 12:25:53,987 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/b
[junit] 2007-12-10 12:25:53,988 DEBUG [RegionServer:0.worker]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1815541752/c
[junit] 2007-12-10 12:25:53,988 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed
result_table,,1197289541672
[junit] 2007-12-10 12:25:54,498 INFO [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1360): Region
server 140.211.11.75:42725 quiesced
[junit] 2007-12-10 12:25:54,498 INFO [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1364): All user
tables quiesced. Proceeding with shutdown
[junit] 2007-12-10 12:25:54,499 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-12-10 12:25:54,499 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:739): Got
regionserver stop message
[junit] 2007-12-10 12:25:54,500 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-12-10 12:25:54,500 INFO [RegionServer:0]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): RegionServer:0 closing
leases
[junit] 2007-12-10 12:25:54,501 INFO [RegionServer:0.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): RegionServer:0.leaseChecker
exiting
[junit] 2007-12-10 12:25:54,501 INFO [RegionServer:0]
org.apache.hadoop.hbase.Leases.close(Leases.java:125): RegionServer:0 closed
leases
[junit] 2007-12-10 12:25:54,502 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1232):
closing region -ROOT-,,0
[junit] 2007-12-10 12:25:54,502 INFO [RegionServer:0.splitter]
org.apache.hadoop.hbase.HRegionServer$Splitter.run(HRegionServer.java:277):
RegionServer:0.splitter exiting
[junit] 2007-12-10 12:25:54,502 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -70236052/info
[junit] 2007-12-10 12:25:54,502 INFO [RegionServer:0.compactor]
org.apache.hadoop.hbase.HRegionServer$Compactor.run(HRegionServer.java:400):
RegionServer:0.compactor exiting
[junit] 2007-12-10 12:25:54,503 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed -ROOT-,,0
[junit] 2007-12-10 12:25:54,503 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1232):
closing region .META.,,1
[junit] 2007-12-10 12:25:54,504 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 1028785192/info
[junit] 2007-12-10 12:25:54,504 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed .META.,,1
[junit] 2007-12-10 12:25:54,504 DEBUG [RegionServer:0]
org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in
/hbase/log_140.211.11.75_1197289526331_42725
[junit] 2007-12-10 12:25:54,504 INFO [RegionServer:0.cacheFlusher]
org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:510):
RegionServer:0.cacheFlusher exiting
[junit] 2007-12-10 12:25:54,518 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:859): telling
master that region server is shutting down at: 140.211.11.75:42725
[junit] 2007-12-10 12:25:54,520 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1327): Region
server 140.211.11.75:42725: MSG_REPORT_EXITING -- cancelling lease
[junit] 2007-12-10 12:25:54,520 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.cancelLease(HMaster.java:1470): Cancelling
lease for 140.211.11.75:42725
[junit] 2007-12-10 12:25:54,521 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1334): Region
server 140.211.11.75:42725: MSG_REPORT_EXITING -- lease cancelled
[junit] 2007-12-10 12:25:54,521 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:866): stopping
server at: 140.211.11.75:42725
[junit] 2007-12-10 12:25:54,858 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-12-10 12:25:54,858 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] 2007-12-10 12:25:54,859 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:125): HMaster closed leases
[junit] 2007-12-10 12:25:54,859 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1149): HMaster main thread
exiting
[junit] 2007-12-10 12:25:54,997 INFO [RegionServer:0.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1173):
worker thread exiting
[junit] 2007-12-10 12:25:54,997 INFO [RegionServer:0]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:871):
RegionServer:0 exiting
[junit] 2007-12-10 12:25:54,998 INFO [main]
org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:238):
Shutdown HMaster 1 region server(s)
[junit] 2007-12-10 12:25:55,032 INFO [main]
org.apache.hadoop.hbase.StaticTestEnvironment.shutdownDfs(StaticTestEnvironment.java:133):
Shutting down FileSystem
[junit] 2007-12-10 12:25:55,117 INFO [main]
org.apache.hadoop.hbase.StaticTestEnvironment.shutdownDfs(StaticTestEnvironment.java: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: 37.81 sec
[junit] Running org.apache.hadoop.hbase.util.TestBase64
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.36 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.068 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.074 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: 72 minutes 6 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-2392
Updating HADOOP-2338
