pig-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Hudson Server <hud...@hudson.zones.apache.org>
Subject Build failed in Hudson: Pig-trunk #669
Date Fri, 22 Jan 2010 14:22:59 GMT
See <http://hudson.zones.apache.org/hudson/job/Pig-trunk/669/changes>

Changes:

[daijy] PIG-1184: PruneColumns optimization does not handle the case of foreach flatten correctly
if flattened bag is not used later

[olga] PIG-1192: Pig 0.6 Docs fixes (chandec via olgan)

------------------------------------------
[...truncated 238840 lines...]
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:35986, dest: /127.0.0.1:38103,
bytes: 1589, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_-4519883474485258605_1014
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 2 for block blk_-4519883474485258605_1014
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38103 is added to blk_-4519883474485258605_1014 size 1589
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.split
is closed by DFSClient_-1427623467
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml	dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml	dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml.
blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_-8373979260215840694_1015
src: /127.0.0.1:35989 dest: /127.0.0.1:38103
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_-8373979260215840694_1015
src: /127.0.0.1:41259 dest: /127.0.0.1:38080
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_-8373979260215840694_1015
src: /127.0.0.1:47941 dest: /127.0.0.1:36031
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:47941, dest: /127.0.0.1:36031,
bytes: 48822, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 0 for block blk_-8373979260215840694_1015
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36031 is added to blk_-8373979260215840694_1015 size 48822
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:41259, dest: /127.0.0.1:38080,
bytes: 48822, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1992836685-127.0.1.1-38080-1264170001426,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 1 for block blk_-8373979260215840694_1015
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38080 is added to blk_-8373979260215840694_1015 size 48822
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:35989, dest: /127.0.0.1:38103,
bytes: 48822, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38103 is added to blk_-8373979260215840694_1015 size 48822
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 2 for block blk_-8373979260215840694_1015
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml
is closed by DFSClient_-1427623467
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml	dst=null	perm=null
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:38103, dest: /127.0.0.1:35992,
bytes: 49206, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.jar	dst=null	perm=null
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:38103, dest: /127.0.0.1:35993,
bytes: 2742642, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:34 INFO mapred.JobTracker: Initializing job_20100122142002425_0002
    [junit] 10/01/22 14:20:34 INFO mapred.JobInProgress: Initializing job_20100122142002425_0002
    [junit] 10/01/22 14:20:34 INFO datanode.DataBlockScanner: Verification succeeded for blk_-3685041014394738560_1011
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_hudson_Job8574906685669331476.jar
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_conf.xml
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_conf.xml.
blk_8298733218035429289_1017
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_8298733218035429289_1017
src: /127.0.0.1:34046 dest: /127.0.0.1:45314
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Deleting block blk_6760959224182101687_1007
file build/test/data/dfs/data/data3/current/blk_6760959224182101687
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Deleting block blk_8009935584258537881_1006
file build/test/data/dfs/data/data4/current/blk_8009935584258537881
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_8298733218035429289_1017
src: /127.0.0.1:47945 dest: /127.0.0.1:36031
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Receiving block blk_8298733218035429289_1017
src: /127.0.0.1:35996 dest: /127.0.0.1:38103
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:35996, dest: /127.0.0.1:38103,
bytes: 48852, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_8298733218035429289_1017
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 0 for block blk_8298733218035429289_1017
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38103 is added to blk_8298733218035429289_1017 size 48852
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:47945, dest: /127.0.0.1:36031,
bytes: 48852, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_8298733218035429289_1017
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 1 for block blk_8298733218035429289_1017
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36031 is added to blk_8298733218035429289_1017 size 48852
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:45314 is added to blk_8298733218035429289_1017 size 48852
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:34046, dest: /127.0.0.1:45314,
bytes: 48852, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1167207178-127.0.1.1-45314-1264170002336,
blockid: blk_8298733218035429289_1017
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: PacketResponder 2 for block blk_8298733218035429289_1017
terminating
    [junit] 10/01/22 14:20:34 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_conf.xml
is closed by DFSClient_-1427623467
    [junit] 10/01/22 14:20:34 INFO mapReduceLayer.MapReduceLauncher: Submitting job: job_20100122142002425_0002
