See http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/840/changes

Changes:

[szetszwo] HADOOP-5835. Fix findbugs warnings found in Block, DataNode, 
NameNode and a few other hdfs classes.  Contributed by Suresh Srinivas

[szetszwo] HADOOP-5829. Fix javac warnings found in ReplicationTargetChooser, 
FSImage, Checkpointer, SecondaryNameNode and a few other hdfs classes.  
Contributed by Suresh Srinivas

[shv] HADOOP-5858. Eliminate UTF8 and fix warnings in test/hdfs-with-mr 
package. Contributed by Konstantin Shvachko.

------------------------------------------
[...truncated 547849 lines...]
    [junit] 09/05/19 16:24:28 INFO mapred.JobTracker: Adding task 
'attempt_200905191624_0001_m_000000_0' to tip task_200905191624_0001_m_000000, 
for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:52506'
    [junit] 09/05/19 16:24:29 INFO mapred.JobInProgress: Choosing rack-local 
task task_200905191624_0001_m_000000
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_200905191624_0001_m_000000_0 task's state:UNASSIGNED
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: Trying to launch : 
attempt_200905191624_0001_m_000000_0
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_200905191624_0001_m_000000_0
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: Received KillTaskAction 
for task: attempt_200905191624_0001_m_000002_0
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: About to purge task: 
attempt_200905191624_0001_m_000002_0
    [junit] 09/05/19 16:24:29 INFO mapred.TaskRunner: 
attempt_200905191624_0001_m_000002_0 done; removing files.
    [junit] 09/05/19 16:24:29 INFO mapred.IndexCache: Map ID 
attempt_200905191624_0001_m_000002_0 not found in cache
    [junit] 09/05/19 16:24:29 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_200905191624_0001_m_1141487593
    [junit] 09/05/19 16:24:29 INFO mapred.JvmManager: JVM Runner 
jvm_200905191624_0001_m_1141487593 spawned.
    [junit] 09/05/19 16:24:29 INFO mapred.TaskTracker: JVM with ID: 
jvm_200905191624_0001_m_1141487593 given task: 
attempt_200905191624_0001_m_000000_0
    [junit] 09/05/19 16:24:29 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        src=/testing/in/part0   dst=null        
perm=null
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=mkdirs      
src=/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0       
dst=null        perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0/part-00000    
dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/05/19 16:24:30 INFO DataNode.clienttrace: src: /127.0.0.1:53144, 
dest: /127.0.0.1:36519, bytes: 19, op: HDFS_READ, cliID: 
DFSClient_attempt_200905191624_0001_m_000000_0, offset: 0, srvID: 
DS-1506865282-67.195.138.9-53144-1242750251485, blockid: 
blk_-5564004554981117559_1002, duration: 235307
    [junit] 09/05/19 16:24:30 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0/part-00000. 
blk_-8459215690303566319_1008
    [junit] 09/05/19 16:24:30 INFO datanode.DataNode: Receiving block 
blk_-8459215690303566319_1008 src: /127.0.0.1:36520 dest: /127.0.0.1:53144
    [junit] 09/05/19 16:24:30 INFO datanode.DataNode: Receiving block 
blk_-8459215690303566319_1008 src: /127.0.0.1:42311 dest: /127.0.0.1:54895
    [junit] 09/05/19 16:24:30 INFO DataNode.clienttrace: src: /127.0.0.1:42311, 
dest: /127.0.0.1:54895, bytes: 8, op: HDFS_WRITE, cliID: 
DFSClient_attempt_200905191624_0001_m_000000_0, offset: 0, srvID: 
DS-1813882785-67.195.138.9-54895-1242750250882, blockid: 
blk_-8459215690303566319_1008, duration: 31117681
    [junit] 09/05/19 16:24:30 INFO datanode.DataNode: PacketResponder 0 for 
block blk_-8459215690303566319_1008 terminating
    [junit] 09/05/19 16:24:30 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:54895 is added to 
blk_-8459215690303566319_1008 size 8
    [junit] 09/05/19 16:24:30 INFO DataNode.clienttrace: src: /127.0.0.1:36520, 
dest: /127.0.0.1:53144, bytes: 8, op: HDFS_WRITE, cliID: 
DFSClient_attempt_200905191624_0001_m_000000_0, offset: 0, srvID: 
DS-1506865282-67.195.138.9-53144-1242750251485, blockid: 
blk_-8459215690303566319_1008, duration: 32182327
    [junit] 09/05/19 16:24:30 INFO datanode.DataNode: PacketResponder 1 for 
block blk_-8459215690303566319_1008 terminating
    [junit] 09/05/19 16:24:30 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:53144 is added to 
