See http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/770/changes
Changes:
[yhemanth] HADOOP-4638. Fixes job recovery to not crash the job tracker for
problems with a single job file. Contributed by Amar Kamat.
[yhemanth] HADOOP-4744. Workaround for jetty6 returning -1 when getLocalPort is
invoked on the connector, by retrying a few times. Contributed by Jothi
Padmanabhan.
------------------------------------------
[...truncated 299791 lines...]
[junit] 2009-03-02 19:15:02,711 INFO mapred.IndexCache
(IndexCache.java:<init>(46)) - IndexCache created with max memory = 10485760
[junit] 2009-03-02 19:15:02,822 INFO net.NetworkTopology
(NetworkTopology.java:add(328)) - Adding a new node: /default-rack/host1.foo.com
[junit] 2009-03-02 19:15:02,827 INFO net.NetworkTopology
(NetworkTopology.java:add(328)) - Adding a new node: /default-rack/host0.foo.com
[junit] rootdir = /test/testDistCh
[junit] root=/test/testDistCh, returnvalue=0
[junit] results:
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f1
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f2
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f3
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub0
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub0/f4
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub1
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub2
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub2/f5
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub2/f6
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub3
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub3/f7
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub3/f8
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub4
[junit]
[junit] args=[/test/testDistCh/sub0:sub0:sub0:,
[junit] /test/testDistCh/sub2:sub2::620]
[junit] newstatus=[sub0:sub0:rwxr-xr-x,
[junit] hudson:supergroup:rwxr-xr-x,
[junit] sub2:supergroup:rw--w----,
[junit] hudson:supergroup:rwxr-xr-x,
[junit] hudson:supergroup:rwxr-xr-x]
[junit] 2009-03-02 19:15:03,276 INFO tools.DistTool (DistCh.java:run(376))
- ops=[/test/testDistCh/sub0:sub0:sub0:null,
/test/testDistCh/sub2:sub2:null:rw--w----]
[junit] 2009-03-02 19:15:03,277 INFO tools.DistTool (DistCh.java:run(377))
- isIgnoreFailures=false
[junit] 2009-03-02 19:15:03,295 INFO tools.DistTool
(DistCh.java:setup(427)) -
distch.job.dir=hdfs://localhost:38656/user/hudson/build/test/mapred/system/distch_m477q4
[junit] 2009-03-02 19:15:03,298 INFO tools.DistTool
(DistCh.java:setup(433)) -
log=hdfs://localhost:38656/user/hudson/build/test/mapred/system/distch_m477q4/_logs
[junit] 2009-03-02 19:15:03,377 INFO tools.DistTool
(DistCh.java:setup(476)) - distch.op.count=5
[junit] 2009-03-02 19:15:03,384 WARN mapred.JobClient
(JobClient.java:configureCommandLineOptions(539)) - Use GenericOptionsParser
for parsing the arguments. Applications should implement Tool for the same.
[junit] 2009-03-02 19:15:03,389 WARN mapred.JobClient
(JobClient.java:configureCommandLineOptions(661)) - No job jar file set. User
classes may not be found. See JobConf(Class) or JobConf#setJar(String).
[junit] 2009-03-02 19:15:03,402 INFO tools.DistTool
(DistCh.java:getSplits(261)) - numSplits=1, splits.size()=1
[junit] 2009-03-02 19:15:03,522 WARN conf.Configuration
(Configuration.java:loadResource(1153)) -
build/test/mapred/local/jobTracker/job_200903021914_0001.xml:a attempt to
override final parameter: hadoop.tmp.dir; Ignoring.
[junit] 2009-03-02 19:15:03,550 INFO mapred.JobClient
(JobClient.java:runJob(1268)) - Running job: job_200903021914_0001
[junit] 2009-03-02 19:15:03,789 INFO mapred.JobInProgress
(JobInProgress.java:initTasks(426)) - Input size for job job_200903021914_0001
= 563
[junit] 2009-03-02 19:15:03,790 INFO mapred.JobInProgress
(JobInProgress.java:initTasks(428)) - Split info for job:job_200903021914_0001
with 1 splits:
[junit] 2009-03-02 19:15:04,554 INFO mapred.JobClient
(JobClient.java:runJob(1291)) - map 0% reduce 0%
[junit] 2009-03-02 19:15:05,846 INFO mapred.JobTracker
(JobTracker.java:createTaskEntry(1692)) - Adding task
'attempt_200903021914_0001_m_000002_0' to tip task_200903021914_0001_m_000002,
for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:05,921 WARN conf.Configuration
(Configuration.java:loadResource(1153)) -
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/test/mapred/local/1_0/taskTracker/jobcache/job_200903021914_0001/job.xml
:a attempt to override final parameter: hadoop.tmp.dir; Ignoring.
[junit] 2009-03-02 19:15:05,978 INFO mapred.JvmManager
(JvmManager.java:<init>(323)) - In JvmRunner constructed JVM ID:
jvm_200903021914_0001_m_-680180399
[junit] 2009-03-02 19:15:05,978 INFO mapred.JvmManager
(JvmManager.java:spawnNewJvm(294)) - JVM Runner
jvm_200903021914_0001_m_-680180399 spawned.
[junit] 2009-03-02 19:15:06,934 INFO mapred.JvmManager
(JvmManager.java:runChild(347)) - JVM : jvm_200903021914_0001_m_-680180399
exited. Number of tasks it ran: 1
[junit] 2009-03-02 19:15:08,855 INFO mapred.JobInProgress
(JobInProgress.java:completedTask(1985)) - Task
'attempt_200903021914_0001_m_000002_0' has completed
task_200903021914_0001_m_000002 successfully.
[junit] 2009-03-02 19:15:08,860 INFO mapred.JobInProgress
(JobInProgress.java:findNewMapTask(1820)) - Choosing a non-local task
task_200903021914_0001_m_000000
[junit] 2009-03-02 19:15:08,860 INFO mapred.JobTracker
(JobTracker.java:createTaskEntry(1692)) - Adding task
'attempt_200903021914_0001_m_000000_0' to tip task_200903021914_0001_m_000000,
for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:08,865 INFO mapred.TaskRunner
(MapTaskRunner.java:close(43)) - attempt_200903021914_0001_m_000002_0 done;
removing files.
[junit] 2009-03-02 19:15:08,866 INFO mapred.IndexCache
(IndexCache.java:removeMap(140)) - Map ID attempt_200903021914_0001_m_000002_0
not found in cache
[junit] 2009-03-02 19:15:08,912 INFO mapred.JvmManager
(JvmManager.java:<init>(323)) - In JvmRunner constructed JVM ID:
jvm_200903021914_0001_m_204408398
[junit] 2009-03-02 19:15:08,912 INFO mapred.JvmManager
(JvmManager.java:spawnNewJvm(294)) - JVM Runner
jvm_200903021914_0001_m_204408398 spawned.
[junit] 2009-03-02 19:15:09,574 INFO mapred.JobClient
(JobClient.java:runJob(1340)) - Task Id : attempt_200903021914_0001_m_000002_0,
Status : SUCCEEDED
[junit] attempt_200903021914_0001_m_000002_0: 2009-03-02 19:15:06,578 WARN
conf.Configuration (Configuration.java:loadResource(1153)) -
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/test/mapred/local/1_0/taskTracker/jobcache/job_200903021914_0001/attempt_200903021914_0001_m_000002_0/job.xml
:a attempt to override final parameter: hadoop.tmp.dir; Ignoring.
[junit] attempt_200903021914_0001_m_000002_0: 2009-03-02 19:15:06,658 INFO
jvm.JvmMetrics (JvmMetrics.java:init(71)) - Initializing JVM Metrics with
processName=MAP, sessionId=
[junit] attempt_200903021914_0001_m_000002_0: 2009-03-02 19:15:06,747 WARN
conf.Configuration (Configuration.java:loadResource(1153)) -
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/test/mapred/local/1_0/taskTracker/jobcache/job_200903021914_0001/attempt_200903021914_0001_m_000002_0/job.xml
:a attempt to override final parameter: hadoop.tmp.dir; Ignoring.
[junit] attempt_200903021914_0001_m_000002_0: 2009-03-02 19:15:06,798 INFO
mapred.TaskRunner (Task.java:done(644)) -
Task:attempt_200903021914_0001_m_000002_0 is done. And is in the process of
commiting
[junit] attempt_200903021914_0001_m_000002_0: 2009-03-02 19:15:06,804 INFO
mapred.TaskRunner (Task.java:sendDone(715)) - Task
'attempt_200903021914_0001_m_000002_0' done.
[junit] 2009-03-02 19:15:12,057 INFO mapred.JvmManager
(JvmManager.java:runChild(347)) - JVM : jvm_200903021914_0001_m_204408398
exited. Number of tasks it ran: 1
[junit] 2009-03-02 19:15:14,870 INFO mapred.JobInProgress
(JobInProgress.java:completedTask(1985)) - Task
'attempt_200903021914_0001_m_000000_0' has completed
task_200903021914_0001_m_000000 successfully.
[junit] 2009-03-02 19:15:14,874 INFO mapred.JobTracker
(JobTracker.java:createTaskEntry(1692)) - Adding task
'attempt_200903021914_0001_m_000001_0' to tip task_200903021914_0001_m_000001,
for tracker 'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:14,908 INFO mapred.JvmManager
(JvmManager.java:<init>(323)) - In JvmRunner constructed JVM ID:
jvm_200903021914_0001_m_-1347310764
[junit] 2009-03-02 19:15:14,908 INFO mapred.JvmManager
(JvmManager.java:spawnNewJvm(294)) - JVM Runner
jvm_200903021914_0001_m_-1347310764 spawned.
[junit] 2009-03-02 19:15:15,651 INFO mapred.JobClient
(JobClient.java:runJob(1291)) - map 100% reduce 0%
[junit] 2009-03-02 19:15:15,653 INFO mapred.JobClient
(JobClient.java:runJob(1340)) - Task Id : attempt_200903021914_0001_m_000000_0,
Status : SUCCEEDED
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:09,478 WARN
conf.Configuration (Configuration.java:loadResource(1153)) -
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/test/mapred/local/1_0/taskTracker/jobcache/job_200903021914_0001/attempt_200903021914_0001_m_000000_0/job.xml
:a attempt to override final parameter: hadoop.tmp.dir; Ignoring.
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:09,558 INFO
jvm.JvmMetrics (JvmMetrics.java:init(71)) - Initializing JVM Metrics with
processName=MAP, sessionId=
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:09,677 WARN
conf.Configuration (Configuration.java:loadResource(1153)) -
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build/test/mapred/local/1_0/taskTracker/jobcache/job_200903021914_0001/attempt_200903021914_0001_m_000000_0/job.xml
:a attempt to override final parameter: hadoop.tmp.dir; Ignoring.
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:09,774 INFO
mapred.MapTask (MapTask.java:runOldMapper(343)) - numReduceTasks: 0
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:09,907 INFO
mapred.TaskRunner (Task.java:done(644)) -
Task:attempt_200903021914_0001_m_000000_0 is done. And is in the process of
commiting
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:11,916 INFO
mapred.TaskRunner (Task.java:commit(744)) - Task
attempt_200903021914_0001_m_000000_0 is allowed to commit now
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:11,930 INFO
mapred.FileOutputCommitter (FileOutputCommitter.java:commitTask(92)) - Saved
output of task 'attempt_200903021914_0001_m_000000_0' to
hdfs://localhost:38656/user/hudson/build/test/mapred/system/distch_m477q4/_logs
[junit] attempt_200903021914_0001_m_000000_0: 2009-03-02 19:15:11,936 INFO
mapred.TaskRunner (Task.java:sendDone(715)) - Task
'attempt_200903021914_0001_m_000000_0' done.
[junit] 2009-03-02 19:15:15,857 INFO mapred.JvmManager
(JvmManager.java:runChild(347)) - JVM : jvm_200903021914_0001_m_-1347310764
exited. Number of tasks it ran: 1
[junit] 2009-03-02 19:15:17,879 INFO mapred.JobInProgress
(JobInProgress.java:completedTask(1985)) - Task
'attempt_200903021914_0001_m_000001_0' has completed
task_200903021914_0001_m_000001 successfully.
[junit] 2009-03-02 19:15:17,880 INFO mapred.JobInProgress
(JobInProgress.java:jobComplete(2099)) - Job job_200903021914_0001 has
completed successfully.
[junit] 2009-03-02 19:15:17,992 INFO mapred.JobTracker
(JobTracker.java:removeMarkedTasks(1813)) - Removed completed task
'attempt_200903021914_0001_m_000000_0' from
'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:17,992 INFO mapred.JobTracker
(JobTracker.java:removeMarkedTasks(1813)) - Removed completed task
'attempt_200903021914_0001_m_000001_0' from
'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:17,993 INFO mapred.JobTracker
(JobTracker.java:removeMarkedTasks(1813)) - Removed completed task
'attempt_200903021914_0001_m_000002_0' from
'tracker_host1.foo.com:localhost/127.0.0.1:44884'
[junit] 2009-03-02 19:15:18,005 INFO mapred.TaskRunner
(MapTaskRunner.java:close(43)) - attempt_200903021914_0001_m_000001_0 done;
removing files.
[junit] 2009-03-02 19:15:18,006 INFO mapred.IndexCache
(IndexCache.java:removeMap(140)) - Map ID attempt_200903021914_0001_m_000001_0
not found in cache
[junit] 2009-03-02 19:15:18,006 INFO mapred.TaskRunner
(MapTaskRunner.java:close(43)) - attempt_200903021914_0001_m_000000_0 done;
removing files.
[junit] 2009-03-02 19:15:18,007 INFO mapred.IndexCache
(IndexCache.java:removeMap(140)) - Map ID attempt_200903021914_0001_m_000000_0
not found in cache
[junit] 2009-03-02 19:15:18,670 INFO mapred.JobClient
(JobClient.java:runJob(1358)) - Job complete: job_200903021914_0001
[junit] 2009-03-02 19:15:18,672 INFO mapred.JobClient
(Counters.java:log(514)) - Counters: 7
[junit] 2009-03-02 19:15:18,672 INFO mapred.JobClient
(Counters.java:log(516)) - Job Counters
[junit] 2009-03-02 19:15:18,673 INFO mapred.JobClient
(Counters.java:log(518)) - Launched map tasks=1
[junit] 2009-03-02 19:15:18,673 INFO mapred.JobClient
(Counters.java:log(516)) - org.apache.hadoop.tools.DistCh$Counter
[junit] 2009-03-02 19:15:18,673 INFO mapred.JobClient
(Counters.java:log(518)) - SUCCEED=5
[junit] 2009-03-02 19:15:18,674 INFO mapred.JobClient
(Counters.java:log(516)) - FileSystemCounters
[junit] 2009-03-02 19:15:18,674 INFO mapred.JobClient
(Counters.java:log(518)) - HDFS_BYTES_READ=563
[junit] 2009-03-02 19:15:18,674 INFO mapred.JobClient
(Counters.java:log(516)) - Map-Reduce Framework
[junit] 2009-03-02 19:15:18,674 INFO mapred.JobClient
(Counters.java:log(518)) - Map input records=5
[junit] 2009-03-02 19:15:18,675 INFO mapred.JobClient
(Counters.java:log(518)) - Spilled Records=0
[junit] 2009-03-02 19:15:18,675 INFO mapred.JobClient
(Counters.java:log(518)) - Map input bytes=466
[junit] 2009-03-02 19:15:18,675 INFO mapred.JobClient
(Counters.java:log(518)) - Map output records=0
[junit] root=/test/testDistCh, returnvalue=0
[junit] results:
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f1
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f2
[junit] -rw-r--r-- 2 hudson supergroup 38 2009-03-02 19:15
/test/testDistCh/f3
[junit] drwxr-xr-x - sub0 sub0 0 2009-03-02 19:15
/test/testDistCh/sub0
[junit] -rw-r--r-- 2 sub0 sub0 43 2009-03-02 19:15
/test/testDistCh/sub0/f4
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub1
[junit] drw--w---- - sub2 supergroup 0 2009-03-02 19:15
/test/testDistCh/sub2
[junit] -rw--w---- 2 sub2 supergroup 43 2009-03-02 19:15
/test/testDistCh/sub2/f5
[junit] -rw--w---- 2 sub2 supergroup 43 2009-03-02 19:15
/test/testDistCh/sub2/f6
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub3
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub3/f7
[junit] -rw-r--r-- 2 hudson supergroup 43 2009-03-02 19:15
/test/testDistCh/sub3/f8
[junit] drwxr-xr-x - hudson supergroup 0 2009-03-02 19:15
/test/testDistCh/sub4
[junit]
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 1
[junit] 2009-03-02 19:15:18,700 INFO ipc.Server (Server.java:stop(1098)) -
Stopping server on 55372
[junit] 2009-03-02 19:15:18,700 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 0 on 55372: exiting
[junit] 2009-03-02 19:15:18,700 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 2 on 55372: exiting
[junit] 2009-03-02 19:15:18,700 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 1 on 55372: exiting
[junit] 2009-03-02 19:15:18,701 INFO ipc.Server (Server.java:run(352)) -
Stopping IPC Server listener on 55372
[junit] 2009-03-02 19:15:18,701 INFO ipc.Server (Server.java:run(536)) -
Stopping IPC Server Responder
[junit] 2009-03-02 19:15:19,333 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(603)) - Exiting DataBlockScanner thread.
[junit] 2009-03-02 19:15:19,702 INFO ipc.Server (Server.java:stop(1098)) -
Stopping server on 55372
[junit] Shutting down DataNode 0
[junit] 2009-03-02 19:15:19,803 INFO ipc.Server (Server.java:stop(1098)) -
Stopping server on 44107
[junit] 2009-03-02 19:15:19,804 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 0 on 44107: exiting
[junit] 2009-03-02 19:15:19,804 INFO ipc.Server (Server.java:run(352)) -
Stopping IPC Server listener on 44107
[junit] 2009-03-02 19:15:19,804 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 1 on 44107: exiting
[junit] 2009-03-02 19:15:19,804 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 2 on 44107: exiting
[junit] 2009-03-02 19:15:19,804 INFO ipc.Server (Server.java:run(536)) -
Stopping IPC Server Responder
[junit] 2009-03-02 19:15:20,159 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(603)) - Exiting DataBlockScanner thread.
[junit] 2009-03-02 19:15:20,804 INFO ipc.Server (Server.java:stop(1098)) -
Stopping server on 44107
[junit] 2009-03-02 19:15:20,907 INFO ipc.Server (Server.java:stop(1098)) -
Stopping server on 38656
[junit] 2009-03-02 19:15:20,907 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 3 on 38656: exiting
[junit] 2009-03-02 19:15:20,907 INFO namenode.DecommissionManager
(DecommissionManager.java:run(67)) - Interrupted Monitor
[junit] java.lang.InterruptedException: sleep interrupted
[junit] at java.lang.Thread.sleep(Native Method)
[junit] at
org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor.run(DecommissionManager.java:65)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 6 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 7 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 0 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 5 on 38656: exiting
[junit] 2009-03-02 19:15:20,907 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 4 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(536)) -
Stopping IPC Server Responder
[junit] 2009-03-02 19:15:20,907 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 2 on 38656: exiting
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 31.075 sec
[junit] 2009-03-02 19:15:20,907 INFO ipc.Server (Server.java:run(352)) -
Stopping IPC Server listener on 38656
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 8 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 1 on 38656: exiting
[junit] 2009-03-02 19:15:20,908 INFO ipc.Server (Server.java:run(992)) -
IPC Server handler 9 on 38656: exiting
[junit] Running org.apache.hadoop.util.TestCyclicIteration
[junit]
[junit]
[junit] integers=[]
[junit] map={}
[junit] start=-1, iteration=[]
[junit]
[junit]
[junit] integers=[0]
[junit] map={0=0}
[junit] start=-1, iteration=[0]
[junit] start=0, iteration=[0]
[junit] start=1, iteration=[0]
[junit]
[junit]
[junit] integers=[0, 2]
[junit] map={0=0, 2=2}
[junit] start=-1, iteration=[0, 2]
[junit] start=0, iteration=[2, 0]
[junit] start=1, iteration=[2, 0]
[junit] start=2, iteration=[0, 2]
[junit] start=3, iteration=[0, 2]
[junit]
[junit]
[junit] integers=[0, 2, 4]
[junit] map={0=0, 2=2, 4=4}
[junit] start=-1, iteration=[0, 2, 4]
[junit] start=0, iteration=[2, 4, 0]
[junit] start=1, iteration=[2, 4, 0]
[junit] start=2, iteration=[4, 0, 2]
[junit] start=3, iteration=[4, 0, 2]
[junit] start=4, iteration=[0, 2, 4]
[junit] start=5, iteration=[0, 2, 4]
[junit]
[junit]
[junit] integers=[0, 2, 4, 6]
[junit] map={0=0, 2=2, 4=4, 6=6}
[junit] start=-1, iteration=[0, 2, 4, 6]
[junit] start=0, iteration=[2, 4, 6, 0]
[junit] start=1, iteration=[2, 4, 6, 0]
[junit] start=2, iteration=[4, 6, 0, 2]
[junit] start=3, iteration=[4, 6, 0, 2]
[junit] start=4, iteration=[6, 0, 2, 4]
[junit] start=5, iteration=[6, 0, 2, 4]
[junit] start=6, iteration=[0, 2, 4, 6]
[junit] start=7, iteration=[0, 2, 4, 6]
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.087 sec
[junit] Running org.apache.hadoop.util.TestGenericsUtil
[junit] 2009-03-02 19:15:22,032 WARN conf.Configuration
(Configuration.java:<clinit>(175)) - DEPRECATED: hadoop-site.xml found in the
classpath. Usage of hadoop-site.xml is deprecated. Instead use core-site.xml,
mapred-site.xml and hdfs-site.xml to override properties of core-default.xml,
mapred-default.xml and hdfs-default.xml respectively
[junit] 2009-03-02 19:15:22,044 WARN util.GenericOptionsParser
(GenericOptionsParser.java:parseGeneralOptions(377)) - options parsing failed:
Missing argument for option:jt
[junit] usage: general options are:
[junit] -archives <paths> comma separated archives to be
unarchived
[junit] on the compute machines.
[junit] -conf <configuration file> specify an application configuration
file
[junit] -D <property=value> use value for given property
[junit] -files <paths> comma separated files to be copied
to the
[junit] map reduce cluster
[junit] -fs <local|namenode:port> specify a namenode
[junit] -jt <local|jobtracker:port> specify a job tracker
[junit] -libjars <paths> comma separated jar files to include
in the
[junit] classpath.
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.184 sec
[junit] Running org.apache.hadoop.util.TestIndexedSort
[junit] sortRandom seed:
8350212373966102532(org.apache.hadoop.util.QuickSort)
[junit] testSorted seed:
-5145397827608362279(org.apache.hadoop.util.QuickSort)
[junit] testAllEqual setting min/max at
115/292(org.apache.hadoop.util.QuickSort)
[junit] sortWritable seed:
349868019564119539(org.apache.hadoop.util.QuickSort)
[junit] QuickSort degen cmp/swp:
23252/3713(org.apache.hadoop.util.QuickSort)
[junit] sortRandom seed: 413046522922751435(org.apache.hadoop.util.HeapSort)
[junit] testSorted seed:
3342023026909933194(org.apache.hadoop.util.HeapSort)
[junit] testAllEqual setting min/max at
228/469(org.apache.hadoop.util.HeapSort)
[junit] sortWritable seed:
3530470734220596879(org.apache.hadoop.util.HeapSort)
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.896 sec
[junit] Running org.apache.hadoop.util.TestProcfsBasedProcessTree
[junit] 2009-03-02 19:15:23,635 INFO util.ProcessTree
(ProcessTree.java:isSetsidSupported(54)) - setsid exited with exit code 0
[junit] 2009-03-02 19:15:24,140 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:testProcessTree(141)) - Root process pid: 21389
[junit] 2009-03-02 19:15:24,189 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:testProcessTree(146)) - ProcessTree: [ 21391
21389 21392 ]
[junit] 2009-03-02 19:15:30,713 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:testProcessTree(159)) - ProcessTree: [ 21403
21401 21391 21405 21389 21395 21393 21399 21397 ]
[junit] 2009-03-02 19:15:30,764 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:run(64)) - Shell Command exit with a non-zero
exit code. This is expected as we are killing the subprocesses of the task
intentionally. org.apache.hadoop.util.Shell$ExitCodeException:
[junit] 2009-03-02 19:15:30,764 INFO util.ProcessTree
(ProcessTree.java:destroyProcessGroup(160)) - Killing all processes in the
process group 21389 with SIGTERM. Exit code 0
[junit] 2009-03-02 19:15:30,765 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:run(70)) - Exit code: 143
[junit] 2009-03-02 19:15:30,851 INFO util.TestProcfsBasedProcessTree
(TestProcfsBasedProcessTree.java:testProcessTree(173)) - RogueTaskThread
successfully joined.
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 7.27 sec
[junit] Running org.apache.hadoop.util.TestReflectionUtils
[junit] 2009-03-02 19:15:31,690 WARN conf.Configuration
(Configuration.java:<clinit>(175)) - DEPRECATED: hadoop-site.xml found in the
classpath. Usage of hadoop-site.xml is deprecated. Instead use core-site.xml,
mapred-site.xml and hdfs-site.xml to override properties of core-default.xml,
mapred-default.xml and hdfs-default.xml respectively
[junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 0.563 sec
[junit] Running org.apache.hadoop.util.TestShell
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.181 sec
[junit] Running org.apache.hadoop.util.TestStringUtils
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.084 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/ws/trunk/build.xml :769:
Tests failed!
Total time: 184 minutes 29 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Publishing Clover coverage report...