See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/574/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 684897 lines...]
[junit] 2011-02-06 12:35:47,390 WARN datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already
shut down.
[junit] 2011-02-06 12:35:47,390 INFO hdfs.MiniDFSCluster
(MiniDFSCluster.java:shutdownDataNodes(835)) - Shutting down DataNode 0
[junit] 2011-02-06 12:35:47,492 INFO ipc.Server (Server.java:stop(1610)) -
Stopping server on 53480
[junit] 2011-02-06 12:35:47,492 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 0 on 53480: exiting
[junit] 2011-02-06 12:35:47,493 INFO ipc.Server (Server.java:run(475)) -
Stopping IPC Server listener on 53480
[junit] 2011-02-06 12:35:47,493 INFO datanode.DataNode
(DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads
is 1
[junit] 2011-02-06 12:35:47,493 WARN datanode.DataNode
(DataXceiverServer.java:run(141)) - DatanodeRegistration(127.0.0.1:36039,
storageID=DS-1455553998-127.0.1.1-36039-1296995736550, infoPort=42382,
ipcPort=53480):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:134)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2011-02-06 12:35:47,493 INFO ipc.Server (Server.java:run(675)) -
Stopping IPC Server Responder
[junit] 2011-02-06 12:35:47,495 INFO datanode.DataNode
(DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2011-02-06 12:35:47,592 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(622)) - Exiting DataBlockScanner thread.
[junit] 2011-02-06 12:35:47,596 INFO datanode.DataNode
(DataNode.java:run(1460)) - DatanodeRegistration(127.0.0.1:36039,
storageID=DS-1455553998-127.0.1.1-36039-1296995736550, infoPort=42382,
ipcPort=53480):Finishing DataNode in:
FSDataset{dirpath='/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data1/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data2/current/finalized'}
[junit] 2011-02-06 12:35:47,596 INFO ipc.Server (Server.java:stop(1610)) -
Stopping server on 53480
[junit] 2011-02-06 12:35:47,596 INFO datanode.DataNode
(DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2011-02-06 12:35:47,597 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk
service threads...
[junit] 2011-02-06 12:35:47,597 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads
have been shut down.
[junit] 2011-02-06 12:35:47,597 WARN datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already
shut down.
[junit] 2011-02-06 12:35:47,700 WARN namenode.FSNamesystem
(FSNamesystem.java:run(2847)) - ReplicationMonitor thread received
InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2011-02-06 12:35:47,700 WARN namenode.DecommissionManager
(DecommissionManager.java:run(70)) - Monitor interrupted:
java.lang.InterruptedException: sleep interrupted
[junit] 2011-02-06 12:35:47,700 INFO namenode.FSEditLog
(FSEditLog.java:printStatistics(559)) - Number of transactions: 6 Total time
for transactions(ms): 2Number of transactions batched in Syncs: 0 Number of
syncs: 3 SyncTimes(ms): 5 3
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:stop(1610)) -
Stopping server on 36868
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 2 on 36868: exiting
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:run(475)) -
Stopping IPC Server listener on 36868
[junit] 2011-02-06 12:35:47,703 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 5 on 36868: exiting
[junit] 2011-02-06 12:35:47,703 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 6 on 36868: exiting
[junit] 2011-02-06 12:35:47,703 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 4 on 36868: exiting
[junit] 2011-02-06 12:35:47,703 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 9 on 36868: exiting
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 7 on 36868: exiting
[junit] 2011-02-06 12:35:47,704 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 0 on 36868: exiting
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:run(675)) -
Stopping IPC Server Responder
[junit] 2011-02-06 12:35:47,704 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 1 on 36868: exiting
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 36.334 sec
[junit] 2011-02-06 12:35:47,703 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 8 on 36868: exiting
[junit] 2011-02-06 12:35:47,702 INFO ipc.Server (Server.java:run(1443)) -
IPC Server handler 3 on 36868: exiting
checkfailure:
-run-test-hdfs-fault-inject-withtestcaseonly:
run-test-hdfs-fault-inject:
BUILD FAILED
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:746:
Tests failed!
Total time: 61 minutes 22 seconds
[FINDBUGS] Skipping publisher since build result is FAILURE
Publishing Javadoc
Archiving artifacts
Recording test results
Recording fingerprints
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
2 tests failed.
REGRESSION:
org.apache.hadoop.hdfs.server.datanode.TestBlockReport.blockReport_09
Error Message:
Wrong number of PendingReplication blocks expected:<2> but was:<1>
Stack Trace:
junit.framework.AssertionFailedError: Wrong number of PendingReplication blocks
expected:<2> but was:<1>
at
org.apache.hadoop.hdfs.server.datanode.TestBlockReport.__CLR3_0_2fte182r7m(TestBlockReport.java:457)
at
org.apache.hadoop.hdfs.server.datanode.TestBlockReport.blockReport_09(TestBlockReport.java:429)
FAILED:
org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore
Error Message:
Image file
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/secondary/current/fsimage
is corrupt with MD5 checksum of 32306d67a4acbc6ccb3bb49e790cfd9c but expecting
e2889bb9ee0079b53e1d6ad739ad3545
Stack Trace:
java.io.IOException: Image file
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/secondary/current/fsimage
is corrupt with MD5 checksum of 32306d67a4acbc6ccb3bb49e790cfd9c but expecting
e2889bb9ee0079b53e1d6ad739ad3545
at
org.apache.hadoop.hdfs.server.namenode.FSImage.loadFSImage(FSImage.java:670)
at
org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.doMerge(SecondaryNameNode.java:710)
at
org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.access$500(SecondaryNameNode.java:603)
at
org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doMerge(SecondaryNameNode.java:480)
at
org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doCheckpoint(SecondaryNameNode.java:441)
at
org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.__CLR3_0_2dn2tm4ubl(TestStorageRestore.java:316)
at
org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore(TestStorageRestore.java:286)
