You are viewing a plain text version of this content. The canonical link for it is here.
Posted to hdfs-dev@hadoop.apache.org by Apache Hudson Server <hu...@hudson.apache.org> on 2011/01/13 05:10:10 UTC

Hadoop-Hdfs-trunk-Commit - Build # 511 - Still Failing

See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk-Commit/511/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 3560 lines...]
    [junit] 2011-01-13 04:09:37,519 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(467)) - isPermissionEnabled=false
    [junit] 2011-01-13 04:09:37,519 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(508)) - isBlockTokenEnabled=false blockKeyUpdateInterval=0 min(s), blockTokenLifetime=0 min(s)
    [junit] 2011-01-13 04:09:37,519 INFO  namenode.NameNode (FSDirectory.java:<init>(125)) - Caching file names occuring more than 10 times 
    [junit] 2011-01-13 04:09:37,529 INFO  common.Storage (FSImageFormat.java:save(481)) - Saving image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/fsimage using no compression
    [junit] 2011-01-13 04:09:37,532 INFO  common.Storage (FSImageFormat.java:save(505)) - Image file of size 113 saved in 0 seconds.
    [junit] 2011-01-13 04:09:37,532 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(173)) - Preallocating Edit log, current size 0
    [junit] 2011-01-13 04:09:37,533 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(180)) - Edit log size is now 1049088 written 512 bytes  at offset 1048576
    [junit] 2011-01-13 04:09:37,539 INFO  common.Storage (FSImage.java:format(1348)) - Storage directory /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name has been successfully formatted.
    [junit] 2011-01-13 04:09:37,540 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(171)) - defaultReplication = 3
    [junit] 2011-01-13 04:09:37,540 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(172)) - maxReplication = 512
    [junit] 2011-01-13 04:09:37,540 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(173)) - minReplication = 1
    [junit] 2011-01-13 04:09:37,541 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(174)) - maxReplicationStreams = 2
    [junit] 2011-01-13 04:09:37,541 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(175)) - shouldCheckForEnoughRacks = false
    [junit] 2011-01-13 04:09:37,541 INFO  util.GSet (BlocksMap.java:computeCapacity(84)) - VM type       = 32-bit
    [junit] 2011-01-13 04:09:37,541 INFO  util.GSet (BlocksMap.java:computeCapacity(85)) - 2% max memory = 9.86125 MB
    [junit] 2011-01-13 04:09:37,542 INFO  util.GSet (BlocksMap.java:computeCapacity(86)) - capacity      = 2^21 = 2097152 entries
    [junit] 2011-01-13 04:09:37,542 INFO  util.GSet (LightWeightGSet.java:<init>(82)) - recommended=2097152, actual=2097152
    [junit] 2011-01-13 04:09:37,549 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(460)) - fsOwner=hudson
    [junit] 2011-01-13 04:09:37,550 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(466)) - supergroup=supergroup
    [junit] 2011-01-13 04:09:37,550 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(467)) - isPermissionEnabled=false
    [junit] 2011-01-13 04:09:37,550 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(508)) - isBlockTokenEnabled=false blockKeyUpdateInterval=0 min(s), blockTokenLifetime=0 min(s)
    [junit] 2011-01-13 04:09:37,551 INFO  metrics.FSNamesystemMetrics (FSNamesystemMetrics.java:<init>(80)) - Initializing FSNamesystemMetrics using context object:org.apache.hadoop.metrics.spi.NullContext
    [junit] 2011-01-13 04:09:37,552 INFO  namenode.FSNamesystem (FSNamesystem.java:registerMBean(4539)) - Registered FSNamesystemStatusMBean
    [junit] 2011-01-13 04:09:37,552 INFO  namenode.NameNode (FSDirectory.java:<init>(125)) - Caching file names occuring more than 10 times 
    [junit] 2011-01-13 04:09:37,553 WARN  common.Util (Util.java:stringAsURI(63)) - Path /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name should be specified as a URI in configuration files. Please update hdfs configuration.
    [junit] 2011-01-13 04:09:37,553 WARN  common.Util (Util.java:stringAsURI(63)) - Path /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name should be specified as a URI in configuration files. Please update hdfs configuration.
    [junit] 2011-01-13 04:09:37,555 INFO  common.Storage (FSImageFormat.java:load(178)) - Loading image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/fsimage using no compression
    [junit] 2011-01-13 04:09:37,555 INFO  common.Storage (FSImageFormat.java:load(181)) - Number of files = 1
    [junit] 2011-01-13 04:09:37,672 INFO  common.Storage (FSImageFormat.java:loadFilesUnderConstruction(349)) - Number of files under construction = 0
    [junit] 2011-01-13 04:09:37,673 INFO  common.Storage (FSImageFormat.java:load(202)) - Image file of size 113 loaded in 0 seconds.
    [junit] 2011-01-13 04:09:37,673 INFO  common.Storage (FSEditLogLoader.java:loadFSEdits(61)) - Edits file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/edits of size 4 edits # 0 loaded in 0 seconds.
    [junit] 2011-01-13 04:09:37,674 INFO  namenode.NameCache (NameCache.java:initialized(143)) - initialized with 0 entries 0 lookups
    [junit] 2011-01-13 04:09:37,674 INFO  namenode.FSNamesystem (FSNamesystem.java:initialize(309)) - Finished loading FSImage in 135 msecs
    [junit] 2011-01-13 04:09:37,675 INFO  util.HostsFileReader (HostsFileReader.java:refresh(85)) - Refreshing hosts (include/exclude) list
    [junit] 2011-01-13 04:09:37,675 DEBUG namenode.TestNNLeaseRecovery (TestNNLeaseRecovery.java:__CLR3_0_2q30srsw5t(363)) - Running __CLR3_0_2q30srsw5t
    [junit] 2011-01-13 04:09:37,677 INFO  namenode.FSEditLog (FSEditLog.java:printStatistics(631)) - Number of transactions: 0 Total time for transactions(ms): 0Number of transactions batched in Syncs: 0 Number of syncs: 0 SyncTimes(ms): 0 
    [junit] 2011-01-13 04:09:37,677 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(173)) - Preallocating Edit log, current size 4
    [junit] 2011-01-13 04:09:37,677 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(180)) - Edit log size is now 1049092 written 512 bytes  at offset 1048580
    [junit] 2011-01-13 04:09:37,684 INFO  namenode.FSNamesystem (FSNamesystem.java:commitBlockSynchronization(2332)) - commitBlockSynchronization(lastblock=Mock for BlockInfoUnderConstruction, hashCode: 2342353, newgenerationstamp=2002, newlength=273487234, newtargets=[null], closeFile=true, deleteBlock=false)
    [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 2.485 sec

checkfailure:
    [touch] Creating /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/testsfailed

BUILD FAILED
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:685: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:648: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:716: Tests failed!

Total time: 15 minutes 27 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) ##############################
1 tests failed.
REGRESSION:  org.apache.hadoop.hdfs.server.datanode.TestBlockRecovery.testErrorReplicas

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.




