hadoop-common-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Hudson Server <hud...@hudson.zones.apache.org>
Subject Build failed in Hudson: Hadoop-trunk #606
Date Wed, 17 Sep 2008 13:41:00 GMT
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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@18e899c, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1dd7736, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@bd93cd, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1f8f8c8, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1533c8, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@83e5f1, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@16d64c5, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@185fe0c, 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: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1e9f5cc, 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
org.mortbay.jetty.servlet.WebApplicationHandler@182a033
    [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
org.mortbay.jetty.Server@18600d6
    [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
org.mortbay.jetty.servlet.WebApplicationHandler@e7d53
    [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
org.mortbay.jetty.Server@553763
    [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
org.mortbay.jetty.servlet.WebApplicationHandler@e0f0ad
    [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
org.mortbay.jetty.Server@135daf
    [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
org.mortbay.jetty.servlet.WebApplicationHandler@1b11b79
    [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
org.mortbay.jetty.Server@128635
    [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


Mime
View raw message