hadoop-common-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From hud...@lucene.zones.apache.org
Subject Build failed in Hudson: Hadoop-Nightly #349
Date Sat, 29 Dec 2007 13:33:28 GMT
See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/349/changes

Changes:

[nigel] Preparing for release 0.15.2

[nigel] HADOOP-2456. Hardcode English locale to prevent NumberFormatException from occurring
when starting the NameNode with certain locales. Contributed by Matthias Friedrich.

[nigel] HADOOP-2453. Move CHANGES.txt comment to 0.16.0

------------------------------------------
[...truncated 48268 lines...]
    [junit] 2007-12-29 13:20:17,356 DEBUG [IPC Server handler 2 on 60000] hbase.HStore(880):
closed result_table,,1198934398607/b (330763908/b)
    [junit] 2007-12-29 13:20:17,357 DEBUG [IPC Server handler 2 on 60000] hbase.HStore(880):
closed result_table,,1198934398607/c (330763908/c)
    [junit] 2007-12-29 13:20:17,357 INFO  [IPC Server handler 2 on 60000] hbase.HRegion(430):
closed result_table,,1198934398607
    [junit] 2007-12-29 13:20:17,357 DEBUG [IPC Server handler 2 on 60000] hbase.HLog(388):
closing log writer in /hbase/hregion_330763908/log
    [junit] 2007-12-29 13:20:17,358 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r1,,1198934363198, startKey: <>, encodedName(1004432247)
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:38758, startCode: 1198934363169
    [junit] 2007-12-29 13:20:17,361 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r2,,1198934393554, startKey: <>, encodedName(132806885)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:17,364 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(293):
HMaster.metaScanner scan of meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:17,364 INFO  [HMaster.metaScanner] hbase.HMaster$MetaScanner(763):
all meta regions scanned
    [junit] 2007-12-29 13:20:18,523 DEBUG [RegionServer:0.cacheFlusher] hbase.HStore(972):
Added 1004432247/a/7585352402922746197 with 5 entries, sequence id 33, and size 270.0 for
r1,,1198934363198/a
    [junit] 2007-12-29 13:20:22,274 INFO  [IPC Server handler 2 on 60000] hbase.HMaster(2547):
created table result_table
    [junit] 2007-12-29 13:20:22,275 DEBUG [main] hbase.HConnectionManager$TableServers(308):
No servers for result_table. Doing a find...
    [junit] 2007-12-29 13:20:22,289 DEBUG [main] hbase.HConnectionManager$TableServers(782):
no server address for regionname: result_table,,1198934398607, startKey: <>, encodedName(330763908)
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-29 13:20:22,290 DEBUG [main] hbase.HConnectionManager$TableServers(680):
Sleeping. Table result_table not currently being served.
    [junit] 2007-12-29 13:20:22,961 INFO  [IPC Server handler 0 on 60000] hbase.HMaster(1858):
assigning region result_table,,1198934398607 to the only server 140.211.11.75:38758
    [junit] 2007-12-29 13:20:22,962 INFO  [RegionServer:0.worker] hbase.HRegionServer$Worker(1153):
MSG_REGION_OPEN : result_table,,1198934398607
    [junit] 2007-12-29 13:20:22,967 DEBUG [RegionServer:0.worker] hbase.HStore(601): starting
result_table,,1198934398607/a (330763908/a) (no reconstruction log)
    [junit] 2007-12-29 13:20:22,969 DEBUG [RegionServer:0.worker] hbase.HStore(629): maximum
sequence id for hstore result_table,,1198934398607/a (330763908/a) is -1
    [junit] 2007-12-29 13:20:22,973 DEBUG [RegionServer:0.worker] hbase.HStore(601): starting
result_table,,1198934398607/b (330763908/b) (no reconstruction log)
    [junit] 2007-12-29 13:20:22,975 DEBUG [RegionServer:0.worker] hbase.HStore(629): maximum
