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/07 13:08:32 UTC
Build failed in Hudson: Hadoop-Nightly #325
See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/325/changes
Changes:
[dhruba] HADOOP-2363. This fix allows running multiple instances of the unit test
in parallel. The bug was introduced in HADOOP-2185 that changed
port-rolling behaviour. (Konstantin Shvachko via dhruba)
[stack] HADOOP-2362 Leaking hdfs file handle on region split
[dhruba] HADOOP-2368. Fix unit tests on Windows.
(Tsz Wo (Nicholas), SZE via dhruba)
[jimk] HADOOP-2365 Result of HashFunction.hash() contains all identical values
[cutting] Add notes for HADOOP-2160 and HADOOP-1327.
[cutting] HADOOP-1327. Regenerate docs, adding new streaming pages.
[cutting] Remove unused file.
[omalley] HADOOP-1327. Adding user documentation for streaming.
------------------------------------------
[...truncated 76830 lines...]
[junit] 2007-12-07 12:06:28,724 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1781): assigning region r1,,1197029184596 to the only server 140.211.11.75:40406
[junit] 2007-12-07 12:06:28,726 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1102): MSG_REGION_OPEN : regionname: r1,,1197029184596, 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}}}
[junit] 2007-12-07 12:06:28,734 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 188225771/a (no reconstruction log)
[junit] 2007-12-07 12:06:28,739 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 188225771/a is -1
[junit] 2007-12-07 12:06:28,745 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 188225771/b (no reconstruction log)
[junit] 2007-12-07 12:06:28,748 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 188225771/b is -1
[junit] 2007-12-07 12:06:28,753 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 188225771/c (no reconstruction log)
[junit] 2007-12-07 12:06:28,757 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 188225771/c is -1
[junit] 2007-12-07 12:06:28,759 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r1,,1197029184596 is 0
[junit] 2007-12-07 12:06:28,761 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r1,,1197029184596 available
[junit] 2007-12-07 12:06:29,735 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_PROCESS_OPEN : regionname: r1,,1197029184596, 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:40406
[junit] 2007-12-07 12:06:29,737 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_OPEN : regionname: r1,,1197029184596, 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:40406
[junit] 2007-12-07 12:06:29,738 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1507): 140.211.11.75:40406 serving r1,,1197029184596
[junit] 2007-12-07 12:06:29,738 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1071): Main processing loop: PendingOpenOperation from 140.211.11.75:40406
[junit] 2007-12-07 12:06:29,740 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2352): regionname: r1,,1197029184596, 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:40406
[junit] 2007-12-07 12:06:29,741 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2398): updating row r1,,1197029184596 in table .META.,,1 with startcode 1197029184560 and server 140.211.11.75:40406
[junit] 2007-12-07 12:06:33,083 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table r1
[junit] 2007-12-07 12:06:33,091 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732): Found 1 region(s) for r1 at address: 140.211.11.75:40406, 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-07 12:06:33,243 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created at /hbase/hregion_48891814/log/hlog.dat.000
[junit] 2007-12-07 12:06:33,261 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 48891814/d (no reconstruction log)
[junit] 2007-12-07 12:06:33,293 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 48891814/d is -1
[junit] 2007-12-07 12:06:33,335 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 48891814/e (no reconstruction log)
[junit] 2007-12-07 12:06:33,344 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 48891814/e is -1
[junit] 2007-12-07 12:06:33,346 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r2,,1197029193115 is 0
[junit] 2007-12-07 12:06:33,357 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r2,,1197029193115 available
[junit] 2007-12-07 12:06:33,372 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 48891814/e
[junit] 2007-12-07 12:06:33,373 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 48891814/d
[junit] 2007-12-07 12:06:33,374 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r2,,1197029193115
[junit] 2007-12-07 12:06:33,375 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/hregion_48891814/log
[junit] 2007-12-07 12:06:33,400 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2484): created table r2
[junit] 2007-12-07 12:06:33,403 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308): No servers for r2. Doing a find...
[junit] 2007-12-07 12:06:33,409 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782): no server address for regionname: r2,,1197029193115, 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-07 12:06:33,411 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680): Sleeping. Table r2 not currently being served.
[junit] 2007-12-07 12:06:33,834 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1781): assigning region r2,,1197029193115 to the only server 140.211.11.75:40406
[junit] 2007-12-07 12:06:33,836 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1102): MSG_REGION_OPEN : regionname: r2,,1197029193115, 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-07 12:06:33,845 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 48891814/d (no reconstruction log)
[junit] 2007-12-07 12:06:33,849 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 48891814/d is -1
[junit] 2007-12-07 12:06:33,863 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 48891814/e (no reconstruction log)
[junit] 2007-12-07 12:06:33,867 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 48891814/e is -1
[junit] 2007-12-07 12:06:33,873 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r2,,1197029193115 is 0
[junit] 2007-12-07 12:06:33,884 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r2,,1197029193115 available
[junit] 2007-12-07 12:06:34,844 DEBUG [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_PROCESS_OPEN : regionname: r2,,1197029193115, 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:40406
[junit] 2007-12-07 12:06:34,845 DEBUG [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_OPEN : regionname: r2,,1197029193115, 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:40406
[junit] 2007-12-07 12:06:34,846 INFO [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1507): 140.211.11.75:40406 serving r2,,1197029193115
[junit] 2007-12-07 12:06:34,847 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1071): Main processing loop: PendingOpenOperation from 140.211.11.75:40406
[junit] 2007-12-07 12:06:34,848 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2352): regionname: r2,,1197029193115, 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:40406
[junit] 2007-12-07 12:06:34,848 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2398): updating row r2,,1197029193115 in table .META.,,1 with startcode 1197029184560 and server 140.211.11.75:40406
[junit] 2007-12-07 12:06:34,853 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-07 12:06:35,146 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added -70236052/info/5542954856878166290 with sequence id 25 and size 230.0
[junit] 2007-12-07 12:06:35,147 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region -ROOT-,,0 in 294ms, sequenceid=25
[junit] 2007-12-07 12:06:35,148 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore -ROOT-,,0/info not needed.
[junit] 2007-12-07 12:06:35,149 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region -ROOT-,,0 does not need compaction
[junit] 2007-12-07 12:06:35,793 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212): HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:40406}
[junit] 2007-12-07 12:06:35,908 DEBUG [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:35,913 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:294): HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:40406} complete
[junit] 2007-12-07 12:06:36,713 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region .META.,,1. Size 468.0
[junit] 2007-12-07 12:06:37,066 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 1028785192/info/2777348830907552644 with sequence id 26 and size 662.0
[junit] 2007-12-07 12:06:37,068 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region .META.,,1 in 356ms, sequenceid=26
[junit] 2007-12-07 12:06:37,069 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-07 12:06:37,069 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region .META.,,1 does not need compaction
[junit] 2007-12-07 12:06:37,744 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212): HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>, server: 140.211.11.75:40406}
[junit] 2007-12-07 12:06:37,769 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): HMaster.metaScanner regioninfo: {regionname: r1,,1197029184596, 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:37,774 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): HMaster.metaScanner regioninfo: {regionname: r2,,1197029193115, 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:37,777 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:294): HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>, server: 140.211.11.75:40406} complete
[junit] 2007-12-07 12:06:37,777 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:775): all meta regions scanned
[junit] 2007-12-07 12:06:38,422 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table r2
[junit] 2007-12-07 12:06:38,470 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732): Found 1 region(s) for r2 at address: 140.211.11.75:40406, 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-07 12:06:38,507 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created at /hbase/hregion_452897619/log/hlog.dat.000
[junit] 2007-12-07 12:06:38,517 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/a (no reconstruction log)
[junit] 2007-12-07 12:06:38,521 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/a is -1
[junit] 2007-12-07 12:06:38,533 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/b (no reconstruction log)
[junit] 2007-12-07 12:06:38,537 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/b is -1
[junit] 2007-12-07 12:06:38,546 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/c (no reconstruction log)
[junit] 2007-12-07 12:06:38,550 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/c is -1
[junit] 2007-12-07 12:06:38,561 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/d (no reconstruction log)
[junit] 2007-12-07 12:06:38,574 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/d is -1
[junit] 2007-12-07 12:06:38,586 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/e (no reconstruction log)
[junit] 2007-12-07 12:06:38,590 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/e is -1
[junit] 2007-12-07 12:06:38,593 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region result_table,,1197029198477 is 0
[junit] 2007-12-07 12:06:38,597 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region result_table,,1197029198477 available
[junit] 2007-12-07 12:06:38,600 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/e
[junit] 2007-12-07 12:06:38,601 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/d
[junit] 2007-12-07 12:06:38,603 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/a
[junit] 2007-12-07 12:06:38,604 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/b
[junit] 2007-12-07 12:06:38,605 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/c
[junit] 2007-12-07 12:06:38,606 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed result_table,,1197029198477
[junit] 2007-12-07 12:06:38,606 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/hregion_452897619/log
[junit] 2007-12-07 12:06:38,622 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2484): created table result_table
[junit] 2007-12-07 12:06:38,624 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308): No servers for result_table. Doing a find...
[junit] 2007-12-07 12:06:38,640 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782): no server address for regionname: result_table,,1197029198477, 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-07 12:06:38,643 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680): Sleeping. Table result_table not currently being served.
[junit] 2007-12-07 12:06:38,762 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region r1,,1197029184596. Size 310.0
[junit] 2007-12-07 12:06:38,872 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 188225771/a/3529670369620072254 with sequence id 34 and size 270.0
[junit] 2007-12-07 12:06:38,910 INFO [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1781): assigning region result_table,,1197029198477 to the only server 140.211.11.75:40406
[junit] 2007-12-07 12:06:38,912 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1102): MSG_REGION_OPEN : regionname: result_table,,1197029198477, 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-07 12:06:38,937 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/a (no reconstruction log)
[junit] 2007-12-07 12:06:38,940 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/a is -1
[junit] 2007-12-07 12:06:38,954 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/b (no reconstruction log)
[junit] 2007-12-07 12:06:38,957 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/b is -1
[junit] 2007-12-07 12:06:38,965 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/c (no reconstruction log)
[junit] 2007-12-07 12:06:38,968 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/c is -1
[junit] 2007-12-07 12:06:38,990 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/d (no reconstruction log)
[junit] 2007-12-07 12:06:38,993 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/d is -1
[junit] 2007-12-07 12:06:39,005 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 188225771/b/5596234344735039685 with sequence id 34 and size 270.0
[junit] 2007-12-07 12:06:39,010 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:581): starting 452897619/e (no reconstruction log)
[junit] 2007-12-07 12:06:39,013 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:608): maximum sequence id for hstore 452897619/e is -1
[junit] 2007-12-07 12:06:39,017 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region result_table,,1197029198477 is 0
[junit] 2007-12-07 12:06:39,019 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region result_table,,1197029198477 available
[junit] 2007-12-07 12:06:39,091 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 188225771/c/358321659314305965 with sequence id 34 and size 310.0
[junit] 2007-12-07 12:06:39,092 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region r1,,1197029184596 in 330ms, sequenceid=34
[junit] 2007-12-07 12:06:39,093 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore r1,,1197029184596/a not needed.
[junit] 2007-12-07 12:06:39,094 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore r1,,1197029184596/b not needed.
[junit] 2007-12-07 12:06:39,094 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore r1,,1197029184596/c not needed.
[junit] 2007-12-07 12:06:39,095 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region r1,,1197029184596 does not need compaction
[junit] 2007-12-07 12:06:39,917 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_PROCESS_OPEN : regionname: result_table,,1197029198477, 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:40406
[junit] 2007-12-07 12:06:39,918 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1471): Received MSG_REPORT_OPEN : regionname: result_table,,1197029198477, 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:40406
[junit] 2007-12-07 12:06:39,919 INFO [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1507): 140.211.11.75:40406 serving result_table,,1197029198477
[junit] 2007-12-07 12:06:39,921 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1071): Main processing loop: PendingOpenOperation from 140.211.11.75:40406
[junit] 2007-12-07 12:06:39,922 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2352): regionname: result_table,,1197029198477, 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:40406
[junit] 2007-12-07 12:06:39,922 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2398): updating row result_table,,1197029198477 in table .META.,,1 with startcode 1197029184560 and server 140.211.11.75:40406
[junit] 2007-12-07 12:06:43,652 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table result_table
[junit] 2007-12-07 12:06:43,677 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:40406, 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-07 12:06:44,031 WARN [IPC Server handler 4 on 40241] 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-07 12:06:44,071 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region r2,,1197029193115. Size 132.0
[junit] 2007-12-07 12:06:44,487 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 48891814/e/7679102966754675183 with sequence id 37 and size 218.0
[junit] 2007-12-07 12:06:44,586 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 48891814/d/4729414793358290815 with sequence id 37 and size 218.0
[junit] 2007-12-07 12:06:44,587 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region r2,,1197029193115 in 516ms, sequenceid=37
[junit] 2007-12-07 12:06:44,588 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore r2,,1197029193115/e not needed.
[junit] 2007-12-07 12:06:44,588 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore r2,,1197029193115/d not needed.
[junit] 2007-12-07 12:06:44,588 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region r2,,1197029193115 does not need compaction
[junit] 2007-12-07 12:06:45,799 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212): HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:40406}
[junit] 2007-12-07 12:06:45,965 DEBUG [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:45,968 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:294): HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>, server: 140.211.11.75:40406} complete
[junit] 2007-12-07 12:06:46,916 WARN [IPC Server handler 6 on 40241] 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-07 12:06:46,917 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-07 12:06:46,989 DEBUG [main] org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175): split: 0->r1,,
[junit] 2007-12-07 12:06:47,071 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region .META.,,1. Size 329.0
[junit] 2007-12-07 12:06:47,132 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 1028785192/info/2469438761849006560 with sequence id 38 and size 481.0
[junit] 2007-12-07 12:06:47,133 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region .META.,,1 in 62ms, sequenceid=38
[junit] 2007-12-07 12:06:47,133 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:965): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-07 12:06:47,134 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region .META.,,1 does not need compaction
[junit] 2007-12-07 12:06:47,697 DEBUG [Thread-180] org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175): split: 0->r1,,
[junit] 2007-12-07 12:06:47,751 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:212): HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>, server: 140.211.11.75:40406}
[junit] 2007-12-07 12:06:47,839 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): HMaster.metaScanner regioninfo: {regionname: r1,,1197029184596, 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:47,843 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): HMaster.metaScanner regioninfo: {regionname: r2,,1197029193115, 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:47,845 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:248): HMaster.metaScanner regioninfo: {regionname: result_table,,1197029198477, 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:40406, startCode: 1197029184560
[junit] 2007-12-07 12:06:47,848 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:294): HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>, server: 140.211.11.75:40406} complete
[junit] 2007-12-07 12:06:47,848 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:775): all meta regions scanned
[junit] 2007-12-07 12:06:49,144 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region result_table,,1197029198477. Size 306.0
[junit] 2007-12-07 12:06:50,112 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-07 12:06:50,115 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-07 12:06:50,128 DEBUG [main] org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:212): Shutting down HBase Cluster
[junit] 2007-12-07 12:06:50,322 INFO [HMaster] org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1215): Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:40406, startcode: 1197029184560, load: (requests: 2 regions: 5)]
[junit] 2007-12-07 12:06:50,339 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:729): Got regionserver stop message
[junit] 2007-12-07 12:06:50,339 INFO [RegionServer:0] org.apache.hadoop.hbase.Leases.close(Leases.java:109): RegionServer:0 closing leases
[junit] 2007-12-07 12:06:50,340 INFO [RegionServer:0.leaseChecker] org.apache.hadoop.hbase.Chore.run(Chore.java:62): RegionServer:0.leaseChecker exiting
[junit] 2007-12-07 12:06:50,340 INFO [RegionServer:0] org.apache.hadoop.hbase.Leases.close(Leases.java:125): RegionServer:0 closed leases
[junit] 2007-12-07 12:06:50,563 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 452897619/e/8650260832468138483 with sequence id 54 and size 212.0
[junit] 2007-12-07 12:06:50,613 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 452897619/d/8587347407437163641 with sequence id 54 and size 212.0
[junit] 2007-12-07 12:06:50,708 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 452897619/a/4042995440014142666 with sequence id 54 and size 206.0
[junit] 2007-12-07 12:06:51,310 INFO [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegionServer$Compactor.run(HRegionServer.java:398): RegionServer:0.compactor exiting
[junit] 2007-12-07 12:06:51,331 INFO [RegionServer:0.splitter] org.apache.hadoop.hbase.HRegionServer$Splitter.run(HRegionServer.java:275): RegionServer:0.splitter exiting
[junit] 2007-12-07 12:06:51,331 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1147): worker thread exiting
[junit] 2007-12-07 12:06:51,332 INFO [HMaster] org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1215): Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:40406, startcode: 1197029184560, load: (requests: 2 regions: 5)]
[junit] 2007-12-07 12:06:51,502 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 452897619/b/3004665155141339089 with sequence id 54 and size 206.0
[junit] 2007-12-07 12:06:52,341 INFO [HMaster] org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1215): Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:40406, startcode: 1197029184560, load: (requests: 2 regions: 5)]
[junit] 2007-12-07 12:06:52,458 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:942): Added 452897619/c/1416916635331178625 with sequence id 54 and size 230.0
[junit] 2007-12-07 12:06:52,459 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region result_table,,1197029198477 in 3315ms, sequenceid=54
[junit] 2007-12-07 12:06:52,461 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1199): closing region -ROOT-,,0
[junit] 2007-12-07 12:06:52,462 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed -70236052/info
[junit] 2007-12-07 12:06:52,463 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed -ROOT-,,0
[junit] 2007-12-07 12:06:52,464 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1199): closing region .META.,,1
[junit] 2007-12-07 12:06:52,464 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 1028785192/info
[junit] 2007-12-07 12:06:52,465 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed .META.,,1
[junit] 2007-12-07 12:06:52,465 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1199): closing region r1,,1197029184596
[junit] 2007-12-07 12:06:52,466 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 188225771/a
[junit] 2007-12-07 12:06:52,466 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 188225771/b
[junit] 2007-12-07 12:06:52,467 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 188225771/c
[junit] 2007-12-07 12:06:52,468 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r1,,1197029184596
[junit] 2007-12-07 12:06:52,468 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1199): closing region r2,,1197029193115
[junit] 2007-12-07 12:06:52,468 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 48891814/e
[junit] 2007-12-07 12:06:52,469 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 48891814/d
[junit] 2007-12-07 12:06:52,469 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r2,,1197029193115
[junit] 2007-12-07 12:06:52,469 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1199): closing region result_table,,1197029198477
[junit] 2007-12-07 12:06:52,469 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/e
[junit] 2007-12-07 12:06:52,470 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/d
[junit] 2007-12-07 12:06:52,470 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/a
[junit] 2007-12-07 12:06:52,470 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/b
[junit] 2007-12-07 12:06:52,470 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:853): closed 452897619/c
[junit] 2007-12-07 12:06:52,471 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed result_table,,1197029198477
[junit] 2007-12-07 12:06:52,471 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/log_140.211.11.75_1197029184560_40406
[junit] 2007-12-07 12:06:52,488 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:837): telling master that region server is shutting down at: 140.211.11.75:40406
[junit] 2007-12-07 12:06:52,491 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1312): Region server 140.211.11.75:40406: MSG_REPORT_EXITING -- cancelling lease
[junit] 2007-12-07 12:06:52,492 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.cancelLease(HMaster.java:1436): Cancelling lease for 140.211.11.75:40406
[junit] 2007-12-07 12:06:52,492 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1319): Region server 140.211.11.75:40406: MSG_REPORT_EXITING -- lease cancelled
[junit] 2007-12-07 12:06:52,494 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:844): stopping server at: 140.211.11.75:40406
[junit] 2007-12-07 12:06:52,494 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:849): RegionServer:0 exiting
[junit] 2007-12-07 12:06:52,495 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-12-07 12:06:52,496 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-12-07 12:06:52,497 INFO [HMaster] org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-12-07 12:06:52,498 INFO [HMaster.leaseChecker] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] 2007-12-07 12:06:52,498 INFO [HMaster] org.apache.hadoop.hbase.Leases.close(Leases.java:125): HMaster closed leases
[junit] 2007-12-07 12:06:52,498 INFO [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1155): HMaster main thread exiting
[junit] 2007-12-07 12:06:52,499 INFO [main] org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:238): Shutdown HMaster 1 region server(s)
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 0
[junit] 2007-12-07 12:06:52,924 WARN [org.apache.hadoop.dfs.PendingReplicationBlocks$PendingReplicationMonitor@bb0d0d] org.apache.hadoop.dfs.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:187): PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep interrupted
[junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 35.287 sec
[junit] Running org.apache.hadoop.hbase.util.TestBase64 [junit] Test org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce FAILED
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.452 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.074 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.08 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: 48 minutes 24 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-1327
Updating HADOOP-2362
Updating HADOOP-2185
Updating HADOOP-2160
Updating HADOOP-2365
Updating HADOOP-2363
Updating HADOOP-2368