See <http://hudson.zones.apache.org/hudson/job/Pig-trunk/623/changes>

Changes:

[gates] PIG-1077:  Support record(row)-based file split in Zebra's 
TableInputFormat.

[olga] PIG-1053: Consider moving to Hadoop for local mode (ankit.modi via olgan)

[daijy] PIG-1060: MultiQuery optimization throws error for multi-level splits

------------------------------------------
[...truncated 206582 lines...]
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-3388285408264901103_1014 src: /127.0.0.1:33242 dest: /127.0.0.1:39535
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-3388285408264901103_1014 src: /127.0.0.1:32971 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:32971, 
dest: /127.0.0.1:51645, bytes: 1589, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-3388285408264901103_1014
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 0 for 
block blk_-3388285408264901103_1014 terminating
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:33242, 
dest: /127.0.0.1:39535, bytes: 1589, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1984890133-127.0.1.1-39535-1258598006504, 
blockid: blk_-3388285408264901103_1014
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_-3388285408264901103_1014 size 1589
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 1 for 
block blk_-3388285408264901103_1014 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:39535 is added to 
blk_-3388285408264901103_1014 size 1589
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:33748, 
dest: /127.0.0.1:34458, bytes: 1589, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-3388285408264901103_1014
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 2 for 
block blk_-3388285408264901103_1014 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:34458 is added to 
blk_-3388285408264901103_1014 size 1589
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.split is closed 
by DFSClient_395457836
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml 
dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=setPermission       
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml 
dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml. 
blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-6813384894621786135_1015 src: /127.0.0.1:32972 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-6813384894621786135_1015 src: /127.0.0.1:33752 dest: /127.0.0.1:34458
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-6813384894621786135_1015 src: /127.0.0.1:33246 dest: /127.0.0.1:39535
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:33246, 
dest: /127.0.0.1:39535, bytes: 48639, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1984890133-127.0.1.1-39535-1258598006504, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 0 for 
block blk_-6813384894621786135_1015 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:39535 is added to 
blk_-6813384894621786135_1015 size 48639
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:33752, 
dest: /127.0.0.1:34458, bytes: 48639, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:34458 is added to 
blk_-6813384894621786135_1015 size 48639
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 1 for 
block blk_-6813384894621786135_1015 terminating
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:32972, 
dest: /127.0.0.1:51645, bytes: 48639, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_-6813384894621786135_1015 size 48639
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 2 for 
block blk_-6813384894621786135_1015 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml is closed 
by DFSClient_395457836
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml 
dst=null        perm=null
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:34458, 
dest: /127.0.0.1:33754, bytes: 49019, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.jar 
dst=null        perm=null
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:51645, 
dest: /127.0.0.1:32976, bytes: 2625792, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-7392176902308286198_1013
    [junit] 09/11/19 02:33:58 INFO mapred.JobTracker: Initializing 
job_20091119023326575_0002
    [junit] 09/11/19 02:33:58 INFO mapred.JobInProgress: Initializing 
job_20091119023326575_0002
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_hudson_Job7967489867006079740.jar
        dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_conf.xml
 dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_conf.xml.
 blk_-8117650403175354073_1017
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-8117650403175354073_1017 src: /127.0.0.1:33756 dest: /127.0.0.1:34458
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-8117650403175354073_1017 src: /127.0.0.1:36397 dest: /127.0.0.1:58915
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: Receiving block 
blk_-8117650403175354073_1017 src: /127.0.0.1:32979 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:32979, 
dest: /127.0.0.1:51645, bytes: 48669, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-8117650403175354073_1017
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 0 for 
block blk_-8117650403175354073_1017 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_-8117650403175354073_1017 size 48669
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:58915 is added to 
blk_-8117650403175354073_1017 size 48669
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:36397, 
dest: /127.0.0.1:58915, bytes: 48669, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1377221848-127.0.1.1-58915-1258598006052, 
blockid: blk_-8117650403175354073_1017
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 1 for 
block blk_-8117650403175354073_1017 terminating
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:33756, 
dest: /127.0.0.1:34458, bytes: 48669, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-8117650403175354073_1017
    [junit] 09/11/19 02:33:58 INFO datanode.DataNode: PacketResponder 2 for 
