You are viewing a plain text version of this content. The canonical link for it is here.
Posted to common-dev@hadoop.apache.org by hu...@lucene.zones.apache.org on 2007/10/27 18:03:17 UTC
Build failed in Hudson: Hadoop-Nightly #284
See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/284/changes
Changes:
[acmurthy] HADOOP-2105. Improve overview.html to clarify supported platforms, software pre-requisites for hadoop, how to install them on various platforms and a better general description of hadoop and it's utility. Contributed by Jim Kellerman.
[omalley] Reverting HADOOP-1622, because it broke map/reduce.
------------------------------------------
[...truncated 32558 lines...]
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:27,403 INFO mapred.ReduceTask (ReduceTask.java:fetchOutputs(1121)) - task_200710271600_0004_r_000000_0 Copying of all map outputs complete. Initiating the last merge on the remaining files in ramfs://mapoutput29057219
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:27,861 INFO mapred.ReduceTask (ReduceTask.java:fetchOutputs(1165)) - task_200710271600_0004_r_000000_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_200710271600_0004_r_000000_0/map_0.out
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:27,890 INFO pipes.PipesReducer (PipesReducer.java:startApplication(68)) - starting application
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:28,009 INFO pipes.PipesReducer (PipesReducer.java:close(102)) - waiting for finish
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:28,023 INFO pipes.PipesReducer (PipesReducer.java:close(104)) - got done
[junit] task_200710271600_0004_r_000000_0: 2007-10-27 16:01:28,033 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'task_200710271600_0004_r_000000_0' done.
[junit] 2007-10-27 16:01:29,417 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_200710271600_0004
[junit] 2007-10-27 16:01:29,419 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 6
[junit] 2007-10-27 16:01:29,420 INFO mapred.JobClient (Counters.java:log(371)) - Job Counters
[junit] 2007-10-27 16:01:29,420 INFO mapred.JobClient (Counters.java:log(373)) - Launched map tasks=2
[junit] 2007-10-27 16:01:29,421 INFO mapred.JobClient (Counters.java:log(373)) - Launched reduce tasks=2
[junit] 2007-10-27 16:01:29,421 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework
[junit] 2007-10-27 16:01:29,422 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=13
[junit] 2007-10-27 16:01:29,422 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=86
[junit] 2007-10-27 16:01:29,422 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=11
[junit] 2007-10-27 16:01:29,423 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=13
[junit] 2007-10-27 16:01:29,423 INFO mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(206)) - Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:33555 to be idle.
[junit] 2007-10-27 16:01:30,427 INFO mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(206)) - Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:33555 to be idle.
[junit] 2007-10-27 16:01:30,457 INFO dfs.StateChange (FSNamesystem.java:blocksToInvalidate(2789)) - BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50010 to delete blk_-414219415345016013 blk_7615855651044125035
[junit] 2007-10-27 16:01:30,458 INFO dfs.StateChange (FSNamesystem.java:blocksToInvalidate(2789)) - BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50011 to delete blk_-414219415345016013 blk_7615855651044125035
[junit] 2007-10-27 16:01:31,088 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(901)) - Removed completed task 'task_200710271600_0004_r_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:33553'
[junit] 2007-10-27 16:01:31,089 INFO mapred.TaskTracker (TaskTracker.java:purgeJob(994)) - Received 'KillJobAction' for job: job_200710271600_0004
[junit] 2007-10-27 16:01:31,089 INFO mapred.TaskRunner (ReduceTaskRunner.java:close(45)) - task_200710271600_0004_r_000000_0 done; removing files.
[junit] 2007-10-27 16:01:31,437 INFO mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(206)) - Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:33555 to be idle.
[junit] 2007-10-27 16:01:31,819 INFO dfs.DataNode (FSDataset.java:invalidate(709)) - Deleting block blk_-414219415345016013 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data1/current/blk_-414219415345016013
[junit] 2007-10-27 16:01:31,820 INFO dfs.DataNode (FSDataset.java:invalidate(709)) - Deleting block blk_7615855651044125035 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data2/current/blk_7615855651044125035
[junit] 2007-10-27 16:01:32,051 INFO dfs.DataNode (FSDataset.java:invalidate(709)) - Deleting block blk_-414219415345016013 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data3/current/blk_-414219415345016013
[junit] 2007-10-27 16:01:32,052 INFO dfs.DataNode (FSDataset.java:invalidate(709)) - Deleting block blk_7615855651044125035 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data4/current/blk_7615855651044125035
[junit] 2007-10-27 16:01:32,198 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(901)) - Removed completed task 'task_200710271600_0004_m_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:33555'
[junit] 2007-10-27 16:01:32,198 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(901)) - Removed completed task 'task_200710271600_0004_m_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:33555'
[junit] 2007-10-27 16:01:32,198 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(901)) - Removed completed task 'task_200710271600_0004_r_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:33555'
[junit] 2007-10-27 16:01:32,199 INFO mapred.TaskTracker (TaskTracker.java:purgeJob(994)) - Received 'KillJobAction' for job: job_200710271600_0004
[junit] 2007-10-27 16:01:32,199 INFO mapred.TaskRunner (ReduceTaskRunner.java:close(45)) - task_200710271600_0004_r_000001_0 done; removing files.
[junit] 2007-10-27 16:01:32,221 INFO mapred.TaskRunner (MapTaskRunner.java:close(41)) - task_200710271600_0004_m_000000_0 done; removing files.
[junit] 2007-10-27 16:01:32,223 INFO mapred.TaskRunner (MapTaskRunner.java:close(41)) - task_200710271600_0004_m_000001_0 done; removing files.
[junit] 2007-10-27 16:01:32,529 INFO ipc.Server (Server.java:stop(677)) - Stopping server on 33555
[junit] 2007-10-27 16:01:32,530 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 0 on 33555: exiting
[junit] 2007-10-27 16:01:32,530 INFO mapred.TaskTracker (TaskTracker.java:shutdown(649)) - Shutting down StatusHttpServer
[junit] 2007-10-27 16:01:32,531 INFO ipc.Server (Server.java:run(316)) - Stopping IPC Server listener on 33555
[junit] 2007-10-27 16:01:32,533 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:33555
[junit] 2007-10-27 16:01:32,533 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 1 on 33555: exiting
[junit] 2007-10-27 16:01:32,537 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:50061
[junit] 2007-10-27 16:01:32,538 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@1c486f2
[junit] 2007-10-27 16:01:32,679 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:32,802 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:32,940 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:32,941 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@f864fe
[junit] 2007-10-27 16:01:32,942 INFO mapred.TaskTracker (TaskTracker.java:offerService(829)) - Interrupted. Closing down.
[junit] 2007-10-27 16:01:32,944 INFO ipc.Server (Server.java:stop(677)) - Stopping server on 33553
[junit] 2007-10-27 16:01:32,944 INFO ipc.Server (Server.java:run(316)) - Stopping IPC Server listener on 33553
[junit] 2007-10-27 16:01:32,945 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:33553
[junit] 2007-10-27 16:01:32,945 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 1 on 33553: exiting
[junit] 2007-10-27 16:01:32,945 INFO mapred.TaskTracker (TaskTracker.java:shutdown(649)) - Shutting down StatusHttpServer
[junit] 2007-10-27 16:01:32,945 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 0 on 33553: exiting
[junit] 2007-10-27 16:01:32,947 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:50060
[junit] 2007-10-27 16:01:32,948 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@53c3f5
[junit] 2007-10-27 16:01:33,073 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:33,196 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:33,319 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:33,320 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@78dc4c
[junit] 2007-10-27 16:01:33,320 INFO mapred.TaskTracker (TaskTracker.java:offerService(829)) - Interrupted. Closing down.
[junit] 2007-10-27 16:01:33,321 INFO mapred.JobTracker (JobTracker.java:close(739)) - Stopping infoServer
[junit] 2007-10-27 16:01:33,323 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:33552
[junit] 2007-10-27 16:01:33,324 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@1579a30
[junit] 2007-10-27 16:01:33,450 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:33,573 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:33,691 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:33,692 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@9903f4
[junit] 2007-10-27 16:01:33,692 INFO mapred.JobTracker (JobTracker.java:close(747)) - Stopping interTrackerServer
[junit] 2007-10-27 16:01:33,692 INFO ipc.Server (Server.java:stop(677)) - Stopping server on 33551
[junit] 2007-10-27 16:01:33,693 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 1 on 33551: exiting
[junit] 2007-10-27 16:01:33,693 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 7 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 6 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 2 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 8 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 9 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 5 on 33551: exiting
[junit] 2007-10-27 16:01:33,694 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 0 on 33551: exiting
[junit] 2007-10-27 16:01:33,693 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 3 on 33551: exiting
[junit] 2007-10-27 16:01:33,693 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 4 on 33551: exiting
[junit] 2007-10-27 16:01:33,693 INFO mapred.JobTracker (JobTracker.java:offerService(734)) - Stopped interTrackerServer
[junit] 2007-10-27 16:01:33,693 INFO mapred.JobTracker (JobTracker.java:close(751)) - Stopping expireTrackers
[junit] 2007-10-27 16:01:33,693 INFO ipc.Server (Server.java:run(316)) - Stopping IPC Server listener on 33551
[junit] 2007-10-27 16:01:33,697 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-27 16:01:33,698 INFO mapred.JobTracker (JobTracker.java:close(761)) - Stopping retirer
[junit] 2007-10-27 16:01:33,698 INFO mapred.JobTracker (JobTracker.java:close(770)) - Stopping initer
[junit] 2007-10-27 16:01:33,699 INFO mapred.JobTracker (JobTracker.java:close(779)) - Stopping expireLaunchingTasks
[junit] 2007-10-27 16:01:33,699 INFO mapred.JobTracker (JobTracker.java:close(789)) - Stopping TaskCommit thread
[junit] 2007-10-27 16:01:33,700 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-27 16:01:33,700 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-27 16:01:33,701 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:33550
[junit] 2007-10-27 16:01:33,702 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@46b90a
[junit] 2007-10-27 16:01:33,826 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:33,947 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:34,064 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:34,065 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@28305d
[junit] 2007-10-27 16:01:34,067 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-27 16:01:34,068 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:33549
[junit] 2007-10-27 16:01:34,069 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@3ac93e
[junit] 2007-10-27 16:01:34,180 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:34,293 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:34,406 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:34,407 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@32060c
[junit] 2007-10-27 16:01:34,408 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-27 16:01:34,409 WARN fs.FSNamesystem (PendingReplicationBlocks.java:run(186)) - PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep interrupted
[junit] 2007-10-27 16:01:34,410 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:33547
[junit] 2007-10-27 16:01:34,410 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.servlet.WebApplicationHandler@1eec35
[junit] 2007-10-27 16:01:34,523 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2007-10-27 16:01:34,629 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2007-10-27 16:01:34,734 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2007-10-27 16:01:34,734 INFO util.Container (Container.java:stop(156)) - Stopped org.mortbay.jetty.Server@1e78fc6
[junit] 2007-10-27 16:01:34,735 INFO fs.FSNamesystem (FSEditLog.java:printStatistics(741)) - Number of transactions: 117 Total time for transactions(ms): 3 Number of syncs: 74 SyncTimes(ms): 208 51
[junit] 2007-10-27 16:01:34,736 INFO ipc.Server (Server.java:stop(677)) - Stopping server on 33546
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 0 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 7 on 33546: exiting
[junit] 2007-10-27 16:01:34,738 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 2 on 33546: exiting
[junit] 2007-10-27 16:01:34,738 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 4 on 33546: exiting
[junit] 2007-10-27 16:01:34,738 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 3 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(316)) - Stopping IPC Server listener on 33546
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 1 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 6 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 9 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 8 on 33546: exiting
[junit] 2007-10-27 16:01:34,737 INFO ipc.Server (Server.java:run(633)) - IPC Server handler 5 on 33546: exiting
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 89.388 sec
[junit] Running org.apache.hadoop.net.TestNetworkTopology
[junit] 2007-10-27 16:01:35,952 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h1:5020
[junit] 2007-10-27 16:01:35,957 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h2:5020
[junit] 2007-10-27 16:01:35,958 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h3:5020
[junit] 2007-10-27 16:01:35,959 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h4:5020
[junit] 2007-10-27 16:01:35,960 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h5:5020
[junit] 2007-10-27 16:01:35,961 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h6:5020
[junit] 2007-10-27 16:01:35,962 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h7:5020
[junit] 2007-10-27 16:01:36,009 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r1/h1:5020
[junit] 2007-10-27 16:01:36,011 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r1/h2:5020
[junit] 2007-10-27 16:01:36,012 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h3:5020
[junit] 2007-10-27 16:01:36,013 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h4:5020
[junit] 2007-10-27 16:01:36,014 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h5:5020
[junit] 2007-10-27 16:01:36,015 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d2/r3/h6:5020
[junit] 2007-10-27 16:01:36,016 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d2/r3/h7:5020
[junit] 2007-10-27 16:01:36,017 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h1:5020
[junit] 2007-10-27 16:01:36,018 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h2:5020
[junit] 2007-10-27 16:01:36,020 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h3:5020
[junit] 2007-10-27 16:01:36,021 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h4:5020
[junit] 2007-10-27 16:01:36,022 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h5:5020
[junit] 2007-10-27 16:01:36,023 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h6:5020
[junit] 2007-10-27 16:01:36,024 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.06 sec
[junit] Running org.apache.hadoop.record.TestBuffer
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.374 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.414 sec
[junit] Running org.apache.hadoop.record.TestRecordMR
[junit] 2007-10-27 16:01:39,059 INFO jvm.JvmMetrics (JvmMetrics.java:init(56)) - Initializing JVM Metrics with processName=JobTracker, sessionId=
[junit] 2007-10-27 16:01:39,099 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-27 16:01:39,205 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1
[junit] 2007-10-27 16:01:39,436 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-27 16:01:39,671 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_1
[junit] 2007-10-27 16:01:39,699 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1
[junit] 2007-10-27 16:01:39,849 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-27 16:01:39,850 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000' done.
[junit] 2007-10-27 16:01:39,935 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce
[junit] 2007-10-27 16:01:39,936 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_iny0e6' done.
[junit] 2007-10-27 16:01:39,943 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_iny0e6' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/genouts
[junit] 2007-10-27 16:01:40,677 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_1
[junit] 2007-10-27 16:01:40,678 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7
[junit] 2007-10-27 16:01:40,681 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework
[junit] 2007-10-27 16:01:40,682 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=10
[junit] 2007-10-27 16:01:40,683 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=100
[junit] 2007-10-27 16:01:40,683 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=100
[junit] 2007-10-27 16:01:40,684 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=698
[junit] 2007-10-27 16:01:40,684 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=100
[junit] 2007-10-27 16:01:40,685 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=100
[junit] 2007-10-27 16:01:40,685 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=100
[junit] 2007-10-27 16:01:40,757 INFO jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized
[junit] 2007-10-27 16:01:40,760 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-27 16:01:40,761 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1
[junit] 2007-10-27 16:01:40,892 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-27 16:01:40,895 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_2
[junit] 2007-10-27 16:01:40,904 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1
[junit] 2007-10-27 16:01:40,947 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+1093
[junit] 2007-10-27 16:01:40,948 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000' done.
[junit] 2007-10-27 16:01:40,974 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce
[junit] 2007-10-27 16:01:40,974 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_2tizro' done.
[junit] 2007-10-27 16:01:40,980 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_2tizro' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/intermediateouts
[junit] 2007-10-27 16:01:41,897 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_2
[junit] 2007-10-27 16:01:41,897 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7
[junit] 2007-10-27 16:01:41,898 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework
[junit] 2007-10-27 16:01:41,898 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=100
[junit] 2007-10-27 16:01:41,898 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=100
[junit] 2007-10-27 16:01:41,899 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=1000
[junit] 2007-10-27 16:01:41,899 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=300
[junit] 2007-10-27 16:01:41,900 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=10
[junit] 2007-10-27 16:01:41,900 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=100
[junit] 2007-10-27 16:01:41,900 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=10
[junit] 2007-10-27 16:01:41,906 INFO jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized
[junit] 2007-10-27 16:01:41,907 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-27 16:01:41,908 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1
[junit] 2007-10-27 16:01:42,123 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-27 16:01:42,125 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_3
[junit] 2007-10-27 16:01:42,149 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1
[junit] 2007-10-27 16:01:42,217 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+209
[junit] 2007-10-27 16:01:42,218 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'map_0000' done.
[junit] 2007-10-27 16:01:42,231 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce
[junit] 2007-10-27 16:01:42,232 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_92yult' done.
[junit] 2007-10-27 16:01:42,236 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_92yult' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/finalouts
[junit] 2007-10-27 16:01:43,127 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_3
[junit] 2007-10-27 16:01:43,127 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7
[junit] 2007-10-27 16:01:43,128 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework
[junit] 2007-10-27 16:01:43,128 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=10
[junit] 2007-10-27 16:01:43,128 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=10
[junit] 2007-10-27 16:01:43,129 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=116
[junit] 2007-10-27 16:01:43,129 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=20
[junit] 2007-10-27 16:01:43,129 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=10
[junit] 2007-10-27 16:01:43,130 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=10
[junit] 2007-10-27 16:01:43,130 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=10
[junit] Original sum: 100
[junit] Recomputed sum: 100
[junit] Success=true
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.786 sec
[junit] Running org.apache.hadoop.record.TestRecordWritable
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.452 sec
[junit] Running org.apache.hadoop.util.TestReflectionUtils
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.838 sec
BUILD FAILED
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml :508: Tests failed!
Total time: 27 minutes 17 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-2105
Updating HADOOP-1622