sequence id for hstore result_table,,1198934398607/b (330763908/b) is -1
    [junit] 2007-12-29 13:20:22,980 DEBUG [RegionServer:0.worker] hbase.HStore(601): starting
result_table,,1198934398607/c (330763908/c) (no reconstruction log)
    [junit] 2007-12-29 13:20:22,982 DEBUG [RegionServer:0.worker] hbase.HStore(629): maximum
sequence id for hstore result_table,,1198934398607/c (330763908/c) is -1
    [junit] 2007-12-29 13:20:22,986 DEBUG [RegionServer:0.worker] hbase.HStore(601): starting
result_table,,1198934398607/d (330763908/d) (no reconstruction log)
    [junit] 2007-12-29 13:20:22,988 DEBUG [RegionServer:0.worker] hbase.HStore(629): maximum
sequence id for hstore result_table,,1198934398607/d (330763908/d) is -1
    [junit] 2007-12-29 13:20:22,992 DEBUG [RegionServer:0.worker] hbase.HStore(601): starting
result_table,,1198934398607/e (330763908/e) (no reconstruction log)
    [junit] 2007-12-29 13:20:22,993 DEBUG [RegionServer:0.worker] hbase.HStore(629): maximum
sequence id for hstore result_table,,1198934398607/e (330763908/e) is -1
    [junit] 2007-12-29 13:20:22,994 DEBUG [RegionServer:0.worker] hbase.HRegion(300): Next
sequence id for region result_table,,1198934398607 is 0
    [junit] 2007-12-29 13:20:22,996 INFO  [RegionServer:0.worker] hbase.HRegion(328): region
result_table,,1198934398607 available
    [junit] 2007-12-29 13:20:23,971 DEBUG [IPC Server handler 3 on 60000] hbase.HMaster(1516):
Received MSG_REPORT_PROCESS_OPEN : result_table,,1198934398607 from 140.211.11.75:38758
    [junit] 2007-12-29 13:20:23,972 DEBUG [IPC Server handler 3 on 60000] hbase.HMaster(1516):
Received MSG_REPORT_OPEN : result_table,,1198934398607 from 140.211.11.75:38758
    [junit] 2007-12-29 13:20:23,972 INFO  [IPC Server handler 3 on 60000] hbase.HMaster(1577):
140.211.11.75:38758 serving result_table,,1198934398607
    [junit] 2007-12-29 13:20:23,972 DEBUG [HMaster] hbase.HMaster(1055): Main processing loop:
PendingOpenOperation from 140.211.11.75:38758
    [junit] 2007-12-29 13:20:23,973 INFO  [HMaster] hbase.HMaster$ProcessRegionOpen(2458):
regionname: result_table,,1198934398607, startKey: <>, encodedName(330763908) 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:38758
    [junit] 2007-12-29 13:20:23,973 DEBUG [HMaster] hbase.HMaster$RegionServerOperation(1907):
numberOfMetaRegions: 1, onlineMetaRegions.size(): 1
    [junit] 2007-12-29 13:20:23,973 INFO  [HMaster] hbase.HMaster$ProcessRegionOpen(2472):
updating row result_table,,1198934398607 in table .META.,,1 with startcode 1198934363169 and
server 140.211.11.75:38758
    [junit] 2007-12-29 13:20:25,359 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(211):
