hadoop-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 #583
Date Sat, 10 Oct 2009 01:00:25 GMT
See <http://hudson.zones.apache.org/hudson/job/Pig-trunk/583/changes>

Changes:

[daijy] PIG-995: Limit Optimizer throw exception 'ERROR 2156: Error while fixing projections'

[daijy] PIG-894: order-by fails when input is empty

------------------------------------------
[...truncated 166540 lines...]
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:48035, dest: /127.0.0.1:36513,
bytes: 1859, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-286696190-127.0.1.1-36513-1255136299705,
blockid: blk_-1334121746913284522_1014
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36513 is added to blk_-1334121746913284522_1014 size 1859
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 0 for block blk_-1334121746913284522_1014
terminating
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:52427, dest: /127.0.0.1:35232,
bytes: 1859, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-1003288558-127.0.1.1-35232-1255136299143,
blockid: blk_-1334121746913284522_1014
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_-1334121746913284522_1014 size 1859
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 1 for block blk_-1334121746913284522_1014
terminating
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:60317, dest: /127.0.0.1:57908,
bytes: 1859, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_-1334121746913284522_1014
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 2 for block blk_-1334121746913284522_1014
terminating
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_-1334121746913284522_1014 size 1859
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.split
is closed by DFSClient_-77174316
    [junit] 09/10/10 00:58:52 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml	dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:52 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml	dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml.
blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: Receiving block blk_8761924747304658191_1015
src: /127.0.0.1:60320 dest: /127.0.0.1:57908
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: Receiving block blk_8761924747304658191_1015
src: /127.0.0.1:52430 dest: /127.0.0.1:35232
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: Receiving block blk_8761924747304658191_1015
src: /127.0.0.1:48038 dest: /127.0.0.1:36513
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36513 is added to blk_8761924747304658191_1015 size 48254
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:48038, dest: /127.0.0.1:36513,
bytes: 48254, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-286696190-127.0.1.1-36513-1255136299705,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 0 for block blk_8761924747304658191_1015
terminating
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:52430, dest: /127.0.0.1:35232,
bytes: 48254, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-1003288558-127.0.1.1-35232-1255136299143,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 1 for block blk_8761924747304658191_1015
terminating
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:60320, dest: /127.0.0.1:57908,
bytes: 48254, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_8761924747304658191_1015 size 48254
    [junit] 09/10/10 00:58:52 INFO datanode.DataNode: PacketResponder 2 for block blk_8761924747304658191_1015
terminating
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_8761924747304658191_1015 size 48254
    [junit] 09/10/10 00:58:52 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml
is closed by DFSClient_-77174316
    [junit] 09/10/10 00:58:52 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml	dst=null	perm=null
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:36513, dest: /127.0.0.1:48039,
bytes: 48634, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-286696190-127.0.1.1-36513-1255136299705,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:52 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.jar	dst=null	perm=null
    [junit] 09/10/10 00:58:52 INFO DataNode.clienttrace: src: /127.0.0.1:57908, dest: /127.0.0.1:60324,
bytes: 2483736, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_3750071453426248789_1013
    [junit] 09/10/10 00:58:52 INFO mapred.JobTracker: Initializing job_20091010005819797_0002
    [junit] 09/10/10 00:58:52 INFO mapred.JobInProgress: Initializing job_20091010005819797_0002
    [junit] 09/10/10 00:58:52 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_hudson_Job3756228276918050786.jar
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:53 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_conf.xml
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:53 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_conf.xml.
blk_2753248026776011957_1017
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: Receiving block blk_2753248026776011957_1017
src: /127.0.0.1:60325 dest: /127.0.0.1:57908
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: Receiving block blk_2753248026776011957_1017
src: /127.0.0.1:34706 dest: /127.0.0.1:55577
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: Receiving block blk_2753248026776011957_1017
src: /127.0.0.1:52436 dest: /127.0.0.1:35232
    [junit] 09/10/10 00:58:53 INFO DataNode.clienttrace: src: /127.0.0.1:52436, dest: /127.0.0.1:35232,