block blk_-8117650403175354073_1017 terminating
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:34458 is added to 
blk_-8117650403175354073_1017 size 48669
    [junit] 09/11/19 02:33:58 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_conf.xml
 is closed by DFSClient_395457836
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.split       
dst=null        perm=null
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:39535, 
dest: /127.0.0.1:33252, bytes: 1605, op: HDFS_READ, cliID: DFSClient_395457836, 
srvID: DS-1984890133-127.0.1.1-39535-1258598006504, blockid: 
blk_-3388285408264901103_1014
    [junit] 09/11/19 02:33:58 INFO mapred.JobInProgress: Input size for job 
job_20091119023326575_0002 = 12. Number of splits = 2
    [junit] 09/11/19 02:33:58 INFO mapred.JobInProgress: 
tip:task_20091119023326575_0002_m_000000 has split on 
node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 09/11/19 02:33:58 INFO mapred.JobInProgress: 
tip:task_20091119023326575_0002_m_000001 has split on 
node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 09/11/19 02:33:58 INFO mapred.JobTracker: Adding task 
'attempt_20091119023326575_0002_m_000003_0' to tip 
task_20091119023326575_0002_m_000003, for tracker 
'tracker_host2.foo.com:localhost/127.0.0.1:59414'
    [junit] 09/11/19 02:33:58 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_20091119023326575_0002_m_000003_0 task's 
state:UNASSIGNED
    [junit] 09/11/19 02:33:58 INFO mapred.TaskTracker: Trying to launch : 
attempt_20091119023326575_0002_m_000003_0
    [junit] 09/11/19 02:33:58 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_20091119023326575_0002_m_000003_0
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml 
dst=null        perm=null
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:39535, 
dest: /127.0.0.1:33253, bytes: 49019, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-1984890133-127.0.1.1-39535-1258598006504, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:33:58 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.jar 
dst=null        perm=null
    [junit] 09/11/19 02:33:58 INFO DataNode.clienttrace: src: /127.0.0.1:58915, 
dest: /127.0.0.1:36401, bytes: 2625792, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-1377221848-127.0.1.1-58915-1258598006052, 
blockid: blk_-7392176902308286198_1013
    [junit] 09/11/19 02:33:59 INFO mapReduceLayer.MapReduceLauncher: Submitting 
job: job_20091119023326575_0002 to execution engine.
    [junit] 09/11/19 02:33:59 INFO mapReduceLayer.MapReduceLauncher: More 
information at: 
http://localhost:54296/jobdetails.jsp?jobid=job_20091119023326575_0002
    [junit] 09/11/19 02:33:59 INFO mapReduceLayer.MapReduceLauncher: To kill 
this job, use: kill job_20091119023326575_0002
    [junit] 09/11/19 02:33:59 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_20091119023326575_0002_m_1153287594
    [junit] 09/11/19 02:33:59 INFO mapred.JvmManager: JVM Runner 
jvm_20091119023326575_0002_m_1153287594 spawned.
    [junit] 09/11/19 02:33:59 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:58915 
to delete  blk_-7392176902308286198_1013
    [junit] 09/11/19 02:33:59 INFO mapReduceLayer.MapReduceLauncher: 0% complete
    [junit] 09/11/19 02:33:59 INFO mapred.TaskTracker: JVM with ID: 
jvm_20091119023326575_0002_m_1153287594 given task: 
attempt_20091119023326575_0002_m_000003_0
    [junit] 09/11/19 02:34:00 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=mkdirs      