HMaster.rootScanner scanning meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:25,384 DEBUG [HMaster.rootScanner] hbase.HMaster$BaseScanner(247):
HMaster.rootScanner regioninfo: {regionname: .META.,,1, startKey: <>, encodedName(1028785192)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:25,386 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(293):
HMaster.rootScanner scan of meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:27,310 DEBUG [main] hbase.HConnectionManager$TableServers(689):
Wake. Retry finding table result_table
    [junit] 2007-12-29 13:20:27,349 DEBUG [main] hbase.HConnectionManager$TableServers(732):
Found 1 region(s) for result_table at address: 140.211.11.75:38758, regioninfo: regionname:
.META.,,1, startKey: <>, encodedName(1028785192) tableDesc: {name: .META., families:
{info:={name: info, max versions: 1, compression: NONE, in memory: false, max length: 2147483647,
bloom filter: none}}}
    [junit] 2007-12-29 13:20:27,349 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(211):
HMaster.metaScanner scanning meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:27,364 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r1,,1198934363198, startKey: <>, encodedName(1004432247)
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:38758, startCode: 1198934363169
    [junit] 2007-12-29 13:20:27,366 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r2,,1198934393554, startKey: <>, encodedName(132806885)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:27,368 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: result_table,,1198934398607, startKey: <>,
encodedName(330763908) 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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:27,371 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(293):
HMaster.metaScanner scan of meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:27,371 INFO  [HMaster.metaScanner] hbase.HMaster$MetaScanner(763):
all meta regions scanned
    [junit] 2007-12-29 13:20:28,124 WARN  [IPC Server handler 3 on 38728] dfs.FSDirectory(400):
DIR* FSDirectory.unprotectedDelete: failed to remove /user/hudson/build/contrib/hbase/test/system
because it does not exist
    [junit] 2007-12-29 13:20:30,764 WARN  [IPC Server handler 1 on 38728] dfs.FSDirectory(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-29 13:20:30,765 WARN  [main] mapred.JobClient(496): No job jar file set.
 User classes may not be found. See JobConf(Class) or JobConf#setJar(String).
    [junit] 2007-12-29 13:20:30,796 DEBUG [main] hbase.HConnectionManager$TableServers(308):
No servers for r1. Doing a find...
    [junit] 2007-12-29 13:20:30,812 DEBUG [main] hbase.HConnectionManager$TableServers(763):
Found 1 servers for table r1
    [junit] 2007-12-29 13:20:30,846 DEBUG [main] mapred.TableInputFormat(175): split: 0->r1,,
    [junit] 2007-12-29 13:20:32,751 DEBUG [RegionServer:0.cacheFlusher] hbase.HStore(972):
Added 1004432247/b/1590656782838317561 with 5 entries, sequence id 33, and size 270.0 for
r1,,1198934363198/b
    [junit] 2007-12-29 13:20:35,367 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(211):
HMaster.rootScanner scanning meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:35,392 DEBUG [HMaster.rootScanner] hbase.HMaster$BaseScanner(247):
HMaster.rootScanner regioninfo: {regionname: .META.,,1, startKey: <>, encodedName(1028785192)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:35,394 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(293):
HMaster.rootScanner scan of meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:37,098 INFO  [IPC Server handler 2 on 60000] hbase.HMaster(1858):
assigning region .META.,,1 to the only server 140.211.11.75:38758
    [junit] 2007-12-29 13:20:37,099 INFO  [RegionServer:0.worker] hbase.HRegionServer$Worker(1153):
MSG_REGION_OPEN : .META.,,1
    [junit] 2007-12-29 13:20:37,357 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(211):
HMaster.metaScanner scanning meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:37,396 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r1,,1198934363198, startKey: <>, encodedName(1004432247)
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:38758, startCode: 1198934363169
    [junit] 2007-12-29 13:20:37,399 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r2,,1198934393554, startKey: <>, encodedName(132806885)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:37,401 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: result_table,,1198934398607, startKey: <>,
encodedName(330763908) 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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:37,402 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(293):
HMaster.metaScanner scan of meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:37,402 INFO  [HMaster.metaScanner] hbase.HMaster$MetaScanner(763):
all meta regions scanned
    [junit] 2007-12-29 13:20:38,108 DEBUG [IPC Server handler 0 on 60000] hbase.HMaster(1516):
Received MSG_REPORT_PROCESS_OPEN : .META.,,1 from 140.211.11.75:38758
    [junit] java.io.IOException: Target http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/mapred/local/localRunner/job_local_1.xml
 already exists
    [junit] 	at org.apache.hadoop.fs.FileUtil.checkDest(FileUtil.java:246)
    [junit] 	at org.apache.hadoop.fs.FileUtil.copy(FileUtil.java:125)
    [junit] 	at org.apache.hadoop.fs.FileUtil.copy(FileUtil.java:116)
    [junit] 	at org.apache.hadoop.fs.FileSystem.copyToLocalFile(FileSystem.java:914)
    [junit] 	at org.apache.hadoop.fs.FileSystem.copyToLocalFile(FileSystem.java:895)
    [junit] 	at org.apache.hadoop.mapred.LocalJobRunner$Job.<init>(LocalJobRunner.java:86)
    [junit] 	at org.apache.hadoop.mapred.LocalJobRunner.submitJob(LocalJobRunner.java:281)
    [junit] 	at org.apache.hadoop.mapred.JobClient.submitJob(JobClient.java:558)
    [junit] 	at org.apache.hadoop.mapred.JobClient.runJob(JobClient.java:753)
    [junit] 	at org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce.testTableJoinMapReduce(TestTableJoinMapReduce.java:191)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:585)
    [junit] 	at junit.framework.TestCase.runTest(TestCase.java:154)
    [junit] 	at junit.framework.TestCase.runBare(TestCase.java:127)
    [junit] 	at junit.framework.TestResult$1.protect(TestResult.java:106)
    [junit] 	at junit.framework.TestResult.runProtected(TestResult.java:124)
    [junit] 	at junit.framework.TestResult.run(TestResult.java:109)
    [junit] 	at junit.framework.TestCase.run(TestCase.java:118)
    [junit] 	at junit.framework.TestSuite.runTest(TestSuite.java:208)
    [junit] 	at junit.framework.TestSuite.run(TestSuite.java:203)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:297)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:672)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:567)
    [junit] 2007-12-29 13:20:41,134 ERROR [Thread-207] mapred.TaskTracker(954): Caught exception:
java.io.InterruptedIOException
    [junit] 	at java.net.SocketOutputStream.socketWrite0(Native Method)
    [junit] 	at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:92)
    [junit] 	at java.net.SocketOutputStream.write(SocketOutputStream.java:136)
    [junit] 	at org.apache.hadoop.ipc.Client$Connection$2.write(Client.java:199)
    [junit] 	at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
    [junit] 	at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:123)
    [junit] 	at java.io.DataOutputStream.flush(DataOutputStream.java:106)
    [junit] 	at org.apache.hadoop.ipc.Client$Connection.sendParam(Client.java:344)
    [junit] 	at org.apache.hadoop.ipc.Client.call(Client.java:501)
    [junit] 	at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:198)
    [junit] 	at org.apache.hadoop.mapred.$Proxy9.heartbeat(Unknown Source)
    [junit] 	at org.apache.hadoop.mapred.TaskTracker.transmitHeartBeat(TaskTracker.java:1004)
    [junit] 	at org.apache.hadoop.mapred.TaskTracker.offerService(TaskTracker.java:902)
    [junit] 	at org.apache.hadoop.mapred.TaskTracker.run(TaskTracker.java:1300)
    [junit] 	at org.apache.hadoop.mapred.MiniMRCluster$TaskTrackerRunner.run(MiniMRCluster.java:144)
    [junit] 	at java.lang.Thread.run(Thread.java:595)

    [junit] 2007-12-29 13:20:41,137 INFO  [IPC Server handler 4 on 60000] hbase.HMaster(1858):
assigning region r1,,1198934363198 to the only server 140.211.11.75:38758
    [junit] 2007-12-29 13:20:41,138 INFO  [RegionServer:0.worker] hbase.HRegionServer$Worker(1153):
MSG_REGION_OPEN : r1,,1198934363198
    [junit] 2007-12-29 13:20:42,441 WARN  [Task Commit Thread] mapred.JobTracker$TaskCommitQueue(2032):
Task Commit Thread exiting...
    [junit] 2007-12-29 13:20:42,441 DEBUG [IPC Server handler 2 on 60000] hbase.HMaster(1516):