bytes: 48284, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-1003288558-127.0.1.1-35232-1255136299143,
blockid: blk_2753248026776011957_1017
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: PacketResponder 0 for block blk_2753248026776011957_1017
terminating
    [junit] 09/10/10 00:58:53 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_2753248026776011957_1017 size 48284
    [junit] 09/10/10 00:58:53 INFO DataNode.clienttrace: src: /127.0.0.1:34706, dest: /127.0.0.1:55577,
bytes: 48284, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-763709620-127.0.1.1-55577-1255136297957,
blockid: blk_2753248026776011957_1017
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: PacketResponder 1 for block blk_2753248026776011957_1017
terminating
    [junit] 09/10/10 00:58:53 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:55577 is added to blk_2753248026776011957_1017 size 48284
    [junit] 09/10/10 00:58:53 INFO DataNode.clienttrace: src: /127.0.0.1:60325, dest: /127.0.0.1:57908,
bytes: 48284, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_2753248026776011957_1017
    [junit] 09/10/10 00:58:53 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_2753248026776011957_1017 size 48284
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: PacketResponder 2 for block blk_2753248026776011957_1017
terminating
    [junit] 09/10/10 00:58:53 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_conf.xml
is closed by DFSClient_-77174316
    [junit] 09/10/10 00:58:53 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.split	dst=null	perm=null
    [junit] 09/10/10 00:58:53 INFO DataNode.clienttrace: src: /127.0.0.1:36513, dest: /127.0.0.1:48044,
bytes: 1875, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-286696190-127.0.1.1-36513-1255136299705,
blockid: blk_-1334121746913284522_1014
    [junit] 09/10/10 00:58:53 INFO mapred.JobInProgress: Input size for job job_20091010005819797_0002
= 12. Number of splits = 2
    [junit] 09/10/10 00:58:53 INFO mapred.JobInProgress: tip:task_20091010005819797_0002_m_000000
has split on node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 09/10/10 00:58:53 INFO mapred.JobInProgress: tip:task_20091010005819797_0002_m_000001
has split on node:/default-rack/h7.grid.sp2.yahoo.net
    [junit] 09/10/10 00:58:53 INFO mapReduceLayer.MapReduceLauncher: Submitting job: job_20091010005819797_0002
to execution engine.
    [junit] 09/10/10 00:58:53 INFO mapReduceLayer.MapReduceLauncher: More information at:
http://localhost:60544/jobdetails.jsp?jobid=job_20091010005819797_0002
    [junit] 09/10/10 00:58:53 INFO mapReduceLayer.MapReduceLauncher: To kill this job, use:
kill job_20091010005819797_0002
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: Deleting block blk_-4052760131583957924_1006
file build/test/data/dfs/data/data2/current/blk_-4052760131583957924
    [junit] 09/10/10 00:58:53 INFO datanode.DataNode: Deleting block blk_-1316834933025031654_1007
file build/test/data/dfs/data/data1/current/blk_-1316834933025031654
    [junit] 09/10/10 00:58:54 INFO mapReduceLayer.MapReduceLauncher: 0% complete
    [junit] 09/10/10 00:58:54 INFO mapred.JobTracker: Adding task 'attempt_20091010005819797_0002_m_000003_0'
to tip task_20091010005819797_0002_m_000003, for tracker 'tracker_host0.foo.com:localhost/127.0.0.1:45897'
    [junit] 09/10/10 00:58:54 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20091010005819797_0002_m_000003_0
task's state:UNASSIGNED
    [junit] 09/10/10 00:58:54 INFO mapred.TaskTracker: Trying to launch : attempt_20091010005819797_0002_m_000003_0
    [junit] 09/10/10 00:58:54 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20091010005819797_0002_m_000003_0
    [junit] 09/10/10 00:58:54 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml	dst=null	perm=null
    [junit] 09/10/10 00:58:54 INFO DataNode.clienttrace: src: /127.0.0.1:35232, dest: /127.0.0.1:52438,