to execution engine.
    [junit] 10/01/22 14:20:34 INFO mapReduceLayer.MapReduceLauncher: More information at:
http://localhost:59794/jobdetails.jsp?jobid=job_20100122142002425_0002
    [junit] 10/01/22 14:20:34 INFO mapReduceLayer.MapReduceLauncher: To kill this job, use:
kill job_20100122142002425_0002
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.split	dst=null	perm=null
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:36031, dest: /127.0.0.1:47947,
bytes: 1605, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_-4519883474485258605_1014
    [junit] 10/01/22 14:20:34 INFO mapred.JobInProgress: Input size for job job_20100122142002425_0002
= 12. Number of splits = 2
    [junit] 10/01/22 14:20:34 INFO mapred.JobInProgress: tip:task_20100122142002425_0002_m_000000
has split on node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 10/01/22 14:20:34 INFO mapred.JobInProgress: tip:task_20100122142002425_0002_m_000001
has split on node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 10/01/22 14:20:34 INFO mapred.JobTracker: Adding task 'attempt_20100122142002425_0002_m_000003_0'
to tip task_20100122142002425_0002_m_000003, for tracker 'tracker_host2.foo.com:localhost/127.0.0.1:35598'
    [junit] 10/01/22 14:20:34 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20100122142002425_0002_m_000003_0
task's state:UNASSIGNED
    [junit] 10/01/22 14:20:34 INFO mapred.TaskTracker: Trying to launch : attempt_20100122142002425_0002_m_000003_0
    [junit] 10/01/22 14:20:34 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20100122142002425_0002_m_000003_0
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml	dst=null	perm=null
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:38080, dest: /127.0.0.1:41267,
bytes: 49206, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-1992836685-127.0.1.1-38080-1264170001426,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:34 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.jar	dst=null	perm=null
    [junit] 10/01/22 14:20:34 INFO DataNode.clienttrace: src: /127.0.0.1:36031, dest: /127.0.0.1:47949,
bytes: 2742642, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Deleting block blk_-1868591793377613991_1005
file build/test/data/dfs/data/data6/current/blk_-1868591793377613991
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Deleting block blk_6760959224182101687_1007
file build/test/data/dfs/data/data6/current/blk_6760959224182101687
    [junit] 10/01/22 14:20:34 INFO datanode.DataNode: Deleting block blk_8009935584258537881_1006
file build/test/data/dfs/data/data5/current/blk_8009935584258537881
    [junit] 10/01/22 14:20:35 INFO mapReduceLayer.MapReduceLauncher: 0% complete
    [junit] 10/01/22 14:20:35 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20100122142002425_0002_m_1134719225
    [junit] 10/01/22 14:20:35 INFO mapred.JvmManager: JVM Runner jvm_20100122142002425_0002_m_1134719225
spawned.
    [junit] 10/01/22 14:20:35 INFO mapred.TaskTracker: JVM with ID: jvm_20100122142002425_0002_m_1134719225
given task: attempt_20100122142002425_0002_m_000003_0
    [junit] 10/01/22 14:20:36 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-406619199/tmp-961107684/_temporary	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 10/01/22 14:20:36 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000003_0
0.0% setup
    [junit] 10/01/22 14:20:36 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000003_0
is done.
    [junit] 10/01/22 14:20:36 INFO mapred.TaskTracker: reported output size for attempt_20100122142002425_0002_m_000003_0
 was 0
    [junit] 10/01/22 14:20:36 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 10/01/22 14:20:36 INFO mapred.JvmManager: JVM : jvm_20100122142002425_0002_m_1134719225
exited. Number of tasks it ran: 1
    [junit] 10/01/22 14:20:37 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:45314 to delete
 blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20100122142002425_0002/attempt_20100122142002425_0002_m_000003_0/output/file.out
in any of the configured local directories
    [junit] 10/01/22 14:20:37 INFO mapred.JobInProgress: Task 'attempt_20100122142002425_0002_m_000003_0'
has completed task_20100122142002425_0002_m_000003 successfully.
    [junit] 10/01/22 14:20:37 INFO mapred.JobTracker: Adding task 'attempt_20100122142002425_0002_m_000000_0'