Hadoop-Hdfs-trunk-Commit - Build # 513 - Still Failing

Posted by Apache Hudson Server <hu...@hudson.apache.org>.
See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk-Commit/513/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 148641 lines...]
    [junit] 2011-01-19 07:12:10,597 INFO  hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(799)) - Shutting down DataNode 0
    [junit] 2011-01-19 07:12:10,698 INFO  ipc.Server (Server.java:stop(1610)) - Stopping server on 35895
    [junit] 2011-01-19 07:12:10,699 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 1 on 35895: exiting
    [junit] 2011-01-19 07:12:10,699 INFO  datanode.DataNode (DataNode.java:shutdown(785)) - Waiting for threadgroup to exit, active threads is 1
    [junit] 2011-01-19 07:12:10,699 WARN  datanode.DataNode (DataXceiverServer.java:run(141)) - DatanodeRegistration(127.0.0.1:45823, storageID=DS-658544987-127.0.1.1-45823-1295421129608, infoPort=38617, ipcPort=35895):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-01-19 07:12:10,699 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 2 on 35895: exiting
    [junit] 2011-01-19 07:12:10,699 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder
    [junit] 2011-01-19 07:12:10,699 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 35895: exiting
    [junit] 2011-01-19 07:12:10,699 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 35895
    [junit] 2011-01-19 07:12:10,701 INFO  datanode.DataNode (DataNode.java:shutdown(785)) - Waiting for threadgroup to exit, active threads is 0
    [junit] 2011-01-19 07:12:10,702 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(622)) - Exiting DataBlockScanner thread.
    [junit] 2011-01-19 07:12:10,702 INFO  datanode.DataNode (DataNode.java:run(1459)) - DatanodeRegistration(127.0.0.1:45823, storageID=DS-658544987-127.0.1.1-45823-1295421129608, infoPort=38617, ipcPort=35895):Finishing DataNode in: FSDataset{dirpath='/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/data/data1/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/data/data2/current/finalized'}
    [junit] 2011-01-19 07:12:10,702 INFO  ipc.Server (Server.java:stop(1610)) - Stopping server on 35895
    [junit] 2011-01-19 07:12:10,703 INFO  datanode.DataNode (DataNode.java:shutdown(785)) - Waiting for threadgroup to exit, active threads is 0
    [junit] 2011-01-19 07:12:10,703 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads...
    [junit] 2011-01-19 07:12:10,703 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down.
    [junit] 2011-01-19 07:12:10,704 WARN  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down.
    [junit] 2011-01-19 07:12:10,805 WARN  namenode.FSNamesystem (FSNamesystem.java:run(2844)) - ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 2011-01-19 07:12:10,805 WARN  namenode.DecommissionManager (DecommissionManager.java:run(70)) - Monitor interrupted: java.lang.InterruptedException: sleep interrupted
    [junit] 2011-01-19 07:12:10,805 INFO  namenode.FSEditLog (FSEditLog.java:printStatistics(631)) - Number of transactions: 12 Total time for transactions(ms): 0Number of transactions batched in Syncs: 1 Number of syncs: 9 SyncTimes(ms): 7 7 
    [junit] 2011-01-19 07:12:10,807 INFO  ipc.Server (Server.java:stop(1610)) - Stopping server on 49515
    [junit] 2011-01-19 07:12:10,807 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 49515: exiting
    [junit] 2011-01-19 07:12:10,807 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 4 on 49515: exiting
    [junit] 2011-01-19 07:12:10,807 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 49515
    [junit] 2011-01-19 07:12:10,807 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 1 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 2 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 3 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 6 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 5 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 9 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 8 on 49515: exiting
    [junit] 2011-01-19 07:12:10,808 INFO  ipc.Server (Server.java:run(1443)) - IPC Server handler 7 on 49515: exiting
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 5.391 sec