bytes: 48634, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-1003288558-127.0.1.1-35232-1255136299143,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:54 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.jar	dst=null	perm=null
    [junit] 09/10/10 00:58:54 INFO DataNode.clienttrace: src: /127.0.0.1:57908, dest: /127.0.0.1:60330,
bytes: 2483736, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_3750071453426248789_1013
    [junit] 09/10/10 00:58:54 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20091010005819797_0002_m_1857093865
    [junit] 09/10/10 00:58:54 INFO mapred.JvmManager: JVM Runner jvm_20091010005819797_0002_m_1857093865
spawned.
    [junit] 09/10/10 00:58:54 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:36513 to delete
 blk_3750071453426248789_1013
    [junit] 09/10/10 00:58:55 INFO mapred.TaskTracker: JVM with ID: jvm_20091010005819797_0002_m_1857093865
given task: attempt_20091010005819797_0002_m_000003_0
    [junit] 09/10/10 00:58:55 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-1427071197/tmp-783301132/_temporary	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/10/10 00:58:55 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000003_0
0.0% setup
    [junit] 09/10/10 00:58:55 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000003_0
is done.
    [junit] 09/10/10 00:58:55 INFO mapred.TaskTracker: reported output size for attempt_20091010005819797_0002_m_000003_0
 was 0
    [junit] 09/10/10 00:58:55 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 09/10/10 00:58:55 INFO mapred.JvmManager: JVM : jvm_20091010005819797_0002_m_1857093865
exited. Number of tasks it ran: 1
    [junit] 09/10/10 00:58:55 INFO datanode.DataNode: Deleting block blk_3750071453426248789_1013
file build/test/data/dfs/data/data7/current/blk_3750071453426248789
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20091010005819797_0002/attempt_20091010005819797_0002_m_000003_0/output/file.out
in any of the configured local directories
    [junit] 09/10/10 00:58:57 INFO mapred.JobInProgress: Task 'attempt_20091010005819797_0002_m_000003_0'
has completed task_20091010005819797_0002_m_000003 successfully.
    [junit] 09/10/10 00:58:57 INFO mapred.JobTracker: Adding task 'attempt_20091010005819797_0002_m_000000_0'
to tip task_20091010005819797_0002_m_000000, for tracker 'tracker_host0.foo.com:localhost/127.0.0.1:45897'
    [junit] 09/10/10 00:58:57 INFO mapred.JobInProgress: Choosing rack-local task task_20091010005819797_0002_m_000000
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20091010005819797_0002_m_000000_0
task's state:UNASSIGNED
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: Trying to launch : attempt_20091010005819797_0002_m_000000_0
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: Received KillTaskAction for task: attempt_20091010005819797_0002_m_000003_0
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: About to purge task: attempt_20091010005819797_0002_m_000003_0
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20091010005819797_0002_m_000000_0
    [junit] 09/10/10 00:58:57 INFO mapred.TaskRunner: attempt_20091010005819797_0002_m_000003_0
done; removing files.
    [junit] 09/10/10 00:58:57 INFO mapred.IndexCache: Map ID attempt_20091010005819797_0002_m_000003_0
not found in cache
    [junit] 09/10/10 00:58:57 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20091010005819797_0002_m_-832698438
    [junit] 09/10/10 00:58:57 INFO mapred.JvmManager: JVM Runner jvm_20091010005819797_0002_m_-832698438
spawned.
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: JVM with ID: jvm_20091010005819797_0002_m_-832698438
given task: attempt_20091010005819797_0002_m_000000_0
    [junit] 09/10/10 00:58:57 INFO mapred.JobTracker: Adding task 'attempt_20091010005819797_0002_m_000001_0'