to tip task_20100122142002425_0002_m_000000, for tracker 'tracker_host2.foo.com:localhost/127.0.0.1:35598'
    [junit] 10/01/22 14:20:37 INFO mapred.JobInProgress: Choosing rack-local task task_20100122142002425_0002_m_000000
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20100122142002425_0002_m_000000_0
task's state:UNASSIGNED
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: Trying to launch : attempt_20100122142002425_0002_m_000000_0
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: Received KillTaskAction for task: attempt_20100122142002425_0002_m_000003_0
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: About to purge task: attempt_20100122142002425_0002_m_000003_0
    [junit] 10/01/22 14:20:37 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20100122142002425_0002_m_000000_0
    [junit] 10/01/22 14:20:37 INFO mapred.TaskRunner: attempt_20100122142002425_0002_m_000003_0
done; removing files.
    [junit] 10/01/22 14:20:37 INFO mapred.IndexCache: Map ID attempt_20100122142002425_0002_m_000003_0
not found in cache
    [junit] 10/01/22 14:20:37 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20100122142002425_0002_m_643524202
    [junit] 10/01/22 14:20:37 INFO mapred.JvmManager: JVM Runner jvm_20100122142002425_0002_m_643524202
spawned.
    [junit] 10/01/22 14:20:38 INFO mapred.JobTracker: Adding task 'attempt_20100122142002425_0002_m_000001_0'
to tip task_20100122142002425_0002_m_000001, for tracker 'tracker_host3.foo.com:localhost/127.0.0.1:32987'
    [junit] 10/01/22 14:20:38 INFO mapred.JobInProgress: Choosing rack-local task task_20100122142002425_0002_m_000001
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20100122142002425_0002_m_000001_0
task's state:UNASSIGNED
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: Trying to launch : attempt_20100122142002425_0002_m_000001_0
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20100122142002425_0002_m_000001_0
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: JVM with ID: jvm_20100122142002425_0002_m_643524202
given task: attempt_20100122142002425_0002_m_000000_0
    [junit] 10/01/22 14:20:38 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.xml	dst=null	perm=null
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:36031, dest: /127.0.0.1:47958,
bytes: 49206, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_-8373979260215840694_1015
    [junit] 10/01/22 14:20:38 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002/job.jar	dst=null	perm=null
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:36031, dest: /127.0.0.1:47959,
bytes: 2742642, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: Deleting block blk_3903073668373300337_1013
file build/test/data/dfs/data/data8/current/blk_3903073668373300337
    [junit] 10/01/22 14:20:38 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20100122142002425_0002_m_1901236542
    [junit] 10/01/22 14:20:38 INFO mapred.JvmManager: JVM Runner jvm_20100122142002425_0002_m_1901236542
spawned.
    [junit] 10/01/22 14:20:38 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/user/hudson/input2.txt	dst=null	perm=null
    [junit] 10/01/22 14:20:38 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0/part-00000
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:45314, dest: /127.0.0.1:34064,
bytes: 10, op: HDFS_READ, cliID: DFSClient_attempt_20100122142002425_0002_m_000000_0, srvID:
DS-1167207178-127.0.1.1-45314-1264170002336, blockid: blk_-4502338686410540282_1012
    [junit] 10/01/22 14:20:38 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0/part-00000.
blk_7213492376637073855_1018
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: Receiving block blk_7213492376637073855_1018
src: /127.0.0.1:41282 dest: /127.0.0.1:38080
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: Receiving block blk_7213492376637073855_1018
src: /127.0.0.1:34066 dest: /127.0.0.1:45314
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: Receiving block blk_7213492376637073855_1018
src: /127.0.0.1:36015 dest: /127.0.0.1:38103
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:36015, dest: /127.0.0.1:38103,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000000_0, srvID:
DS-1463347349-127.0.1.1-38103-1264170000919, blockid: blk_7213492376637073855_1018
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: PacketResponder 0 for block blk_7213492376637073855_1018
terminating
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:34066, dest: /127.0.0.1:45314,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000000_0, srvID:
DS-1167207178-127.0.1.1-45314-1264170002336, blockid: blk_7213492376637073855_1018
    [junit] 10/01/22 14:20:38 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38103 is added to blk_7213492376637073855_1018 size 39
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: PacketResponder 1 for block blk_7213492376637073855_1018
terminating
    [junit] 10/01/22 14:20:38 INFO DataNode.clienttrace: src: /127.0.0.1:41282, dest: /127.0.0.1:38080,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000000_0, srvID:
