hadoop-common-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From hud...@lucene.zones.apache.org
Subject Build failed in Hudson: Hadoop-Nightly #285
Date Mon, 29 Oct 2007 02:15:30 GMT
See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/285/changes

------------------------------------------
[...truncated 32789 lines...]
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:26,947 INFO  mapred.ReduceTask
(ReduceTask.java:fetchOutputs(977)) - task_200710290213_0004_r_000001_0 Scheduled 1 of 1 known
outputs (0 slow hosts and 0 dup hosts)
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:26,948 INFO  mapred.ReduceTask
(ReduceTask.java:copyOutput(703)) - task_200710290213_0004_r_000001_0 Copying task_200710290213_0004_m_000000_0
output from lucene.zones.apache.org.
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:26,959 INFO  mapred.ReduceTask
(ReduceTask.java:copyOutput(751)) - task_200710290213_0004_r_000001_0 done copying task_200710290213_0004_m_000000_0
output from lucene.zones.apache.org.
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:26,980 INFO  mapred.ReduceTask
(ReduceTask.java:fetchOutputs(1121)) - task_200710290213_0004_r_000001_0 Copying of all map
outputs complete. Initiating the last merge on the remaining files in ramfs://mapoutput13480046
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:27,448 INFO  mapred.ReduceTask
(ReduceTask.java:fetchOutputs(1165)) - task_200710290213_0004_r_000001_0 Merge of the 2 files
in InMemoryFileSystem complete. Local file is http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/mapred/local/1_0/task_200710290213_0004_r_000001_0/map_0.out

    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:27,502 INFO  pipes.PipesReducer
(PipesReducer.java:startApplication(68)) - starting application
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:27,634 INFO  pipes.PipesReducer
(PipesReducer.java:close(102)) - waiting for finish
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:27,639 INFO  pipes.PipesReducer
(PipesReducer.java:close(104)) - got done
    [junit] task_200710290213_0004_r_000001_0: 2007-10-29 02:14:27,647 INFO  mapred.TaskRunner
(Task.java:done(382)) - Task 'task_200710290213_0004_r_000001_0' done.
    [junit] 2007-10-29 02:14:29,295 INFO  mapred.JobClient (JobClient.java:runJob(833)) -
Job complete: job_200710290213_0004
    [junit] 2007-10-29 02:14:29,296 INFO  mapred.JobClient (Counters.java:log(367)) - Counters:
6
    [junit] 2007-10-29 02:14:29,297 INFO  mapred.JobClient (Counters.java:log(371)) -   Job
Counters 
    [junit] 2007-10-29 02:14:29,297 INFO  mapred.JobClient (Counters.java:log(373)) -    
Launched map tasks=2
    [junit] 2007-10-29 02:14:29,297 INFO  mapred.JobClient (Counters.java:log(373)) -    
Launched reduce tasks=2
    [junit] 2007-10-29 02:14:29,298 INFO  mapred.JobClient (Counters.java:log(371)) -   Map-Reduce
Framework
    [junit] 2007-10-29 02:14:29,298 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output records=13
    [junit] 2007-10-29 02:14:29,298 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output bytes=86
    [junit] 2007-10-29 02:14:29,298 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input groups=11
    [junit] 2007-10-29 02:14:29,299 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input records=13
    [junit] 2007-10-29 02:14:29,300 INFO  mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(206))
- Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:62084 to be idle.
    [junit] 2007-10-29 02:14:29,895 INFO  mapred.JobTracker (JobTracker.java:removeMarkedTasks(901))
- Removed completed task 'task_200710290213_0004_m_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62085'
    [junit] 2007-10-29 02:14:29,896 INFO  mapred.JobTracker (JobTracker.java:removeMarkedTasks(901))
- Removed completed task 'task_200710290213_0004_r_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62085'
    [junit] 2007-10-29 02:14:29,897 INFO  mapred.TaskTracker (TaskTracker.java:purgeJob(994))