to tip task_20091010005819797_0002_m_000001, for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:41286'
    [junit] 09/10/10 00:58:57 INFO mapred.JobInProgress: Choosing rack-local task task_20091010005819797_0002_m_000001
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20091010005819797_0002_m_000001_0
task's state:UNASSIGNED
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: Trying to launch : attempt_20091010005819797_0002_m_000001_0
    [junit] 09/10/10 00:58:57 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20091010005819797_0002_m_000001_0
    [junit] 09/10/10 00:58:57 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.xml	dst=null	perm=null
    [junit] 09/10/10 00:58:57 INFO DataNode.clienttrace: src: /127.0.0.1:57908, dest: /127.0.0.1:60339,
bytes: 48634, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_8761924747304658191_1015
    [junit] 09/10/10 00:58:57 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002/job.jar	dst=null	perm=null
    [junit] 09/10/10 00:58:57 INFO DataNode.clienttrace: src: /127.0.0.1:57908, dest: /127.0.0.1:60340,
bytes: 2483736, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_3750071453426248789_1013
    [junit] 09/10/10 00:58:58 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20091010005819797_0002_m_1506276631
    [junit] 09/10/10 00:58:58 INFO mapred.JvmManager: JVM Runner jvm_20091010005819797_0002_m_1506276631
spawned.
    [junit] 09/10/10 00:58:58 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/user/hudson/input2.txt	dst=null	perm=null
    [junit] 09/10/10 00:58:58 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0/part-00000
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:58 INFO DataNode.clienttrace: src: /127.0.0.1:55577, dest: /127.0.0.1:34723,
bytes: 10, op: HDFS_READ, cliID: DFSClient_attempt_20091010005819797_0002_m_000000_0, srvID:
DS-763709620-127.0.1.1-55577-1255136297957, blockid: blk_8073274333389882793_1012
    [junit] 09/10/10 00:58:58 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0/part-00000.
blk_7973526658410217689_1018
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: Receiving block blk_7973526658410217689_1018
src: /127.0.0.1:60344 dest: /127.0.0.1:57908
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: Receiving block blk_7973526658410217689_1018
src: /127.0.0.1:52454 dest: /127.0.0.1:35232
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: Receiving block blk_7973526658410217689_1018
src: /127.0.0.1:34726 dest: /127.0.0.1:55577
    [junit] 09/10/10 00:58:58 INFO DataNode.clienttrace: src: /127.0.0.1:34726, dest: /127.0.0.1:55577,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000000_0, srvID:
DS-763709620-127.0.1.1-55577-1255136297957, blockid: blk_7973526658410217689_1018
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: PacketResponder 0 for block blk_7973526658410217689_1018
terminating
    [junit] 09/10/10 00:58:58 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:55577 is added to blk_7973526658410217689_1018 size 39
    [junit] 09/10/10 00:58:58 INFO DataNode.clienttrace: src: /127.0.0.1:52454, dest: /127.0.0.1:35232,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000000_0, srvID:
DS-1003288558-127.0.1.1-35232-1255136299143, blockid: blk_7973526658410217689_1018
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: PacketResponder 1 for block blk_7973526658410217689_1018
terminating
    [junit] 09/10/10 00:58:58 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_7973526658410217689_1018 size 39
    [junit] 09/10/10 00:58:58 INFO DataNode.clienttrace: src: /127.0.0.1:60344, dest: /127.0.0.1:57908,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000000_0, srvID:
DS-2066684421-127.0.1.1-57908-1255136298560, blockid: blk_7973526658410217689_1018
    [junit] 09/10/10 00:58:58 INFO datanode.DataNode: PacketResponder 2 for block blk_7973526658410217689_1018
terminating
    [junit] 09/10/10 00:58:58 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_7973526658410217689_1018 size 39
    [junit] 09/10/10 00:58:58 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0/part-00000
is closed by DFSClient_attempt_20091010005819797_0002_m_000000_0
    [junit] 09/10/10 00:58:58 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000000_0
is in commit-pending, task state:COMMIT_PENDING
    [junit] 09/10/10 00:58:58 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000000_0
0.0% 
    [junit] 09/10/10 00:58:58 INFO mapred.TaskTracker: JVM with ID: jvm_20091010005819797_0002_m_1506276631