DS-1992836685-127.0.1.1-38080-1264170001426, blockid: blk_7213492376637073855_1018
    [junit] 10/01/22 14:20:38 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:45314 is added to blk_7213492376637073855_1018 size 39
    [junit] 10/01/22 14:20:38 INFO datanode.DataNode: PacketResponder 2 for block blk_7213492376637073855_1018
terminating
    [junit] 10/01/22 14:20:38 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38080 is added to blk_7213492376637073855_1018 size 39
    [junit] 10/01/22 14:20:38 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0/part-00000
is closed by DFSClient_attempt_20100122142002425_0002_m_000000_0
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000000_0
is in commit-pending, task state:COMMIT_PENDING
    [junit] 10/01/22 14:20:38 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000000_0
0.0% 
    [junit] 10/01/22 14:20:39 INFO mapred.TaskTracker: JVM with ID: jvm_20100122142002425_0002_m_1901236542
given task: attempt_20100122142002425_0002_m_000001_0
    [junit] 10/01/22 14:20:39 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/user/hudson/input1.txt	dst=null	perm=null
    [junit] 10/01/22 14:20:39 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0/part-00001
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:39 INFO DataNode.clienttrace: src: /127.0.0.1:38103, dest: /127.0.0.1:36021,
bytes: 10, op: HDFS_READ, cliID: DFSClient_attempt_20100122142002425_0002_m_000001_0, srvID:
DS-1463347349-127.0.1.1-38103-1264170000919, blockid: blk_-3685041014394738560_1011
    [junit] 10/01/22 14:20:39 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0/part-00001.
blk_2219336130341092980_1019
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: Receiving block blk_2219336130341092980_1019
src: /127.0.0.1:47972 dest: /127.0.0.1:36031
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: Receiving block blk_2219336130341092980_1019
src: /127.0.0.1:34075 dest: /127.0.0.1:45314
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: Receiving block blk_2219336130341092980_1019
src: /127.0.0.1:36024 dest: /127.0.0.1:38103
    [junit] 10/01/22 14:20:39 INFO DataNode.clienttrace: src: /127.0.0.1:36024, dest: /127.0.0.1:38103,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000001_0, srvID:
DS-1463347349-127.0.1.1-38103-1264170000919, blockid: blk_2219336130341092980_1019
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: PacketResponder 0 for block blk_2219336130341092980_1019
terminating
    [junit] 10/01/22 14:20:39 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38103 is added to blk_2219336130341092980_1019 size 39
    [junit] 10/01/22 14:20:39 INFO DataNode.clienttrace: src: /127.0.0.1:34075, dest: /127.0.0.1:45314,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000001_0, srvID:
DS-1167207178-127.0.1.1-45314-1264170002336, blockid: blk_2219336130341092980_1019
    [junit] 10/01/22 14:20:39 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:45314 is added to blk_2219336130341092980_1019 size 39
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: PacketResponder 1 for block blk_2219336130341092980_1019
terminating
    [junit] 10/01/22 14:20:39 INFO DataNode.clienttrace: src: /127.0.0.1:47972, dest: /127.0.0.1:36031,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20100122142002425_0002_m_000001_0, srvID:
DS-575681396-127.0.1.1-36031-1264170001864, blockid: blk_2219336130341092980_1019
    [junit] 10/01/22 14:20:39 INFO datanode.DataNode: PacketResponder 2 for block blk_2219336130341092980_1019
terminating
    [junit] 10/01/22 14:20:39 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36031 is added to blk_2219336130341092980_1019 size 39
    [junit] 10/01/22 14:20:39 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0/part-00001
is closed by DFSClient_attempt_20100122142002425_0002_m_000001_0
    [junit] 10/01/22 14:20:39 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000001_0
is in commit-pending, task state:COMMIT_PENDING
    [junit] 10/01/22 14:20:39 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000001_0
0.0% 
    [junit] 10/01/22 14:20:40 INFO mapred.TaskTracker: Received commit task action for attempt_20100122142002425_0002_m_000000_0
    [junit] 10/01/22 14:20:40 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0