src=/tmp/temp-883675194/tmp-436547546/_temporary        dst=null        
perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/11/19 02:34:00 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000003_0 0.0% setup
    [junit] 09/11/19 02:34:00 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000003_0 is done.
    [junit] 09/11/19 02:34:00 INFO mapred.TaskTracker: reported output size for 
attempt_20091119023326575_0002_m_000003_0  was 0
    [junit] 09/11/19 02:34:00 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/11/19 02:34:00 INFO mapred.JvmManager: JVM : 
jvm_20091119023326575_0002_m_1153287594 exited. Number of tasks it ran: 1
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_20091119023326575_0002/attempt_20091119023326575_0002_m_000003_0/output/file.out
 in any of the configured local directories
    [junit] 09/11/19 02:34:01 INFO mapred.JobInProgress: Task 
'attempt_20091119023326575_0002_m_000003_0' has completed 
task_20091119023326575_0002_m_000003 successfully.
    [junit] 09/11/19 02:34:01 INFO mapred.JobTracker: Adding task 
'attempt_20091119023326575_0002_m_000000_0' to tip 
task_20091119023326575_0002_m_000000, for tracker 
'tracker_host2.foo.com:localhost/127.0.0.1:59414'
    [junit] 09/11/19 02:34:01 INFO mapred.JobInProgress: Choosing rack-local 
task task_20091119023326575_0002_m_000000
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_20091119023326575_0002_m_000000_0 task's 
state:UNASSIGNED
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: Trying to launch : 
attempt_20091119023326575_0002_m_000000_0
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_20091119023326575_0002_m_000000_0
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: Received KillTaskAction 
for task: attempt_20091119023326575_0002_m_000003_0
    [junit] 09/11/19 02:34:01 INFO mapred.TaskTracker: About to purge task: 
attempt_20091119023326575_0002_m_000003_0
    [junit] 09/11/19 02:34:01 INFO mapred.TaskRunner: 
attempt_20091119023326575_0002_m_000003_0 done; removing files.
    [junit] 09/11/19 02:34:01 INFO mapred.IndexCache: Map ID 
attempt_20091119023326575_0002_m_000003_0 not found in cache
    [junit] 09/11/19 02:34:01 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_20091119023326575_0002_m_1758403489
    [junit] 09/11/19 02:34:01 INFO mapred.JvmManager: JVM Runner 
jvm_20091119023326575_0002_m_1758403489 spawned.
    [junit] 09/11/19 02:34:02 INFO datanode.DataNode: Deleting block 
blk_-7392176902308286198_1013 file 
build/test/data/dfs/data/data5/current/blk_-7392176902308286198
    [junit] 09/11/19 02:34:02 INFO mapred.JobTracker: Adding task 
'attempt_20091119023326575_0002_m_000001_0' to tip 
task_20091119023326575_0002_m_000001, for tracker 
'tracker_host3.foo.com:localhost/127.0.0.1:33169'
    [junit] 09/11/19 02:34:02 INFO mapred.JobInProgress: Choosing rack-local 
task task_20091119023326575_0002_m_000001
    [junit] 09/11/19 02:34:02 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_20091119023326575_0002_m_000001_0 task's 
state:UNASSIGNED
    [junit] 09/11/19 02:34:02 INFO mapred.TaskTracker: Trying to launch : 
attempt_20091119023326575_0002_m_000001_0
    [junit] 09/11/19 02:34:02 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_20091119023326575_0002_m_000001_0
    [junit] 09/11/19 02:34:02 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.xml 
dst=null        perm=null
    [junit] 09/11/19 02:34:02 INFO DataNode.clienttrace: src: /127.0.0.1:51645, 
dest: /127.0.0.1:32988, bytes: 49019, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-6813384894621786135_1015
    [junit] 09/11/19 02:34:02 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002/job.jar 
dst=null        perm=null
    [junit] 09/11/19 02:34:02 INFO DataNode.clienttrace: src: /127.0.0.1:34458, 
