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$replicationmoni...@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
selectchannelconnec...@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
selectchannelconnec...@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
selectchannelconnec...@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.dataxceiverser...@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.dataxceiverser...@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$replicationmoni...@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
selectchannelconnec...@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
selectchannelconnec...@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
selectchannelconnec...@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.dataxceiverser...@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.dataxceiverser...@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$replicationmoni...@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
selectchannelconnec...@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
selectchannelconnec...@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
selectchannelconnec...@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.dataxceiverser...@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.dataxceiverser...@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$replicationmoni...@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
selectchannelconnec...@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
selectchannelconnec...@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
selectchannelconnec...@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.dataxceiverser...@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.dataxceiverser...@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$replicationmoni...@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:[email protected]/index.html?query=something#middle, Transformed
url r:http://abc:[email protected]/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...