dst=null	perm=null
    [junit] 10/01/22 14:20:40 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-406619199/tmp-961107684	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 10/01/22 14:20:40 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=rename
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0/part-00000
dst=/tmp/temp-406619199/tmp-961107684/part-00000	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:40 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000000_0
dst=null	perm=null
    [junit] 10/01/22 14:20:40 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000000_0
1.0% 
    [junit] 10/01/22 14:20:40 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000000_0
is done.
    [junit] 10/01/22 14:20:40 INFO mapred.TaskTracker: reported output size for attempt_20100122142002425_0002_m_000000_0
 was 0
    [junit] 10/01/22 14:20:40 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 10/01/22 14:20:41 INFO mapred.JvmManager: JVM : jvm_20100122142002425_0002_m_643524202
exited. Number of tasks it ran: 1
    [junit] 10/01/22 14:20:41 INFO mapred.TaskTracker: Received commit task action for attempt_20100122142002425_0002_m_000001_0
    [junit] 10/01/22 14:20:41 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0
dst=null	perm=null
    [junit] 10/01/22 14:20:41 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-406619199/tmp-961107684	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 10/01/22 14:20:41 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=rename
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0/part-00001
dst=/tmp/temp-406619199/tmp-961107684/part-00001	perm=hudson:supergroup:rw-r--r--
    [junit] 10/01/22 14:20:41 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-406619199/tmp-961107684/_temporary/_attempt_20100122142002425_0002_m_000001_0
dst=null	perm=null
    [junit] 10/01/22 14:20:41 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000001_0
1.0% 
    [junit] 10/01/22 14:20:41 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000001_0
is done.
    [junit] 10/01/22 14:20:41 INFO mapred.TaskTracker: reported output size for attempt_20100122142002425_0002_m_000001_0
 was 0
    [junit] 10/01/22 14:20:41 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 10/01/22 14:20:41 INFO mapred.JvmManager: JVM : jvm_20100122142002425_0002_m_1901236542
exited. Number of tasks it ran: 1
    [junit] 10/01/22 14:20:43 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20100122142002425_0002/attempt_20100122142002425_0002_m_000000_0/output/file.out
in any of the configured local directories
    [junit] 10/01/22 14:20:43 INFO mapred.JobInProgress: Task 'attempt_20100122142002425_0002_m_000000_0'
has completed task_20100122142002425_0002_m_000000 successfully.
    [junit] 10/01/22 14:20:44 INFO mapReduceLayer.MapReduceLauncher: 25% complete
    [junit] 10/01/22 14:20:44 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20100122142002425_0002/attempt_20100122142002425_0002_m_000001_0/output/file.out
in any of the configured local directories
    [junit] 10/01/22 14:20:44 INFO mapred.JobInProgress: Task 'attempt_20100122142002425_0002_m_000001_0'
has completed task_20100122142002425_0002_m_000001 successfully.
    [junit] 10/01/22 14:20:44 INFO mapred.JobTracker: Adding task 'attempt_20100122142002425_0002_m_000002_0'
to tip task_20100122142002425_0002_m_000002, for tracker 'tracker_host3.foo.com:localhost/127.0.0.1:32987'
    [junit] 10/01/22 14:20:44 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20100122142002425_0002_m_000002_0
task's state:UNASSIGNED
    [junit] 10/01/22 14:20:44 INFO mapred.TaskTracker: Trying to launch : attempt_20100122142002425_0002_m_000002_0
    [junit] 10/01/22 14:20:44 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20100122142002425_0002_m_000002_0
    [junit] 10/01/22 14:20:44 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20100122142002425_0002_m_1681253248
    [junit] 10/01/22 14:20:44 INFO mapred.JvmManager: JVM Runner jvm_20100122142002425_0002_m_1681253248
spawned.
    [junit] 10/01/22 14:20:44 INFO mapReduceLayer.MapReduceLauncher: 50% complete
    [junit] 10/01/22 14:20:44 INFO mapred.TaskTracker: JVM with ID: jvm_20100122142002425_0002_m_1681253248
given task: attempt_20100122142002425_0002_m_000002_0
    [junit] 10/01/22 14:20:45 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000002_0