dest: /127.0.0.1:33768, bytes: 2625792, op: HDFS_READ, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-7392176902308286198_1013
    [junit] 09/11/19 02:34:02 INFO mapred.TaskTracker: JVM with ID: 
jvm_20091119023326575_0002_m_1758403489 given task: 
attempt_20091119023326575_0002_m_000000_0
    [junit] 09/11/19 02:34:02 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_20091119023326575_0002_m_-1509526529
    [junit] 09/11/19 02:34:02 INFO mapred.JvmManager: JVM Runner 
jvm_20091119023326575_0002_m_-1509526529 spawned.
    [junit] 09/11/19 02:34:02 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        src=/user/hudson/input2.txt     dst=null        
perm=null
    [junit] 09/11/19 02:34:02 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0/part-00000
  dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:51645, 
dest: /127.0.0.1:32995, bytes: 10, op: HDFS_READ, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000000_0, srvID: 
DS-2142175154-127.0.1.1-51645-1258598005082, blockid: 
blk_-4036976361044975465_1012
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0/part-00000.
 blk_1783466514706258377_1018
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_1783466514706258377_1018 src: /127.0.0.1:33268 dest: /127.0.0.1:39535
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_1783466514706258377_1018 src: /127.0.0.1:36416 dest: /127.0.0.1:58915
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_1783466514706258377_1018 src: /127.0.0.1:32998 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:32998, 
dest: /127.0.0.1:51645, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000000_0, srvID: 
DS-2142175154-127.0.1.1-51645-1258598005082, blockid: 
blk_1783466514706258377_1018
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 0 for 
block blk_1783466514706258377_1018 terminating
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_1783466514706258377_1018 size 39
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:58915 is added to 
blk_1783466514706258377_1018 size 39
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:36416, 
dest: /127.0.0.1:58915, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000000_0, srvID: 
DS-1377221848-127.0.1.1-58915-1258598006052, blockid: 
blk_1783466514706258377_1018
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:33268, 
dest: /127.0.0.1:39535, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000000_0, srvID: 
DS-1984890133-127.0.1.1-39535-1258598006504, blockid: 
blk_1783466514706258377_1018
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:39535 is added to 
blk_1783466514706258377_1018 size 39
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 1 for 
block blk_1783466514706258377_1018 terminating
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 2 for 
block blk_1783466514706258377_1018 terminating
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0/part-00000
 is closed by DFSClient_attempt_20091119023326575_0002_m_000000_0
    [junit] 09/11/19 02:34:03 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000000_0 is in commit-pending, task 
state:COMMIT_PENDING
    [junit] 09/11/19 02:34:03 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000000_0 0.0% 
    [junit] 09/11/19 02:34:03 INFO mapred.TaskTracker: JVM with ID: 
jvm_20091119023326575_0002_m_-1509526529 given task: 
attempt_20091119023326575_0002_m_000001_0
    [junit] 09/11/19 02:34:03 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        src=/user/hudson/input1.txt     dst=null        
perm=null
    [junit] 09/11/19 02:34:03 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=create      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0/part-00001
  dst=null        perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:39535, 
dest: /127.0.0.1:33276, bytes: 10, op: HDFS_READ, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000001_0, srvID: 
DS-1984890133-127.0.1.1-39535-1258598006504, blockid: 
blk_3688278329124920242_1011
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0/part-00001.
 blk_3881053833396778110_1019
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_3881053833396778110_1019 src: /127.0.0.1:33005 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_3881053833396778110_1019 src: /127.0.0.1:36425 dest: /127.0.0.1:58915
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: Receiving block 
blk_3881053833396778110_1019 src: /127.0.0.1:33786 dest: /127.0.0.1:34458
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:33786, 
dest: /127.0.0.1:34458, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000001_0, srvID: 
DS-1649789720-127.0.1.1-34458-1258598005579, blockid: 
blk_3881053833396778110_1019
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 0 for 
block blk_3881053833396778110_1019 terminating
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:34458 is added to 
blk_3881053833396778110_1019 size 39
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:36425, 
dest: /127.0.0.1:58915, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000001_0, srvID: 
DS-1377221848-127.0.1.1-58915-1258598006052, blockid: 
blk_3881053833396778110_1019
    [junit] 09/11/19 02:34:03 INFO DataNode.clienttrace: src: /127.0.0.1:33005, 