given task: attempt_20091010005819797_0002_m_000001_0
    [junit] 09/10/10 00:58:59 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/user/hudson/input1.txt	dst=null	perm=null
    [junit] 09/10/10 00:58:59 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=create
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0/part-00001
dst=null	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:58:59 INFO DataNode.clienttrace: src: /127.0.0.1:55577, dest: /127.0.0.1:34732,
bytes: 10, op: HDFS_READ, cliID: DFSClient_attempt_20091010005819797_0002_m_000001_0, srvID:
DS-763709620-127.0.1.1-55577-1255136297957, blockid: blk_-2248922827833092161_1011
    [junit] 09/10/10 00:58:59 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0/part-00001.
blk_7607962732334717308_1019
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: Receiving block blk_7607962732334717308_1019
src: /127.0.0.1:60353 dest: /127.0.0.1:57908
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: Receiving block blk_7607962732334717308_1019
src: /127.0.0.1:34734 dest: /127.0.0.1:55577
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: Receiving block blk_7607962732334717308_1019
src: /127.0.0.1:52464 dest: /127.0.0.1:35232
    [junit] 09/10/10 00:58:59 INFO DataNode.clienttrace: src: /127.0.0.1:52464, dest: /127.0.0.1:35232,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000001_0, srvID:
DS-1003288558-127.0.1.1-35232-1255136299143, blockid: blk_7607962732334717308_1019
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: PacketResponder 0 for block blk_7607962732334717308_1019
terminating
    [junit] 09/10/10 00:58:59 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_7607962732334717308_1019 size 39
    [junit] 09/10/10 00:58:59 INFO DataNode.clienttrace: src: /127.0.0.1:34734, dest: /127.0.0.1:55577,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000001_0, srvID:
DS-763709620-127.0.1.1-55577-1255136297957, blockid: blk_7607962732334717308_1019
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: PacketResponder 1 for block blk_7607962732334717308_1019
terminating
    [junit] 09/10/10 00:58:59 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:55577 is added to blk_7607962732334717308_1019 size 39
    [junit] 09/10/10 00:58:59 INFO DataNode.clienttrace: src: /127.0.0.1:60353, dest: /127.0.0.1:57908,
bytes: 39, op: HDFS_WRITE, cliID: DFSClient_attempt_20091010005819797_0002_m_000001_0, srvID:
DS-2066684421-127.0.1.1-57908-1255136298560, blockid: blk_7607962732334717308_1019
    [junit] 09/10/10 00:58:59 INFO datanode.DataNode: PacketResponder 2 for block blk_7607962732334717308_1019
terminating
    [junit] 09/10/10 00:58:59 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_7607962732334717308_1019 size 39
    [junit] 09/10/10 00:58:59 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0/part-00001
is closed by DFSClient_attempt_20091010005819797_0002_m_000001_0
    [junit] 09/10/10 00:58:59 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000001_0
is in commit-pending, task state:COMMIT_PENDING
    [junit] 09/10/10 00:58:59 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000001_0
0.0% 
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: Received commit task action for attempt_20091010005819797_0002_m_000000_0
    [junit] 09/10/10 00:59:00 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0
dst=null	perm=null
    [junit] 09/10/10 00:59:00 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-1427071197/tmp-783301132	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/10/10 00:59:00 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=rename
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0/part-00000
dst=/tmp/temp-1427071197/tmp-783301132/part-00000	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:59:00 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000000_0
dst=null	perm=null
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000000_0
1.0% 
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000000_0
is done.
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: reported output size for attempt_20091010005819797_0002_m_000000_0
 was 0
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 09/10/10 00:59:00 INFO mapred.JvmManager: JVM : jvm_20091010005819797_0002_m_-832698438
exited. Number of tasks it ran: 1
    [junit] 09/10/10 00:59:00 INFO mapred.TaskTracker: Received commit task action for attempt_20091010005819797_0002_m_000001_0
    [junit] 09/10/10 00:59:01 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0