0.0% 
    [junit] 10/01/22 14:20:45 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-406619199/tmp-961107684/_temporary	dst=null	perm=null
    [junit] 10/01/22 14:20:45 INFO mapred.TaskTracker: attempt_20100122142002425_0002_m_000002_0
0.0% cleanup
    [junit] 10/01/22 14:20:45 INFO mapred.TaskTracker: Task attempt_20100122142002425_0002_m_000002_0
is done.
    [junit] 10/01/22 14:20:45 INFO mapred.TaskTracker: reported output size for attempt_20100122142002425_0002_m_000002_0
 was 0
    [junit] 10/01/22 14:20:45 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 10/01/22 14:20:45 INFO mapred.JvmManager: JVM : jvm_20100122142002425_0002_m_1681253248
exited. Number of tasks it ran: 1
    [junit] 10/01/22 14:20:47 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20100122142002425_0002/attempt_20100122142002425_0002_m_000002_0/output/file.out
in any of the configured local directories
    [junit] 10/01/22 14:20:47 INFO mapred.JobInProgress: Task 'attempt_20100122142002425_0002_m_000002_0'
has completed task_20100122142002425_0002_m_000002 successfully.
    [junit] 10/01/22 14:20:47 INFO mapred.JobInProgress: Job job_20100122142002425_0002 has
completed successfully.
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_hudson_Job8574906685669331476.jar.
blk_-5803266619274250679_1019
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: Receiving block blk_-5803266619274250679_1019
src: /127.0.0.1:43924 dest: /127.0.0.1:38080
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: Receiving block blk_-5803266619274250679_1019
src: /127.0.0.1:35599 dest: /127.0.0.1:36031
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: Receiving block blk_-5803266619274250679_1019
src: /127.0.0.1:48555 dest: /127.0.0.1:45314
    [junit] 10/01/22 14:20:47 INFO DataNode.clienttrace: src: /127.0.0.1:48555, dest: /127.0.0.1:45314,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1167207178-127.0.1.1-45314-1264170002336,
blockid: blk_-5803266619274250679_1019
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:45314 is added to blk_-5803266619274250679_1019 size 6117
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: PacketResponder 0 for block blk_-5803266619274250679_1019
terminating
    [junit] 10/01/22 14:20:47 INFO DataNode.clienttrace: src: /127.0.0.1:35599, dest: /127.0.0.1:36031,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-575681396-127.0.1.1-36031-1264170001864,
blockid: blk_-5803266619274250679_1019
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36031 is added to blk_-5803266619274250679_1019 size 6117
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: PacketResponder 1 for block blk_-5803266619274250679_1019
terminating
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:38080 is added to blk_-5803266619274250679_1019 size 6117
    [junit] 10/01/22 14:20:47 INFO DataNode.clienttrace: src: /127.0.0.1:43924, dest: /127.0.0.1:38080,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-1427623467, srvID: DS-1992836685-127.0.1.1-38080-1264170001426,
blockid: blk_-5803266619274250679_1019
    [junit] 10/01/22 14:20:47 INFO datanode.DataNode: PacketResponder 2 for block blk_-5803266619274250679_1019
terminating
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-406619199/tmp-961107684/_logs/history/localhost_1264170002449_job_20100122142002425_0002_hudson_Job8574906685669331476.jar
is closed by DFSClient_-1427623467
    [junit] 10/01/22 14:20:47 INFO mapred.JobTracker: Removed completed task 'attempt_20100122142002425_0002_m_000001_0'
from 'tracker_host3.foo.com:localhost/127.0.0.1:32987'
    [junit] 10/01/22 14:20:47 INFO mapred.JobTracker: Removed completed task 'attempt_20100122142002425_0002_m_000002_0'
from 'tracker_host3.foo.com:localhost/127.0.0.1:32987'
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3903073668373300337
is added to invalidSet of 127.0.0.1:45314
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3903073668373300337
is added to invalidSet of 127.0.0.1:38103
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3903073668373300337
is added to invalidSet of 127.0.0.1:36031
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-4519883474485258605
is added to invalidSet of 127.0.0.1:36031
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-4519883474485258605
is added to invalidSet of 127.0.0.1:45314
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-4519883474485258605
is added to invalidSet of 127.0.0.1:38103
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-8373979260215840694
is added to invalidSet of 127.0.0.1:36031
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-8373979260215840694
is added to invalidSet of 127.0.0.1:38080
    [junit] 10/01/22 14:20:47 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-8373979260215840694