- Received 'KillJobAction' for job: job_200710290213_0004
    [junit] 2007-10-29 02:14:29,897 INFO  mapred.TaskRunner (MapTaskRunner.java:close(41))
- task_200710290213_0004_m_000000_0 done; removing files.
    [junit] 2007-10-29 02:14:29,900 INFO  mapred.TaskRunner (ReduceTaskRunner.java:close(45))
- task_200710290213_0004_r_000001_0 done; removing files.
    [junit] 2007-10-29 02:14:30,187 INFO  dfs.DataNode (FSDataset.java:invalidate(709)) -
Deleting block blk_2835197432124045512 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data1/current/blk_2835197432124045512

    [junit] 2007-10-29 02:14:30,188 INFO  dfs.DataNode (FSDataset.java:invalidate(709)) -
Deleting block blk_6255534627867866313 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data2/current/blk_6255534627867866313

    [junit] 2007-10-29 02:14:30,304 INFO  mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(206))
- Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:62084 to be idle.
    [junit] 2007-10-29 02:14:30,516 INFO  mapred.JobTracker (JobTracker.java:removeMarkedTasks(901))
- Removed completed task 'task_200710290213_0004_m_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62084'
    [junit] 2007-10-29 02:14:30,516 INFO  mapred.JobTracker (JobTracker.java:removeMarkedTasks(901))
- Removed completed task 'task_200710290213_0004_r_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62084'
    [junit] 2007-10-29 02:14:30,517 INFO  mapred.TaskTracker (TaskTracker.java:purgeJob(994))
- Received 'KillJobAction' for job: job_200710290213_0004
    [junit] 2007-10-29 02:14:30,517 INFO  mapred.TaskRunner (ReduceTaskRunner.java:close(45))
- task_200710290213_0004_r_000000_0 done; removing files.
    [junit] 2007-10-29 02:14:30,518 INFO  mapred.TaskRunner (MapTaskRunner.java:close(41))
- task_200710290213_0004_m_000001_0 done; removing files.
    [junit] 2007-10-29 02:14:30,956 INFO  dfs.DataNode (FSDataset.java:invalidate(709)) -
Deleting block blk_2835197432124045512 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data3/current/blk_2835197432124045512

    [junit] 2007-10-29 02:14:30,957 INFO  dfs.DataNode (FSDataset.java:invalidate(709)) -
Deleting block blk_6255534627867866313 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data4/current/blk_6255534627867866313

    [junit] 2007-10-29 02:14:31,321 INFO  ipc.Server (Server.java:stop(677)) - Stopping server
on 62084
    [junit] 2007-10-29 02:14:31,322 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
0 on 62084: exiting
    [junit] 2007-10-29 02:14:31,323 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
1 on 62084: exiting
    [junit] 2007-10-29 02:14:31,323 INFO  ipc.Server (Server.java:run(316)) - Stopping IPC
Server listener on 62084
    [junit] 2007-10-29 02:14:31,323 INFO  mapred.TaskTracker (TaskTracker.java:run(511)) -
Shutting down: Map-events fetcher for all reduce tasks on tracker_lucene.zones.apache.org:/127.0.0.1:62084
    [junit] 2007-10-29 02:14:31,323 INFO  mapred.TaskTracker (TaskTracker.java:shutdown(649))
- Shutting down StatusHttpServer
    [junit] 2007-10-29 02:14:31,327 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:50060
    [junit] 2007-10-29 02:14:31,328 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@1c3e9ba
    [junit] 2007-10-29 02:14:31,511 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:31,689 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:31,814 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:31,815 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@45e228
    [junit] 2007-10-29 02:14:31,816 INFO  mapred.TaskTracker (TaskTracker.java:offerService(829))
- Interrupted. Closing down.
    [junit] 2007-10-29 02:14:31,840 INFO  ipc.Server (Server.java:stop(677)) - Stopping server
on 62085
    [junit] 2007-10-29 02:14:31,840 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
1 on 62085: exiting
    [junit] 2007-10-29 02:14:31,840 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
