You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@hbase.apache.org by Apache Hudson Server <hu...@hudson.zones.apache.org> on 2009/06/17 08:03:35 UTC

Build failed in Hudson: HBase-Patch #646

See http://hudson.zones.apache.org/hudson/job/HBase-Patch/646/changes

Changes:

[stack] Move past alpha version

[stack] HBASE-1329 Visibility into ZooKeeper

[stack] set version for alpha release

[stack] HBASE-1329 Visibility into ZooKeeper

------------------------------------------
[...truncated 23632 lines...]
    [junit] 
    [junit] 2009-06-17 06:24:58,704 WARN  [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@18d4c9a] namenode.FSNamesystem$ReplicationMonitor(2306): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 2009-06-17 06:24:59.553::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:24:59.559::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/hdfs  to /tmp/Jetty_localhost_37415_hdfs____5uye5a/webapp
    [junit] 2009-06-17 06:24:59.733::INFO:  Started SelectChannelConnector@localhost:37415
    [junit] Starting DataNode 0 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2 
    [junit] 2009-06-17 06:25:00.230::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:00.236::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_52626_datanode____.jo5aak/webapp
    [junit] 2009-06-17 06:25:00.404::INFO:  Started SelectChannelConnector@localhost:52626
    [junit] Starting DataNode 1 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4 
    [junit] 2009-06-17 06:25:00.911::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:00.917::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_40241_datanode____opgxwa/webapp
    [junit] 2009-06-17 06:25:01.082::INFO:  Started SelectChannelConnector@localhost:40241
    [junit] 2009-06-17 06:25:01,252 INFO  [main] regionserver.HLog(209): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=100, optionallogflushinternal=10000ms
    [junit] 2009-06-17 06:25:01,261 INFO  [main] regionserver.HLog(299): New hlog /user/hudson/testscanner/1682632464/.logs/hlog.dat.1245219901253
    [junit] 2009-06-17 06:25:01,261 DEBUG [main] regionserver.HRegion(264): Opening region testscanner,,1245219901234, encoded=1682632464
    [junit] 2009-06-17 06:25:01,291 INFO  [main] regionserver.HRegion(339): region testscanner,,1245219901234/1682632464 available; sequence id is 0
    [junit] 2009-06-17 06:25:01,855 INFO  [main] regionserver.TestScanner(370): Added: 17576
    [junit] 2009-06-17 06:25:01,855 INFO  [main] regionserver.TestScanner(419): Taking out counting scan
    [junit] 2009-06-17 06:25:02,747 INFO  [main] regionserver.TestScanner(453): Found 17575 items
    [junit] 2009-06-17 06:25:02,748 INFO  [main] regionserver.TestScanner(419): Taking out counting scan
    [junit] 2009-06-17 06:25:02,751 INFO  [main] regionserver.TestScanner(432): Starting flush at flush index 100
    [junit] 2009-06-17 06:25:02,752 DEBUG [main] regionserver.HRegion(884): Started memcache flush for region testscanner,,1245219901234. Current region memcache size 2.6m
    [junit] 2009-06-17 06:25:02,913 DEBUG [main] regionserver.Store(526): Added hdfs://localhost:42349/user/hudson/testscanner/1682632464/info/591614886643743534, entries=17576, sequenceid=17577, memsize=2.6m, filesize=691.0k to testscanner,,1245219901234
    [junit] 2009-06-17 06:25:02,915 DEBUG [main] regionserver.HRegion(961): Finished memcache flush of ~2.6m for region testscanner,,1245219901234 in 163ms, sequence id=17577, compaction requested=false
    [junit] 2009-06-17 06:25:02,915 INFO  [main] regionserver.TestScanner$1(437): Finishing flush
    [junit] 2009-06-17 06:25:02,915 INFO  [main] regionserver.TestScanner(448): Continuing on after kicking off background flush
    [junit] 2009-06-17 06:25:02,915 INFO  [main] regionserver.TestScanner(427): after next() just after next flush
    [junit] 2009-06-17 06:25:03,616 INFO  [main] regionserver.TestScanner(453): Found 17575 items
    [junit] 2009-06-17 06:25:03,616 DEBUG [main] regionserver.HRegion(436): Closing testscanner,,1245219901234: compactions & flushes disabled 
    [junit] 2009-06-17 06:25:03,616 DEBUG [main] regionserver.HRegion(466): Updates disabled for region, no outstanding scanners on testscanner,,1245219901234
    [junit] 2009-06-17 06:25:03,617 DEBUG [main] regionserver.HRegion(473): No more row locks outstanding on region testscanner,,1245219901234
    [junit] 2009-06-17 06:25:03,617 DEBUG [main] regionserver.Store(445): closed info
    [junit] 2009-06-17 06:25:03,617 INFO  [main] regionserver.HRegion(485): Closed testscanner,,1245219901234
    [junit] 2009-06-17 06:25:03,617 DEBUG [main] regionserver.HLog(456): closing hlog writer in hdfs://localhost:42349/user/hudson/testscanner/1682632464/.logs
    [junit] 2009-06-17 06:25:03,645 INFO  [main] hbase.HBaseTestCase(626): Shutting down FileSystem
    [junit] 2009-06-17 06:25:03,645 INFO  [main] hbase.HBaseTestCase(633): Shutting down Mini DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2009-06-17 06:25:03,783 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@16d3046] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:60968, storageID=DS-1036161422-67.195.138.9-60968-1245219901086, infoPort=40241, ipcPort=50681):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] Shutting down DataNode 0
    [junit] 2009-06-17 06:25:04,888 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@1bb9533] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:34766, storageID=DS-1005150283-67.195.138.9-34766-1245219900408, infoPort=52626, ipcPort=55436):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2009-06-17 06:25:05,092 WARN  [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@189cab] namenode.FSNamesystem$ReplicationMonitor(2306): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 2009-06-17 06:25:05.958::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:05.963::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/hdfs  to /tmp/Jetty_localhost_37642_hdfs____qckr22/webapp
    [junit] 2009-06-17 06:25:06.134::INFO:  Started SelectChannelConnector@localhost:37642
    [junit] Starting DataNode 0 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2 
    [junit] 2009-06-17 06:25:06.669::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:06.674::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_50979_datanode____fnen2f/webapp
    [junit] 2009-06-17 06:25:06.837::INFO:  Started SelectChannelConnector@localhost:50979
    [junit] Starting DataNode 1 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4 
    [junit] 2009-06-17 06:25:07.322::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:07.328::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_42928_datanode____n1fi3s/webapp
    [junit] 2009-06-17 06:25:07.490::INFO:  Started SelectChannelConnector@localhost:42928
    [junit] 2009-06-17 06:25:07,639 INFO  [main] regionserver.HLog(209): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=100, optionallogflushinternal=10000ms
    [junit] 2009-06-17 06:25:07,652 INFO  [main] regionserver.HLog(299): New hlog /user/hudson/testscanner/525044773/.logs/hlog.dat.1245219907640
    [junit] 2009-06-17 06:25:07,652 DEBUG [main] regionserver.HRegion(264): Opening region testscanner,,1245219907616, encoded=525044773
    [junit] 2009-06-17 06:25:07,682 INFO  [main] regionserver.HRegion(339): region testscanner,,1245219907616/525044773 available; sequence id is 0
    [junit] 2009-06-17 06:25:07,924 INFO  [main] regionserver.TestScanner(394): Added: 17576
    [junit] 2009-06-17 06:25:07,924 INFO  [main] regionserver.TestScanner(419): Taking out counting scan
    [junit] 2009-06-17 06:25:08,425 INFO  [main] regionserver.TestScanner(453): Found 17575 items
    [junit] 2009-06-17 06:25:08,426 INFO  [main] regionserver.TestScanner(419): Taking out counting scan
    [junit] 2009-06-17 06:25:08,429 INFO  [main] regionserver.TestScanner(432): Starting flush at flush index 100
    [junit] 2009-06-17 06:25:08,429 INFO  [main] regionserver.TestScanner(448): Continuing on after kicking off background flush
    [junit] 2009-06-17 06:25:08,429 DEBUG [Thread-334] regionserver.HRegion(884): Started memcache flush for region testscanner,,1245219907616. Current region memcache size 2.6m
    [junit] 2009-06-17 06:25:08,429 INFO  [main] regionserver.TestScanner(427): after next() just after next flush
    [junit] 2009-06-17 06:25:08,552 DEBUG [Thread-334] regionserver.Store(526): Added hdfs://localhost:42247/user/hudson/testscanner/525044773/info/2837628977765680963, entries=17576, sequenceid=17577, memsize=2.6m, filesize=691.0k to testscanner,,1245219907616
    [junit] 2009-06-17 06:25:08,554 DEBUG [Thread-334] regionserver.HRegion(961): Finished memcache flush of ~2.6m for region testscanner,,1245219907616 in 125ms, sequence id=17577, compaction requested=false
    [junit] 2009-06-17 06:25:08,554 INFO  [Thread-334] regionserver.TestScanner$1(437): Finishing flush
    [junit] 2009-06-17 06:25:08,997 INFO  [main] regionserver.TestScanner(453): Found 17575 items
    [junit] 2009-06-17 06:25:08,998 DEBUG [main] regionserver.HRegion(436): Closing testscanner,,1245219907616: compactions & flushes disabled 
    [junit] 2009-06-17 06:25:08,998 DEBUG [main] regionserver.HRegion(466): Updates disabled for region, no outstanding scanners on testscanner,,1245219907616
    [junit] 2009-06-17 06:25:08,998 DEBUG [main] regionserver.HRegion(473): No more row locks outstanding on region testscanner,,1245219907616
    [junit] 2009-06-17 06:25:08,999 DEBUG [main] regionserver.Store(445): closed info
    [junit] 2009-06-17 06:25:09,000 INFO  [main] regionserver.HRegion(485): Closed testscanner,,1245219907616
    [junit] 2009-06-17 06:25:09,000 DEBUG [main] regionserver.HLog(456): closing hlog writer in hdfs://localhost:42247/user/hudson/testscanner/525044773/.logs
    [junit] 2009-06-17 06:25:09,028 INFO  [main] hbase.HBaseTestCase(626): Shutting down FileSystem
    [junit] 2009-06-17 06:25:09,028 INFO  [main] hbase.HBaseTestCase(633): Shutting down Mini DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2009-06-17 06:25:09,136 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@6dd60e] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:36104, storageID=DS-1445922656-67.195.138.9-36104-1245219907492, infoPort=42928, ipcPort=46217):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] Shutting down DataNode 0
    [junit] 2009-06-17 06:25:10,271 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@28bda] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:53096, storageID=DS-898589614-67.195.138.9-53096-1245219906840, infoPort=50979, ipcPort=59647):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2009-06-17 06:25:11,473 WARN  [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@128647a] namenode.FSNamesystem$ReplicationMonitor(2306): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 70.322 sec
    [junit] Running org.apache.hadoop.hbase.regionserver.TestStore
    [junit] 2009-06-17 06:25:12,279 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testGet_FromFilesOnly/625128906/family/5383074947363245313, entries=2, sequenceid=1245219911840, memsize=298.0, filesize=385.0 to table,,1245219912220
    [junit] 2009-06-17 06:25:12,304 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testGet_FromFilesOnly/625128906/family/3891089324708367243, entries=2, sequenceid=1245219911841, memsize=298.0, filesize=385.0 to table,,1245219912220
    [junit] 2009-06-17 06:25:12,318 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testGet_FromFilesOnly/625128906/family/4214217589540847581, entries=2, sequenceid=1245219911842, memsize=298.0, filesize=385.0 to table,,1245219912220
    [junit] 2009-06-17 06:25:12,391 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testGet_FromMemCacheAndFiles/154240759/family/6698873312271503579, entries=2, sequenceid=1245219911841, memsize=298.0, filesize=385.0 to table,,1245219912377
    [junit] 2009-06-17 06:25:12,403 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testGet_FromMemCacheAndFiles/154240759/family/2437195315313046621, entries=2, sequenceid=1245219911842, memsize=298.0, filesize=385.0 to table,,1245219912377
    [junit] 2009-06-17 06:25:12,563 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testIncrementColumnValue_UpdatingFromSF/777946133/family/489458638109524370, entries=2, sequenceid=1245219911841, memsize=314.0, filesize=401.0 to table,,1245219912544
    [junit] 2009-06-17 06:25:12,612 DEBUG [main] regionserver.Store(526): Added test/build/data/TestStore/testIncrementColumnValue_AddingNewAfterSFCheck/703737692/family/3181094821837017346, entries=2, sequenceid=1245219911841, memsize=314.0, filesize=401.0 to table,,1245219912597
    [junit] Tests run: 8, Failures: 0, Errors: 0, Time elapsed: 0.773 sec
    [junit] Running org.apache.hadoop.hbase.regionserver.TestStoreFile
    [junit] 2009-06-17 06:25:14.708::INFO:  Logging to STDERR via org.mortbay.log.StdErrLog
    [junit] 2009-06-17 06:25:14.755::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:14.786::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/hdfs  to /tmp/Jetty_localhost_52764_hdfs____.j00tem/webapp
    [junit] 2009-06-17 06:25:37.626::INFO:  Started SelectChannelConnector@localhost:52764
    [junit] Starting DataNode 0 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2 
    [junit] 2009-06-17 06:25:38.329::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:38.336::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_36644_datanode____.y6y0me/webapp
    [junit] 2009-06-17 06:25:38.560::INFO:  Started SelectChannelConnector@localhost:36644
    [junit] Starting DataNode 1 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4 
    [junit] 2009-06-17 06:25:39.209::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:39.215::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_53201_datanode____.ftt1l0/webapp
    [junit] 2009-06-17 06:25:39.417::INFO:  Started SelectChannelConnector@localhost:53201
    [junit] 2009-06-17 06:25:39,847 INFO  [main] regionserver.TestStoreFile(164): Midkey: mitestBasicHalfMapFiletestBasicHalfMapFile!??e
    [junit] 2009-06-17 06:25:39,858 INFO  [main] regionserver.TestStoreFile(183): First in top: aatestBasicHalfMapFiletestBasicHalfMapFile!??e
    [junit] 2009-06-17 06:25:39,865 INFO  [main] regionserver.TestStoreFile(186): Last in top: zztestBasicHalfMapFiletestBasicHalfMapFile!??e
    [junit] 2009-06-17 06:25:40,026 INFO  [main] regionserver.TestStoreFile(237): First top when key < bottom: /aa/1473914524603146611
    [junit] 2009-06-17 06:25:40,032 INFO  [main] regionserver.TestStoreFile(245): Last top when key < bottom: /zz/1473914524603146611
    [junit] 2009-06-17 06:25:40,378 INFO  [main] regionserver.TestStoreFile(269): First bottom when key > top: /aa/1473914524603146611
    [junit] 2009-06-17 06:25:40,385 INFO  [main] regionserver.TestStoreFile(277): Last bottom when key > top: /zz/1473914524603146611
    [junit] 2009-06-17 06:25:40,397 INFO  [main] hbase.HBaseTestCase(626): Shutting down FileSystem
    [junit] 2009-06-17 06:25:40,398 INFO  [main] hbase.HBaseTestCase(633): Shutting down Mini DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2009-06-17 06:25:40,502 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@18bbf55] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:48986, storageID=DS-953981881-67.195.138.9-48986-1245219939422, infoPort=53201, ipcPort=57465):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] Shutting down DataNode 0
    [junit] 2009-06-17 06:25:41,605 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@12a73d9] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:39184, storageID=DS-770351301-67.195.138.9-39184-1245219938567, infoPort=36644, ipcPort=44604):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2009-06-17 06:25:42,707 WARN  [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@90832e] namenode.FSNamesystem$ReplicationMonitor(2306): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 2009-06-17 06:25:43.617::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:43.623::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/hdfs  to /tmp/Jetty_localhost_47073_hdfs____i3phzn/webapp
    [junit] 2009-06-17 06:25:43.817::INFO:  Started SelectChannelConnector@localhost:47073
    [junit] Starting DataNode 0 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2 
    [junit] 2009-06-17 06:25:44.282::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:44.302::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_37915_datanode____.in1en4/webapp
    [junit] 2009-06-17 06:25:44.479::INFO:  Started SelectChannelConnector@localhost:37915
    [junit] Starting DataNode 1 with dfs.data.dir: http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4 
    [junit] 2009-06-17 06:25:45.022::INFO:  jetty-6.1.14
    [junit] 2009-06-17 06:25:45.029::INFO:  Extract jar:http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-0.20.0-plus4681-core.jar!/webapps/datanode  to /tmp/Jetty_localhost_58731_datanode____.thwzif/webapp
    [junit] 2009-06-17 06:25:45.205::INFO:  Started SelectChannelConnector@localhost:58731
    [junit] 2009-06-17 06:25:45,518 INFO  [main] hbase.HBaseTestCase(626): Shutting down FileSystem
    [junit] 2009-06-17 06:25:45,519 INFO  [main] hbase.HBaseTestCase(633): Shutting down Mini DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2009-06-17 06:25:45,622 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@2479a4] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:59827, storageID=DS-668989172-67.195.138.9-59827-1245219945209, infoPort=58731, ipcPort=39290):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] Shutting down DataNode 0
    [junit] 2009-06-17 06:25:46,762 WARN  [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@1d056de] datanode.DataXceiverServer(137): DatanodeRegistration(127.0.0.1:59785, storageID=DS-237525171-67.195.138.9-59785-1245219944481, infoPort=37915, ipcPort=47772):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2009-06-17 06:25:47,864 WARN  [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@4dd1b] namenode.FSNamesystem$ReplicationMonitor(2306): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 34.455 sec
    [junit] Running org.apache.hadoop.hbase.regionserver.TestStoreScanner
    [junit] Tests run: 14, Failures: 0, Errors: 0, Time elapsed: 0.072 sec
    [junit] Running org.apache.hadoop.hbase.regionserver.TestWildcardColumnTracker
    [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 0.317 sec
    [junit] Running org.apache.hadoop.hbase.util.TestBase64
    [junit] 
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.134 sec
    [junit] Running org.apache.hadoop.hbase.util.TestBytes
    [junit] AAA
    [junit] CCC
    [junit] EEE
    [junit] AAA
    [junit] BBB
    [junit] CCC
    [junit] DDD
    [junit] http://A
    [junit] http://]
    [junit] http://z
    [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 0.084 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.079 sec
    [junit] Running org.apache.hadoop.hbase.util.TestRootPath
    [junit] 2009-06-17 06:25:50,623 INFO  [main] util.TestRootPath(60): Got expected exception when checking invalid path:
    [junit] java.io.IOException: Root directory does not contain a scheme
    [junit] 	at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSUtils.java:212)
    [junit] 	at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(TestRootPath.java:56)
    [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:597)
    [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:421)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:766)
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.071 sec

BUILD FAILED
http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml :460: Tests failed!

Total time: 35 minutes 26 seconds
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Publishing Clover coverage report...


Hudson build is back to normal: HBase-Patch #647

Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/HBase-Patch/647/changes