blk_-8459215690303566319_1008 size 8
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0/part-00000 is 
closed by DFSClient_attempt_200905191624_0001_m_000000_0
    [junit] 09/05/19 16:24:30 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:30 INFO mapred.TaskTracker: Task 
attempt_200905191624_0001_m_000000_0 is in commit-pending, task 
state:COMMIT_PENDING
    [junit] 09/05/19 16:24:30 INFO mapred.TaskTracker: 
attempt_200905191624_0001_m_000000_0 0.0% 
    [junit] 09/05/19 16:24:32 INFO mapred.TaskTracker: Received commit task 
action for attempt_200905191624_0001_m_000000_0
    [junit] 09/05/19 16:24:32 WARN util.ProcessTree: Error executing shell 
command org.apache.hadoop.util.Shell$ExitCodeException: kill: No such process
    [junit] 
    [junit] 09/05/19 16:24:32 INFO util.ProcessTree: Killing process group25246 
with SIGKILL. Exit code 1
    [junit] 09/05/19 16:24:32 INFO mapred.DefaultTaskController: Process exited 
with exit code:0
    [junit] 09/05/19 16:24:32 INFO mapred.JvmManager: JVM : 
jvm_200905191624_0001_m_-1805702474 exited. Number of tasks it ran: 1
    [junit] 09/05/19 16:24:32 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=listStatus  
src=/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0       
dst=null        perm=null
    [junit] 09/05/19 16:24:32 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=mkdirs      src=/testing/out        dst=null        
perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/05/19 16:24:32 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:32 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:32 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=rename      
src=/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0/part-00000    
dst=/testing/out/part-00000     perm=hudson:supergroup:rw-r--r--
    [junit] 09/05/19 16:24:32 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:32 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:32 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/testing/out/_temporary/_attempt_200905191624_0001_m_000000_0       
dst=null        perm=null
    [junit] 09/05/19 16:24:32 INFO mapred.TaskTracker: 
attempt_200905191624_0001_m_000000_0 1.0% Records R/W=1/1
    [junit] 09/05/19 16:24:32 INFO mapred.TaskTracker: Task 
attempt_200905191624_0001_m_000000_0 is done.
    [junit] 09/05/19 16:24:32 INFO mapred.TaskTracker: reported output size for 
attempt_200905191624_0001_m_000000_0  was 0
    [junit] 09/05/19 16:24:32 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/05/19 16:24:32 WARN util.ProcessTree: Error executing shell 
command org.apache.hadoop.util.Shell$ExitCodeException: kill: No such process
    [junit] 
    [junit] 09/05/19 16:24:32 INFO util.ProcessTree: Killing all processes in 
the process group 25301 with SIGTERM. Exit code 1
    [junit] 09/05/19 16:24:35 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_200905191624_0001/attempt_200905191624_0001_m_000000_0/output/file.out
 in any of the configured local directories
    [junit] 09/05/19 16:24:35 INFO mapred.JobInProgress: Task 
'attempt_200905191624_0001_m_000000_0' has completed 
task_200905191624_0001_m_000000 successfully.
    [junit] 09/05/19 16:24:35 INFO mapred.JobTracker: Adding task 
'attempt_200905191624_0001_m_000001_0' to tip task_200905191624_0001_m_000001, 
for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:52506'
    [junit] 09/05/19 16:24:35 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_200905191624_0001_m_000001_0 task's state:UNASSIGNED
    [junit] 09/05/19 16:24:35 INFO mapred.TaskTracker: Trying to launch : 
attempt_200905191624_0001_m_000001_0
    [junit] 09/05/19 16:24:35 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_200905191624_0001_m_000001_0
    [junit] 09/05/19 16:24:35 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_200905191624_0001_m_-817894943
    [junit] 09/05/19 16:24:35 INFO mapred.JvmManager: JVM Runner 
jvm_200905191624_0001_m_-817894943 spawned.
    [junit] 09/05/19 16:24:35 INFO mapred.TaskTracker: JVM with ID: 
jvm_200905191624_0001_m_-817894943 given task: 
attempt_200905191624_0001_m_000001_0
    [junit] 09/05/19 16:24:35 INFO streaming.StreamJob:  map 100%  reduce 0%
    [junit] 09/05/19 16:24:36 INFO mapred.TaskTracker: 
attempt_200905191624_0001_m_000001_0 0.0% 
    [junit] 09/05/19 16:24:36 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:36 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:36 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      src=/testing/out/_temporary     dst=null        
perm=null
    [junit] 09/05/19 16:24:36 INFO mapred.TaskTracker: 
