See http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/606/changes
Changes:
[ddas] HADOOP-4125. Handles Reduce cleanup tip on the web ui. Contributed by
Amareshwari Sriramadasu.
[szetszwo] HADOOP-3623. Refactor LeaseManager. (szetszwo)
[omalley] HADOOP-4181. Expand abbreviation of 'br' to 'branch' for the git
commands in
saveVersion.sh.
[lohit] HADOOP-3911. Add a check to fsck options to make sure -files is not the
first option to resolve conflicts with GenericOptionsParser
[dhruba] HADOOP-4139. Optimize Hive multi group-by.
(Namin Jain via dhruba)
[omalley] HADOOP-4181. Include a .gitignore and saveVersion.sh change to support
developing under git. (omalley)
[hairong] HADOOP-4007. Remove DFSFileInfo. Contributed by Sanjay Radia.
[szetszwo] HADOOP-4174. Move fs image/edit log methods from ClientProtocol to
NamenodeProtocol. (shv via szetszwo)
[szetszwo] HADOOP-4174. Move fs image/edit log methods from ClientProtocol to
NamenodeProtocol. (shv via szetszwo)
[acmurthy] HADOOP-4129. Changed memory limits of TaskTracker and Tasks to be in
KiloBytes rather than bytes. Contributed by Vinod Kumar Vavilapalli.
[ddas] HADOOP-3570. Includes user specified libjar files in the client side
classpath path. Contributed by Sharad Agarwal.
[ddas] HADOOP-3245. Adds the feature for supporting JobTracker restart. Running
jobs can be recovered from the history file. The history file format has been
modified to support recovery. The task attempt ID now has the JobTracker start
time to disinguish attempts of the same TIP across restarts. Contributed by
Amar Ramesh Kamat.
------------------------------------------
[...truncated 217544 lines...]
[junit] 2008-09-17 13:40:26,844 INFO hdfs.StateChange
(FSNamesystem.java:addStoredBlock(2857)) - BLOCK* NameSystem.addStoredBlock:
blockMap updated: 127.0.0.1:37409 is added to blk_-7169221198705558734_1001
size 100
[junit] 2008-09-17 13:40:26,845 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 0 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,873 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 9 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,875 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 7 on 37399,
ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,875 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,900 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=hudson,hudson ip=/127.0.0.1
cmd=setPermission src=/data/file1 dst=null
perm=hudson:supergroup:rw-------
[junit] 2008-09-17 13:40:26,901 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 7 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,906 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 6 on 37399,
ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,907 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,909 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=hudson,hudson ip=/127.0.0.1
cmd=open src=/data/file1 dst=null perm=null
[junit] 2008-09-17 13:40:26,910 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 6 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,919 INFO DataNode.clienttrace
(BlockSender.java:sendBlock(396)) - src: /127.0.0.1:37409, dest:
/127.0.0.1:37415, bytes: 104, op: HDFS_READ, cliID: DFSClient_1083810992,
srvID: DS-1482189001-140.211.11.106-37409-1221658826557, blockid:
blk_-7169221198705558734_1001
[junit] 2008-09-17 13:40:26,923 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 8 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,923 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 8 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,925 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 5 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,925 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,926 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=null, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:26,927 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=user839534559,group1,group2
ip=/127.0.0.1 cmd=mkdirs src=/data/child1 dst=null
perm=hudson:supergroup:rwxr-xr-x
[junit] 2008-09-17 13:40:26,928 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 5 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,930 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 3 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,930 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,931 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=null, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:26,931 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,931 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=WRITE, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:26,932 INFO ipc.Server (Server.java:run(890)) -
IPC Server handler 3 on 37399, call mkdirs(/data/child2, rwxr-xr-x) from
127.0.0.1:37416: error: org.apache.hadoop.fs.permission.AccessControlException:
Permission denied: user=user839534559, access=WRITE,
inode="data":hudson:supergroup:rwxr-xr-x
[junit] org.apache.hadoop.fs.permission.AccessControlException: Permission
denied: user=user839534559, access=WRITE,
inode="data":hudson:supergroup:rwxr-xr-x
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.check(PermissionChecker.java:175)
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.check(PermissionChecker.java:156)
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.checkPermission(PermissionChecker.java:104)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkPermission(FSNamesystem.java:4284)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkAncestorAccess(FSNamesystem.java:4254)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.mkdirsInternal(FSNamesystem.java:1709)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.mkdirs(FSNamesystem.java:1678)
[junit] at
org.apache.hadoop.hdfs.server.namenode.NameNode.mkdirs(NameNode.java:469)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:452)
[junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:888)
[junit] 2008-09-17 13:40:26,933 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 3 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,937 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 4 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,938 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,938 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=WRITE, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:26,939 INFO ipc.Server (Server.java:run(890)) -
IPC Server handler 4 on 37399, call create(/data/file2, rwxr-xr-x,
DFSClient_1903107708, true, 3, 67108864) from 127.0.0.1:37416: error:
org.apache.hadoop.fs.permission.AccessControlException: Permission denied:
user=user839534559, access=WRITE, inode="data":hudson:supergroup:rwxr-xr-x
[junit] org.apache.hadoop.fs.permission.AccessControlException: Permission
denied: user=user839534559, access=WRITE,
inode="data":hudson:supergroup:rwxr-xr-x
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.check(PermissionChecker.java:175)
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.check(PermissionChecker.java:156)
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.checkPermission(PermissionChecker.java:104)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkPermission(FSNamesystem.java:4284)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkAncestorAccess(FSNamesystem.java:4254)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.startFileInternal(FSNamesystem.java:1030)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.startFile(FSNamesystem.java:991)
[junit] at
org.apache.hadoop.hdfs.server.namenode.NameNode.create(NameNode.java:299)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:452)
[junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:888)
[junit] 2008-09-17 13:40:26,940 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 4 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,943 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 2 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,944 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:26,945 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=null, parentAccess=null, access=READ,
subAccess=null
[junit] 2008-09-17 13:40:26,945 INFO ipc.Server (Server.java:run(890)) -
IPC Server handler 2 on 37399, call getBlockLocations(/data/file1, 0,
671088640) from 127.0.0.1:37416: error:
org.apache.hadoop.fs.permission.AccessControlException: Permission denied:
user=user839534559, access=READ, inode="file1":hudson:supergroup:rw-------
[junit] org.apache.hadoop.fs.permission.AccessControlException: Permission
denied: user=user839534559, access=READ,
inode="file1":hudson:supergroup:rw-------
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.check(PermissionChecker.java:175)
[junit] at
org.apache.hadoop.hdfs.server.namenode.PermissionChecker.checkPermission(PermissionChecker.java:110)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkPermission(FSNamesystem.java:4284)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkPathAccess(FSNamesystem.java:4244)
[junit] at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlockLocations(FSNamesystem.java:741)
[junit] at
org.apache.hadoop.hdfs.server.namenode.NameNode.getBlockLocations(NameNode.java:270)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:452)
[junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:888)
[junit] 2008-09-17 13:40:26,946 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 2 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,949 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 1 on 37399,
ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,950 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,976 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=hudson,hudson ip=/127.0.0.1
cmd=setPermission src=/data dst=null
perm=hudson:supergroup:rwxr-xr-x
[junit] 2008-09-17 13:40:26,976 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 1 on 37399,
ugi=null
[junit] 2008-09-17 13:40:26,977 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 0 on 37399,
ugi=hudson,hudson
[junit] 2008-09-17 13:40:26,978 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=hudson,hudson
[junit] 2008-09-17 13:40:27,003 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=hudson,hudson ip=/127.0.0.1
cmd=setPermission src=/data/child1 dst=null
perm=hudson:supergroup:rwxrwxrwx
[junit] 2008-09-17 13:40:27,004 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 0 on 37399,
ugi=null
[junit] 2008-09-17 13:40:27,010 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 9 on 37399,
ugi=hudson,hudson
[junit] 2008-09-17 13:40:27,010 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=hudson,hudson
[junit] 2008-09-17 13:40:27,030 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=hudson,hudson ip=/127.0.0.1
cmd=setPermission src=/ dst=null perm=hudson:supergroup:rwxrwxrwx
[junit] 2008-09-17 13:40:27,030 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 9 on 37399,
ugi=null
[junit] 2008-09-17 13:40:27,031 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 7 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,032 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,032 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=null, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:27,032 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,033 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=WRITE, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:27,061 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=user839534559,group1,group2
ip=/127.0.0.1 cmd=mkdirs src=/foo/bar dst=null
perm=user839534559:supergroup:rwxr-xr-x
[junit] 2008-09-17 13:40:27,062 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 7 on 37399,
ugi=null
[junit] 2008-09-17 13:40:27,063 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 6 on 37399,
ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,064 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,064 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=null, parentAccess=WRITE, access=null,
subAccess=null
[junit] 2008-09-17 13:40:27,064 DEBUG security.UserGroupInformation
(PermissionChecker.java:<init>(40)) - ugi=user839534559,group1,group2
[junit] 2008-09-17 13:40:27,065 DEBUG security.UserGroupInformation
(PermissionChecker.java:checkPermission(88)) - ACCESS CHECK: [EMAIL PROTECTED],
doCheckOwner=false, ancestorAccess=WRITE, parentAccess=null, access=null,
subAccess=null
[junit] 2008-09-17 13:40:27,091 INFO FSNamesystem.audit
(FSNamesystem.java:logAuditEvent(107)) - ugi=user839534559,group1,group2
ip=/127.0.0.1 cmd=rename src=/foo/bar dst=/data/child1
perm=hudson:supergroup:rwxrwxrwx
[junit] 2008-09-17 13:40:27,092 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 6 on 37399,
ugi=null
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 2
[junit] 2008-09-17 13:40:27,105 INFO http.SocketListener
(SocketListener.java:stop(212)) - Stopped SocketListener on 127.0.0.1:37410
[junit] 2008-09-17 13:40:27,334 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2008-09-17 13:40:27,402 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2008-09-17 13:40:27,403 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,483 INFO util.Container
(Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2008-09-17 13:40:27,483 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,483 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37411
[junit] 2008-09-17 13:40:27,484 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 0 on 37411: exiting
[junit] 2008-09-17 13:40:27,484 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 2 on 37411: exiting
[junit] 2008-09-17 13:40:27,485 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 1 on 37411: exiting
[junit] 2008-09-17 13:40:27,485 INFO ipc.Server (Server.java:run(330)) -
Stopping IPC Server listener on 37411
[junit] 2008-09-17 13:40:27,487 WARN datanode.DataNode
(DataXceiverServer.java:run(90)) - DatanodeRegistration(127.0.0.1:37409,
storageID=DS-1482189001-140.211.11.106-37409-1221658826557, infoPort=37410,
ipcPort=37411):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at
java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at
sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at
org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:85)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2008-09-17 13:40:27,488 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2008-09-17 13:40:27,489 INFO datanode.DataNode
(DataNode.java:run(1124)) - DatanodeRegistration(127.0.0.1:37409,
storageID=DS-1482189001-140.211.11.106-37409-1221658826557, infoPort=37410,
ipcPort=37411):Finishing DataNode in:
FSDataset{dirpath='/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data5/current,/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data6/current'}
[junit] 2008-09-17 13:40:27,489 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37411
[junit] 2008-09-17 13:40:27,490 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2008-09-17 13:40:27,489 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(599)) - Exiting DataBlockScanner thread.
[junit] Shutting down DataNode 1
[junit] 2008-09-17 13:40:27,492 INFO util.ThreadedServer
(ThreadedServer.java:run(656)) - Stopping Acceptor
ServerSocket[addr=localhost/127.0.0.1,port=0,localport=37407]
[junit] 2008-09-17 13:40:27,495 INFO http.SocketListener
(SocketListener.java:stop(212)) - Stopped SocketListener on 127.0.0.1:37407
[junit] 2008-09-17 13:40:27,564 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2008-09-17 13:40:27,640 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2008-09-17 13:40:27,641 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,719 INFO util.Container
(Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2008-09-17 13:40:27,720 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,720 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37408
[junit] 2008-09-17 13:40:27,720 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 0 on 37408: exiting
[junit] 2008-09-17 13:40:27,720 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 1 on 37408: exiting
[junit] 2008-09-17 13:40:27,721 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 2 on 37408: exiting
[junit] 2008-09-17 13:40:27,721 INFO ipc.Server (Server.java:run(330)) -
Stopping IPC Server listener on 37408
[junit] 2008-09-17 13:40:27,722 WARN datanode.DataNode
(DataXceiverServer.java:run(90)) - DatanodeRegistration(127.0.0.1:37406,
storageID=DS-1745820022-140.211.11.106-37406-1221658825726, infoPort=37407,
ipcPort=37408):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at
java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at
sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at
org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:85)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2008-09-17 13:40:27,723 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2008-09-17 13:40:27,723 INFO datanode.DataNode
(DataNode.java:run(1124)) - DatanodeRegistration(127.0.0.1:37406,
storageID=DS-1745820022-140.211.11.106-37406-1221658825726, infoPort=37407,
ipcPort=37408):Finishing DataNode in:
FSDataset{dirpath='/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data3/current,/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data4/current'}
[junit] 2008-09-17 13:40:27,724 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37408
[junit] 2008-09-17 13:40:27,723 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(599)) - Exiting DataBlockScanner thread.
[junit] 2008-09-17 13:40:27,724 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] Shutting down DataNode 0
[junit] 2008-09-17 13:40:27,726 INFO util.ThreadedServer
(ThreadedServer.java:run(656)) - Stopping Acceptor
ServerSocket[addr=localhost/127.0.0.1,port=0,localport=37404]
[junit] 2008-09-17 13:40:27,727 INFO http.SocketListener
(SocketListener.java:stop(212)) - Stopped SocketListener on 127.0.0.1:37404
[junit] 2008-09-17 13:40:27,799 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2008-09-17 13:40:27,863 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2008-09-17 13:40:27,864 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,931 INFO util.Container
(Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2008-09-17 13:40:27,932 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:27,932 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37405
[junit] 2008-09-17 13:40:27,933 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 0 on 37405: exiting
[junit] 2008-09-17 13:40:27,934 INFO ipc.Server (Server.java:run(330)) -
Stopping IPC Server listener on 37405
[junit] 2008-09-17 13:40:27,935 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 2 on 37405: exiting
[junit] 2008-09-17 13:40:27,935 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 1 on 37405: exiting
[junit] 2008-09-17 13:40:27,936 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 8 on 37399,
ugi=null
[junit] 2008-09-17 13:40:27,936 DEBUG security.UserGroupInformation
(UserGroupInformation.java:setCurrentUGI(46)) - IPC Server handler 8 on 37399,
ugi=null
[junit] 2008-09-17 13:40:27,938 WARN datanode.DataNode
(DataXceiverServer.java:run(90)) - DatanodeRegistration(127.0.0.1:37403,
storageID=DS-1412993813-140.211.11.106-37403-1221658824846, infoPort=37404,
ipcPort=37405):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at
java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at
sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at
org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:85)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2008-09-17 13:40:27,939 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2008-09-17 13:40:27,939 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(599)) - Exiting DataBlockScanner thread.
[junit] 2008-09-17 13:40:27,940 INFO datanode.DataNode
(DataNode.java:run(1124)) - DatanodeRegistration(127.0.0.1:37403,
storageID=DS-1412993813-140.211.11.106-37403-1221658824846, infoPort=37404,
ipcPort=37405):Finishing DataNode in:
FSDataset{dirpath='/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data1/current,/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build/test/data/dfs/data/data2/current'}
[junit] 2008-09-17 13:40:27,941 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37405
[junit] 2008-09-17 13:40:27,941 INFO datanode.DataNode
(DataNode.java:shutdown(568)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2008-09-17 13:40:27,942 INFO http.SocketListener
(SocketListener.java:stop(212)) - Stopped SocketListener on 127.0.0.1:37400
[junit] 2008-09-17 13:40:28,008 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/static,/static]
[junit] 2008-09-17 13:40:28,073 INFO util.Container
(Container.java:stop(156)) - Stopped HttpContext[/logs,/logs]
[junit] 2008-09-17 13:40:28,074 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:28,136 INFO util.Container
(Container.java:stop(156)) - Stopped WebApplicationContext[/,/]
[junit] 2008-09-17 13:40:28,136 INFO util.Container
(Container.java:stop(156)) - Stopped [EMAIL PROTECTED]
[junit] 2008-09-17 13:40:28,137 WARN namenode.FSNamesystem
(FSNamesystem.java:run(2264)) - ReplicationMonitor thread received
InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2008-09-17 13:40:28,137 INFO namenode.FSNamesystem
(FSEditLog.java:printStatistics(945)) - Number of transactions: 12 Total time
for transactions(ms): 3 Number of syncs: 9 SyncTimes(ms): 116 109
[junit] 2008-09-17 13:40:28,172 INFO ipc.Server (Server.java:stop(992)) -
Stopping server on 37399
[junit] 2008-09-17 13:40:28,172 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 0 on 37399: exiting
[junit] 2008-09-17 13:40:28,173 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 1 on 37399: exiting
[junit] 2008-09-17 13:40:28,173 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 2 on 37399: exiting
[junit] 2008-09-17 13:40:28,173 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 6 on 37399: exiting
[junit] 2008-09-17 13:40:28,174 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 3 on 37399: exiting
[junit] 2008-09-17 13:40:28,174 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 5 on 37399: exiting
[junit] 2008-09-17 13:40:28,174 INFO ipc.Server (Server.java:run(330)) -
Stopping IPC Server listener on 37399
[junit] 2008-09-17 13:40:28,174 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 7 on 37399: exiting
[junit] 2008-09-17 13:40:28,175 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 8 on 37399: exiting
[junit] 2008-09-17 13:40:28,174 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 4 on 37399: exiting
[junit] 2008-09-17 13:40:28,175 INFO ipc.Server (Server.java:run(920)) -
IPC Server handler 9 on 37399: exiting
[junit] 2008-09-17 13:40:28,176 INFO ipc.Server (Server.java:run(502)) -
Stopping IPC Server Responder
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 15.426 sec
[junit] Running org.apache.hadoop.security.TestUnixUserGroupInformation
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.484 sec
[junit] Running org.apache.hadoop.util.TestGenericsUtil
[junit] 2008-09-17 13:40:29,774 WARN util.GenericOptionsParser
(GenericOptionsParser.java:parseGeneralOptions(345)) - options parsing failed:
Missing argument for option:jt
[junit] usage: general options are:
[junit] -archives <paths> comma separated archives to be
unarchived
[junit] on the compute machines.
[junit] -conf <configuration file> specify an application configuration
file
[junit] -D <property=value> use value for given property
[junit] -files <paths> comma separated files to be copied
to the
[junit] map reduce cluster
[junit] -fs <local|namenode:port> specify a namenode
[junit] -jt <local|jobtracker:port> specify a job tracker
[junit] -libjars <paths> comma separated jar files to include
in the
[junit] classpath.
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 0.187 sec
[junit] Running org.apache.hadoop.util.TestIndexedSort
[junit] sortRandom seed:
-8170522536807500069(org.apache.hadoop.util.QuickSort)
[junit] testSorted seed:
-4458332847728739565(org.apache.hadoop.util.QuickSort)
[junit] testAllEqual setting min/max at
323/39(org.apache.hadoop.util.QuickSort)
[junit] sortWritable seed:
-7599422933167759046(org.apache.hadoop.util.QuickSort)
[junit] QuickSort degen cmp/swp:
23252/3713(org.apache.hadoop.util.QuickSort)
[junit] sortRandom seed:
5967690104260980561(org.apache.hadoop.util.HeapSort)
[junit] testSorted seed:
-2482673484242788211(org.apache.hadoop.util.HeapSort)
[junit] testAllEqual setting min/max at
180/123(org.apache.hadoop.util.HeapSort)
[junit] sortWritable seed:
3938305031454151016(org.apache.hadoop.util.HeapSort)
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 1.614 sec
[junit] Running org.apache.hadoop.util.TestProcfsBasedProcessTree
[junit] 2008-09-17 13:40:32,511 INFO mapred.ProcfsBasedProcessTree
(ProcfsBasedProcessTree.java:isAvailable(76)) -
ProcfsBasedProcfsBasedProcessTree currently is supported only on Linux and
Windows
[junit] ProcfsBasedProcessTree is not available on this system. Not testing
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.054 sec
[junit] Running org.apache.hadoop.util.TestReflectionUtils
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.78 sec
[junit] Running org.apache.hadoop.util.TestShell
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.283 sec
[junit] Running org.apache.hadoop.util.TestStringUtils
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.087 sec
BUILD FAILED
/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build.xml:658:
Tests failed!
Total time: 108 minutes 2 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
