hadoop-common-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Amit Kumar Singh <amitsi...@cse.iitb.ac.in>
Subject Reduce task is stalled. Just wont execute
Date Thu, 08 May 2008 04:30:03 GMT
Hi,

I have been trying word count example distributed with Hadoop 0.16.3.
It works fine on single machine mode. But the moment i add an extra 
slave reduce phase stalls.

I Get following message in my logs SLAVE
.
2008-05-07 23:37:27,860 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:37:33,862 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:37:39,864 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:37:42,866 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:37:48,868 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:37:54,870 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:00,872 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:03,873 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:09,875 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:15,876 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:18,878 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:24,880 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:30,882 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:38:33,883 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:18,898 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:24,900 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:30,902 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:33,903 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:39,905 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:45,907 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:48,908 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:39:54,910 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:00,912 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:03,913 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:09,915 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:15,917 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:18,919 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:24,921 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:27,120 INFO org.apache.hadoop.mapred.TaskTracker: 
LaunchTaskAction: task_200805080929_0001_m_000001_1
2008-05-07 23:40:28,705 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_m_000001_1 1.0% 
hdfs://master:54310/user/hadoop/d3:337381+337381
2008-05-07 23:40:28,708 INFO org.apache.hadoop.mapred.TaskTracker: Task 
task_200805080929_0001_m_000001_1 is done.
2008-05-07 23:40:30,923 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.16666667% reduce > copy (1 of 2 at 
0.03 MB/s) >
2008-05-07 23:40:36,925 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.33333334% reduce > copy (2 of 2 at 
0.00 MB/s)
2008-05-07 23:40:37,558 INFO org.apache.hadoop.mapred.TaskTracker: 
task_200805080929_0001_r_000000_0 0.8684772% reduce > reduce
2008-05-07 23:40:37,559 INFO org.apache.hadoop.mapred.TaskTracker: Task 
task_200805080929_0001_r_000000_0 is done.
2008-05-07 23:40:39,692 INFO org.apache.hadoop.mapred.TaskTracker: 
Received 'KillJobAction' for job: job_200805080929_0001
2008-05-07 23:40:39,692 INFO org.apache.hadoop.mapred.TaskRunner: 
task_200805080929_0001_m_000001_1 done; removing files.
2008-05-07 23:40:39,695 INFO org.apache.hadoop.mapred.TaskRunner: 
task_200805080929_0001_m_000000_0 done; removing files.
2008-05-07 23:40:39,698 INFO org.apache.hadoop.mapred.TaskRunner: 
task_200805080929_0001_r_000000_0 done; removing files.
2008-05-07 23:45:49,869 INFO org.apache.hadoop.mapred.TaskTracker: 
LaunchTaskAction: task_200805080929_0002_m_000001_0


And in MASTER(which is also a slave)
008-05-08 09:30:58,991 INFO org.apache.hadoop.mapred.JobInProgress: Task 
'task_200805080929_0001_m_000000_0' has completed 
tip_200805080929_0001_m_000000 successfully.
2008-05-08 09:33:39,111 INFO org.apache.hadoop.mapred.JobInProgress: 
Failed fetch notification #1 for task task_200805080929_0001_m_000001_0
2008-05-08 09:36:14,303 INFO org.apache.hadoop.conf.Configuration: found 
resource webapps/static/jobconf.xsl at 
file:/home/hadoop/HADOOP/hadoop-0.16.3/webapps/static/jobconf.xsl
2008-05-08 09:38:36,511 INFO org.apache.hadoop.mapred.JobInProgress: 
Failed fetch notification #2 for task task_200805080929_0001_m_000001_0
2008-05-08 09:43:44,540 INFO org.apache.hadoop.mapred.JobInProgress: 
Failed fetch notification #3 for task task_200805080929_0001_m_000001_0
2008-05-08 09:43:44,540 INFO org.apache.hadoop.mapred.JobInProgress:* 
Too many fetch-failures for output of task: 
ta*sk_200805080929_0001_m_000001_0 ... killing it
2008-05-08 09:43:44,540 INFO org.apache.hadoop.mapred.TaskInProgress: 
Error from task_200805080929_0001_m_000001_0: Too many fetch-failures
2008-05-08 09:43:44,541 INFO org.apache.hadoop.mapred.JobInProgress: 
Choosing normal task tip_200805080929_0001_m_000001
2008-05-08 09:43:44,541 INFO org.apache.hadoop.mapred.JobTracker: Adding 
task 'task_200805080929_0001_m_000001_1' to tip 
tip_200805080929_0001_m_000001, for tracker 
'tracker_mtech-desktop:localhost/127.0.0.1:39716'
2008-05-08 09:43:46,695 INFO org.apache.hadoop.mapred.TaskRunner: Saved 
output of task 'task_200805080929_0001_m_000001_1' to 
hdfs://master:54310/user/hadoop/d4
2008-05-08 09:43:46,695 INFO org.apache.hadoop.mapred.JobInProgress: 
Task 'task_200805080929_0001_m_000001_1' has completed 
tip_200805080929_0001_m_000001 successfully.
2008-05-08 09:43:46,757 INFO org.apache.hadoop.mapred.JobTracker: 
Removed completed task 'task_200805080929_0001_m_000001_0' from 'tracker_cse


Can any one give some ideas as to what might be the problem.

Configuration of cluster is as per 
(http://www.michael-noll.com/wiki/Running_Hadoop_On_Ubuntu_Linux_%28Multi-Node_Cluster%29)

Mime
View raw message