attempt_200905191624_0001_m_000001_0 0.0% cleanup
    [junit] 09/05/19 16:24:36 INFO mapred.TaskTracker: Task 
attempt_200905191624_0001_m_000001_0 is done.
    [junit] 09/05/19 16:24:36 INFO mapred.TaskTracker: reported output size for 
attempt_200905191624_0001_m_000001_0  was 0
    [junit] 09/05/19 16:24:36 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/05/19 16:24:36 WARN util.ProcessTree: Error executing shell 
command org.apache.hadoop.util.Shell$ExitCodeException: kill: No such process
    [junit] 
    [junit] 09/05/19 16:24:36 INFO util.ProcessTree: Killing all processes in 
the process group 25391 with SIGTERM. Exit code 1
    [junit] 09/05/19 16:24:37 WARN util.ProcessTree: Error executing shell 
command org.apache.hadoop.util.Shell$ExitCodeException: kill: No such process
    [junit] 
    [junit] 09/05/19 16:24:37 INFO util.ProcessTree: Killing process group25301 
with SIGKILL. Exit code 1
    [junit] 09/05/19 16:24:37 INFO mapred.DefaultTaskController: Process exited 
with exit code:0
    [junit] 09/05/19 16:24:37 INFO mapred.JvmManager: JVM : 
jvm_200905191624_0001_m_1141487593 exited. Number of tasks it ran: 1
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_200905191624_0001/attempt_200905191624_0001_m_000001_0/output/file.out
 in any of the configured local directories
    [junit] 09/05/19 16:24:38 INFO mapred.JobInProgress: Task 
'attempt_200905191624_0001_m_000001_0' has completed 
task_200905191624_0001_m_000001 successfully.
    [junit] 09/05/19 16:24:38 INFO mapred.JobInProgress: Job 
job_200905191624_0001 has completed successfully.
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/testing/out/_logs/history/localhost_1242750251777_job_200905191624_0001_hudson_streamjob5941134286382617831.jar.
 blk_1776209926462988433_1008
    [junit] 09/05/19 16:24:38 INFO datanode.DataNode: Receiving block 
blk_1776209926462988433_1008 src: /127.0.0.1:36527 dest: /127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO datanode.DataNode: Receiving block 
blk_1776209926462988433_1008 src: /127.0.0.1:42318 dest: /127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO DataNode.clienttrace: src: /127.0.0.1:42318, 
dest: /127.0.0.1:54895, bytes: 4570, op: HDFS_WRITE, cliID: 
DFSClient_-212785646, offset: 0, srvID: 
DS-1813882785-67.195.138.9-54895-1242750250882, blockid: 
blk_1776209926462988433_1008, duration: 2372725
    [junit] 09/05/19 16:24:38 INFO datanode.DataNode: PacketResponder 0 for 
block blk_1776209926462988433_1008 terminating
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:54895 is added to 
blk_1776209926462988433_1008 size 4570
    [junit] 09/05/19 16:24:38 INFO DataNode.clienttrace: src: /127.0.0.1:36527, 
dest: /127.0.0.1:53144, bytes: 4570, op: HDFS_WRITE, cliID: 
DFSClient_-212785646, offset: 0, srvID: 
DS-1506865282-67.195.138.9-53144-1242750251485, blockid: 
blk_1776209926462988433_1008, duration: 3251605
    [junit] 09/05/19 16:24:38 INFO datanode.DataNode: PacketResponder 1 for 
block blk_1776209926462988433_1008 terminating
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:53144 is added to 
blk_1776209926462988433_1008 size 4570
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/testing/out/_logs/history/localhost_1242750251777_job_200905191624_0001_hudson_streamjob5941134286382617831.jar
 is closed by DFSClient_-212785646
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-6300384444103755576 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-6300384444103755576 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-1945889872183587322 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-1945889872183587322 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_6770030167606641444 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_6770030167606641444 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO mapred.JobTracker: Removed completed task 
'attempt_200905191624_0001_m_000000_0' from 
'tracker_host1.foo.com:localhost/127.0.0.1:52506'
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO mapred.JobTracker: Removed completed task 
'attempt_200905191624_0001_m_000001_0' from 
'tracker_host1.foo.com:localhost/127.0.0.1:52506'
    [junit] 09/05/19 16:24:38 INFO mapred.JobTracker: Removed completed task 
'attempt_200905191624_0001_m_000002_0' from 
'tracker_host1.foo.com:localhost/127.0.0.1:52506'
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Received 'KillJobAction' 
for job: job_200905191624_0001
    [junit] 09/05/19 16:24:38 INFO mapred.TaskRunner: 