dest: /127.0.0.1:51645, bytes: 39, op: HDFS_WRITE, cliID: 
DFSClient_attempt_20091119023326575_0002_m_000001_0, srvID: 
DS-2142175154-127.0.1.1-51645-1258598005082, blockid: 
blk_3881053833396778110_1019
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 1 for 
block blk_3881053833396778110_1019 terminating
    [junit] 09/11/19 02:34:03 INFO datanode.DataNode: PacketResponder 2 for 
block blk_3881053833396778110_1019 terminating
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:58915 is added to 
blk_3881053833396778110_1019 size 39
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_3881053833396778110_1019 size 39
    [junit] 09/11/19 02:34:03 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0/part-00001
 is closed by DFSClient_attempt_20091119023326575_0002_m_000001_0
    [junit] 09/11/19 02:34:03 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000001_0 is in commit-pending, task 
state:COMMIT_PENDING
    [junit] 09/11/19 02:34:03 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000001_0 0.0% 
    [junit] 09/11/19 02:34:04 INFO mapred.TaskTracker: Received commit task 
action for attempt_20091119023326575_0002_m_000000_0
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=listStatus  
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0
     dst=null        perm=null
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=mkdirs      src=/tmp/temp-883675194/tmp-436547546   
dst=null        perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=rename      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0/part-00000
  dst=/tmp/temp-883675194/tmp-436547546/part-00000        
perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000000_0
     dst=null        perm=null
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000000_0 1.0% 
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000000_0 is done.
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: reported output size for 
attempt_20091119023326575_0002_m_000000_0  was 0
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: Received commit task 
action for attempt_20091119023326575_0002_m_000001_0
    [junit] 09/11/19 02:34:05 INFO mapred.JvmManager: JVM : 
jvm_20091119023326575_0002_m_1758403489 exited. Number of tasks it ran: 1
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=listStatus  
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0
     dst=null        perm=null
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=mkdirs      src=/tmp/temp-883675194/tmp-436547546   
dst=null        perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=rename      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0/part-00001
  dst=/tmp/temp-883675194/tmp-436547546/part-00001        
perm=hudson:supergroup:rw-r--r--
    [junit] 09/11/19 02:34:05 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/tmp/temp-883675194/tmp-436547546/_temporary/_attempt_20091119023326575_0002_m_000001_0
     dst=null        perm=null
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000001_0 1.0% 
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000001_0 is done.
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: reported output size for 
attempt_20091119023326575_0002_m_000001_0  was 0
    [junit] 09/11/19 02:34:05 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/11/19 02:34:05 INFO mapred.JvmManager: JVM : 
jvm_20091119023326575_0002_m_-1509526529 exited. Number of tasks it ran: 1
    [junit] 09/11/19 02:34:07 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_20091119023326575_0002/attempt_20091119023326575_0002_m_000000_0/output/file.out
 in any of the configured local directories
    [junit] 09/11/19 02:34:07 INFO mapred.JobInProgress: Task 
'attempt_20091119023326575_0002_m_000000_0' has completed 
task_20091119023326575_0002_m_000000 successfully.
    [junit] 09/11/19 02:34:08 INFO mapReduceLayer.MapReduceLauncher: 25% 
complete
    [junit] 09/11/19 02:34:08 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_20091119023326575_0002/attempt_20091119023326575_0002_m_000001_0/output/file.out
 in any of the configured local directories
    [junit] 09/11/19 02:34:08 INFO mapred.JobInProgress: Task 