Received MSG_REPORT_PROCESS_OPEN : r1,,1198934363198 from 140.211.11.75:38758
    [junit] 2007-12-29 13:20:42,466 DEBUG [main] hbase.LocalHBaseCluster(212): Shutting down
HBase Cluster
    [junit] 2007-12-29 13:20:42,466 INFO  [main] hbase.HMaster(2526): Cluster shutdown requested.
Starting to quiesce servers
    [junit] 2007-12-29 13:20:43,448 INFO  [RegionServer:0] hbase.HRegionServer(774): Got quiesce
server message
    [junit] 2007-12-29 13:20:43,448 INFO  [RegionServer:0.worker] hbase.HRegionServer$Worker(1153):
MSG_REGIONSERVER_QUIESCE : 
    [junit] 2007-12-29 13:20:43,448 DEBUG [RegionServer:0.worker] hbase.HRegionServer(1295):
closing region r1,,1198934363198
    [junit] 2007-12-29 13:20:45,376 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(211):
HMaster.rootScanner scanning meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:45,396 DEBUG [HMaster.rootScanner] hbase.HMaster$BaseScanner(247):
HMaster.rootScanner regioninfo: {regionname: .META.,,1, startKey: <>, encodedName(1028785192)
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:38758,
startCode: 1198934363169
    [junit] 2007-12-29 13:20:45,398 INFO  [HMaster.rootScanner] hbase.HMaster$BaseScanner(293):
HMaster.rootScanner scan of meta region {regionname: -ROOT-,,0, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:46,028 DEBUG [RegionServer:0.cacheFlusher] hbase.HStore(972):
Added 1004432247/c/4976254715571928525 with 5 entries, sequence id 33, and size 310.0 for
r1,,1198934363198/c
    [junit] 2007-12-29 13:20:46,029 DEBUG [RegionServer:0.cacheFlusher] hbase.HRegion(943):
Finished memcache flush for region r1,,1198934363198 in 44386ms, sequenceid=33
    [junit] 2007-12-29 13:20:46,030 DEBUG [RegionServer:0.compactor] hbase.HStore(996): compaction
for HStore r1,,1198934363198/a not needed.
    [junit] 2007-12-29 13:20:46,030 DEBUG [RegionServer:0.cacheFlusher] hbase.HRegion(837):
Started memcache flush for region .META.,,1. Size 558.0
    [junit] 2007-12-29 13:20:46,030 DEBUG [RegionServer:0.compactor] hbase.HStore(996): compaction
for HStore r1,,1198934363198/b not needed.
    [junit] 2007-12-29 13:20:46,030 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
r1,,1198934363198/a (1004432247/a)
    [junit] 2007-12-29 13:20:46,031 DEBUG [RegionServer:0.compactor] hbase.HStore(996): compaction
for HStore r1,,1198934363198/c not needed.
    [junit] 2007-12-29 13:20:46,031 DEBUG [RegionServer:0.compactor] hbase.HRegion(707): region
r1,,1198934363198 does not need compaction
    [junit] 2007-12-29 13:20:46,031 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
r1,,1198934363198/b (1004432247/b)
    [junit] 2007-12-29 13:20:46,032 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
r1,,1198934363198/c (1004432247/c)
    [junit] 2007-12-29 13:20:46,032 INFO  [RegionServer:0.worker] hbase.HRegion(430): closed
r1,,1198934363198
    [junit] 2007-12-29 13:20:46,033 DEBUG [RegionServer:0.worker] hbase.HRegionServer(1295):
closing region r2,,1198934393554
    [junit] 2007-12-29 13:20:46,033 DEBUG [RegionServer:0.worker] hbase.HRegion(837): Started
memcache flush for region r2,,1198934393554. Size 132.0
    [junit] 2007-12-29 13:20:47,365 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(211):
HMaster.metaScanner scanning meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758}
    [junit] 2007-12-29 13:20:47,379 DEBUG [HMaster.metaScanner] hbase.HMaster$BaseScanner(247):
HMaster.metaScanner regioninfo: {regionname: r1,,1198934363198, startKey: <>, encodedName(1004432247)
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:38758, startCode: 1198934363169
    [junit] 2007-12-29 13:20:47,380 INFO  [HMaster.metaScanner] hbase.HMaster$BaseScanner(293):
HMaster.metaScanner scan of meta region {regionname: .META.,,1, startKey: <>, server:
140.211.11.75:38758} complete
    [junit] 2007-12-29 13:20:47,381 INFO  [HMaster.metaScanner] hbase.HMaster$MetaScanner(763):
all meta regions scanned
    [junit] 2007-12-29 13:20:50,435 INFO  [HMaster.leaseChecker] hbase.Leases$Lease(342):
HMaster.leaseChecker lease expired 1437218154/1437218154
    [junit] 2007-12-29 13:20:50,436 INFO  [HMaster.leaseChecker] hbase.HMaster$ServerExpirer(3147):
140.211.11.75:38758 lease expired
    [junit] 2007-12-29 13:20:50,515 DEBUG [HMaster] hbase.HMaster(1206): telling root scanner
to stop
    [junit] 2007-12-29 13:20:50,515 DEBUG [HMaster] hbase.HMaster(1214): telling meta scanner
to stop
    [junit] 2007-12-29 13:20:50,516 INFO  [HMaster.rootScanner] hbase.Chore(66): HMaster.rootScanner
exiting
    [junit] 2007-12-29 13:20:50,516 INFO  [HMaster.metaScanner] hbase.Chore(66): HMaster.metaScanner
exiting
    [junit] 2007-12-29 13:20:50,516 INFO  [IPC Server handler 1 on 60000] hbase.HMaster(1380):
All user tables quiesced. Proceeding with shutdown
    [junit] 2007-12-29 13:20:50,516 DEBUG [HMaster] hbase.HMaster(1222): meta and root scanners
notified
    [junit] 2007-12-29 13:20:50,517 DEBUG [IPC Server handler 1 on 60000] hbase.HMaster(1206):
telling root scanner to stop
    [junit] 2007-12-29 13:20:50,517 DEBUG [HMaster] hbase.HMaster(1206): telling root scanner
to stop
    [junit] 2007-12-29 13:20:50,517 DEBUG [IPC Server handler 1 on 60000] hbase.HMaster(1214):
telling meta scanner to stop
    [junit] 2007-12-29 13:20:50,517 DEBUG [HMaster] hbase.HMaster(1214): telling meta scanner
to stop
    [junit] 2007-12-29 13:20:50,518 DEBUG [IPC Server handler 1 on 60000] hbase.HMaster(1222):
meta and root scanners notified
    [junit] 2007-12-29 13:20:50,518 DEBUG [HMaster] hbase.HMaster(1222): meta and root scanners
notified
    [junit] 2007-12-29 13:20:50,519 INFO  [HMaster] hbase.Leases(109): HMaster closing leases
    [junit] 2007-12-29 13:20:50,519 INFO  [RegionServer:0] hbase.HRegionServer(768): Got regionserver
stop message
    [junit] 2007-12-29 13:20:50,519 INFO  [RegionServer:0] hbase.Leases(109): RegionServer:0
closing leases
    [junit] 2007-12-29 13:20:50,519 INFO  [HMaster.leaseChecker] hbase.Chore(66): HMaster.leaseChecker
exiting
    [junit] 2007-12-29 13:20:50,520 INFO  [RegionServer:0.leaseChecker] hbase.Chore(66): RegionServer:0.leaseChecker
exiting
    [junit] 2007-12-29 13:20:50,520 INFO  [HMaster] hbase.Leases(125): HMaster closed leases
    [junit] 2007-12-29 13:20:50,520 INFO  [RegionServer:0] hbase.Leases(125): RegionServer:0
closed leases
    [junit] 2007-12-29 13:20:50,521 INFO  [HMaster] hbase.HMaster(1139): HMaster main thread
exiting
    [junit] 2007-12-29 13:20:51,075 INFO  [RegionServer:0.compactor] hbase.HRegionServer$Compactor(425):
RegionServer:0.compactor exiting
    [junit] 2007-12-29 13:20:51,525 INFO  [RegionServer:0.splitter] hbase.HRegionServer$Splitter(302):
RegionServer:0.splitter exiting
    [junit] 2007-12-29 13:20:55,211 DEBUG [RegionServer:0.cacheFlusher] hbase.HStore(972):
Added 1028785192/info/3573498259001272973 with 6 entries, sequence id 37, and size 752.0 for
.META.,,1/info
    [junit] 2007-12-29 13:20:55,212 DEBUG [RegionServer:0.cacheFlusher] hbase.HRegion(943):
Finished memcache flush for region .META.,,1 in 9182ms, sequenceid=37
    [junit] 2007-12-29 13:20:55,213 DEBUG [RegionServer:0] hbase.HRegionServer(1261): closing
region -ROOT-,,0
    [junit] 2007-12-29 13:20:55,213 DEBUG [RegionServer:0] hbase.HStore(880): closed -ROOT-,,0/info
(70236052/info)
    [junit] 2007-12-29 13:20:55,214 INFO  [RegionServer:0] hbase.HRegion(430): closed -ROOT-,,0
    [junit] 2007-12-29 13:20:55,214 DEBUG [RegionServer:0] hbase.HRegionServer(1261): closing
region .META.,,1
    [junit] 2007-12-29 13:20:55,215 DEBUG [RegionServer:0] hbase.HStore(880): closed .META.,,1/info
(1028785192/info)
    [junit] 2007-12-29 13:20:55,215 INFO  [RegionServer:0] hbase.HRegion(430): closed .META.,,1
    [junit] 2007-12-29 13:21:04,696 DEBUG [RegionServer:0.worker] hbase.HStore(972): Added
132806885/e/2002921514783112533 with 3 entries, sequence id 38, and size 218.0 for r2,,1198934393554/e
    [junit] 2007-12-29 13:21:08,505 DEBUG [RegionServer:0.worker] hbase.HStore(972): Added
132806885/d/6242598714378742295 with 3 entries, sequence id 38, and size 218.0 for r2,,1198934393554/d
    [junit] 2007-12-29 13:21:08,506 DEBUG [RegionServer:0.worker] hbase.HRegion(943): Finished
memcache flush for region r2,,1198934393554 in 22473ms, sequenceid=38
    [junit] 2007-12-29 13:21:08,506 DEBUG [RegionServer:0] hbase.HLog(388): closing log writer
in /hbase/log_140.211.11.75_1198934363169_38758
    [junit] 2007-12-29 13:21:08,506 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
r2,,1198934393554/e (132806885/e)
    [junit] 2007-12-29 13:21:08,507 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
r2,,1198934393554/d (132806885/d)
    [junit] 2007-12-29 13:21:08,507 INFO  [RegionServer:0.worker] hbase.HRegion(430): closed
r2,,1198934393554
    [junit] 2007-12-29 13:21:08,507 DEBUG [RegionServer:0.worker] hbase.HRegionServer(1295):
closing region result_table,,1198934398607
    [junit] 2007-12-29 13:21:08,508 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
result_table,,1198934398607/e (330763908/e)
    [junit] 2007-12-29 13:21:08,508 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
result_table,,1198934398607/d (330763908/d)
    [junit] 2007-12-29 13:21:08,508 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
result_table,,1198934398607/a (330763908/a)
    [junit] 2007-12-29 13:21:08,508 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
result_table,,1198934398607/b (330763908/b)
    [junit] 2007-12-29 13:21:08,509 DEBUG [RegionServer:0.worker] hbase.HStore(880): closed
result_table,,1198934398607/c (330763908/c)
    [junit] 2007-12-29 13:21:08,509 INFO  [RegionServer:0.worker] hbase.HRegion(430): closed
result_table,,1198934398607
    [junit] 2007-12-29 13:21:08,509 INFO  [RegionServer:0.worker] hbase.HRegionServer$Worker(1202):
worker thread exiting
    [junit] 2007-12-29 13:21:11,187 INFO  [RegionServer:0] hbase.HRegionServer(888): telling
master that region server is shutting down at: 140.211.11.75:38758
    [junit] 2007-12-29 13:21:21,284 WARN  [RegionServer:0] hbase.HRegionServer(892): Failed
to send exiting message to master: 
    [junit] java.net.ConnectException: Connection refused
    [junit] 	at java.net.PlainSocketImpl.socketConnect(Native Method)
    [junit] 	at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333)
    [junit] 	at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195)
    [junit] 	at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182)
    [junit] 	at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366)
    [junit] 	at java.net.Socket.connect(Socket.java:520)
    [junit] 	at org.apache.hadoop.ipc.Client$Connection.setupIOstreams(Client.java:159)
    [junit] 	at org.apache.hadoop.ipc.Client.getConnection(Client.java:575)
    [junit] 	at org.apache.hadoop.ipc.Client.call(Client.java:498)
    [junit] 	at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:198)
    [junit] 	at $Proxy6.regionServerReport(Unknown Source)
    [junit] 	at org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:890)
    [junit] 	at java.lang.Thread.run(Thread.java:595)
    [junit] 2007-12-29 13:21:21,286 INFO  [RegionServer:0] hbase.HRegionServer(895): stopping