0 on 62085: exiting
    [junit] 2007-10-29 02:14:31,842 INFO  ipc.Server (Server.java:run(316)) - Stopping IPC
Server listener on 62085
    [junit] 2007-10-29 02:14:31,844 INFO  mapred.TaskTracker (TaskTracker.java:shutdown(649))
- Shutting down StatusHttpServer
    [junit] 2007-10-29 02:14:31,844 INFO  mapred.TaskTracker (TaskTracker.java:run(496)) -
Shutting down: Map-events fetcher for all reduce tasks on tracker_lucene.zones.apache.org:/127.0.0.1:62085
    [junit] 2007-10-29 02:14:31,846 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:50061
    [junit] 2007-10-29 02:14:31,847 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@1bfbfb8
    [junit] 2007-10-29 02:14:31,978 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:32,096 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:32,218 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:32,219 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@2b249
    [junit] 2007-10-29 02:14:32,220 INFO  mapred.TaskTracker (TaskTracker.java:offerService(829))
- Interrupted. Closing down.
    [junit] 2007-10-29 02:14:32,221 INFO  mapred.JobTracker (JobTracker.java:close(739)) -
Stopping infoServer
    [junit] 2007-10-29 02:14:32,222 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:62083
    [junit] 2007-10-29 02:14:32,223 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@1f44ec7
    [junit] 2007-10-29 02:14:32,340 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:32,453 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:32,577 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:32,578 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@111ded2
    [junit] 2007-10-29 02:14:32,578 INFO  mapred.JobTracker (JobTracker.java:close(747)) -
Stopping interTrackerServer
    [junit] 2007-10-29 02:14:32,578 INFO  ipc.Server (Server.java:stop(677)) - Stopping server
on 62081
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
2 on 62081: exiting
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
1 on 62081: exiting
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
4 on 62081: exiting
    [junit] 2007-10-29 02:14:32,579 INFO  mapred.JobTracker (JobTracker.java:close(751)) -
Stopping expireTrackers
    [junit] 2007-10-29 02:14:32,579 INFO  mapred.JobTracker (JobTracker.java:offerService(734))
- Stopped interTrackerServer
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(316)) - Stopping IPC
Server listener on 62081
    [junit] 2007-10-29 02:14:32,580 ERROR mapred.JobTracker (JobTracker.java:run(308)) - Tracker
Expiry Thread got exception: java.lang.InterruptedException: sleep interrupted
    [junit] 	at java.lang.Thread.sleep(Native Method)
    [junit] 	at org.apache.hadoop.mapred.JobTracker$ExpireTrackers.run(JobTracker.java:263)
    [junit] 	at java.lang.Thread.run(Thread.java:595)

    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
0 on 62081: exiting
    [junit] 2007-10-29 02:14:32,581 INFO  mapred.JobTracker (JobTracker.java:close(761)) -
Stopping retirer
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
8 on 62081: exiting
    [junit] 2007-10-29 02:14:32,582 INFO  mapred.JobTracker (JobTracker.java:close(770)) -
Stopping initer
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
9 on 62081: exiting
    [junit] 2007-10-29 02:14:32,582 INFO  mapred.JobTracker (JobTracker.java:close(779)) -
Stopping expireLaunchingTasks
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
5 on 62081: exiting
    [junit] 2007-10-29 02:14:32,583 INFO  mapred.JobTracker (JobTracker.java:close(789)) -
Stopping TaskCommit thread
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
6 on 62081: exiting
    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
3 on 62081: exiting
    [junit] 2007-10-29 02:14:32,583 WARN  mapred.JobTracker (JobTracker.java:run(2014)) -
Task Commit Thread exiting, got interrupted: java.lang.InterruptedException
    [junit] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:1815)
    [junit] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1850)
    [junit] 	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:359)
    [junit] 	at org.apache.hadoop.mapred.JobTracker$TaskCommitQueue.run(JobTracker.java:1916)

    [junit] 2007-10-29 02:14:32,579 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