is added to invalidSet of 127.0.0.1:38103
    [junit] 10/01/22 14:20:47 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20100122142002425_0002
    [junit] 10/01/22 14:20:47 INFO mapred.TaskRunner: attempt_20100122142002425_0002_m_000001_0
done; removing files.
    [junit] 10/01/22 14:20:47 INFO mapred.IndexCache: Map ID attempt_20100122142002425_0002_m_000001_0
not found in cache
    [junit] 10/01/22 14:20:47 INFO mapred.TaskRunner: attempt_20100122142002425_0002_m_000002_0
done; removing files.
    [junit] 10/01/22 14:20:47 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/hadoop-hudson/mapred/system/job_20100122142002425_0002	dst=null	perm=null
    [junit] 10/01/22 14:20:47 INFO mapred.IndexCache: Map ID attempt_20100122142002425_0002_m_000002_0
not found in cache
    [junit] 10/01/22 14:20:48 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20100122142002425_0002
    [junit] 10/01/22 14:20:48 WARN mapred.TaskTracker: Unknown job job_20100122142002425_0002
being deleted.
    [junit] 10/01/22 14:20:49 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:45314 to delete
 blk_-4519883474485258605_1014 blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:49 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:38103 to delete
 blk_-8373979260215840694_1015 blk_-4519883474485258605_1014 blk_3903073668373300337_1013
    [junit] 10/01/22 14:20:49 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20100122142002425_0002
    [junit] 10/01/22 14:20:49 WARN mapred.TaskTracker: Unknown job job_20100122142002425_0002
being deleted.
    [junit] 10/01/22 14:20:49 INFO mapReduceLayer.MapReduceLauncher: 100% complete
    [junit] 10/01/22 14:20:49 INFO mapReduceLayer.MapReduceLauncher: Successfully stored result
in: "hdfs://localhost:47577/tmp/temp-406619199/tmp-961107684"
    [junit] 10/01/22 14:20:49 INFO mapReduceLayer.MapReduceLauncher: Records written : 2
    [junit] 10/01/22 14:20:49 INFO mapReduceLayer.MapReduceLauncher: Bytes written : 78
    [junit] 10/01/22 14:20:49 INFO mapReduceLayer.MapReduceLauncher: Success!
    [junit] 10/01/22 14:20:49 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-406619199/tmp-961107684	dst=null	perm=null
    [junit] 10/01/22 14:20:49 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/temp-406619199/tmp-961107684/part-00000	dst=null	perm=null
    [junit] 10/01/22 14:20:49 INFO DataNode.clienttrace: src: /127.0.0.1:38103, dest: /127.0.0.1:58009,
bytes: 43, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_7213492376637073855_1018
    [junit] 10/01/22 14:20:49 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/temp-406619199/tmp-961107684/part-00001	dst=null	perm=null
    [junit] 10/01/22 14:20:49 INFO DataNode.clienttrace: src: /127.0.0.1:38103, dest: /127.0.0.1:58010,
bytes: 43, op: HDFS_READ, cliID: DFSClient_-1427623467, srvID: DS-1463347349-127.0.1.1-38103-1264170000919,
blockid: blk_2219336130341092980_1019
    [junit] 10/01/22 14:20:49 INFO mapred.JobTracker: Removed completed task 'attempt_20100122142002425_0002_m_000000_0'
from 'tracker_host2.foo.com:localhost/127.0.0.1:35598'
    [junit] 10/01/22 14:20:49 INFO mapred.JobTracker: Removed completed task 'attempt_20100122142002425_0002_m_000003_0'
from 'tracker_host2.foo.com:localhost/127.0.0.1:35598'
    [junit] 10/01/22 14:20:49 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20100122142002425_0002
    [junit] 10/01/22 14:20:49 INFO mapred.TaskRunner: attempt_20100122142002425_0002_m_000000_0
done; removing files.
    [junit] 10/01/22 14:20:49 INFO mapred.IndexCache: Map ID attempt_20100122142002425_0002_m_000000_0
not found in cache
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 44.49 sec

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

Total time: 249 minutes 35 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


Mime
View raw message