See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/556/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 54365 lines...]
[junit] 2011-01-19 11:29:24,127 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 1 on 32993: starting
[junit] 2011-01-19 11:29:24,126 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 0 on 32993: starting
[junit] 2011-01-19 11:29:24,128 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 2 on 32993: starting
[junit] 2011-01-19 11:29:24,128 INFO datanode.DataNode
(DataNode.java:offerService(904)) - using BLOCKREPORT_INTERVAL of 21600000msec
Initial delay: 0msec
[junit] 2011-01-19 11:29:24,141 INFO datanode.DataNode
(DataNode.java:blockReport(1143)) - BlockReport of 0 blocks got processed in 8
msecs
[junit] 2011-01-19 11:29:24,141 INFO datanode.DataNode
(DataNode.java:offerService(946)) - Starting Periodic block scanner.
[junit] Starting DataNode 1 with dfs.datanode.data.dir:
file:/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data3/,file:/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data4/
[junit] 2011-01-19 11:30:27,271 INFO security.UserGroupInformation
(UserGroupInformation.java:initUGI(259)) - JAAS Configuration already set up
for Hadoop, not re-installing.
[junit] 2011-01-19 11:31:09,410 INFO datanode.DataNode
(DataNode.java:registerMXBean(536)) - DataNode MXBean already registered
[junit] 2011-01-19 11:31:09,411 INFO datanode.DataNode
(DataNode.java:initDataXceiver(472)) - Opened info server at 55692
[junit] 2011-01-19 11:31:09,411 INFO datanode.DataNode
(DataXceiverServer.java:<init>(77)) - Balancing bandwith is 1048576 bytes/s
[junit] 2011-01-19 11:31:09,413 INFO common.Storage
(DataStorage.java:recoverTransitionRead(127)) - Storage directory
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data3
is not formatted.
[junit] 2011-01-19 11:31:09,414 INFO common.Storage
(DataStorage.java:recoverTransitionRead(128)) - Formatting ...
[junit] 2011-01-19 11:31:09,416 INFO common.Storage
(DataStorage.java:recoverTransitionRead(127)) - Storage directory
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data4
is not formatted.
[junit] 2011-01-19 11:31:09,416 INFO common.Storage
(DataStorage.java:recoverTransitionRead(128)) - Formatting ...
[junit] 2011-01-19 11:31:51,503 INFO datanode.DataNode
(FSDataset.java:registerMBean(1772)) - Registered FSDatasetStatusMBean
[junit] 2011-01-19 11:31:51,503 INFO datanode.DirectoryScanner
(DirectoryScanner.java:<init>(149)) - scan starts at 1295446363503 with
interval 21600000
[junit] 2011-01-19 11:31:51,505 INFO http.HttpServer
(HttpServer.java:addGlobalFilter(409)) - Added global filtersafety
(class=org.apache.hadoop.http.HttpServer$QuotingInputFilter)
[junit] 2011-01-19 11:31:51,506 INFO http.HttpServer
(HttpServer.java:start(579)) - Port returned by
webServer.getConnectors()[0].getLocalPort() before open() is -1. Opening the
listener on 0
[junit] 2011-01-19 11:31:51,507 INFO http.HttpServer
(HttpServer.java:start(584)) - listener.getLocalPort() returned 44075
webServer.getConnectors()[0].getLocalPort() returned 44075
[junit] 2011-01-19 11:31:51,507 INFO http.HttpServer
(HttpServer.java:start(617)) - Jetty bound to port 44075
[junit] 2011-01-19 11:31:51,508 INFO mortbay.log (?:invoke0(?)) -
jetty-6.1.14
[junit] 2011-01-19 11:31:51,626 INFO mortbay.log (?:invoke0(?)) - Started
SelectChannelConnector@localhost:44075
[junit] 2011-01-19 11:31:51,627 INFO jvm.JvmMetrics
(JvmMetrics.java:init(71)) - Cannot initialize JVM Metrics with
processName=DataNode, sessionId=null - already initialized
[junit] 2011-01-19 11:31:51,629 INFO ipc.Server (Server.java:run(338)) -
Starting SocketReader
[junit] 2011-01-19 11:31:51,629 INFO metrics.RpcMetrics
(RpcMetrics.java:<init>(63)) - Initializing RPC Metrics with hostName=DataNode,
port=49250
[junit] 2011-01-19 11:31:51,630 INFO metrics.RpcDetailedMetrics
(RpcDetailedMetrics.java:<init>(57)) - Initializing RPC Metrics with
hostName=DataNode, port=49250
[junit] 2011-01-19 11:31:51,631 INFO datanode.DataNode
(DataNode.java:initIpcServer(432)) - dnRegistration =
DatanodeRegistration(h2.grid.sp2.yahoo.net:55692, storageID=, infoPort=44075,
ipcPort=49250)
[junit] 2011-01-19 11:31:51,633 INFO hdfs.StateChange
(FSNamesystem.java:registerDatanode(2517)) - BLOCK*
NameSystem.registerDatanode: node registration from 127.0.0.1:55692 storage
DS-1269954937-127.0.1.1-55692-1295436711632
[junit] 2011-01-19 11:31:51,633 INFO net.NetworkTopology
(NetworkTopology.java:add(331)) - Adding a new node:
/default-rack/127.0.0.1:55692
[junit] 2011-01-19 11:31:51,637 INFO datanode.DataNode
(DataNode.java:register(714)) - New storage id
DS-1269954937-127.0.1.1-55692-1295436711632 is assigned to data-node
127.0.0.1:55692
[junit] 2011-01-19 11:31:51,651 INFO datanode.DataNode
(DataNode.java:run(1438)) - DatanodeRegistration(127.0.0.1:55692,
storageID=DS-1269954937-127.0.1.1-55692-1295436711632, infoPort=44075,
ipcPort=49250)In DataNode.run, data =
FSDataset{dirpath='/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data3/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data4/current/finalized'}
[junit] 2011-01-19 11:31:51,653 INFO ipc.Server (Server.java:run(608)) -
IPC Server Responder: starting
[junit] Starting DataNode 2 with dfs.datanode.data.dir:
file:/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data5/,file:/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data6/
[junit] 2011-01-19 11:31:51,654 INFO security.UserGroupInformation
(UserGroupInformation.java:initUGI(259)) - JAAS Configuration already set up
for Hadoop, not re-installing.
[junit] 2011-01-19 11:31:51,662 INFO ipc.Server (Server.java:run(443)) -
IPC Server listener on 49250: starting
[junit] 2011-01-19 11:31:51,669 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 2 on 49250: starting
[junit] 2011-01-19 11:31:51,669 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 0 on 49250: starting
[junit] 2011-01-19 11:31:51,668 INFO ipc.Server (Server.java:run(1368)) -
IPC Server handler 1 on 49250: starting
[junit] 2011-01-19 11:31:51,672 INFO datanode.DataNode
(DataNode.java:offerService(904)) - using BLOCKREPORT_INTERVAL of 21600000msec
Initial delay: 0msec
[junit] 2011-01-19 11:31:51,687 INFO datanode.DataNode
(DataNode.java:blockReport(1143)) - BlockReport of 0 blocks got processed in 2
msecs
[junit] 2011-01-19 11:31:51,688 INFO datanode.DataNode
(DataNode.java:offerService(946)) - Starting Periodic block scanner.
[junit] 2011-01-19 11:32:33,816 INFO datanode.DataNode
(DataNode.java:registerMXBean(536)) - DataNode MXBean already registered
[junit] 2011-01-19 11:32:33,817 INFO datanode.DataNode
(DataNode.java:initDataXceiver(472)) - Opened info server at 34155
[junit] 2011-01-19 11:32:33,818 INFO datanode.DataNode
(DataXceiverServer.java:<init>(77)) - Balancing bandwith is 1048576 bytes/s
[junit] 2011-01-19 11:32:33,820 INFO common.Storage
(DataStorage.java:recoverTransitionRead(127)) - Storage directory
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data5
is not formatted.
[junit] 2011-01-19 11:32:33,820 INFO common.Storage
(DataStorage.java:recoverTransitionRead(128)) - Formatting ...
[junit] 2011-01-19 11:32:33,822 INFO common.Storage
(DataStorage.java:recoverTransitionRead(127)) - Storage directory
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data6
is not formatted.
[junit] 2011-01-19 11:32:33,823 INFO common.Storage
(DataStorage.java:recoverTransitionRead(128)) - Formatting ...
Build timed out. Aborting
[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)
##############################
11 tests failed.
REGRESSION: org.apache.hadoop.hdfs.TestDFSShell.testErrOutPut
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestDFSUpgradeFromImage.testUpgradeFromImage
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION:
org.apache.hadoop.hdfs.TestDistributedFileSystem.testAllWithDualPort
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestFileAppend.testComplexFlush
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestFileAppend2.testComplexAppend
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestFileAppend3.testAppendToPartialChunk
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestHDFSTrash.testTrashEmptier
Error Message:
null
Stack Trace:
junit.framework.AssertionFailedError: null
at org.apache.hadoop.fs.TestTrash.testTrashEmptier(TestTrash.java:460)
at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
at junit.extensions.TestSetup$1.protect(TestSetup.java:23)
at junit.extensions.TestSetup.run(TestSetup.java:27)
REGRESSION: org.apache.hadoop.hdfs.TestPread.testPreadDFSSimulated
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION:
org.apache.hadoop.hdfs.TestQuota.testMultipleFilesSmallerThanOneBlock
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION: org.apache.hadoop.hdfs.TestRestartDFS.testRestartDualPortDFS
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
FAILED: TEST-org.apache.hadoop.hdfs.server.datanode.TestDiskError.xml.<init>
Error Message:
Stack Trace:
Test report file
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/TEST-org.apache.hadoop.hdfs.server.datanode.TestDiskError.xml
was length 0