checkfailure:
    [touch] Creating /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/testsfailed

BUILD FAILED
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:700: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:657: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:725: Tests failed!

Total time: 9 minutes 10 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) ##############################
1 tests failed.
FAILED:  org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore

Error Message:
Image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/secondary/current/fsimage is corrupt with MD5 checksum of de640a9fef79296c6b850711d44d40ad but expecting 655b26e43ad02c03a5cd8116d38ce38a

Stack Trace:
java.io.IOException: Image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/secondary/current/fsimage is corrupt with MD5 checksum of de640a9fef79296c6b850711d44d40ad but expecting 655b26e43ad02c03a5cd8116d38ce38a
	at org.apache.hadoop.hdfs.server.namenode.FSImage.loadFSImage(FSImage.java:1063)
	at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.doMerge(SecondaryNameNode.java:702)
	at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.access$500(SecondaryNameNode.java:600)
	at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doMerge(SecondaryNameNode.java:477)
	at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doCheckpoint(SecondaryNameNode.java:438)
	at org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.__CLR3_0_2dn2tm4r7b(TestStorageRestore.java:316)
	at org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore(TestStorageRestore.java:286)




Hadoop-Hdfs-trunk-Commit - Build # 512 - Still Failing

Posted by Apache Hudson Server <hu...@hudson.apache.org>.
See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk-Commit/512/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 3569 lines...]
    [junit] 2011-01-16 08:29:43,872 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(467)) - isPermissionEnabled=false
    [junit] 2011-01-16 08:29:43,873 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(508)) - isBlockTokenEnabled=false blockKeyUpdateInterval=0 min(s), blockTokenLifetime=0 min(s)
    [junit] 2011-01-16 08:29:43,873 INFO  namenode.NameNode (FSDirectory.java:<init>(125)) - Caching file names occuring more than 10 times 
    [junit] 2011-01-16 08:29:43,882 INFO  common.Storage (FSImageFormat.java:save(481)) - Saving image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/fsimage using no compression
    [junit] 2011-01-16 08:29:43,887 INFO  common.Storage (FSImageFormat.java:save(505)) - Image file of size 113 saved in 0 seconds.
    [junit] 2011-01-16 08:29:43,887 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(173)) - Preallocating Edit log, current size 0
    [junit] 2011-01-16 08:29:43,888 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(180)) - Edit log size is now 1049088 written 512 bytes  at offset 1048576
    [junit] 2011-01-16 08:29:43,895 INFO  common.Storage (FSImage.java:format(1348)) - Storage directory /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name has been successfully formatted.
    [junit] 2011-01-16 08:29:43,895 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(171)) - defaultReplication = 3
    [junit] 2011-01-16 08:29:43,896 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(172)) - maxReplication = 512
    [junit] 2011-01-16 08:29:43,896 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(173)) - minReplication = 1
    [junit] 2011-01-16 08:29:43,896 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(174)) - maxReplicationStreams = 2
    [junit] 2011-01-16 08:29:43,896 INFO  namenode.FSNamesystem (BlockManager.java:setConfigurationParameters(175)) - shouldCheckForEnoughRacks = false
    [junit] 2011-01-16 08:29:43,897 INFO  util.GSet (BlocksMap.java:computeCapacity(84)) - VM type       = 32-bit
    [junit] 2011-01-16 08:29:43,897 INFO  util.GSet (BlocksMap.java:computeCapacity(85)) - 2% max memory = 9.86125 MB
    [junit] 2011-01-16 08:29:43,897 INFO  util.GSet (BlocksMap.java:computeCapacity(86)) - capacity      = 2^21 = 2097152 entries
    [junit] 2011-01-16 08:29:43,898 INFO  util.GSet (LightWeightGSet.java:<init>(82)) - recommended=2097152, actual=2097152
    [junit] 2011-01-16 08:29:43,904 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(460)) - fsOwner=hudson
    [junit] 2011-01-16 08:29:43,905 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(466)) - supergroup=supergroup
    [junit] 2011-01-16 08:29:43,905 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(467)) - isPermissionEnabled=false
    [junit] 2011-01-16 08:29:43,906 INFO  namenode.FSNamesystem (FSNamesystem.java:setConfigurationParameters(508)) - isBlockTokenEnabled=false blockKeyUpdateInterval=0 min(s), blockTokenLifetime=0 min(s)
    [junit] 2011-01-16 08:29:43,906 INFO  metrics.FSNamesystemMetrics (FSNamesystemMetrics.java:<init>(80)) - Initializing FSNamesystemMetrics using context object:org.apache.hadoop.metrics.spi.NullContext
    [junit] 2011-01-16 08:29:43,907 INFO  namenode.FSNamesystem (FSNamesystem.java:registerMBean(4539)) - Registered FSNamesystemStatusMBean
    [junit] 2011-01-16 08:29:43,907 INFO  namenode.NameNode (FSDirectory.java:<init>(125)) - Caching file names occuring more than 10 times 
    [junit] 2011-01-16 08:29:43,908 WARN  common.Util (Util.java:stringAsURI(63)) - Path /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name should be specified as a URI in configuration files. Please update hdfs configuration.
    [junit] 2011-01-16 08:29:43,909 WARN  common.Util (Util.java:stringAsURI(63)) - Path /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name should be specified as a URI in configuration files. Please update hdfs configuration.
    [junit] 2011-01-16 08:29:43,910 INFO  common.Storage (FSImageFormat.java:load(178)) - Loading image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/fsimage using no compression
    [junit] 2011-01-16 08:29:43,910 INFO  common.Storage (FSImageFormat.java:load(181)) - Number of files = 1
    [junit] 2011-01-16 08:29:43,911 INFO  common.Storage (FSImageFormat.java:loadFilesUnderConstruction(349)) - Number of files under construction = 0
    [junit] 2011-01-16 08:29:43,911 INFO  common.Storage (FSImageFormat.java:load(202)) - Image file of size 113 loaded in 0 seconds.
    [junit] 2011-01-16 08:29:43,911 INFO  common.Storage (FSEditLogLoader.java:loadFSEdits(61)) - Edits file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/data/dfs/name/current/edits of size 4 edits # 0 loaded in 0 seconds.
    [junit] 2011-01-16 08:29:44,030 INFO  namenode.NameCache (NameCache.java:initialized(143)) - initialized with 0 entries 0 lookups
    [junit] 2011-01-16 08:29:44,030 INFO  namenode.FSNamesystem (FSNamesystem.java:initialize(309)) - Finished loading FSImage in 135 msecs
    [junit] 2011-01-16 08:29:44,031 INFO  util.HostsFileReader (HostsFileReader.java:refresh(85)) - Refreshing hosts (include/exclude) list
    [junit] 2011-01-16 08:29:44,031 DEBUG namenode.TestNNLeaseRecovery (TestNNLeaseRecovery.java:__CLR3_0_2q30srsw5t(363)) - Running __CLR3_0_2q30srsw5t
    [junit] 2011-01-16 08:29:44,033 INFO  namenode.FSEditLog (FSEditLog.java:printStatistics(631)) - Number of transactions: 0 Total time for transactions(ms): 0Number of transactions batched in Syncs: 0 Number of syncs: 0 SyncTimes(ms): 0 
    [junit] 2011-01-16 08:29:44,033 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(173)) - Preallocating Edit log, current size 4
    [junit] 2011-01-16 08:29:44,033 DEBUG namenode.FSNamesystem (EditLogFileOutputStream.java:preallocate(180)) - Edit log size is now 1049092 written 512 bytes  at offset 1048580
    [junit] 2011-01-16 08:29:44,040 INFO  namenode.FSNamesystem (FSNamesystem.java:commitBlockSynchronization(2332)) - commitBlockSynchronization(lastblock=Mock for BlockInfoUnderConstruction, hashCode: 2148614, newgenerationstamp=2002, newlength=273487234, newtargets=[null], closeFile=true, deleteBlock=false)
    [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 2.49 sec

checkfailure:
    [touch] Creating /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build/test/testsfailed

BUILD FAILED
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:694: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:657: The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk-Commit/trunk/build.xml:725: Tests failed!

Total time: 15 minutes 27 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) ##############################
1 tests failed.
FAILED:  org.apache.hadoop.hdfs.server.datanode.TestBlockRecovery.testErrorReplicas

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.