dst=null	perm=null
    [junit] 09/10/10 00:59:01 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=mkdirs
src=/tmp/temp-1427071197/tmp-783301132	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 09/10/10 00:59:01 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=rename
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0/part-00001
dst=/tmp/temp-1427071197/tmp-783301132/part-00001	perm=hudson:supergroup:rw-r--r--
    [junit] 09/10/10 00:59:01 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-1427071197/tmp-783301132/_temporary/_attempt_20091010005819797_0002_m_000001_0
dst=null	perm=null
    [junit] 09/10/10 00:59:01 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000001_0
1.0% 
    [junit] 09/10/10 00:59:01 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000001_0
is done.
    [junit] 09/10/10 00:59:01 INFO mapred.TaskTracker: reported output size for attempt_20091010005819797_0002_m_000001_0
 was 0
    [junit] 09/10/10 00:59:01 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 09/10/10 00:59:01 INFO mapred.JvmManager: JVM : jvm_20091010005819797_0002_m_1506276631
exited. Number of tasks it ran: 1
    [junit] 09/10/10 00:59:03 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20091010005819797_0002/attempt_20091010005819797_0002_m_000000_0/output/file.out
in any of the configured local directories
    [junit] 09/10/10 00:59:03 INFO mapred.JobInProgress: Task 'attempt_20091010005819797_0002_m_000000_0'
has completed task_20091010005819797_0002_m_000000 successfully.
    [junit] 09/10/10 00:59:03 INFO mapReduceLayer.MapReduceLauncher: 25% complete
    [junit] 09/10/10 00:59:03 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20091010005819797_0002/attempt_20091010005819797_0002_m_000001_0/output/file.out
in any of the configured local directories
    [junit] 09/10/10 00:59:03 INFO mapred.JobInProgress: Task 'attempt_20091010005819797_0002_m_000001_0'
has completed task_20091010005819797_0002_m_000001 successfully.
    [junit] 09/10/10 00:59:03 INFO mapred.JobTracker: Adding task 'attempt_20091010005819797_0002_m_000002_0'
to tip task_20091010005819797_0002_m_000002, for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:41286'
    [junit] 09/10/10 00:59:03 INFO mapred.TaskTracker: LaunchTaskAction (registerTask): attempt_20091010005819797_0002_m_000002_0
task's state:UNASSIGNED
    [junit] 09/10/10 00:59:03 INFO mapred.TaskTracker: Trying to launch : attempt_20091010005819797_0002_m_000002_0
    [junit] 09/10/10 00:59:03 INFO mapred.TaskTracker: In TaskLauncher, current free slots
: 2 and trying to launch attempt_20091010005819797_0002_m_000002_0
    [junit] 09/10/10 00:59:03 INFO mapred.JvmManager: In JvmRunner constructed JVM ID: jvm_20091010005819797_0002_m_2031261339
    [junit] 09/10/10 00:59:03 INFO mapred.JvmManager: JVM Runner jvm_20091010005819797_0002_m_2031261339
spawned.
    [junit] 09/10/10 00:59:04 INFO mapReduceLayer.MapReduceLauncher: 50% complete
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: JVM with ID: jvm_20091010005819797_0002_m_2031261339
given task: attempt_20091010005819797_0002_m_000002_0
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000002_0
0.0% 
    [junit] 09/10/10 00:59:04 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/temp-1427071197/tmp-783301132/_temporary	dst=null	perm=null
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: attempt_20091010005819797_0002_m_000002_0
0.0% cleanup
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: Task attempt_20091010005819797_0002_m_000002_0
is done.
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: reported output size for attempt_20091010005819797_0002_m_000002_0
 was 0
    [junit] 09/10/10 00:59:04 INFO mapred.TaskTracker: addFreeSlot : current free slots :
2
    [junit] 09/10/10 00:59:04 INFO mapred.JvmManager: JVM : jvm_20091010005819797_0002_m_2031261339