attempt_200905191624_0001_m_000000_0 done; removing files.
    [junit] 09/05/19 16:24:38 INFO mapred.IndexCache: Map ID 
attempt_200905191624_0001_m_000000_0 not found in cache
    [junit] 09/05/19 16:24:38 INFO mapred.TaskRunner: 
attempt_200905191624_0001_m_000001_0 done; removing files.
    [junit] 09/05/19 16:24:38 INFO mapred.IndexCache: Map ID 
attempt_200905191624_0001_m_000001_0 not found in cache
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/user/hudson/build/contrib/streaming/test/system/job_200905191624_0001      
dst=null        perm=null
    [junit] 09/05/19 16:24:38 INFO streaming.StreamJob: Job complete: 
job_200905191624_0001
    [junit] 09/05/19 16:24:38 INFO streaming.StreamJob: Output: /testing/out
    [junit] 09/05/19 16:24:38 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=listStatus  src=/testing/out        dst=null        
perm=null
    [junit] 09/05/19 16:24:38 INFO mapred.TestMiniMRWithDFS: File list[0]: 
hdfs://localhost:55327/testing/out/part-00000
    [junit] 09/05/19 16:24:38 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        src=/testing/out/part-00000     dst=null        
perm=null
    [junit] 09/05/19 16:24:38 INFO DataNode.clienttrace: src: /127.0.0.1:54895, 
dest: /127.0.0.1:42319, bytes: 12, op: HDFS_READ, cliID: DFSClient_-212785646, 
offset: 0, srvID: DS-1813882785-67.195.138.9-54895-1242750250882, blockid: 
blk_-8459215690303566319_1008, duration: 268858
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-8420727823925090490 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-8420727823925090490 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_1776209926462988433 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_1776209926462988433 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-8459215690303566319 is added to invalidSet of 
127.0.0.1:54895
    [junit] 09/05/19 16:24:38 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-8459215690303566319 is added to invalidSet of 
127.0.0.1:53144
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:38 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      src=/testing/out        dst=null        
perm=null
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Shutting down: 
Map-events fetcher for all reduce tasks on 
tracker_host0.foo.com:localhost/127.0.0.1:47619
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping server on 47619
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 0 on 47619: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 2 on 47619: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 1 on 47619: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 3 on 47619: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping IPC Server listener on 
47619
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Shutting down 
StatusHttpServer
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Interrupted. Closing 
down.
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Shutting down: 
Map-events fetcher for all reduce tasks on 
tracker_host1.foo.com:localhost/127.0.0.1:52506
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping server on 52506
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 1 on 52506: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 0 on 52506: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 2 on 52506: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: IPC Server handler 3 on 52506: 
exiting
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping IPC Server listener on 
52506
    [junit] 09/05/19 16:24:38 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Shutting down 
StatusHttpServer
    [junit] 09/05/19 16:24:38 INFO mapred.TaskTracker: Interrupted. Closing 
down.
    [junit] 09/05/19 16:24:38 INFO mapred.JobTracker: Stopping infoServer
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: Stopping 
interTrackerServer
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping server on 48711
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 0 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 1 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 8 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 7 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 4 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 9 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: Stopped interTrackerServer
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: Stopping expireTrackers
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping IPC Server listener on 
48711
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 6 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 5 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 3 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 2 on 48711: 
exiting
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: Stopping retirer
    [junit] 09/05/19 16:24:39 INFO mapred.EagerTaskInitializationListener: 
Stopping Job Init Manager thread
    [junit] 09/05/19 16:24:39 INFO mapred.EagerTaskInitializationListener: 
JobInitManagerThread interrupted.
    [junit] 09/05/19 16:24:39 INFO mapred.EagerTaskInitializationListener: 
Shutting down thread pool
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: Stopping 
expireLaunchingTasks
    [junit] 09/05/19 16:24:39 INFO mapred.JobTracker: stopped all jobtracker 
services
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping server on 36171
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 0 on 36171: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping IPC Server listener on 
36171
    [junit] 09/05/19 16:24:39 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 1 on 36171: 
exiting
    [junit] 09/05/19 16:24:39 INFO ipc.Server: IPC Server handler 2 on 36171: 
exiting
    [junit] 09/05/19 16:24:39 INFO datanode.DataNode: Waiting for threadgroup 
to exit, active threads is 1
    [junit] 09/05/19 16:24:39 WARN datanode.DataNode: 