server at: 140.211.11.75:38758
    [junit] 2007-12-29 13:21:21,286 INFO  [RegionServer:0] hbase.HRegionServer(900): RegionServer:0
exiting
    [junit] 2007-12-29 13:21:21,287 INFO  [main] hbase.LocalHBaseCluster(238): Shutdown HMaster
1 region server(s)
    [junit] 2007-12-29 13:21:32,388 INFO  [main] hbase.StaticTestEnvironment(133): Shutting
down FileSystem
    [junit] 2007-12-29 13:21:33,367 INFO  [main] hbase.StaticTestEnvironment(140): Shutting
down Mini DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 0
    [junit] 2007-12-29 13:21:33,694 ERROR [DataNode: [http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data1,/export/home/hudson/hudson/jobs/Hadoop-Nightly/workspace/trunk/build/contrib/hbase/test/data/dfs/data/data2]]
 dfs.DataNode(1725): Exception: java.lang.reflect.UndeclaredThrowableException
    [junit] 	at org.apache.hadoop.dfs.$Proxy1.sendHeartbeat(Unknown Source)
    [junit] 	at org.apache.hadoop.dfs.DataNode.offerService(DataNode.java:554)
    [junit] 	at org.apache.hadoop.dfs.DataNode.run(DataNode.java:1723)
    [junit] 	at java.lang.Thread.run(Thread.java:595)
    [junit] Caused by: java.lang.InterruptedException
    [junit] 	at java.lang.Object.wait(Native Method)
    [junit] 	at org.apache.hadoop.ipc.Client.call(Client.java:504)
    [junit] 	at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:198)
    [junit] 	... 4 more

    [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 175.885 sec
    [junit] 2007-12-29 13:21:37,038 INFO  [main] hbase.HRegionServer$ShutdownThread(151):
Starting shutdown thread.
    [junit] 2007-12-29 13:21:37,039 INFO  [main] hbase.HRegionServer$ShutdownThread(156):
Shutdown thread complete
    [junit] Test org.apache.hadoop.hbase.shell.algebra.TestTableJoinMapReduce FAILED
    [junit] Running org.apache.hadoop.hbase.util.TestBase64

    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.246 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.061 sec
    [junit] Running org.onelab.test.TestFilter
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.071 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: 127 minutes 21 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-2453
Updating HADOOP-2456


Mime
View raw message