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