You are viewing a plain text version of this content. The canonical link for it is here.
Posted to common-dev@hadoop.apache.org by hu...@lucene.zones.apache.org on 2007/12/10 13:26:36 UTC
Build failed in Hudson: Hadoop-Nightly #328
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:bcd@www.example.com/index.html?query=something#middle, Transformed url r:http://abc:bcd@com.example.www/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