DatanodeRegistration(127.0.0.1:53144, 
storageID=DS-1506865282-67.195.138.9-53144-1242750251485, infoPort=57351, 
ipcPort=36171):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] 09/05/19 16:24:39 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:54895 
to delete  blk_-8420727823925090490_1007 blk_-1945889872183587322_1004 
blk_-6300384444103755576_1003 blk_6770030167606641444_1005 
blk_1776209926462988433_1008 blk_-8459215690303566319_1008
    [junit] 09/05/19 16:24:39 INFO datanode.DataBlockScanner: Exiting 
DataBlockScanner thread.
    [junit] 09/05/19 16:24:40 INFO datanode.DataNode: Waiting for threadgroup 
to exit, active threads is 0
    [junit] 09/05/19 16:24:40 INFO datanode.DataNode: 
DatanodeRegistration(127.0.0.1:53144, 
storageID=DS-1506865282-67.195.138.9-53144-1242750251485, infoPort=57351, 
ipcPort=36171):Finishing DataNode in: 
FSDataset{dirpath='http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/data/data3/current,/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/data/data4/current'}
 
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping server on 36171
    [junit] 09/05/19 16:24:40 INFO datanode.DataNode: Waiting for threadgroup 
to exit, active threads is 0
    [junit] Shutting down DataNode 0
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping server on 37109
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 2 on 37109: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping IPC Server listener on 
37109
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 0 on 37109: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 1 on 37109: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:40 WARN datanode.DataNode: 
DatanodeRegistration(127.0.0.1:54895, 
storageID=DS-1813882785-67.195.138.9-54895-1242750250882, infoPort=44450, 
ipcPort=37109):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] 09/05/19 16:24:40 INFO datanode.DataNode: Waiting for threadgroup 
to exit, active threads is 0
    [junit] 09/05/19 16:24:40 INFO datanode.DataBlockScanner: Exiting 
DataBlockScanner thread.
    [junit] 09/05/19 16:24:40 INFO datanode.DataNode: 
DatanodeRegistration(127.0.0.1:54895, 
storageID=DS-1813882785-67.195.138.9-54895-1242750250882, infoPort=44450, 
ipcPort=37109):Finishing DataNode in: 
FSDataset{dirpath='http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/data/data1/current,/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/data/data2/current'}
 
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping server on 37109
    [junit] 09/05/19 16:24:40 INFO datanode.DataNode: Waiting for threadgroup 
to exit, active threads is 0
    [junit] 09/05/19 16:24:40 WARN namenode.FSNamesystem: ReplicationMonitor 
thread received InterruptedException.java.lang.InterruptedException: sleep 
interrupted
    [junit] 09/05/19 16:24:40 WARN namenode.DecommissionManager: Monitor 
interrupted: java.lang.InterruptedException: sleep interrupted
    [junit] 09/05/19 16:24:40 INFO namenode.FSNamesystem: Number of 
transactions: 51 Total time for transactions(ms): 10Number of transactions 
batched in Syncs: 1 Number of syncs: 34 SyncTimes(ms): 306 242 
    [junit] 09/05/19 16:24:40 INFO namenode.FSNamesystem: current list of 
storage 
dirs:http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/contrib/streaming/test/data/dfs/name1(IMAGE_AND_EDITS);/home/hudson/hudson-slave/workspace/Hadoop-trunk/trunk/build/contrib/streaming/test/data/dfs/name2(IMAGE_AND_EDITS);
 
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping server on 55327
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 0 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 1 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 4 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 6 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 3 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 2 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 7 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 9 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping IPC Server listener on 
55327
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 5 on 55327: 
exiting
    [junit] 09/05/19 16:24:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 09/05/19 16:24:40 INFO ipc.Server: IPC Server handler 8 on 55327: 
exiting
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 31.737 sec
    [junit] Running org.apache.hadoop.typedbytes.TestIO
    [junit] 09/05/19 16:24:40 WARN conf.Configuration: DEPRECATED: 
hadoop-site.xml found in the classpath. Usage of hadoop-site.xml is deprecated. 
Instead use core-site.xml, mapred-site.xml and hdfs-site.xml to override 
properties of core-default.xml, mapred-default.xml and hdfs-default.xml 
respectively
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.269 sec
    [junit] Running org.apache.hadoop.typedbytes.TestTypedBytesWritable
    [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.189 sec

BUILD FAILED
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build.xml 
:1046: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build.xml 
:1027: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/src/contrib/build.xml
 :48: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/src/contrib/streaming/build.xml
 :42: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/src/contrib/build-contrib.xml
 :250: Tests failed!

Total time: 251 minutes 50 seconds
Publishing Javadoc
Recording test results
Recording fingerprints
Publishing Clover coverage report...

Reply via email to