7 on 62081: exiting
    [junit] 2007-10-29 02:14:32,584 INFO  mapred.JobTracker (JobTracker.java:close(797)) -
stopped all jobtracker services
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2007-10-29 02:14:32,586 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:62080
    [junit] 2007-10-29 02:14:32,587 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@73305c
    [junit] 2007-10-29 02:14:32,714 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:32,841 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:32,968 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:32,968 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@a7dd39
    [junit] 2007-10-29 02:14:32,970 INFO  dfs.DataNode (DataNode.java:run(1512)) - Finishing
DataNode in: FSDataset{dirpath='http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data3/current,/export/home/hudson/hudson/jobs/Hadoop-Nightly/workspace/trunk/build/test/data/dfs/data/data4/current'}

    [junit] Shutting down DataNode 0
    [junit] 2007-10-29 02:14:32,971 INFO  util.ThreadedServer (ThreadedServer.java:run(656))
- Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=62079]
    [junit] 2007-10-29 02:14:32,972 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:62079
    [junit] 2007-10-29 02:14:32,973 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@933bcb
    [junit] 2007-10-29 02:14:33,092 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:33,208 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:33,328 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:33,329 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@2b323e
    [junit] 2007-10-29 02:14:33,330 INFO  dfs.DataNode (DataNode.java:run(761)) - Exiting
DataXceiveServer due to java.net.SocketException: Socket closed
    [junit] 2007-10-29 02:14:33,330 INFO  dfs.DataNode (DataNode.java:run(1512)) - Finishing
DataNode in: FSDataset{dirpath='http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data1/current,/export/home/hudson/hudson/jobs/Hadoop-Nightly/workspace/trunk/build/test/data/dfs/data/data2/current'}

    [junit] 2007-10-29 02:14:33,331 WARN  fs.FSNamesystem (PendingReplicationBlocks.java:run(186))
- PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep
interrupted
    [junit] 2007-10-29 02:14:33,332 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 0.0.0.0:62077
    [junit] 2007-10-29 02:14:33,333 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@1eec35
    [junit] 2007-10-29 02:14:33,467 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2007-10-29 02:14:33,580 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2007-10-29 02:14:33,698 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2007-10-29 02:14:33,699 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@1e78fc6
    [junit] 2007-10-29 02:14:33,700 INFO  fs.FSNamesystem (FSEditLog.java:printStatistics(741))
- Number of transactions: 117 Total time for transactions(ms): 4 Number of syncs: 77 SyncTimes(ms):
106 50 
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:stop(677)) - Stopping server
on 62076
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
1 on 62076: exiting
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
3 on 62076: exiting
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
4 on 62076: exiting
    [junit] 2007-10-29 02:14:33,703 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
7 on 62076: exiting
    [junit] 2007-10-29 02:14:33,703 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
8 on 62076: exiting
    [junit] 2007-10-29 02:14:33,703 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
9 on 62076: exiting
    [junit] 2007-10-29 02:14:33,704 INFO  ipc.Server (Server.java:run(316)) - Stopping IPC
Server listener on 62076
    [junit] 2007-10-29 02:14:33,703 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
6 on 62076: exiting
    [junit] 2007-10-29 02:14:33,703 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
5 on 62076: exiting
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
0 on 62076: exiting
    [junit] 2007-10-29 02:14:33,702 INFO  ipc.Server (Server.java:run(633)) - IPC Server handler
2 on 62076: exiting
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 85.003 sec
    [junit] Running org.apache.hadoop.net.TestNetworkTopology
    [junit] 2007-10-29 02:14:34,341 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r1/h1:5020
    [junit] 2007-10-29 02:14:34,346 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r1/h2:5020
    [junit] 2007-10-29 02:14:34,347 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h3:5020
    [junit] 2007-10-29 02:14:34,348 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h4:5020
    [junit] 2007-10-29 02:14:34,349 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h5:5020
    [junit] 2007-10-29 02:14:34,350 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d2/r3/h6:5020
    [junit] 2007-10-29 02:14:34,351 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d2/r3/h7:5020
    [junit] 2007-10-29 02:14:34,398 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d1/r1/h1:5020
    [junit] 2007-10-29 02:14:34,400 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d1/r1/h2:5020
    [junit] 2007-10-29 02:14:34,401 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d1/r2/h3:5020
    [junit] 2007-10-29 02:14:34,402 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d1/r2/h4:5020
    [junit] 2007-10-29 02:14:34,403 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d1/r2/h5:5020
    [junit] 2007-10-29 02:14:34,405 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d2/r3/h6:5020
    [junit] 2007-10-29 02:14:34,406 INFO  net.NetworkTopology (NetworkTopology.java:remove(351))