'attempt_20091119023326575_0002_m_000001_0' has completed 
task_20091119023326575_0002_m_000001 successfully.
    [junit] 09/11/19 02:34:08 INFO mapred.JobTracker: Adding task 
'attempt_20091119023326575_0002_m_000002_0' to tip 
task_20091119023326575_0002_m_000002, for tracker 
'tracker_host3.foo.com:localhost/127.0.0.1:33169'
    [junit] 09/11/19 02:34:08 INFO mapred.TaskTracker: LaunchTaskAction 
(registerTask): attempt_20091119023326575_0002_m_000002_0 task's 
state:UNASSIGNED
    [junit] 09/11/19 02:34:08 INFO mapred.TaskTracker: Trying to launch : 
attempt_20091119023326575_0002_m_000002_0
    [junit] 09/11/19 02:34:08 INFO mapred.TaskTracker: In TaskLauncher, current 
free slots : 2 and trying to launch attempt_20091119023326575_0002_m_000002_0
    [junit] 09/11/19 02:34:08 INFO mapred.JvmManager: In JvmRunner constructed 
JVM ID: jvm_20091119023326575_0002_m_-938885149
    [junit] 09/11/19 02:34:08 INFO mapred.JvmManager: JVM Runner 
jvm_20091119023326575_0002_m_-938885149 spawned.
    [junit] 09/11/19 02:34:08 INFO mapReduceLayer.MapReduceLauncher: 50% 
complete
    [junit] 09/11/19 02:34:08 INFO mapred.TaskTracker: JVM with ID: 
jvm_20091119023326575_0002_m_-938885149 given task: 
attempt_20091119023326575_0002_m_000002_0
    [junit] 09/11/19 02:34:09 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000002_0 0.0% 
    [junit] 09/11/19 02:34:09 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/tmp/temp-883675194/tmp-436547546/_temporary        dst=null        
perm=null
    [junit] 09/11/19 02:34:09 INFO mapred.TaskTracker: 
attempt_20091119023326575_0002_m_000002_0 0.0% cleanup
    [junit] 09/11/19 02:34:09 INFO mapred.TaskTracker: Task 
attempt_20091119023326575_0002_m_000002_0 is done.
    [junit] 09/11/19 02:34:09 INFO mapred.TaskTracker: reported output size for 
attempt_20091119023326575_0002_m_000002_0  was 0
    [junit] 09/11/19 02:34:09 INFO mapred.TaskTracker: addFreeSlot : current 
free slots : 2
    [junit] 09/11/19 02:34:09 INFO mapred.JvmManager: JVM : 
jvm_20091119023326575_0002_m_-938885149 exited. Number of tasks it ran: 1
    [junit] 09/11/19 02:34:11 INFO mapred.TaskTracker: 
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find 
taskTracker/jobcache/job_20091119023326575_0002/attempt_20091119023326575_0002_m_000002_0/output/file.out
 in any of the configured local directories
    [junit] 09/11/19 02:34:11 INFO mapred.JobInProgress: Task 
'attempt_20091119023326575_0002_m_000002_0' has completed 
task_20091119023326575_0002_m_000002 successfully.
    [junit] 09/11/19 02:34:11 INFO mapred.JobInProgress: Job 
job_20091119023326575_0002 has completed successfully.
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.allocateBlock: 
/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_hudson_Job7967489867006079740.jar.
 blk_-4300934375526664791_1019
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: Receiving block 
blk_-4300934375526664791_1019 src: /127.0.0.1:33013 dest: /127.0.0.1:51645
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: Receiving block 
blk_-4300934375526664791_1019 src: /127.0.0.1:33793 dest: /127.0.0.1:34458
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: Receiving block 
blk_-4300934375526664791_1019 src: /127.0.0.1:36434 dest: /127.0.0.1:58915
    [junit] 09/11/19 02:34:11 INFO DataNode.clienttrace: src: /127.0.0.1:36434, 