exited. Number of tasks it ran: 1
    [junit] 09/10/10 00:59:06 INFO mapred.TaskTracker: org.apache.hadoop.util.DiskChecker$DiskErrorException:
Could not find taskTracker/jobcache/job_20091010005819797_0002/attempt_20091010005819797_0002_m_000002_0/output/file.out
in any of the configured local directories
    [junit] 09/10/10 00:59:06 INFO mapred.JobInProgress: Task 'attempt_20091010005819797_0002_m_000002_0'
has completed task_20091010005819797_0002_m_000002 successfully.
    [junit] 09/10/10 00:59:06 INFO mapred.JobInProgress: Job job_20091010005819797_0002 has
completed successfully.
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_hudson_Job3756228276918050786.jar.
blk_-4670792676074632197_1019
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: Receiving block blk_-4670792676074632197_1019
src: /127.0.0.1:48077 dest: /127.0.0.1:36513
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: Receiving block blk_-4670792676074632197_1019
src: /127.0.0.1:52471 dest: /127.0.0.1:35232
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: Receiving block blk_-4670792676074632197_1019
src: /127.0.0.1:60363 dest: /127.0.0.1:57908
    [junit] 09/10/10 00:59:06 INFO DataNode.clienttrace: src: /127.0.0.1:60363, dest: /127.0.0.1:57908,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-2066684421-127.0.1.1-57908-1255136298560,
blockid: blk_-4670792676074632197_1019
    [junit] 09/10/10 00:59:06 INFO DataNode.clienttrace: src: /127.0.0.1:52471, dest: /127.0.0.1:35232,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-1003288558-127.0.1.1-35232-1255136299143,
blockid: blk_-4670792676074632197_1019
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:57908 is added to blk_-4670792676074632197_1019 size 6117
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: PacketResponder 0 for block blk_-4670792676074632197_1019
terminating
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:35232 is added to blk_-4670792676074632197_1019 size 6117
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: PacketResponder 1 for block blk_-4670792676074632197_1019
terminating
    [junit] 09/10/10 00:59:06 INFO DataNode.clienttrace: src: /127.0.0.1:48077, dest: /127.0.0.1:36513,
bytes: 6117, op: HDFS_WRITE, cliID: DFSClient_-77174316, srvID: DS-286696190-127.0.1.1-36513-1255136299705,
blockid: blk_-4670792676074632197_1019
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap
updated: 127.0.0.1:36513 is added to blk_-4670792676074632197_1019 size 6117
    [junit] 09/10/10 00:59:06 INFO datanode.DataNode: PacketResponder 2 for block blk_-4670792676074632197_1019
terminating
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: DIR* NameSystem.completeFile: file /tmp/temp-1427071197/tmp-783301132/_logs/history/localhost_1255136299820_job_20091010005819797_0002_hudson_Job3756228276918050786.jar
is closed by DFSClient_-77174316
    [junit] 09/10/10 00:59:06 INFO mapred.JobTracker: Removed completed task 'attempt_20091010005819797_0002_m_000001_0'
from 'tracker_host1.foo.com:localhost/127.0.0.1:41286'
    [junit] 09/10/10 00:59:06 INFO mapred.JobTracker: Removed completed task 'attempt_20091010005819797_0002_m_000002_0'
from 'tracker_host1.foo.com:localhost/127.0.0.1:41286'
    [junit] 09/10/10 00:59:06 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20091010005819797_0002
    [junit] 09/10/10 00:59:06 INFO mapred.TaskRunner: attempt_20091010005819797_0002_m_000001_0
done; removing files.
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3750071453426248789
is added to invalidSet of 127.0.0.1:36513
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3750071453426248789
is added to invalidSet of 127.0.0.1:35232
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_3750071453426248789
is added to invalidSet of 127.0.0.1:57908
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1334121746913284522
is added to invalidSet of 127.0.0.1:36513
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1334121746913284522
is added to invalidSet of 127.0.0.1:35232
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1334121746913284522
is added to invalidSet of 127.0.0.1:57908
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_8761924747304658191
is added to invalidSet of 127.0.0.1:36513
    [junit] 09/10/10 00:59:06 INFO mapred.IndexCache: Map ID attempt_20091010005819797_0002_m_000001_0
