See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/330/changes
Changes: [jimk] HADOOP-2392 HADOOP-2324 HADOOP-2396 HADOOP-2397 HADOOP-2392, HADOOP-2324: Chore - initialChore() now returns boolean HMaster - rather than retry in root and meta scanners, return if a scan fails. It will get retried on the next scan. This has two effects: 1) scanners exit more quickly during shutdown and 2) they don't keep retrying to connect to a dead server, allowing them to recover from a server going down more quickly. - initialScan in root and meta scanners return boolean and do not progress to maintenanceScan until the initial scan completes successfully. HRegionServer - speed up region server exit by reordering join's so that we join with threads in the order that we told them to stop TestTableMapReduce - remove overrides of heartbeat and thread wake intervals HADOOP-2396: HMaster - move check for null HRegionInfo before first attempt to dereference it. HADOOP-2397: - HMaster$BaseScanner.checkAssigned: don't try to split dead server's log if initial startup has completed. HADOOP-2353: HMsg - change toString() to only output the region name rather than calling HRegionInfo.toString() StaticTestEnvironment - make logging a bit less verbose TestHLog - was writing to local file system and failing on Windows [dhruba] HADOOP-2401. Only the current leaseholder can abandon a block for a HDFS file. ClientProtocol version changed from 20 to 21. (Tsz Wo (Nicholas), SZE via dhruba) [stack] HADOOP-2370 Allow column families with an unlimited number of versions [stack] HADOOP-2243 getRow returns empty Map if no-such row.. should return null Intentionally not added to the CHANGES.txt because way hbase currently works is correct; this commit just adds a bit of clarifying javadoc. [stack] HADOOP-2395 Implement "ALTER TABLE ... CHANGE column" operation ------------------------------------------ [...truncated 38377 lines...] [junit] 2007-12-12 12:20:13,200 INFO mapred.JobClient (Counters.java:log(371)) - Job Counters [junit] 2007-12-12 12:20:13,201 INFO mapred.JobClient (Counters.java:log(373)) - Launched map tasks=2 [junit] 2007-12-12 12:20:13,202 INFO mapred.JobClient (Counters.java:log(373)) - Launched reduce tasks=2 [junit] 2007-12-12 12:20:13,202 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework [junit] 2007-12-12 12:20:13,202 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=13 [junit] 2007-12-12 12:20:13,203 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=86 [junit] 2007-12-12 12:20:13,203 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=11 [junit] 2007-12-12 12:20:13,203 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=13 [junit] 2007-12-12 12:20:13,204 INFO mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(207)) - Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:62346 to be idle. [junit] 2007-12-12 12:20:13,662 INFO dfs.StateChange (FSNamesystem.java:blocksToInvalidate(2848)) - BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:62253 to delete blk_3618852707215897671 blk_643888712779078887 [junit] 2007-12-12 12:20:13,663 INFO dfs.StateChange (FSNamesystem.java:blocksToInvalidate(2848)) - BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:62288 to delete blk_3618852707215897671 blk_643888712779078887 [junit] 2007-12-12 12:20:13,804 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(902)) - Removed completed task 'task_200712121219_0004_m_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62341' [junit] 2007-12-12 12:20:13,804 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(902)) - Removed completed task 'task_200712121219_0004_r_000000_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62341' [junit] 2007-12-12 12:20:13,806 INFO mapred.TaskTracker (TaskTracker.java:purgeJob(1075)) - Received 'KillJobAction' for job: job_200712121219_0004 [junit] 2007-12-12 12:20:13,808 INFO mapred.TaskRunner (ReduceTaskRunner.java:close(45)) - task_200712121219_0004_r_000000_0 done; removing files. [junit] 2007-12-12 12:20:13,815 INFO mapred.TaskRunner (MapTaskRunner.java:close(41)) - task_200712121219_0004_m_000000_0 done; removing files. [junit] 2007-12-12 12:20:14,210 INFO mapred.MiniMRCluster (MiniMRCluster.java:waitUntilIdle(207)) - Waiting for task tracker tracker_lucene.zones.apache.org:/127.0.0.1:62346 to be idle. [junit] 2007-12-12 12:20:14,901 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(902)) - Removed completed task 'task_200712121219_0004_m_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62346' [junit] 2007-12-12 12:20:14,902 INFO mapred.JobTracker (JobTracker.java:removeMarkedTasks(902)) - Removed completed task 'task_200712121219_0004_r_000001_0' from 'tracker_lucene.zones.apache.org:/127.0.0.1:62346' [junit] 2007-12-12 12:20:14,904 INFO mapred.TaskTracker (TaskTracker.java:purgeJob(1075)) - Received 'KillJobAction' for job: job_200712121219_0004 [junit] 2007-12-12 12:20:14,905 INFO mapred.TaskRunner (ReduceTaskRunner.java:close(45)) - task_200712121219_0004_r_000001_0 done; removing files. [junit] 2007-12-12 12:20:14,908 INFO mapred.TaskRunner (MapTaskRunner.java:close(41)) - task_200712121219_0004_m_000001_0 done; removing files. [junit] 2007-12-12 12:20:15,224 INFO ipc.Server (Server.java:stop(725)) - Stopping server on 62346 [junit] 2007-12-12 12:20:15,225 INFO mapred.TaskTracker (TaskTracker.java:shutdown(687)) - Shutting down StatusHttpServer [junit] 2007-12-12 12:20:15,226 INFO ipc.Server (Server.java:run(328)) - Stopping IPC Server listener on 62346 [junit] 2007-12-12 12:20:15,226 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 1 on 62346: exiting [junit] 2007-12-12 12:20:15,226 INFO mapred.TaskTracker (TaskTracker.java:run(539)) - Shutting down: Map-events fetcher for all reduce tasks on tracker_lucene.zones.apache.org:/127.0.0.1:62346 [junit] 2007-12-12 12:20:15,226 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 0 on 62346: exiting [junit] 2007-12-12 12:20:15,240 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62345 [junit] 2007-12-12 12:20:15,244 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:15,546 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:15,735 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:15,870 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:15,871 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:15,872 INFO dfs.DataNode (FSDataset.java:invalidate(740)) - Deleting block blk_3618852707215897671 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data3/current/blk_3618852707215897671 [junit] 2007-12-12 12:20:15,873 INFO mapred.TaskTracker (TaskTracker.java:offerService(908)) - Interrupted. Closing down. [junit] 2007-12-12 12:20:16,012 INFO ipc.Server (Server.java:stop(725)) - Stopping server on 62341 [junit] 2007-12-12 12:20:16,013 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 0 on 62341: exiting [junit] 2007-12-12 12:20:16,013 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 1 on 62341: exiting [junit] 2007-12-12 12:20:16,013 INFO ipc.Server (Server.java:run(328)) - Stopping IPC Server listener on 62341 [junit] 2007-12-12 12:20:16,129 INFO dfs.DataNode (FSDataset.java:invalidate(740)) - Deleting block blk_3618852707215897671 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data1/current/blk_3618852707215897671 [junit] 2007-12-12 12:20:16,130 INFO dfs.DataNode (FSDataset.java:invalidate(740)) - Deleting block blk_643888712779078887 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data2/current/blk_643888712779078887 [junit] 2007-12-12 12:20:16,131 INFO dfs.DataNode (FSDataset.java:invalidate(740)) - Deleting block blk_643888712779078887 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/test/data/dfs/data/data4/current/blk_643888712779078887 [junit] 2007-12-12 12:20:16,132 INFO mapred.TaskTracker (TaskTracker.java:shutdown(687)) - Shutting down StatusHttpServer [junit] 2007-12-12 12:20:16,133 INFO mapred.TaskTracker (TaskTracker.java:run(508)) - Shutting down: Map-events fetcher for all reduce tasks on tracker_lucene.zones.apache.org:/127.0.0.1:62341 [junit] 2007-12-12 12:20:16,140 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62340 [junit] 2007-12-12 12:20:16,141 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:16,273 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:16,395 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:16,523 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:16,524 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:16,524 INFO mapred.TaskTracker (TaskTracker.java:offerService(908)) - Interrupted. Closing down. [junit] 2007-12-12 12:20:16,525 INFO mapred.JobTracker (JobTracker.java:close(738)) - Stopping infoServer [junit] 2007-12-12 12:20:16,527 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62307 [junit] 2007-12-12 12:20:16,528 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:16,658 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:16,781 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:16,903 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:16,904 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:16,904 INFO mapred.JobTracker (JobTracker.java:close(746)) - Stopping interTrackerServer [junit] 2007-12-12 12:20:16,904 INFO ipc.Server (Server.java:stop(725)) - Stopping server on 62304 [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 0 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 8 on 62304: exiting [junit] 2007-12-12 12:20:16,906 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 5 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 1 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 3 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 6 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 9 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 2 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(328)) - Stopping IPC Server listener on 62304 [junit] 2007-12-12 12:20:16,905 INFO mapred.JobTracker (JobTracker.java:offerService(733)) - Stopped interTrackerServer [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 4 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 7 on 62304: exiting [junit] 2007-12-12 12:20:16,905 INFO mapred.JobTracker (JobTracker.java:close(750)) - Stopping expireTrackers [junit] 2007-12-12 12:20:16,910 ERROR mapred.JobTracker (JobTracker.java:run(309)) - 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:264) [junit] at java.lang.Thread.run(Thread.java:595) [junit] 2007-12-12 12:20:16,911 INFO mapred.JobTracker (JobTracker.java:close(762)) - Stopping retirer [junit] 2007-12-12 12:20:16,911 INFO mapred.JobTracker (JobTracker.java:close(771)) - Stopping initer [junit] 2007-12-12 12:20:16,913 INFO mapred.JobTracker (JobTracker.java:close(780)) - Stopping expireLaunchingTasks [junit] 2007-12-12 12:20:16,914 INFO mapred.JobTracker (JobTracker.java:close(790)) - Stopping TaskCommit thread [junit] 2007-12-12 12:20:16,915 WARN mapred.JobTracker (JobTracker.java:run(2035)) - 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:1937) [junit] 2007-12-12 12:20:16,915 INFO mapred.JobTracker (JobTracker.java:close(798)) - stopped all jobtracker services [junit] Shutting down the Mini HDFS Cluster [junit] Shutting down DataNode 1 [junit] 2007-12-12 12:20:16,917 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62295 [junit] 2007-12-12 12:20:16,919 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,042 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:17,159 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:17,281 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:17,282 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,283 INFO dfs.DataNode (DataNode.java:run(1729)) - 127.0.0.1:62288: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-12-12 12:20:17,285 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62265 [junit] 2007-12-12 12:20:17,286 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,399 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:17,528 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:17,638 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:17,638 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,640 INFO dfs.DataNode (DataNode.java:run(1729)) - 127.0.0.1:62253: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-12-12 12:20:17,642 INFO http.SocketListener (SocketListener.java:stop(212)) - Stopped SocketListener on 0.0.0.0:62237 [junit] 2007-12-12 12:20:17,642 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,761 INFO util.Container (Container.java:stop(156)) - Stopped WebApplicationContext[/,/] [junit] 2007-12-12 12:20:17,875 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/logs,/logs] [junit] 2007-12-12 12:20:17,992 INFO util.Container (Container.java:stop(156)) - Stopped HttpContext[/static,/static] [junit] 2007-12-12 12:20:17,993 INFO util.Container (Container.java:stop(156)) - Stopped [EMAIL PROTECTED] [junit] 2007-12-12 12:20:17,994 INFO fs.FSNamesystem (FSEditLog.java:printStatistics(738)) - Number of transactions: 117 Total time for transactions(ms): 5 Number of syncs: 76 SyncTimes(ms): 86 50 [junit] 2007-12-12 12:20:17,995 INFO ipc.Server (Server.java:stop(725)) - Stopping server on 62216 [junit] 2007-12-12 12:20:17,996 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 0 on 62216: exiting [junit] 2007-12-12 12:20:17,998 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 1 on 62216: exiting [junit] 2007-12-12 12:20:17,998 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 4 on 62216: exiting [junit] 2007-12-12 12:20:17,998 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 2 on 62216: exiting [junit] 2007-12-12 12:20:17,998 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 5 on 62216: exiting [junit] 2007-12-12 12:20:17,998 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 7 on 62216: exiting [junit] 2007-12-12 12:20:17,997 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 9 on 62216: exiting [junit] 2007-12-12 12:20:17,997 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 8 on 62216: exiting [junit] 2007-12-12 12:20:17,997 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 6 on 62216: exiting [junit] 2007-12-12 12:20:17,997 INFO ipc.Server (Server.java:run(681)) - IPC Server handler 3 on 62216: exiting [junit] 2007-12-12 12:20:17,996 INFO ipc.Server (Server.java:run(328)) - Stopping IPC Server listener on 62216 [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 68.253 sec [junit] Running org.apache.hadoop.net.TestNetworkTopology [junit] 2007-12-12 12:20:19,032 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h1:5020 [junit] 2007-12-12 12:20:19,038 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h2:5020 [junit] 2007-12-12 12:20:19,039 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h3:5020 [junit] 2007-12-12 12:20:19,040 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h4:5020 [junit] 2007-12-12 12:20:19,041 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h5:5020 [junit] 2007-12-12 12:20:19,042 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h6:5020 [junit] 2007-12-12 12:20:19,043 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h7:5020 [junit] 2007-12-12 12:20:19,105 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r1/h1:5020 [junit] 2007-12-12 12:20:19,107 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r1/h2:5020 [junit] 2007-12-12 12:20:19,108 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h3:5020 [junit] 2007-12-12 12:20:19,109 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h4:5020 [junit] 2007-12-12 12:20:19,111 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d1/r2/h5:5020 [junit] 2007-12-12 12:20:19,112 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d2/r3/h6:5020 [junit] 2007-12-12 12:20:19,113 INFO net.NetworkTopology (NetworkTopology.java:remove(351)) - Removing a node: /d2/r3/h7:5020 [junit] 2007-12-12 12:20:19,114 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h1:5020 [junit] 2007-12-12 12:20:19,116 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r1/h2:5020 [junit] 2007-12-12 12:20:19,117 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h3:5020 [junit] 2007-12-12 12:20:19,119 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h4:5020 [junit] 2007-12-12 12:20:19,120 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d1/r2/h5:5020 [junit] 2007-12-12 12:20:19,121 INFO net.NetworkTopology (NetworkTopology.java:add(320)) - Adding a new node: /d2/r3/h6:5020 [junit] 2007-12-12 12:20:19,122 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.09 sec [junit] Running org.apache.hadoop.record.TestBuffer [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.352 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: 7.498 sec [junit] Running org.apache.hadoop.record.TestRecordMR [junit] 2007-12-12 12:20:31,909 INFO jvm.JvmMetrics (JvmMetrics.java:init(56)) - Initializing JVM Metrics with processName=JobTracker, sessionId= [junit] 2007-12-12 12:20:31,968 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-12-12 12:20:31,982 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1 [junit] 2007-12-12 12:20:32,189 WARN conf.Configuration (Configuration.java:loadResource(808)) - build/test/mapred/local/localRunner/job_local_1.xml:a attempt to override final parameter: hadoop.tmp.dir; Ignoring. [junit] 2007-12-12 12:20:32,197 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_1 [junit] 2007-12-12 12:20:32,228 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1 [junit] 2007-12-12 12:20:32,658 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-12-12 12:20:32,661 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'job_local_1_map_0000' done. [junit] 2007-12-12 12:20:33,208 INFO mapred.JobClient (JobClient.java:runJob(772)) - map 100% reduce 0% [junit] 2007-12-12 12:20:33,348 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce [junit] 2007-12-12 12:20:33,348 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_l4eisj' done. [junit] 2007-12-12 12:20:33,358 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_l4eisj' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/genouts [junit] 2007-12-12 12:20:34,246 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_1 [junit] 2007-12-12 12:20:34,247 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7 [junit] 2007-12-12 12:20:34,255 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework [junit] 2007-12-12 12:20:34,257 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=10 [junit] 2007-12-12 12:20:34,258 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=102 [junit] 2007-12-12 12:20:34,259 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=100 [junit] 2007-12-12 12:20:34,260 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=714 [junit] 2007-12-12 12:20:34,261 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=102 [junit] 2007-12-12 12:20:34,262 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=102 [junit] 2007-12-12 12:20:34,263 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=102 [junit] 2007-12-12 12:20:34,361 INFO jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized [junit] 2007-12-12 12:20:34,365 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-12-12 12:20:34,367 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1 [junit] 2007-12-12 12:20:34,502 WARN conf.Configuration (Configuration.java:loadResource(808)) - build/test/mapred/local/localRunner/job_local_2.xml:a attempt to override final parameter: hadoop.tmp.dir; Ignoring. [junit] 2007-12-12 12:20:34,505 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_2 [junit] 2007-12-12 12:20:34,516 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1 [junit] 2007-12-12 12:20:34,565 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+1113 [junit] 2007-12-12 12:20:34,565 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'job_local_2_map_0000' done. [junit] 2007-12-12 12:20:34,588 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce [junit] 2007-12-12 12:20:34,588 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_sfsv2m' done. [junit] 2007-12-12 12:20:34,594 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_sfsv2m' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/intermediateouts [junit] 2007-12-12 12:20:35,516 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_2 [junit] 2007-12-12 12:20:35,517 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7 [junit] 2007-12-12 12:20:35,518 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework [junit] 2007-12-12 12:20:35,519 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=102 [junit] 2007-12-12 12:20:35,519 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=102 [junit] 2007-12-12 12:20:35,519 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=1020 [junit] 2007-12-12 12:20:35,520 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=306 [junit] 2007-12-12 12:20:35,520 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=10 [junit] 2007-12-12 12:20:35,521 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=102 [junit] 2007-12-12 12:20:35,521 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=10 [junit] 2007-12-12 12:20:35,877 INFO jvm.JvmMetrics (JvmMetrics.java:init(51)) - Cannot initialize JVM Metrics with processName=JobTracker, sessionId= - already initialized [junit] 2007-12-12 12:20:35,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-12-12 12:20:35,879 INFO mapred.FileInputFormat (FileInputFormat.java:validateInput(157)) - Total input paths to process : 1 [junit] 2007-12-12 12:20:35,948 WARN conf.Configuration (Configuration.java:loadResource(808)) - build/test/mapred/local/localRunner/job_local_3.xml:a attempt to override final parameter: hadoop.tmp.dir; Ignoring. [junit] 2007-12-12 12:20:35,950 INFO mapred.JobClient (JobClient.java:runJob(755)) - Running job: job_local_3 [junit] 2007-12-12 12:20:35,956 INFO mapred.MapTask (MapTask.java:run(127)) - numReduceTasks: 1 [junit] 2007-12-12 12:20:35,976 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-12-12 12:20:35,977 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'job_local_3_map_0000' done. [junit] 2007-12-12 12:20:35,992 INFO mapred.LocalJobRunner (LocalJobRunner.java:statusUpdate(210)) - reduce > reduce [junit] 2007-12-12 12:20:35,993 INFO mapred.TaskRunner (Task.java:done(382)) - Task 'reduce_821jjx' done. [junit] 2007-12-12 12:20:35,999 INFO mapred.TaskRunner (Task.java:saveTaskOutput(434)) - Saved output of task 'reduce_821jjx' to http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/mapred.loadtest/finalouts [junit] 2007-12-12 12:20:36,975 INFO mapred.JobClient (JobClient.java:runJob(833)) - Job complete: job_local_3 [junit] 2007-12-12 12:20:36,976 INFO mapred.JobClient (Counters.java:log(367)) - Counters: 7 [junit] 2007-12-12 12:20:36,977 INFO mapred.JobClient (Counters.java:log(371)) - Map-Reduce Framework [junit] 2007-12-12 12:20:36,977 INFO mapred.JobClient (Counters.java:log(373)) - Map input records=10 [junit] 2007-12-12 12:20:36,978 INFO mapred.JobClient (Counters.java:log(373)) - Map output records=10 [junit] 2007-12-12 12:20:36,979 INFO mapred.JobClient (Counters.java:log(373)) - Map input bytes=116 [junit] 2007-12-12 12:20:36,979 INFO mapred.JobClient (Counters.java:log(373)) - Map output bytes=20 [junit] 2007-12-12 12:20:36,980 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input groups=10 [junit] 2007-12-12 12:20:36,981 INFO mapred.JobClient (Counters.java:log(373)) - Reduce input records=10 [junit] 2007-12-12 12:20:36,982 INFO mapred.JobClient (Counters.java:log(373)) - Reduce output records=10 [junit] Original sum: 102 [junit] Recomputed sum: 102 [junit] Success=true [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 6.684 sec [junit] Running org.apache.hadoop.record.TestRecordWritable [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 5.039 sec [junit] Running org.apache.hadoop.security.TestUnixUserGroupInformation [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.492 sec [junit] Running org.apache.hadoop.util.TestReflectionUtils [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.939 sec BUILD FAILED http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml :511: Tests failed! Total time: 46 minutes 49 seconds Recording fingerprints Publishing Javadoc Recording test results Updating HADOOP-2243 Updating HADOOP-2392 Updating HADOOP-2370 Updating HADOOP-2353 Updating HADOOP-2396 Updating HADOOP-2401 Updating HADOOP-2324 Updating HADOOP-2397 Updating HADOOP-2395