dest: /127.0.0.1:58915, bytes: 6117, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1377221848-127.0.1.1-58915-1258598006052, 
blockid: blk_-4300934375526664791_1019
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: PacketResponder 0 for 
block blk_-4300934375526664791_1019 terminating
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:58915 is added to 
blk_-4300934375526664791_1019 size 6117
    [junit] 09/11/19 02:34:11 INFO DataNode.clienttrace: src: /127.0.0.1:33793, 
dest: /127.0.0.1:34458, bytes: 6117, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-1649789720-127.0.1.1-34458-1258598005579, 
blockid: blk_-4300934375526664791_1019
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:34458 is added to 
blk_-4300934375526664791_1019 size 6117
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: PacketResponder 1 for 
block blk_-4300934375526664791_1019 terminating
    [junit] 09/11/19 02:34:11 INFO DataNode.clienttrace: src: /127.0.0.1:33013, 
dest: /127.0.0.1:51645, bytes: 6117, op: HDFS_WRITE, cliID: 
DFSClient_395457836, srvID: DS-2142175154-127.0.1.1-51645-1258598005082, 
blockid: blk_-4300934375526664791_1019
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:51645 is added to 
blk_-4300934375526664791_1019 size 6117
    [junit] 09/11/19 02:34:11 INFO datanode.DataNode: PacketResponder 2 for 
block blk_-4300934375526664791_1019 terminating
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: DIR* 
NameSystem.completeFile: file 
/tmp/temp-883675194/tmp-436547546/_logs/history/localhost_1258598006604_job_20091119023326575_0002_hudson_Job7967489867006079740.jar
 is closed by DFSClient_395457836
    [junit] 09/11/19 02:34:11 INFO mapred.JobTracker: Removed completed task 
'attempt_20091119023326575_0002_m_000001_0' from 
'tracker_host3.foo.com:localhost/127.0.0.1:33169'
    [junit] 09/11/19 02:34:11 INFO mapred.JobTracker: Removed completed task 
'attempt_20091119023326575_0002_m_000002_0' from 
'tracker_host3.foo.com:localhost/127.0.0.1:33169'
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-7392176902308286198 is added to invalidSet of 
127.0.0.1:58915
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-7392176902308286198 is added to invalidSet of 
127.0.0.1:34458
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-7392176902308286198 is added to invalidSet of 
127.0.0.1:51645
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-3388285408264901103 is added to invalidSet of 
127.0.0.1:51645
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-3388285408264901103 is added to invalidSet of 
127.0.0.1:39535
    [junit] 09/11/19 02:34:11 INFO mapred.TaskTracker: Received 'KillJobAction' 
for job: job_20091119023326575_0002
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-3388285408264901103 is added to invalidSet of 
127.0.0.1:34458
    [junit] 09/11/19 02:34:11 INFO mapred.TaskRunner: 
attempt_20091119023326575_0002_m_000001_0 done; removing files.
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-6813384894621786135 is added to invalidSet of 
127.0.0.1:39535
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-6813384894621786135 is added to invalidSet of 
127.0.0.1:34458
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* 
NameSystem.addToInvalidates: blk_-6813384894621786135 is added to invalidSet of 
127.0.0.1:51645
    [junit] 09/11/19 02:34:11 INFO mapred.IndexCache: Map ID 
attempt_20091119023326575_0002_m_000001_0 not found in cache
    [junit] 09/11/19 02:34:11 INFO mapred.TaskRunner: 
attempt_20091119023326575_0002_m_000002_0 done; removing files.
    [junit] 09/11/19 02:34:11 INFO mapred.IndexCache: Map ID 
attempt_20091119023326575_0002_m_000002_0 not found in cache
    [junit] 09/11/19 02:34:11 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=delete      
src=/tmp/hadoop-hudson/mapred/system/job_20091119023326575_0002 dst=null        
perm=null
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:58915 
to delete  blk_-7392176902308286198_1013
    [junit] 09/11/19 02:34:11 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:34458 