- Removing a node: /d2/r3/h7:5020
    [junit] 2007-10-29 02:14:34,407 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r1/h1:5020
    [junit] 2007-10-29 02:14:34,408 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r1/h2:5020
    [junit] 2007-10-29 02:14:34,409 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h3:5020
    [junit] 2007-10-29 02:14:34,411 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h4:5020
    [junit] 2007-10-29 02:14:34,412 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d1/r2/h5:5020
    [junit] 2007-10-29 02:14:34,413 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d2/r3/h6:5020
    [junit] 2007-10-29 02:14:34,414 INFO  net.NetworkTopology (NetworkTopology.java:add(320))
- Adding a new node: /d2/r3/h7:5020
    [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.061 sec
    [junit] Running org.apache.hadoop.record.TestBuffer
    [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.118 sec
    [junit] Running org.apache.hadoop.record.TestRecordIO
    [junit] Illustrating toString bugT,102,4567,99344109427290,3.1449999809265137,1.5234,'random
text,#000102030405060708090a0b0c0d0e0f101112131415161718191a1b1c1d1e1f202122232425262728292a2b2c2d2e2f303132333435363738393a3b3c3d3e3f404142434445464748494a4b4c4d4e4f505152535455565758595a5b5c5d5e5f606162636465666768696a6b6c6d6e6f707172737475767778797a7b7c7d7e7f808182838485868788898a8b8c8d8e8f909192939495969798999a9b9c9d9e9fa0a1a2a3a4a5a6a7a8a9aaabacadaeafb0b1b2b3b4b5b6b7b8b9babbbcbdbebfc0c1c2c3c4c5c6c7c8c9cacbcccdcecfd0d1d2d3d4d5d6d7d8d9dadbdcdddedfe0e1e2e3e4e5e6e7e8e9eaebecedeeeff0f1f2f3f4f5f6f7f8f9fafbfcfdfeff,v{},m{},s{'other
random text}

    [junit] Illustrating toString bugT,102,4567,99344109427290,3.1449999809265137,1.5234,'random
text,#000102030405060708090a0b0c0d0e0f101112131415161718191a1b1c1d1e1f202122232425262728292a2b2c2d2e2f303132333435363738393a3b3c3d3e3f404142434445464748494a4b4c4d4e4f505152535455565758595a5b5c5d5e5f606162636465666768696a6b6c6d6e6f707172737475767778797a7b7c7d7e7f808182838485868788898a8b8c8d8e8f909192939495969798999a9b9c9d9e9fa0a1a2a3a4a5a6a7a8a9aaabacadaeafb0b1b2b3b4b5b6b7b8b9babbbcbdbebfc0c1c2c3c4c5c6c7c8c9cacbcccdcecfd0d1d2d3d4d5d6d7d8d9dadbdcdddedfe0e1e2e3e4e5e6e7e8e9eaebecedeeeff0f1f2f3f4f5f6f7f8f9fafbfcfdfeff,v{},m{},s{'other
random text}

    [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 0.38 sec
    [junit] Running org.apache.hadoop.record.TestRecordMR
    [junit] 2007-10-29 02:14:37,142 INFO  jvm.JvmMetrics (JvmMetrics.java:init(56)) - Initializing
JVM Metrics with processName=JobTracker, sessionId=
    [junit] 2007-10-29 02:14:37,328 WARN  mapred.JobClient (JobClient.java:submitJob(496))
- No job jar file set.  User classes may not be found. See JobConf(Class) or JobConf#setJar(String).
    [junit] 2007-10-29 02:14:37,358 INFO  mapred.FileInputFormat (FileInputFormat.java:validateInput(157))
- Total input paths to process : 1
    [junit] 2007-10-29 02:14:37,671 WARN  conf.Configuration (Configuration.java:loadResource(842))
- build/test/mapred/local/localRunner/job_local_1.xml:a attempt to override final parameter:
hadoop.tmp.dir;  Ignoring.
    [junit] 2007-10-29 02:14:37,681 INFO  mapred.JobClient (JobClient.java:runJob(755)) -
Running job: job_local_1
    [junit] 2007-10-29 02:14:37,717 INFO  mapred.MapTask (MapTask.java:run(127)) - numReduceTasks:
1
    [junit] 2007-10-29 02:14:37,895 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/genins/answer.key
:0+190
    [junit] 2007-10-29 02:14:37,897 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000'
done.
    [junit] 2007-10-29 02:14:37,992 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- reduce > reduce
    [junit] 2007-10-29 02:14:37,994 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_uy7n4t'
done.
    [junit] 2007-10-29 02:14:38,003 INFO  mapred.TaskRunner (Task.java:saveTaskOutput(434))
- Saved output of task 'reduce_uy7n4t' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/genouts

    [junit] 2007-10-29 02:14:38,684 INFO  mapred.JobClient (JobClient.java:runJob(833)) -
Job complete: job_local_1
    [junit] 2007-10-29 02:14:38,686 INFO  mapred.JobClient (Counters.java:log(367)) - Counters:
7
    [junit] 2007-10-29 02:14:38,693 INFO  mapred.JobClient (Counters.java:log(371)) -   Map-Reduce
Framework
    [junit] 2007-10-29 02:14:38,694 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input records=10
    [junit] 2007-10-29 02:14:38,696 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output records=105
    [junit] 2007-10-29 02:14:38,697 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input bytes=100
    [junit] 2007-10-29 02:14:38,698 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output bytes=734
    [junit] 2007-10-29 02:14:38,699 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input groups=105
    [junit] 2007-10-29 02:14:38,700 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input records=105
    [junit] 2007-10-29 02:14:38,701 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce output records=105
    [junit] 2007-10-29 02:14:38,728 INFO  jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot
initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized
    [junit] 2007-10-29 02:14:38,732 WARN  mapred.JobClient (JobClient.java:submitJob(496))
- No job jar file set.  User classes may not be found. See JobConf(Class) or JobConf#setJar(String).
    [junit] 2007-10-29 02:14:38,735 INFO  mapred.FileInputFormat (FileInputFormat.java:validateInput(157))
- Total input paths to process : 1
    [junit] 2007-10-29 02:14:38,852 WARN  conf.Configuration (Configuration.java:loadResource(842))
- build/test/mapred/local/localRunner/job_local_2.xml:a attempt to override final parameter:
hadoop.tmp.dir;  Ignoring.
    [junit] 2007-10-29 02:14:38,855 INFO  mapred.JobClient (JobClient.java:runJob(755)) -
Running job: job_local_2
    [junit] 2007-10-29 02:14:38,867 INFO  mapred.MapTask (MapTask.java:run(127)) - numReduceTasks:
1
    [junit] 2007-10-29 02:14:38,946 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/genouts/part-00000
:0+1143
    [junit] 2007-10-29 02:14:38,947 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000'
done.
    [junit] 2007-10-29 02:14:38,972 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- reduce > reduce
    [junit] 2007-10-29 02:14:38,973 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_7jb7o8'
done.
    [junit] 2007-10-29 02:14:38,979 INFO  mapred.TaskRunner (Task.java:saveTaskOutput(434))
- Saved output of task 'reduce_7jb7o8' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/intermediateouts

    [junit] 2007-10-29 02:14:39,864 INFO  mapred.JobClient (JobClient.java:runJob(833)) -
Job complete: job_local_2
    [junit] 2007-10-29 02:14:39,865 INFO  mapred.JobClient (Counters.java:log(367)) - Counters:
7
    [junit] 2007-10-29 02:14:39,866 INFO  mapred.JobClient (Counters.java:log(371)) -   Map-Reduce
Framework
    [junit] 2007-10-29 02:14:39,866 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input records=105
    [junit] 2007-10-29 02:14:39,867 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output records=105
    [junit] 2007-10-29 02:14:39,867 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input bytes=1050
    [junit] 2007-10-29 02:14:39,868 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output bytes=315
    [junit] 2007-10-29 02:14:39,868 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input groups=10
    [junit] 2007-10-29 02:14:39,869 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input records=105
    [junit] 2007-10-29 02:14:39,869 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce output records=10
    [junit] 2007-10-29 02:14:39,876 INFO  jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot
initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized
    [junit] 2007-10-29 02:14:39,878 WARN  mapred.JobClient (JobClient.java:submitJob(496))
- No job jar file set.  User classes may not be found. See JobConf(Class) or JobConf#setJar(String).
    [junit] 2007-10-29 02:14:39,879 INFO  mapred.FileInputFormat (FileInputFormat.java:validateInput(157))
- Total input paths to process : 1
    [junit] 2007-10-29 02:14:39,952 WARN  conf.Configuration (Configuration.java:loadResource(842))
- build/test/mapred/local/localRunner/job_local_3.xml:a attempt to override final parameter:
hadoop.tmp.dir;  Ignoring.
    [junit] 2007-10-29 02:14:39,954 INFO  mapred.JobClient (JobClient.java:runJob(755)) -
Running job: job_local_3
    [junit] 2007-10-29 02:14:39,961 INFO  mapred.MapTask (MapTask.java:run(127)) - numReduceTasks:
1
    [junit] 2007-10-29 02:14:39,979 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/intermediateouts/part-00000
:0+212
    [junit] 2007-10-29 02:14:39,980 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000'
done.
    [junit] 2007-10-29 02:14:39,997 INFO  mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210))
