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/09 13:37:15 UTC
Build failed in Hudson: Hadoop-Nightly #327
See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/327/changes
Changes:
[stack] HADOOP-2384 Delete all members of a column family on a specific row
[stack] HADOOP-1550 No means of deleting a'row'
I forgot to add this file when I commited patch for HADOOP-1550
------------------------------------------
[...truncated 56214 lines...]
[junit] 2007-12-09 12:35:48,992 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 888253996/a is -1
[junit] 2007-12-09 12:35:48,997 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 888253996/b (no reconstruction log)
[junit] 2007-12-09 12:35:49,000 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 888253996/b is -1
[junit] 2007-12-09 12:35:49,007 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 888253996/c (no reconstruction log)
[junit] 2007-12-09 12:35:49,011 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 888253996/c is -1
[junit] 2007-12-09 12:35:49,013 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r1,,1197203744883 is 0
[junit] 2007-12-09 12:35:49,015 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r1,,1197203744883 available
[junit] 2007-12-09 12:35:49,990 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_PROCESS_OPEN : regionname: r1,,1197203744883, 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:43712
[junit] 2007-12-09 12:35:49,991 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_OPEN : regionname: r1,,1197203744883, 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:43712
[junit] 2007-12-09 12:35:49,992 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1550): 140.211.11.75:43712 serving r1,,1197203744883
[junit] 2007-12-09 12:35:49,993 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop: PendingOpenOperation from 140.211.11.75:43712
[junit] 2007-12-09 12:35:49,994 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2431): regionname: r1,,1197203744883, 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:43712
[junit] 2007-12-09 12:35:49,995 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1880): numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-09 12:35:49,996 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2445): updating row r1,,1197203744883 in table .META.,,1 with startcode 1197203744848 and server 140.211.11.75:43712
[junit] 2007-12-09 12:35:53,258 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table r1
[junit] 2007-12-09 12:35:53,266 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732): Found 1 region(s) for r1 at address: 140.211.11.75:43712, 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-09 12:35:53,292 INFO [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created at /hbase/hregion_2032161406/log/hlog.dat.000
[junit] 2007-12-09 12:35:53,300 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 2032161406/d (no reconstruction log)
[junit] 2007-12-09 12:35:53,303 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 2032161406/d is -1
[junit] 2007-12-09 12:35:53,311 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 2032161406/e (no reconstruction log)
[junit] 2007-12-09 12:35:53,314 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 2032161406/e is -1
[junit] 2007-12-09 12:35:53,315 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r2,,1197203753277 is 0
[junit] 2007-12-09 12:35:53,317 INFO [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r2,,1197203753277 available
[junit] 2007-12-09 12:35:53,319 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 2032161406/e
[junit] 2007-12-09 12:35:53,320 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 2032161406/d
[junit] 2007-12-09 12:35:53,320 INFO [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r2,,1197203753277
[junit] 2007-12-09 12:35:53,321 DEBUG [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/hregion_2032161406/log
[junit] 2007-12-09 12:35:53,733 INFO [IPC Server handler 4 on 60000] org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2520): created table r2
[junit] 2007-12-09 12:35:53,734 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308): No servers for r2. Doing a find...
[junit] 2007-12-09 12:35:53,739 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782): no server address for regionname: r2,,1197203753277, 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-09 12:35:53,741 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680): Sleeping. Table r2 not currently being served.
[junit] 2007-12-09 12:35:54,029 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1831): assigning region r2,,1197203753277 to the only server 140.211.11.75:43712
[junit] 2007-12-09 12:35:54,031 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1124): MSG_REGION_OPEN : regionname: r2,,1197203753277, 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-09 12:35:54,039 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 2032161406/d (no reconstruction log)
[junit] 2007-12-09 12:35:54,042 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 2032161406/d is -1
[junit] 2007-12-09 12:35:54,047 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting 2032161406/e (no reconstruction log)
[junit] 2007-12-09 12:35:54,051 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore 2032161406/e is -1
[junit] 2007-12-09 12:35:54,052 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region r2,,1197203753277 is 0
[junit] 2007-12-09 12:35:54,055 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region r2,,1197203753277 available
[junit] 2007-12-09 12:35:54,998 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-09 12:35:55,039 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_PROCESS_OPEN : regionname: r2,,1197203753277, 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:43712
[junit] 2007-12-09 12:35:55,040 DEBUG [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_OPEN : regionname: r2,,1197203753277, 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:43712
[junit] 2007-12-09 12:35:55,040 INFO [IPC Server handler 2 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1550): 140.211.11.75:43712 serving r2,,1197203753277
[junit] 2007-12-09 12:35:55,042 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop: PendingOpenOperation from 140.211.11.75:43712
[junit] 2007-12-09 12:35:55,043 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2431): regionname: r2,,1197203753277, 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:43712
[junit] 2007-12-09 12:35:55,043 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1880): numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-09 12:35:55,044 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2445): updating row r2,,1197203753277 in table .META.,,1 with startcode 1197203744848 and server 140.211.11.75:43712
[junit] 2007-12-09 12:35:55,074 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -70236052/info/5042968640820627996 with sequence id 23 and size 230.0
[junit] 2007-12-09 12:35:55,075 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region -ROOT-,,0 in 77ms, sequenceid=23
[junit] 2007-12-09 12:35:55,076 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore -ROOT-,,0/info not needed.
[junit] 2007-12-09 12:35:55,076 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region -ROOT-,,0 does not need compaction
[junit] 2007-12-09 12:35:56,048 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:43712}
[junit] 2007-12-09 12:35:56,077 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:35:56,081 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:43712} complete
[junit] 2007-12-09 12:35:56,987 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-09 12:35:57,480 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 1028785192/info/7119916998828073864 with sequence id 26 and size 666.0
[junit] 2007-12-09 12:35:57,481 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region .META.,,1 in 494ms, sequenceid=26
[junit] 2007-12-09 12:35:57,482 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-09 12:35:57,483 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region .META.,,1 does not need compaction
[junit] 2007-12-09 12:35:57,997 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:43712}
[junit] 2007-12-09 12:35:58,019 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249): HMaster.metaScanner regioninfo: {regionname: r1,,1197203744883, 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:35:58,023 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249): HMaster.metaScanner regioninfo: {regionname: r2,,1197203753277, 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:35:58,027 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:43712} complete
[junit] 2007-12-09 12:35:58,028 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:774): all meta regions scanned
[junit] 2007-12-09 12:35:58,747 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table r2
[junit] 2007-12-09 12:35:58,764 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732): Found 1 region(s) for r2 at address: 140.211.11.75:43712, 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-09 12:35:58,804 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:300): new log writer created at /hbase/hregion_-1864303521/log/hlog.dat.000
[junit] 2007-12-09 12:35:58,812 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/a (no reconstruction log)
[junit] 2007-12-09 12:35:58,815 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/a is -1
[junit] 2007-12-09 12:35:58,824 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/b (no reconstruction log)
[junit] 2007-12-09 12:35:58,828 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/b is -1
[junit] 2007-12-09 12:35:58,838 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/c (no reconstruction log)
[junit] 2007-12-09 12:35:58,841 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/c is -1
[junit] 2007-12-09 12:35:58,849 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/d (no reconstruction log)
[junit] 2007-12-09 12:35:58,851 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/d is -1
[junit] 2007-12-09 12:35:58,859 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/e (no reconstruction log)
[junit] 2007-12-09 12:35:58,861 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/e is -1
[junit] 2007-12-09 12:35:58,862 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region result_table,,1197203758772 is 0
[junit] 2007-12-09 12:35:58,865 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region result_table,,1197203758772 available
[junit] 2007-12-09 12:35:58,868 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/e
[junit] 2007-12-09 12:35:58,868 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/d
[junit] 2007-12-09 12:35:58,869 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/a
[junit] 2007-12-09 12:35:58,870 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/b
[junit] 2007-12-09 12:35:58,871 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/c
[junit] 2007-12-09 12:35:58,871 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed result_table,,1197203758772
[junit] 2007-12-09 12:35:58,872 DEBUG [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/hregion_-1864303521/log
[junit] 2007-12-09 12:35:59,017 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region r1,,1197203744883. Size 310.0
[junit] 2007-12-09 12:35:59,292 INFO [IPC Server handler 3 on 60000] org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2520): created table result_table
[junit] 2007-12-09 12:35:59,293 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:308): No servers for result_table. Doing a find...
[junit] 2007-12-09 12:35:59,311 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:782): no server address for regionname: result_table,,1197203758772, 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-09 12:35:59,313 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:680): Sleeping. Table result_table not currently being served.
[junit] 2007-12-09 12:35:59,903 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 888253996/a/8334914626209353137 with sequence id 34 and size 270.0
[junit] 2007-12-09 12:35:59,991 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 888253996/b/1019109921634685240 with sequence id 34 and size 270.0
[junit] 2007-12-09 12:36:00,089 INFO [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1831): assigning region result_table,,1197203758772 to the only server 140.211.11.75:43712
[junit] 2007-12-09 12:36:00,091 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1124): MSG_REGION_OPEN : regionname: result_table,,1197203758772, 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-09 12:36:00,101 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/a (no reconstruction log)
[junit] 2007-12-09 12:36:00,104 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/a is -1
[junit] 2007-12-09 12:36:00,109 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/b (no reconstruction log)
[junit] 2007-12-09 12:36:00,127 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/b is -1
[junit] 2007-12-09 12:36:00,133 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/c (no reconstruction log)
[junit] 2007-12-09 12:36:00,140 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/c is -1
[junit] 2007-12-09 12:36:00,146 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/d (no reconstruction log)
[junit] 2007-12-09 12:36:00,148 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/d is -1
[junit] 2007-12-09 12:36:00,154 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:600): starting -1864303521/e (no reconstruction log)
[junit] 2007-12-09 12:36:00,156 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.<init>(HStore.java:627): maximum sequence id for hstore -1864303521/e is -1
[junit] 2007-12-09 12:36:00,158 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:299): Next sequence id for region result_table,,1197203758772 is 0
[junit] 2007-12-09 12:36:00,160 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:327): region result_table,,1197203758772 available
[junit] 2007-12-09 12:36:00,452 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 888253996/c/7608542430472569599 with sequence id 34 and size 310.0
[junit] 2007-12-09 12:36:00,453 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region r1,,1197203744883 in 1436ms, sequenceid=34
[junit] 2007-12-09 12:36:00,453 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore r1,,1197203744883/a not needed.
[junit] 2007-12-09 12:36:00,454 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore r1,,1197203744883/b not needed.
[junit] 2007-12-09 12:36:00,455 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore r1,,1197203744883/c not needed.
[junit] 2007-12-09 12:36:00,455 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region r1,,1197203744883 does not need compaction
[junit] 2007-12-09 12:36:01,099 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_PROCESS_OPEN : regionname: result_table,,1197203758772, 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:43712
[junit] 2007-12-09 12:36:01,100 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1489): Received MSG_REPORT_OPEN : regionname: result_table,,1197203758772, 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:43712
[junit] 2007-12-09 12:36:01,100 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1550): 140.211.11.75:43712 serving result_table,,1197203758772
[junit] 2007-12-09 12:36:01,102 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1065): Main processing loop: PendingOpenOperation from 140.211.11.75:43712
[junit] 2007-12-09 12:36:01,103 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2431): regionname: result_table,,1197203758772, 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:43712
[junit] 2007-12-09 12:36:01,103 DEBUG [HMaster] org.apache.hadoop.hbase.HMaster$RegionServerOperation.metaTableAvailable(HMaster.java:1880): numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
[junit] 2007-12-09 12:36:01,104 INFO [HMaster] org.apache.hadoop.hbase.HMaster$ProcessRegionOpen.process(HMaster.java:2445): updating row result_table,,1197203758772 in table .META.,,1 with startcode 1197203744848 and server 140.211.11.75:43712
[junit] 2007-12-09 12:36:04,056 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region r2,,1197203753277. Size 132.0
[junit] 2007-12-09 12:36:04,109 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 2032161406/e/4541213841759961140 with sequence id 37 and size 218.0
[junit] 2007-12-09 12:36:04,159 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 2032161406/d/3855743137019695681 with sequence id 37 and size 218.0
[junit] 2007-12-09 12:36:04,160 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region r2,,1197203753277 in 104ms, sequenceid=37
[junit] 2007-12-09 12:36:04,160 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore r2,,1197203753277/e not needed.
[junit] 2007-12-09 12:36:04,161 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore r2,,1197203753277/d not needed.
[junit] 2007-12-09 12:36:04,161 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region r2,,1197203753277 does not need compaction
[junit] 2007-12-09 12:36:04,316 DEBUG [main] org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:689): Wake. Retry finding table result_table
[junit] 2007-12-09 12:36:04,334 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:43712, 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-09 12:36:04,635 WARN [IPC Server handler 7 on 43686] 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-09 12:36:06,058 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:43712}
[junit] 2007-12-09 12:36:06,109 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:36:06,112 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:43712} complete
[junit] 2007-12-09 12:36:06,504 WARN [IPC Server handler 7 on 43686] 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-09 12:36:06,505 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-09 12:36:06,577 DEBUG [main] org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175): split: 0->r1,,
[junit] 2007-12-09 12:36:06,740 DEBUG [Thread-177] org.apache.hadoop.hbase.mapred.TableInputFormat.getSplits(TableInputFormat.java:175): split: 0->r1,,
[junit] 2007-12-09 12:36:07,487 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-09 12:36:07,582 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added 1028785192/info/3690931722696138728 with sequence id 53 and size 483.0
[junit] 2007-12-09 12:36:07,583 DEBUG [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region .META.,,1 in 97ms, sequenceid=53
[junit] 2007-12-09 12:36:07,585 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HStore.needsCompaction(HStore.java:984): compaction for HStore .META.,,1/info not needed.
[junit] 2007-12-09 12:36:07,586 DEBUG [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegion.compactIfNeeded(HRegion.java:702): region .META.,,1 does not need compaction
[junit] 2007-12-09 12:36:08,373 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:43712}
[junit] 2007-12-09 12:36:09,175 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-09 12:36:09,177 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-09 12:36:09,187 INFO [main] org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228): result_table.column.size: 5
[junit] 2007-12-09 12:36:09,205 INFO [main] org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228): result_table.column.size: 5
[junit] 2007-12-09 12:36:09,209 INFO [main] org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:228): result_table.column.size: 5
[junit] 2007-12-09 12:36:09,211 INFO [main] org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.verify(TestTableJoinMapReduce.java:232): result_table.row.count: 3
[junit] 2007-12-09 12:36:09,211 DEBUG [main] org.apache.hadoop.hbase.LocalHBaseCluster.shutdown(LocalHBaseCluster.java:212): Shutting down HBase Cluster
[junit] 2007-12-09 12:36:09,212 INFO [main] org.apache.hadoop.hbase.HMaster.shutdown(HMaster.java:2499): Cluster shutdown requested. Starting to quiesce servers
[junit] 2007-12-09 12:36:09,234 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249): HMaster.metaScanner regioninfo: {regionname: r1,,1197203744883, 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:36:09,359 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249): HMaster.metaScanner regioninfo: {regionname: r2,,1197203753277, 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:36:09,363 DEBUG [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:249): HMaster.metaScanner regioninfo: {regionname: result_table,,1197203758772, 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:43712, startCode: 1197203744848
[junit] 2007-12-09 12:36:09,366 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:43712} complete
[junit] 2007-12-09 12:36:09,366 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.HMaster$MetaScanner.metaRegionsScanned(HMaster.java:774): all meta regions scanned
[junit] 2007-12-09 12:36:09,378 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:745): Got quiesce server message
[junit] 2007-12-09 12:36:09,379 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-09 12:36:09,379 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266): closing region r1,,1197203744883
[junit] 2007-12-09 12:36:09,380 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 888253996/a
[junit] 2007-12-09 12:36:09,381 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 888253996/b
[junit] 2007-12-09 12:36:09,381 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 888253996/c
[junit] 2007-12-09 12:36:09,382 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r1,,1197203744883
[junit] 2007-12-09 12:36:09,382 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266): closing region r2,,1197203753277
[junit] 2007-12-09 12:36:09,383 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 2032161406/e
[junit] 2007-12-09 12:36:09,383 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 2032161406/d
[junit] 2007-12-09 12:36:09,384 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed r2,,1197203753277
[junit] 2007-12-09 12:36:09,384 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer.closeUserRegions(HRegionServer.java:1266): closing region result_table,,1197203758772
[junit] 2007-12-09 12:36:09,385 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.snapshotMemcaches(HRegion.java:832): Started memcache flush for region result_table,,1197203758772. Size 306.0
[junit] 2007-12-09 12:36:09,880 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -1864303521/e/6516309791555576487 with sequence id 54 and size 212.0
[junit] 2007-12-09 12:36:09,938 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -1864303521/d/7658659872059875271 with sequence id 54 and size 212.0
[junit] 2007-12-09 12:36:10,060 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -1864303521/a/311415590551091547 with sequence id 54 and size 206.0
[junit] 2007-12-09 12:36:10,122 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -1864303521/b/2038832066556027915 with sequence id 54 and size 206.0
[junit] 2007-12-09 12:36:10,240 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.internalFlushCache(HStore.java:961): Added -1864303521/c/6485271303889749511 with sequence id 54 and size 230.0
[junit] 2007-12-09 12:36:10,242 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:938): Finished memcache flush for region result_table,,1197203758772 in 857ms, sequenceid=54
[junit] 2007-12-09 12:36:10,244 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/e
[junit] 2007-12-09 12:36:10,245 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/d
[junit] 2007-12-09 12:36:10,246 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/a
[junit] 2007-12-09 12:36:10,247 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/b
[junit] 2007-12-09 12:36:10,248 DEBUG [RegionServer:0.worker] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -1864303521/c
[junit] 2007-12-09 12:36:10,249 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed result_table,,1197203758772
[junit] 2007-12-09 12:36:10,387 INFO [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1345): Region server 140.211.11.75:43712 quiesced
[junit] 2007-12-09 12:36:10,388 INFO [IPC Server handler 1 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1349): All user tables quiesced. Proceeding with shutdown
[junit] 2007-12-09 12:36:10,389 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:739): Got regionserver stop message
[junit] 2007-12-09 12:36:10,389 INFO [RegionServer:0] org.apache.hadoop.hbase.Leases.close(Leases.java:109): RegionServer:0 closing leases
[junit] 2007-12-09 12:36:10,390 INFO [RegionServer:0.leaseChecker] org.apache.hadoop.hbase.Chore.run(Chore.java:62): RegionServer:0.leaseChecker exiting
[junit] 2007-12-09 12:36:10,391 INFO [RegionServer:0] org.apache.hadoop.hbase.Leases.close(Leases.java:125): RegionServer:0 closed leases
[junit] 2007-12-09 12:36:10,393 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1232): closing region -ROOT-,,0
[junit] 2007-12-09 12:36:10,396 INFO [RegionServer:0.splitter] org.apache.hadoop.hbase.HRegionServer$Splitter.run(HRegionServer.java:277): RegionServer:0.splitter exiting
[junit] 2007-12-09 12:36:10,397 INFO [RegionServer:0.cacheFlusher] org.apache.hadoop.hbase.HRegionServer$Flusher.run(HRegionServer.java:510): RegionServer:0.cacheFlusher exiting
[junit] 2007-12-09 12:36:10,397 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed -70236052/info
[junit] 2007-12-09 12:36:10,399 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed -ROOT-,,0
[junit] 2007-12-09 12:36:10,399 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:1232): closing region .META.,,1
[junit] 2007-12-09 12:36:10,400 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HStore.close(HStore.java:872): closed 1028785192/info
[junit] 2007-12-09 12:36:10,400 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegion.close(HRegion.java:428): closed .META.,,1
[junit] 2007-12-09 12:36:10,401 DEBUG [RegionServer:0] org.apache.hadoop.hbase.HLog.close(HLog.java:386): closing log writer in /hbase/log_140.211.11.75_1197203744848_43712
[junit] 2007-12-09 12:36:10,396 INFO [RegionServer:0.compactor] org.apache.hadoop.hbase.HRegionServer$Compactor.run(HRegionServer.java:400): RegionServer:0.compactor exiting
[junit] 2007-12-09 12:36:10,427 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:43712
[junit] 2007-12-09 12:36:10,429 DEBUG [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1312): Region server 140.211.11.75:43712: MSG_REPORT_EXITING -- cancelling lease
[junit] 2007-12-09 12:36:10,430 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.cancelLease(HMaster.java:1454): Cancelling lease for 140.211.11.75:43712
[junit] 2007-12-09 12:36:10,431 INFO [IPC Server handler 0 on 60000] org.apache.hadoop.hbase.HMaster.regionServerReport(HMaster.java:1319): Region server 140.211.11.75:43712: MSG_REPORT_EXITING -- lease cancelled
[junit] 2007-12-09 12:36:10,433 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:866): stopping server at: 140.211.11.75:43712
[junit] 2007-12-09 12:36:11,255 INFO [RegionServer:0.worker] org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:1173): worker thread exiting
[junit] 2007-12-09 12:36:11,256 INFO [RegionServer:0] org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:871): RegionServer:0 exiting
[junit] 2007-12-09 12:36:11,396 INFO [HMaster.rootScanner] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-12-09 12:36:11,397 INFO [HMaster] org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-12-09 12:36:11,399 INFO [HMaster.leaseChecker] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] 2007-12-09 12:36:11,399 INFO [HMaster] org.apache.hadoop.hbase.Leases.close(Leases.java:125): HMaster closed leases
[junit] 2007-12-09 12:36:11,396 INFO [HMaster.metaScanner] org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-12-09 12:36:11,401 INFO [HMaster] org.apache.hadoop.hbase.HMaster.run(HMaster.java:1151): HMaster main thread exiting
[junit] 2007-12-09 12:36:11,401 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] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 32.328 sec
[junit] Running org.apache.hadoop.hbase.util.TestBase64
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.323 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.067 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.169 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: 53 minutes 48 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-1550
Updating HADOOP-2384