to delete  blk_-6813384894621786135_1015 blk_-7392176902308286198_1013 
blk_-3388285408264901103_1014
    [junit] 09/11/19 02:34:13 INFO mapred.TaskTracker: Received 'KillJobAction' 
for job: job_20091119023326575_0002
    [junit] 09/11/19 02:34:13 WARN mapred.TaskTracker: Unknown job 
job_20091119023326575_0002 being deleted.
    [junit] 09/11/19 02:34:13 INFO mapred.TaskTracker: Received 'KillJobAction' 
for job: job_20091119023326575_0002
    [junit] 09/11/19 02:34:13 WARN mapred.TaskTracker: Unknown job 
job_20091119023326575_0002 being deleted.
    [junit] 09/11/19 02:34:13 INFO datanode.DataNode: Deleting block 
blk_-7392176902308286198_1013 file 
build/test/data/dfs/data/data4/current/blk_-7392176902308286198
    [junit] 09/11/19 02:34:13 INFO datanode.DataNode: Deleting block 
blk_-6813384894621786135_1015 file 
build/test/data/dfs/data/data4/current/blk_-6813384894621786135
    [junit] 09/11/19 02:34:13 INFO datanode.DataNode: Deleting block 
blk_-3388285408264901103_1014 file 
build/test/data/dfs/data/data3/current/blk_-3388285408264901103
    [junit] 09/11/19 02:34:13 INFO mapReduceLayer.MapReduceLauncher: 100% 
complete
    [junit] 09/11/19 02:34:13 INFO mapReduceLayer.MapReduceLauncher: 
Successfully stored result in: 
"hdfs://localhost:46092/tmp/temp-883675194/tmp-436547546"
    [junit] 09/11/19 02:34:13 INFO mapReduceLayer.MapReduceLauncher: Records 
written : 2
    [junit] 09/11/19 02:34:13 INFO mapReduceLayer.MapReduceLauncher: Bytes 
written : 78
    [junit] 09/11/19 02:34:13 INFO mapReduceLayer.MapReduceLauncher: Success!
    [junit] 09/11/19 02:34:13 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=listStatus  src=/tmp/temp-883675194/tmp-436547546   
dst=null        perm=null
    [junit] 09/11/19 02:34:13 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/temp-883675194/tmp-436547546/part-00000        dst=null        
perm=null
    [junit] 09/11/19 02:34:13 INFO DataNode.clienttrace: src: /127.0.0.1:39535, 
dest: /127.0.0.1:33288, bytes: 43, op: HDFS_READ, cliID: DFSClient_395457836, 
srvID: DS-1984890133-127.0.1.1-39535-1258598006504, blockid: 
blk_1783466514706258377_1018
    [junit] 09/11/19 02:34:13 INFO FSNamesystem.audit: ugi=hudson,hudson        
ip=/127.0.0.1   cmd=open        
src=/tmp/temp-883675194/tmp-436547546/part-00001        dst=null        
perm=null
    [junit] 09/11/19 02:34:13 INFO DataNode.clienttrace: src: /127.0.0.1:51645, 
dest: /127.0.0.1:33017, bytes: 43, op: HDFS_READ, cliID: DFSClient_395457836, 
srvID: DS-2142175154-127.0.1.1-51645-1258598005082, blockid: 
blk_3881053833396778110_1019
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 44.415 sec

BUILD FAILED
<http://hudson.zones.apache.org/hudson/job/Pig-trunk/ws/trunk/build.xml>:553: 
The following error occurred while executing this line:
<http://hudson.zones.apache.org/hudson/job/Pig-trunk/ws/trunk/build.xml>:486: 
The following error occurred while executing this line:
<http://hudson.zones.apache.org/hudson/job/Pig-trunk/ws/trunk/build.xml>:548: 
Tests failed!

Total time: 220 minutes 3 seconds
Publishing Javadoc
Archiving artifacts
Recording test results
Recording fingerprints
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure

Reply via email to