- reduce > reduce
    [junit] 2007-10-29 02:14:39,998 INFO  mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_6rkptn'
done.
    [junit] 2007-10-29 02:14:40,005 INFO  mapred.TaskRunner (Task.java:saveTaskOutput(434))
- Saved output of task 'reduce_6rkptn' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/finalouts

    [junit] 2007-10-29 02:14:40,964 INFO  mapred.JobClient (JobClient.java:runJob(833)) -
Job complete: job_local_3
    [junit] 2007-10-29 02:14:40,965 INFO  mapred.JobClient (Counters.java:log(367)) - Counters:
7
    [junit] 2007-10-29 02:14:40,965 INFO  mapred.JobClient (Counters.java:log(371)) -   Map-Reduce
Framework
    [junit] 2007-10-29 02:14:40,967 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input records=10
    [junit] 2007-10-29 02:14:40,968 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output records=10
    [junit] 2007-10-29 02:14:40,969 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map input bytes=119
    [junit] 2007-10-29 02:14:40,970 INFO  mapred.JobClient (Counters.java:log(373)) -    
Map output bytes=20
    [junit] 2007-10-29 02:14:40,971 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input groups=10
    [junit] 2007-10-29 02:14:40,972 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce input records=10
    [junit] 2007-10-29 02:14:40,973 INFO  mapred.JobClient (Counters.java:log(373)) -    
Reduce output records=10
    [junit] Original sum: 105
    [junit] Recomputed sum: 105
    [junit] Success=true
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.473 sec
    [junit] Running org.apache.hadoop.record.TestRecordWritable
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 3.949 sec
    [junit] Running org.apache.hadoop.util.TestReflectionUtils
    [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 1.206 sec

BUILD FAILED
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml :508: Tests
failed!

Total time: 30 minutes 48 seconds
Recording fingerprints
Publishing Javadoc
Recording test results


Mime
View raw message