not found in cache
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_8761924747304658191
is added to invalidSet of 127.0.0.1:35232
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_8761924747304658191
is added to invalidSet of 127.0.0.1:57908
    [junit] 09/10/10 00:59:06 INFO mapred.TaskRunner: attempt_20091010005819797_0002_m_000002_0
done; removing files.
    [junit] 09/10/10 00:59:06 INFO mapred.IndexCache: Map ID attempt_20091010005819797_0002_m_000002_0
not found in cache
    [junit] 09/10/10 00:59:06 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete
src=/tmp/hadoop-hudson/mapred/system/job_20091010005819797_0002	dst=null	perm=null
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:35232 to delete
 blk_8761924747304658191_1015 blk_-1334121746913284522_1014 blk_3750071453426248789_1013
    [junit] 09/10/10 00:59:06 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:57908 to delete
 blk_8761924747304658191_1015 blk_-1334121746913284522_1014 blk_3750071453426248789_1013
    [junit] 09/10/10 00:59:07 INFO datanode.DataNode: Deleting block blk_-1334121746913284522_1014
file build/test/data/dfs/data/data5/current/blk_-1334121746913284522
    [junit] 09/10/10 00:59:07 INFO datanode.DataNode: Deleting block blk_3750071453426248789_1013
file build/test/data/dfs/data/data6/current/blk_3750071453426248789
    [junit] 09/10/10 00:59:07 INFO datanode.DataNode: Deleting block blk_8761924747304658191_1015
file build/test/data/dfs/data/data6/current/blk_8761924747304658191
    [junit] 09/10/10 00:59:07 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20091010005819797_0002
    [junit] 09/10/10 00:59:07 WARN mapred.TaskTracker: Unknown job job_20091010005819797_0002
being deleted.
    [junit] 09/10/10 00:59:07 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20091010005819797_0002
    [junit] 09/10/10 00:59:07 WARN mapred.TaskTracker: Unknown job job_20091010005819797_0002
being deleted.
    [junit] 09/10/10 00:59:08 INFO mapReduceLayer.MapReduceLauncher: 100% complete
    [junit] 09/10/10 00:59:08 INFO mapReduceLayer.MapReduceLauncher: Successfully stored result
in: "hdfs://localhost:59989/tmp/temp-1427071197/tmp-783301132"
    [junit] 09/10/10 00:59:08 INFO mapReduceLayer.MapReduceLauncher: Records written : 2
    [junit] 09/10/10 00:59:08 INFO mapReduceLayer.MapReduceLauncher: Bytes written : 78
    [junit] 09/10/10 00:59:08 INFO mapReduceLayer.MapReduceLauncher: Success!
    [junit] 09/10/10 00:59:08 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=listStatus
src=/tmp/temp-1427071197/tmp-783301132	dst=null	perm=null
    [junit] 09/10/10 00:59:08 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/temp-1427071197/tmp-783301132/part-00000	dst=null	perm=null
    [junit] 09/10/10 00:59:08 INFO DataNode.clienttrace: src: /127.0.0.1:55577, dest: /127.0.0.1:34744,
bytes: 43, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-763709620-127.0.1.1-55577-1255136297957,
blockid: blk_7973526658410217689_1018
    [junit] 09/10/10 00:59:08 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open
src=/tmp/temp-1427071197/tmp-783301132/part-00001	dst=null	perm=null
    [junit] 09/10/10 00:59:08 INFO DataNode.clienttrace: src: /127.0.0.1:55577, dest: /127.0.0.1:34745,
bytes: 43, op: HDFS_READ, cliID: DFSClient_-77174316, srvID: DS-763709620-127.0.1.1-55577-1255136297957,
blockid: blk_7607962732334717308_1019
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 45.248 sec

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

Total time: 169 minutes 14 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