See <http://hudson.zones.apache.org/hudson/job/Pig-trunk/686/changes>
Changes:
[rding] PIG-1169: Top-N queries produce incorrect results when a store
statement is added between order by and limit statements
------------------------------------------
[...truncated 244312 lines...]
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:36013,
dest: /127.0.0.1:32979, bytes: 1589, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_3398506634867950097_1014
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: PacketResponder 1 for
block blk_3398506634867950097_1014 terminating
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:36514,
dest: /127.0.0.1:60287, bytes: 1589, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_3398506634867950097_1014
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: PacketResponder 2 for
block blk_3398506634867950097_1014 terminating
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_3398506634867950097_1014 size 1589
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:60287 is added to
blk_3398506634867950097_1014 size 1589
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.split is closed
by DFSClient_-1266622966
[junit] 10/02/18 14:27:23 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=create
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:23 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=setPermission
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.allocateBlock:
/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml.
blk_8068977330733341753_1015
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: Receiving block
blk_8068977330733341753_1015 src: /127.0.0.1:36518 dest: /127.0.0.1:60287
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: Receiving block
blk_8068977330733341753_1015 src: /127.0.0.1:36017 dest: /127.0.0.1:32979
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: Receiving block
blk_8068977330733341753_1015 src: /127.0.0.1:60291 dest: /127.0.0.1:47319
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:60291,
dest: /127.0.0.1:47319, bytes: 48171, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-1035847289-127.0.1.1-47319-1266503211943,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: PacketResponder 0 for
block blk_8068977330733341753_1015 terminating
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:47319 is added to
blk_8068977330733341753_1015 size 48171
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:36017,
dest: /127.0.0.1:32979, bytes: 48171, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_8068977330733341753_1015 size 48171
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: PacketResponder 1 for
block blk_8068977330733341753_1015 terminating
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:36518,
dest: /127.0.0.1:60287, bytes: 48171, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:60287 is added to
blk_8068977330733341753_1015 size 48171
[junit] 10/02/18 14:27:23 INFO datanode.DataNode: PacketResponder 2 for
block blk_8068977330733341753_1015 terminating
[junit] 10/02/18 14:27:23 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml is closed
by DFSClient_-1266622966
[junit] 10/02/18 14:27:23 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml
dst=null perm=null
[junit] 10/02/18 14:27:23 INFO DataNode.clienttrace: src: /127.0.0.1:60287,
dest: /127.0.0.1:36521, bytes: 48551, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:23 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.jar
dst=null perm=null
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:60287,
dest: /127.0.0.1:36522, bytes: 2893887, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_5276665465226215722_1013
[junit] 10/02/18 14:27:24 INFO mapred.JobTracker: Initializing
job_20100218142652017_0002
[junit] 10/02/18 14:27:24 INFO mapred.JobInProgress: Initializing
job_20100218142652017_0002
[junit] 10/02/18 14:27:24 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=create
src=/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_hudson_Job49626562104165072.jar
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:24 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=create
src=/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_conf.xml
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK*
NameSystem.allocateBlock:
/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_conf.xml.
blk_9171490700483951222_1017
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Receiving block
blk_9171490700483951222_1017 src: /127.0.0.1:36021 dest: /127.0.0.1:32979
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Receiving block
blk_9171490700483951222_1017 src: /127.0.0.1:36524 dest: /127.0.0.1:60287
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Receiving block
blk_9171490700483951222_1017 src: /127.0.0.1:60296 dest: /127.0.0.1:47319
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:60296,
dest: /127.0.0.1:47319, bytes: 48201, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-1035847289-127.0.1.1-47319-1266503211943,
blockid: blk_9171490700483951222_1017
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: PacketResponder 0 for
block blk_9171490700483951222_1017 terminating
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:47319 is added to
blk_9171490700483951222_1017 size 48201
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:36524,
dest: /127.0.0.1:60287, bytes: 48201, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_9171490700483951222_1017
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:60287 is added to
blk_9171490700483951222_1017 size 48201
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: PacketResponder 1 for
block blk_9171490700483951222_1017 terminating
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:36021,
dest: /127.0.0.1:32979, bytes: 48201, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_9171490700483951222_1017
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_9171490700483951222_1017 size 48201
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: PacketResponder 2 for
block blk_9171490700483951222_1017 terminating
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_conf.xml
is closed by DFSClient_-1266622966
[junit] 10/02/18 14:27:24 INFO mapReduceLayer.MapReduceLauncher: Submitting
job: job_20100218142652017_0002 to execution engine.
[junit] 10/02/18 14:27:24 INFO mapReduceLayer.MapReduceLauncher: More
information at:
http://localhost:35972/jobdetails.jsp?jobid=job_20100218142652017_0002
[junit] 10/02/18 14:27:24 INFO mapReduceLayer.MapReduceLauncher: To kill
this job, use: kill job_20100218142652017_0002
[junit] 10/02/18 14:27:24 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.split
dst=null perm=null
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:32979,
dest: /127.0.0.1:36024, bytes: 1605, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_3398506634867950097_1014
[junit] 10/02/18 14:27:24 INFO mapred.JobInProgress: Input size for job
job_20100218142652017_0002 = 12. Number of splits = 2
[junit] 10/02/18 14:27:24 INFO mapred.JobInProgress:
tip:task_20100218142652017_0002_m_000000 has split on
node:/default-rack/h7.grid.sp2.yahoo.net
[junit] 10/02/18 14:27:24 INFO mapred.JobInProgress:
tip:task_20100218142652017_0002_m_000001 has split on
node:/default-rack/h7.grid.sp2.yahoo.net
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Deleting block
blk_-5291593274969839665_1006 file
build/test/data/dfs/data/data6/current/blk_-5291593274969839665
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Deleting block
blk_-340269418460415197_1007 file
build/test/data/dfs/data/data5/current/blk_-340269418460415197
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:47319
to delete blk_5276665465226215722_1013
[junit] 10/02/18 14:27:24 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:33960
to delete blk_-5291593274969839665_1006 blk_1052459288649280538_1005
blk_-340269418460415197_1007
[junit] 10/02/18 14:27:24 INFO mapred.JobTracker: Adding task
'attempt_20100218142652017_0002_m_000003_0' to tip
task_20100218142652017_0002_m_000003, for tracker
'tracker_host3.foo.com:localhost/127.0.0.1:32814'
[junit] 10/02/18 14:27:24 INFO mapred.TaskTracker: LaunchTaskAction
(registerTask): attempt_20100218142652017_0002_m_000003_0 task's
state:UNASSIGNED
[junit] 10/02/18 14:27:24 INFO mapred.TaskTracker: Trying to launch :
attempt_20100218142652017_0002_m_000003_0
[junit] 10/02/18 14:27:24 INFO mapred.TaskTracker: In TaskLauncher, current
free slots : 2 and trying to launch attempt_20100218142652017_0002_m_000003_0
[junit] 10/02/18 14:27:24 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml
dst=null perm=null
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:60287,
dest: /127.0.0.1:36527, bytes: 48551, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:24 INFO mapReduceLayer.MapReduceLauncher: 0% complete
[junit] 10/02/18 14:27:24 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.jar
dst=null perm=null
[junit] 10/02/18 14:27:24 INFO DataNode.clienttrace: src: /127.0.0.1:47319,
dest: /127.0.0.1:60299, bytes: 2893887, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-1035847289-127.0.1.1-47319-1266503211943,
blockid: blk_5276665465226215722_1013
[junit] 10/02/18 14:27:24 INFO datanode.DataNode: Deleting block
blk_5276665465226215722_1013 file
build/test/data/dfs/data/data7/current/blk_5276665465226215722
[junit] 10/02/18 14:27:25 INFO mapred.JvmManager: In JvmRunner constructed
JVM ID: jvm_20100218142652017_0002_m_-1426059895
[junit] 10/02/18 14:27:25 INFO mapred.JvmManager: JVM Runner
jvm_20100218142652017_0002_m_-1426059895 spawned.
[junit] 10/02/18 14:27:25 INFO mapred.TaskTracker: JVM with ID:
jvm_20100218142652017_0002_m_-1426059895 given task:
attempt_20100218142652017_0002_m_000003_0
[junit] 10/02/18 14:27:26 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=mkdirs
src=/tmp/temp1664457296/tmp-1296460196/_temporary dst=null
perm=hudson:supergroup:rwxr-xr-x
[junit] 10/02/18 14:27:26 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000003_0 0.0% setup
[junit] 10/02/18 14:27:26 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000003_0 is done.
[junit] 10/02/18 14:27:26 INFO mapred.TaskTracker: reported output size for
attempt_20100218142652017_0002_m_000003_0 was 0
[junit] 10/02/18 14:27:26 INFO mapred.TaskTracker: addFreeSlot : current
free slots : 2
[junit] 10/02/18 14:27:26 INFO mapred.JvmManager: JVM :
jvm_20100218142652017_0002_m_-1426059895 exited. Number of tasks it ran: 1
[junit] 10/02/18 14:27:26 INFO datanode.DataNode: Deleting block
blk_-5291593274969839665_1006 file
build/test/data/dfs/data/data2/current/blk_-5291593274969839665
[junit] 10/02/18 14:27:26 INFO datanode.DataNode: Deleting block
blk_-340269418460415197_1007 file
build/test/data/dfs/data/data1/current/blk_-340269418460415197
[junit] 10/02/18 14:27:26 INFO datanode.DataNode: Deleting block
blk_1052459288649280538_1005 file
build/test/data/dfs/data/data1/current/blk_1052459288649280538
[junit] 10/02/18 14:27:27 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:60287
to delete blk_-5291593274969839665_1006 blk_1052459288649280538_1005
blk_-340269418460415197_1007
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker:
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find
taskTracker/jobcache/job_20100218142652017_0002/attempt_20100218142652017_0002_m_000003_0/output/file.out
in any of the configured local directories
[junit] 10/02/18 14:27:27 INFO mapred.JobInProgress: Task
'attempt_20100218142652017_0002_m_000003_0' has completed
task_20100218142652017_0002_m_000003 successfully.
[junit] 10/02/18 14:27:27 INFO mapred.JobTracker: Adding task
'attempt_20100218142652017_0002_m_000000_0' to tip
task_20100218142652017_0002_m_000000, for tracker
'tracker_host3.foo.com:localhost/127.0.0.1:32814'
[junit] 10/02/18 14:27:27 INFO mapred.JobInProgress: Choosing rack-local
task task_20100218142652017_0002_m_000000
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker: LaunchTaskAction
(registerTask): attempt_20100218142652017_0002_m_000000_0 task's
state:UNASSIGNED
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker: Trying to launch :
attempt_20100218142652017_0002_m_000000_0
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker: Received KillTaskAction
for task: attempt_20100218142652017_0002_m_000003_0
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker: About to purge task:
attempt_20100218142652017_0002_m_000003_0
[junit] 10/02/18 14:27:27 INFO mapred.TaskTracker: In TaskLauncher, current
free slots : 2 and trying to launch attempt_20100218142652017_0002_m_000000_0
[junit] 10/02/18 14:27:27 INFO mapred.TaskRunner:
attempt_20100218142652017_0002_m_000003_0 done; removing files.
[junit] 10/02/18 14:27:27 INFO mapred.IndexCache: Map ID
attempt_20100218142652017_0002_m_000003_0 not found in cache
[junit] 10/02/18 14:27:27 INFO mapred.JvmManager: In JvmRunner constructed
JVM ID: jvm_20100218142652017_0002_m_-1403932345
[junit] 10/02/18 14:27:27 INFO mapred.JvmManager: JVM Runner
jvm_20100218142652017_0002_m_-1403932345 spawned.
[junit] 10/02/18 14:27:28 INFO mapred.TaskTracker: JVM with ID:
jvm_20100218142652017_0002_m_-1403932345 given task:
attempt_20100218142652017_0002_m_000000_0
[junit] 10/02/18 14:27:28 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open src=/user/hudson/input2.txt dst=null
perm=null
[junit] 10/02/18 14:27:28 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=create
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0/part-00000
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:28 INFO DataNode.clienttrace: src: /127.0.0.1:47319,
dest: /127.0.0.1:60310, bytes: 10, op: HDFS_READ, cliID:
DFSClient_attempt_20100218142652017_0002_m_000000_0, srvID:
DS-1035847289-127.0.1.1-47319-1266503211943, blockid:
blk_8295799543263891138_1012
[junit] 10/02/18 14:27:28 INFO hdfs.StateChange: BLOCK*
NameSystem.allocateBlock:
/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0/part-00000.
blk_7061000197120941720_1018
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: Receiving block
blk_7061000197120941720_1018 src: /127.0.0.1:36038 dest: /127.0.0.1:32979
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: Receiving block
blk_7061000197120941720_1018 src: /127.0.0.1:60312 dest: /127.0.0.1:47319
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: Receiving block
blk_7061000197120941720_1018 src: /127.0.0.1:58882 dest: /127.0.0.1:33960
[junit] 10/02/18 14:27:28 INFO DataNode.clienttrace: src: /127.0.0.1:58882,
dest: /127.0.0.1:33960, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000000_0, srvID:
DS-651995009-127.0.1.1-33960-1266503210508, blockid:
blk_7061000197120941720_1018
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: PacketResponder 0 for
block blk_7061000197120941720_1018 terminating
[junit] 10/02/18 14:27:28 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:33960 is added to
blk_7061000197120941720_1018 size 39
[junit] 10/02/18 14:27:28 INFO DataNode.clienttrace: src: /127.0.0.1:60312,
dest: /127.0.0.1:47319, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000000_0, srvID:
DS-1035847289-127.0.1.1-47319-1266503211943, blockid:
blk_7061000197120941720_1018
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: PacketResponder 1 for
block blk_7061000197120941720_1018 terminating
[junit] 10/02/18 14:27:28 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:47319 is added to
blk_7061000197120941720_1018 size 39
[junit] 10/02/18 14:27:28 INFO DataNode.clienttrace: src: /127.0.0.1:36038,
dest: /127.0.0.1:32979, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000000_0, srvID:
DS-27052338-127.0.1.1-32979-1266503211469, blockid: blk_7061000197120941720_1018
[junit] 10/02/18 14:27:28 INFO datanode.DataNode: PacketResponder 2 for
block blk_7061000197120941720_1018 terminating
[junit] 10/02/18 14:27:28 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_7061000197120941720_1018 size 39
[junit] 10/02/18 14:27:28 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0/part-00000
is closed by DFSClient_attempt_20100218142652017_0002_m_000000_0
[junit] 10/02/18 14:27:28 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000000_0 is in commit-pending, task
state:COMMIT_PENDING
[junit] 10/02/18 14:27:28 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000000_0 0.0%
[junit] 10/02/18 14:27:29 INFO mapred.JobTracker: Adding task
'attempt_20100218142652017_0002_m_000001_0' to tip
task_20100218142652017_0002_m_000001, for tracker
'tracker_host0.foo.com:localhost/127.0.0.1:44083'
[junit] 10/02/18 14:27:29 INFO mapred.JobInProgress: Choosing rack-local
task task_20100218142652017_0002_m_000001
[junit] 10/02/18 14:27:29 INFO mapred.TaskTracker: LaunchTaskAction
(registerTask): attempt_20100218142652017_0002_m_000001_0 task's
state:UNASSIGNED
[junit] 10/02/18 14:27:29 INFO mapred.TaskTracker: Trying to launch :
attempt_20100218142652017_0002_m_000001_0
[junit] 10/02/18 14:27:29 INFO mapred.TaskTracker: In TaskLauncher, current
free slots : 2 and trying to launch attempt_20100218142652017_0002_m_000001_0
[junit] 10/02/18 14:27:29 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.xml
dst=null perm=null
[junit] 10/02/18 14:27:29 INFO DataNode.clienttrace: src: /127.0.0.1:47319,
dest: /127.0.0.1:60314, bytes: 48551, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-1035847289-127.0.1.1-47319-1266503211943,
blockid: blk_8068977330733341753_1015
[junit] 10/02/18 14:27:29 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002/job.jar
dst=null perm=null
[junit] 10/02/18 14:27:29 INFO DataNode.clienttrace: src: /127.0.0.1:32979,
dest: /127.0.0.1:36042, bytes: 2893887, op: HDFS_READ, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_5276665465226215722_1013
[junit] 10/02/18 14:27:29 INFO mapred.JvmManager: In JvmRunner constructed
JVM ID: jvm_20100218142652017_0002_m_-241262454
[junit] 10/02/18 14:27:29 INFO mapred.JvmManager: JVM Runner
jvm_20100218142652017_0002_m_-241262454 spawned.
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Deleting block
blk_-5291593274969839665_1006 file
build/test/data/dfs/data/data4/current/blk_-5291593274969839665
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Deleting block
blk_-340269418460415197_1007 file
build/test/data/dfs/data/data3/current/blk_-340269418460415197
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Deleting block
blk_1052459288649280538_1005 file
build/test/data/dfs/data/data3/current/blk_1052459288649280538
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker: JVM with ID:
jvm_20100218142652017_0002_m_-241262454 given task:
attempt_20100218142652017_0002_m_000001_0
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker: Received commit task
action for attempt_20100218142652017_0002_m_000000_0
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open src=/user/hudson/input1.txt dst=null
perm=null
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=create
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0/part-00001
dst=null perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=listStatus
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0
dst=null perm=null
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=mkdirs src=/tmp/temp1664457296/tmp-1296460196
dst=null perm=hudson:supergroup:rwxr-xr-x
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=rename
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0/part-00000
dst=/tmp/temp1664457296/tmp-1296460196/part-00000
perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:30 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=delete
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000000_0
dst=null perm=null
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000000_0 1.0%
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000000_0 is done.
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker: reported output size for
attempt_20100218142652017_0002_m_000000_0 was 0
[junit] 10/02/18 14:27:30 INFO mapred.TaskTracker: addFreeSlot : current
free slots : 2
[junit] 10/02/18 14:27:30 INFO DataNode.clienttrace: src: /127.0.0.1:60287,
dest: /127.0.0.1:36550, bytes: 10, op: HDFS_READ, cliID:
DFSClient_attempt_20100218142652017_0002_m_000001_0, srvID:
DS-765087567-127.0.1.1-60287-1266503211020, blockid:
blk_1682203498743959906_1011
[junit] 10/02/18 14:27:30 INFO hdfs.StateChange: BLOCK*
NameSystem.allocateBlock:
/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0/part-00001.
blk_-1297509060924874361_1019
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Receiving block
blk_-1297509060924874361_1019 src: /127.0.0.1:36049 dest: /127.0.0.1:32979
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Receiving block
blk_-1297509060924874361_1019 src: /127.0.0.1:36552 dest: /127.0.0.1:60287
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: Receiving block
blk_-1297509060924874361_1019 src: /127.0.0.1:60324 dest: /127.0.0.1:47319
[junit] 10/02/18 14:27:30 INFO DataNode.clienttrace: src: /127.0.0.1:60324,
dest: /127.0.0.1:47319, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000001_0, srvID:
DS-1035847289-127.0.1.1-47319-1266503211943, blockid:
blk_-1297509060924874361_1019
[junit] 10/02/18 14:27:30 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:47319 is added to
blk_-1297509060924874361_1019 size 39
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: PacketResponder 0 for
block blk_-1297509060924874361_1019 terminating
[junit] 10/02/18 14:27:30 INFO DataNode.clienttrace: src: /127.0.0.1:36552,
dest: /127.0.0.1:60287, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000001_0, srvID:
DS-765087567-127.0.1.1-60287-1266503211020, blockid:
blk_-1297509060924874361_1019
[junit] 10/02/18 14:27:30 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:60287 is added to
blk_-1297509060924874361_1019 size 39
[junit] 10/02/18 14:27:30 INFO DataNode.clienttrace: src: /127.0.0.1:36049,
dest: /127.0.0.1:32979, bytes: 39, op: HDFS_WRITE, cliID:
DFSClient_attempt_20100218142652017_0002_m_000001_0, srvID:
DS-27052338-127.0.1.1-32979-1266503211469, blockid:
blk_-1297509060924874361_1019
[junit] 10/02/18 14:27:30 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_-1297509060924874361_1019 size 39
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: PacketResponder 1 for
block blk_-1297509060924874361_1019 terminating
[junit] 10/02/18 14:27:30 INFO datanode.DataNode: PacketResponder 2 for
block blk_-1297509060924874361_1019 terminating
[junit] 10/02/18 14:27:30 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0/part-00001
is closed by DFSClient_attempt_20100218142652017_0002_m_000001_0
[junit] 10/02/18 14:27:31 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000001_0 is in commit-pending, task
state:COMMIT_PENDING
[junit] 10/02/18 14:27:31 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000001_0 0.0%
[junit] 10/02/18 14:27:31 INFO mapred.JvmManager: JVM :
jvm_20100218142652017_0002_m_-1403932345 exited. Number of tasks it ran: 1
[junit] 10/02/18 14:27:32 INFO mapred.TaskTracker: Received commit task
action for attempt_20100218142652017_0002_m_000001_0
[junit] 10/02/18 14:27:33 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=listStatus
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0
dst=null perm=null
[junit] 10/02/18 14:27:33 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=mkdirs src=/tmp/temp1664457296/tmp-1296460196
dst=null perm=hudson:supergroup:rwxr-xr-x
[junit] 10/02/18 14:27:33 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=rename
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0/part-00001
dst=/tmp/temp1664457296/tmp-1296460196/part-00001
perm=hudson:supergroup:rw-r--r--
[junit] 10/02/18 14:27:33 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=delete
src=/tmp/temp1664457296/tmp-1296460196/_temporary/_attempt_20100218142652017_0002_m_000001_0
dst=null perm=null
[junit] 10/02/18 14:27:33 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000001_0 1.0%
[junit] 10/02/18 14:27:33 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000001_0 is done.
[junit] 10/02/18 14:27:33 INFO mapred.TaskTracker: reported output size for
attempt_20100218142652017_0002_m_000001_0 was 0
[junit] 10/02/18 14:27:33 INFO mapred.TaskTracker: addFreeSlot : current
free slots : 2
[junit] 10/02/18 14:27:33 INFO mapred.JvmManager: JVM :
jvm_20100218142652017_0002_m_-241262454 exited. Number of tasks it ran: 1
[junit] 10/02/18 14:27:33 INFO mapred.TaskTracker:
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find
taskTracker/jobcache/job_20100218142652017_0002/attempt_20100218142652017_0002_m_000000_0/output/file.out
in any of the configured local directories
[junit] 10/02/18 14:27:33 INFO mapred.JobInProgress: Task
'attempt_20100218142652017_0002_m_000000_0' has completed
task_20100218142652017_0002_m_000000 successfully.
[junit] 10/02/18 14:27:33 INFO mapReduceLayer.MapReduceLauncher: 25%
complete
[junit] 10/02/18 14:27:35 INFO mapred.TaskTracker:
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find
taskTracker/jobcache/job_20100218142652017_0002/attempt_20100218142652017_0002_m_000001_0/output/file.out
in any of the configured local directories
[junit] 10/02/18 14:27:35 INFO mapred.JobInProgress: Task
'attempt_20100218142652017_0002_m_000001_0' has completed
task_20100218142652017_0002_m_000001 successfully.
[junit] 10/02/18 14:27:35 INFO mapred.JobTracker: Adding task
'attempt_20100218142652017_0002_m_000002_0' to tip
task_20100218142652017_0002_m_000002, for tracker
'tracker_host0.foo.com:localhost/127.0.0.1:44083'
[junit] 10/02/18 14:27:35 INFO mapred.TaskTracker: LaunchTaskAction
(registerTask): attempt_20100218142652017_0002_m_000002_0 task's
state:UNASSIGNED
[junit] 10/02/18 14:27:35 INFO mapred.TaskTracker: Trying to launch :
attempt_20100218142652017_0002_m_000002_0
[junit] 10/02/18 14:27:35 INFO mapred.TaskTracker: In TaskLauncher, current
free slots : 2 and trying to launch attempt_20100218142652017_0002_m_000002_0
[junit] 10/02/18 14:27:35 INFO mapred.JvmManager: In JvmRunner constructed
JVM ID: jvm_20100218142652017_0002_m_-1390033111
[junit] 10/02/18 14:27:35 INFO mapred.JvmManager: JVM Runner
jvm_20100218142652017_0002_m_-1390033111 spawned.
[junit] 10/02/18 14:27:35 INFO mapReduceLayer.MapReduceLauncher: 50%
complete
[junit] 10/02/18 14:27:35 INFO mapred.TaskTracker: JVM with ID:
jvm_20100218142652017_0002_m_-1390033111 given task:
attempt_20100218142652017_0002_m_000002_0
[junit] 10/02/18 14:27:36 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000002_0 0.0%
[junit] 10/02/18 14:27:36 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=delete
src=/tmp/temp1664457296/tmp-1296460196/_temporary dst=null
perm=null
[junit] 10/02/18 14:27:36 INFO mapred.TaskTracker:
attempt_20100218142652017_0002_m_000002_0 0.0% cleanup
[junit] 10/02/18 14:27:36 INFO mapred.TaskTracker: Task
attempt_20100218142652017_0002_m_000002_0 is done.
[junit] 10/02/18 14:27:36 INFO mapred.TaskTracker: reported output size for
attempt_20100218142652017_0002_m_000002_0 was 0
[junit] 10/02/18 14:27:36 INFO mapred.TaskTracker: addFreeSlot : current
free slots : 2
[junit] 10/02/18 14:27:36 INFO mapred.JvmManager: JVM :
jvm_20100218142652017_0002_m_-1390033111 exited. Number of tasks it ran: 1
[junit] 10/02/18 14:27:38 INFO mapred.TaskTracker:
org.apache.hadoop.util.DiskChecker$DiskErrorException: Could not find
taskTracker/jobcache/job_20100218142652017_0002/attempt_20100218142652017_0002_m_000002_0/output/file.out
in any of the configured local directories
[junit] 10/02/18 14:27:38 INFO mapred.JobInProgress: Task
'attempt_20100218142652017_0002_m_000002_0' has completed
task_20100218142652017_0002_m_000002 successfully.
[junit] 10/02/18 14:27:38 INFO mapred.JobInProgress: Job
job_20100218142652017_0002 has completed successfully.
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.allocateBlock:
/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_hudson_Job49626562104165072.jar.
blk_-5190046973993338672_1019
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: Receiving block
blk_-5190046973993338672_1019 src: /127.0.0.1:36559 dest: /127.0.0.1:60287
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: Receiving block
blk_-5190046973993338672_1019 src: /127.0.0.1:36058 dest: /127.0.0.1:32979
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: Receiving block
blk_-5190046973993338672_1019 src: /127.0.0.1:60332 dest: /127.0.0.1:47319
[junit] 10/02/18 14:27:38 INFO DataNode.clienttrace: src: /127.0.0.1:60332,
dest: /127.0.0.1:47319, bytes: 6115, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-1035847289-127.0.1.1-47319-1266503211943,
blockid: blk_-5190046973993338672_1019
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: PacketResponder 0 for
block blk_-5190046973993338672_1019 terminating
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:47319 is added to
blk_-5190046973993338672_1019 size 6115
[junit] 10/02/18 14:27:38 INFO DataNode.clienttrace: src: /127.0.0.1:36058,
dest: /127.0.0.1:32979, bytes: 6115, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-27052338-127.0.1.1-32979-1266503211469,
blockid: blk_-5190046973993338672_1019
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:32979 is added to
blk_-5190046973993338672_1019 size 6115
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: PacketResponder 1 for
block blk_-5190046973993338672_1019 terminating
[junit] 10/02/18 14:27:38 INFO DataNode.clienttrace: src: /127.0.0.1:36559,
dest: /127.0.0.1:60287, bytes: 6115, op: HDFS_WRITE, cliID:
DFSClient_-1266622966, srvID: DS-765087567-127.0.1.1-60287-1266503211020,
blockid: blk_-5190046973993338672_1019
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:60287 is added to
blk_-5190046973993338672_1019 size 6115
[junit] 10/02/18 14:27:38 INFO datanode.DataNode: PacketResponder 2 for
block blk_-5190046973993338672_1019 terminating
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: DIR*
NameSystem.completeFile: file
/tmp/temp1664457296/tmp-1296460196/_logs/history/localhost_1266503212040_job_20100218142652017_0002_hudson_Job49626562104165072.jar
is closed by DFSClient_-1266622966
[junit] 10/02/18 14:27:38 INFO mapred.JobTracker: Removed completed task
'attempt_20100218142652017_0002_m_000001_0' from
'tracker_host0.foo.com:localhost/127.0.0.1:44083'
[junit] 10/02/18 14:27:38 INFO mapred.JobTracker: Removed completed task
'attempt_20100218142652017_0002_m_000002_0' from
'tracker_host0.foo.com:localhost/127.0.0.1:44083'
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_5276665465226215722 is added to invalidSet of
127.0.0.1:60287
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_5276665465226215722 is added to invalidSet of
127.0.0.1:32979
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_5276665465226215722 is added to invalidSet of
127.0.0.1:47319
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_3398506634867950097 is added to invalidSet of
127.0.0.1:47319
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_3398506634867950097 is added to invalidSet of
127.0.0.1:32979
[junit] 10/02/18 14:27:38 INFO mapred.TaskTracker: Received 'KillJobAction'
for job: job_20100218142652017_0002
[junit] 10/02/18 14:27:38 INFO mapred.TaskRunner:
attempt_20100218142652017_0002_m_000002_0 done; removing files.
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_3398506634867950097 is added to invalidSet of
127.0.0.1:60287
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_8068977330733341753 is added to invalidSet of
127.0.0.1:47319
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_8068977330733341753 is added to invalidSet of
127.0.0.1:32979
[junit] 10/02/18 14:27:38 INFO hdfs.StateChange: BLOCK*
NameSystem.addToInvalidates: blk_8068977330733341753 is added to invalidSet of
127.0.0.1:60287
[junit] 10/02/18 14:27:38 INFO mapred.IndexCache: Map ID
attempt_20100218142652017_0002_m_000002_0 not found in cache
[junit] 10/02/18 14:27:38 INFO mapred.TaskRunner:
attempt_20100218142652017_0002_m_000001_0 done; removing files.
[junit] 10/02/18 14:27:38 INFO mapred.IndexCache: Map ID
attempt_20100218142652017_0002_m_000001_0 not found in cache
[junit] 10/02/18 14:27:38 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=delete
src=/tmp/hadoop-hudson/mapred/system/job_20100218142652017_0002 dst=null
perm=null
[junit] 10/02/18 14:27:38 INFO mapred.TaskTracker: Received 'KillJobAction'
for job: job_20100218142652017_0002
[junit] 10/02/18 14:27:38 WARN mapred.TaskTracker: Unknown job
job_20100218142652017_0002 being deleted.
[junit] 10/02/18 14:27:39 INFO mapred.TaskTracker: Received 'KillJobAction'
for job: job_20100218142652017_0002
[junit] 10/02/18 14:27:39 WARN mapred.TaskTracker: Unknown job
job_20100218142652017_0002 being deleted.
[junit] 10/02/18 14:27:39 INFO mapReduceLayer.MapReduceLauncher: 100%
complete
[junit] 10/02/18 14:27:39 INFO mapReduceLayer.MapReduceLauncher:
Successfully stored result in:
"hdfs://localhost:37828/tmp/temp1664457296/tmp-1296460196"
[junit] 10/02/18 14:27:39 INFO mapReduceLayer.MapReduceLauncher: Records
written : 2
[junit] 10/02/18 14:27:39 INFO mapReduceLayer.MapReduceLauncher: Bytes
written : 78
[junit] 10/02/18 14:27:39 INFO mapReduceLayer.MapReduceLauncher: Success!
[junit] 10/02/18 14:27:39 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=listStatus src=/tmp/temp1664457296/tmp-1296460196
dst=null perm=null
[junit] 10/02/18 14:27:39 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/temp1664457296/tmp-1296460196/part-00000 dst=null
perm=null
[junit] 10/02/18 14:27:39 INFO DataNode.clienttrace: src: /127.0.0.1:32979,
dest: /127.0.0.1:36060, bytes: 43, op: HDFS_READ, cliID: DFSClient_-1266622966,
srvID: DS-27052338-127.0.1.1-32979-1266503211469, blockid:
blk_7061000197120941720_1018
[junit] 10/02/18 14:27:39 INFO FSNamesystem.audit: ugi=hudson,hudson
ip=/127.0.0.1 cmd=open
src=/tmp/temp1664457296/tmp-1296460196/part-00001 dst=null
perm=null
[junit] 10/02/18 14:27:39 INFO DataNode.clienttrace: src: /127.0.0.1:60287,
dest: /127.0.0.1:36563, bytes: 43, op: HDFS_READ, cliID: DFSClient_-1266622966,
srvID: DS-765087567-127.0.1.1-60287-1266503211020, blockid:
blk_-1297509060924874361_1019
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 44.555 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: 257 minutes 26 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
