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 #614
Date Thu, 25 Sep 2008 16:30:31 GMT
See http://hudson.zones.apache.org/hudson/job/Hadoop-trunk/614/changes

Changes:

[szetszwo] HADOOP-4244. Change test-patch.sh to check Eclipse classpath no matter it is run
by Hudson or not. (szetszwo)

[lohit] HADOOP-4245. Move modifications from BUG to IMPROVEMENTS. (lohit)

[lohit] HADOOP-4234 Moving updates in CHANGES.txt from BUG to IMPROVEMENTS.

[lohit] HADOOP-4245. Update to latest version of KFS "glue" library jar. (Sriram Rao via lohit)

[lohit] HADOOP-4234. Fix KFS "glue" layer to allow applications to interface with multiple
KFS metaservers. (Sriram Rao via lohit)

[omalley] HADOOP-4249. Fix eclipse path to include the hsqldb.jar. (szetszwo via
omalley)

------------------------------------------
[...truncated 234622 lines...]
    [junit] 2008-09-25 16:30:02,756 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 0 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,756 INFO  hdfs.StateChange (FSNamesystem.java:addStoredBlock(2881))
- BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:33333 is added to blk_3937755069918167157_1001
size 100
    [junit] 2008-09-25 16:30:02,766 INFO  DataNode.clienttrace (BlockReceiver.java:run(907))
- src: /127.0.0.1:33342, dest: /127.0.0.1:33336, bytes: 100, op: HDFS_WRITE, cliID: DFSClient_-1872561071,
srvID: DS-1081934773-140.211.11.106-33336-1222360201695, blockid: blk_3937755069918167157_1001
    [junit] 2008-09-25 16:30:02,767 INFO  datanode.DataNode (BlockReceiver.java:run(971))
- PacketResponder 2 for block blk_3937755069918167157_1001 terminating
    [junit] 2008-09-25 16:30:02,767 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 0 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,769 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 6 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,769 INFO  hdfs.StateChange (FSNamesystem.java:addStoredBlock(2881))
- BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:33336 is added to blk_3937755069918167157_1001
size 100
    [junit] 2008-09-25 16:30:02,770 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 6 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,786 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 1 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,808 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 1 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,809 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 5 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,809 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,835 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission	src=/data/file1	dst=null	perm=hudson:supergroup:rw-------
    [junit] 2008-09-25 16:30:02,835 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 5 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,838 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 9 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,839 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,840 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=hudson,hudson	ip=/127.0.0.1	cmd=open	src=/data/file1	dst=null	perm=null
    [junit] 2008-09-25 16:30:02,841 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 9 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,847 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(396))
- src: /127.0.0.1:33336, dest: /127.0.0.1:33345, bytes: 104, op: HDFS_READ, cliID: DFSClient_-1872561071,
srvID: DS-1081934773-140.211.11.106-33336-1222360201695, blockid: blk_3937755069918167157_1001
    [junit] 2008-09-25 16:30:02,866 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 3 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,866 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 3 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,867 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 2 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,868 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,868 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1b7edd3, doCheckOwner=false,
ancestorAccess=null, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:02,869 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=user-181320963,group1,group2	ip=/127.0.0.1	cmd=mkdirs	src=/data/child1	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 2008-09-25 16:30:02,870 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 2 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,871 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 7 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,871 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,871 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@bb6086, doCheckOwner=false,
ancestorAccess=null, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:02,872 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,872 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1be1041, doCheckOwner=false,
ancestorAccess=WRITE, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:02,873 INFO  ipc.Server (Server.java:run(890)) - IPC Server handler
7 on 33327, call mkdirs(/data/child2, rwxr-xr-x) from 127.0.0.1:33346: error: org.apache.hadoop.fs.permission.AccessControlException:
Permission denied: user=user-181320963, access=WRITE, inode="data":hudson:supergroup:rwxr-xr-x
    [junit] org.apache.hadoop.fs.permission.AccessControlException: Permission denied: user=user-181320963,
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:4329)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkAncestorAccess(FSNamesystem.java:4299)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.mkdirsInternal(FSNamesystem.java:1732)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.mkdirs(FSNamesystem.java:1701)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.NameNode.mkdirs(NameNode.java:471)
    [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-25 16:30:02,874 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 7 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,876 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 8 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,876 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,877 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@dafa2c, doCheckOwner=false,
ancestorAccess=WRITE, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:02,877 INFO  ipc.Server (Server.java:run(890)) - IPC Server handler
8 on 33327, call create(/data/file2, rwxr-xr-x, DFSClient_942020273, true, 3, 67108864) from
127.0.0.1:33346: error: org.apache.hadoop.fs.permission.AccessControlException: Permission
denied: user=user-181320963, access=WRITE, inode="data":hudson:supergroup:rwxr-xr-x
    [junit] org.apache.hadoop.fs.permission.AccessControlException: Permission denied: user=user-181320963,
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:4329)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkAncestorAccess(FSNamesystem.java:4299)
    [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:301)
    [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-25 16:30:02,878 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 8 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,880 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 4 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,881 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,881 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@11c19e6, doCheckOwner=false,
ancestorAccess=null, parentAccess=null, access=READ, subAccess=null
    [junit] 2008-09-25 16:30:02,882 INFO  ipc.Server (Server.java:run(890)) - IPC Server handler
4 on 33327, call getBlockLocations(/data/file1, 0, 671088640) from 127.0.0.1:33346: error:
org.apache.hadoop.fs.permission.AccessControlException: Permission denied: user=user-181320963,
access=READ, inode="file1":hudson:supergroup:rw-------
    [junit] org.apache.hadoop.fs.permission.AccessControlException: Permission denied: user=user-181320963,
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:4329)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.checkPathAccess(FSNamesystem.java:4289)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlockLocations(FSNamesystem.java:744)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.NameNode.getBlockLocations(NameNode.java:272)
    [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-25 16:30:02,883 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 4 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,886 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 0 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,886 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,906 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission	src=/data	dst=null	perm=hudson:supergroup:rwxr-xr-x
    [junit] 2008-09-25 16:30:02,907 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 0 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,908 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 6 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,909 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,935 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission	src=/data/child1	dst=null	perm=hudson:supergroup:rwxrwxrwx
    [junit] 2008-09-25 16:30:02,936 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 6 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,937 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 1 on 33327, ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,938 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=hudson,hudson
    [junit] 2008-09-25 16:30:02,975 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=hudson,hudson	ip=/127.0.0.1	cmd=setPermission	src=/	dst=null	perm=hudson:supergroup:rwxrwxrwx
    [junit] 2008-09-25 16:30:02,975 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 1 on 33327, ugi=null
    [junit] 2008-09-25 16:30:02,977 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 5 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,977 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,978 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@23d278, doCheckOwner=false,
ancestorAccess=null, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:02,978 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:02,979 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1cec874, doCheckOwner=false,
ancestorAccess=WRITE, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:03,009 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=user-181320963,group1,group2	ip=/127.0.0.1	cmd=mkdirs	src=/foo/bar	dst=null	perm=user-181320963:supergroup:rwxr-xr-x
    [junit] 2008-09-25 16:30:03,010 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 5 on 33327, ugi=null
    [junit] 2008-09-25 16:30:03,011 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 9 on 33327, ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:03,012 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:03,012 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@1b493c6, doCheckOwner=false,
ancestorAccess=null, parentAccess=WRITE, access=null, subAccess=null
    [junit] 2008-09-25 16:30:03,012 DEBUG security.UserGroupInformation (PermissionChecker.java:<init>(40))
- ugi=user-181320963,group1,group2
    [junit] 2008-09-25 16:30:03,013 DEBUG security.UserGroupInformation (PermissionChecker.java:checkPermission(88))
- ACCESS CHECK: org.apache.hadoop.hdfs.server.namenode.PermissionChecker@51e67c, doCheckOwner=false,
ancestorAccess=WRITE, parentAccess=null, access=null, subAccess=null
    [junit] 2008-09-25 16:30:03,041 INFO  FSNamesystem.audit (FSNamesystem.java:logAuditEvent(108))
- ugi=user-181320963,group1,group2	ip=/127.0.0.1	cmd=rename	src=/foo/bar	dst=/data/child1
perm=hudson:supergroup:rwxrwxrwx
    [junit] 2008-09-25 16:30:03,042 DEBUG security.UserGroupInformation (UserGroupInformation.java:setCurrentUGI(46))
- IPC Server handler 9 on 33327, ugi=null
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 2
    [junit] 2008-09-25 16:30:03,056 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 127.0.0.1:33340
    [junit] 2008-09-25 16:30:03,202 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2008-09-25 16:30:03,272 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2008-09-25 16:30:03,272 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@c28cb7
    [junit] 2008-09-25 16:30:03,364 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2008-09-25 16:30:03,364 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@1e9d9b1
    [junit] 2008-09-25 16:30:03,370 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33341
    [junit] 2008-09-25 16:30:03,365 INFO  datanode.DataBlockScanner (DataBlockScanner.java:verifyBlock(434))
- Verification succeeded for blk_3937755069918167157_1001
    [junit] 2008-09-25 16:30:03,371 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
2 on 33341: exiting
    [junit] 2008-09-25 16:30:03,372 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
1 on 33341: exiting
    [junit] 2008-09-25 16:30:03,371 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
0 on 33341: exiting
    [junit] 2008-09-25 16:30:03,372 INFO  ipc.Server (Server.java:run(330)) - Stopping IPC
Server listener on 33341
    [junit] 2008-09-25 16:30:03,374 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 1
    [junit] 2008-09-25 16:30:03,374 INFO  ipc.Server (Server.java:run(502)) - Stopping IPC
Server Responder
    [junit] 2008-09-25 16:30:03,376 INFO  datanode.DataNode (DataNode.java:run(1130)) - DatanodeRegistration(127.0.0.1:33339,
storageID=DS-1280868638-140.211.11.106-33339-1222360202419, infoPort=33340, ipcPort=33341):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-25 16:30:03,377 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33341
    [junit] 2008-09-25 16:30:03,376 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(599))
- Exiting DataBlockScanner thread.
    [junit] 2008-09-25 16:30:03,378 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 1
    [junit] 2008-09-25 16:30:03,380 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 127.0.0.1:33337
    [junit] 2008-09-25 16:30:03,453 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2008-09-25 16:30:03,524 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2008-09-25 16:30:03,524 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@aa3518
    [junit] 2008-09-25 16:30:03,591 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2008-09-25 16:30:03,592 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@11df164
    [junit] 2008-09-25 16:30:03,592 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33338
    [junit] 2008-09-25 16:30:03,592 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
0 on 33338: exiting
    [junit] 2008-09-25 16:30:03,592 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
2 on 33338: exiting
    [junit] 2008-09-25 16:30:03,592 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
1 on 33338: exiting
    [junit] 2008-09-25 16:30:03,593 INFO  ipc.Server (Server.java:run(330)) - Stopping IPC
Server listener on 33338
    [junit] 2008-09-25 16:30:03,594 WARN  datanode.DataNode (DataXceiverServer.java:run(90))
- DatanodeRegistration(127.0.0.1:33336, storageID=DS-1081934773-140.211.11.106-33336-1222360201695,
infoPort=33337, ipcPort=33338):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-25 16:30:03,595 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2008-09-25 16:30:03,595 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(599))
- Exiting DataBlockScanner thread.
    [junit] 2008-09-25 16:30:03,596 INFO  datanode.DataNode (DataNode.java:run(1130)) - DatanodeRegistration(127.0.0.1:33336,
storageID=DS-1081934773-140.211.11.106-33336-1222360201695, infoPort=33337, ipcPort=33338):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-25 16:30:03,596 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33338
    [junit] 2008-09-25 16:30:03,597 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 0
    [junit] 2008-09-25 16:30:03,598 INFO  util.ThreadedServer (ThreadedServer.java:run(656))
- Stopping Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=33334]
    [junit] 2008-09-25 16:30:03,598 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 127.0.0.1:33334
    [junit] 2008-09-25 16:30:03,671 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2008-09-25 16:30:03,736 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2008-09-25 16:30:03,737 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@21447f
    [junit] 2008-09-25 16:30:03,804 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2008-09-25 16:30:03,805 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@152bdc7
    [junit] 2008-09-25 16:30:03,805 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33335
    [junit] 2008-09-25 16:30:03,806 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
0 on 33335: exiting
    [junit] 2008-09-25 16:30:03,807 INFO  ipc.Server (Server.java:run(330)) - Stopping IPC
Server listener on 33335
    [junit] 2008-09-25 16:30:03,808 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
1 on 33335: exiting
    [junit] 2008-09-25 16:30:03,808 WARN  datanode.DataNode (DataXceiverServer.java:run(90))
- DatanodeRegistration(127.0.0.1:33333, storageID=DS-830428096-140.211.11.106-33333-1222360201083,
infoPort=33334, ipcPort=33335):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-25 16:30:03,810 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
2 on 33335: exiting
    [junit] 2008-09-25 16:30:03,810 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2008-09-25 16:30:03,811 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(599))
- Exiting DataBlockScanner thread.
    [junit] 2008-09-25 16:30:03,811 INFO  datanode.DataNode (DataNode.java:run(1130)) - DatanodeRegistration(127.0.0.1:33333,
storageID=DS-830428096-140.211.11.106-33333-1222360201083, infoPort=33334, ipcPort=33335):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-25 16:30:03,812 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33335
    [junit] 2008-09-25 16:30:03,813 INFO  datanode.DataNode (DataNode.java:shutdown(574))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2008-09-25 16:30:03,814 INFO  util.ThreadedServer (ThreadedServer.java:run(656))
- Stopping Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=33328]
    [junit] 2008-09-25 16:30:03,815 INFO  http.SocketListener (SocketListener.java:stop(212))
- Stopped SocketListener on 127.0.0.1:33328
    [junit] 2008-09-25 16:30:03,879 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/static,/static]
    [junit] 2008-09-25 16:30:03,943 INFO  util.Container (Container.java:stop(156)) - Stopped
HttpContext[/logs,/logs]
    [junit] 2008-09-25 16:30:03,943 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.servlet.WebApplicationHandler@161f39e
    [junit] 2008-09-25 16:30:04,009 INFO  util.Container (Container.java:stop(156)) - Stopped
WebApplicationContext[/,/]
    [junit] 2008-09-25 16:30:04,010 INFO  util.Container (Container.java:stop(156)) - Stopped
org.mortbay.jetty.Server@100aff5
    [junit] 2008-09-25 16:30:04,010 WARN  namenode.FSNamesystem (FSNamesystem.java:run(2271))
- ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException:
sleep interrupted
    [junit] 2008-09-25 16:30:04,011 INFO  namenode.FSNamesystem (FSEditLog.java:printStatistics(959))
- Number of transactions: 12 Total time for transactions(ms): 0 Number of syncs: 9 SyncTimes(ms):
124 109 
    [junit] 2008-09-25 16:30:04,040 INFO  ipc.Server (Server.java:stop(992)) - Stopping server
on 33327
    [junit] 2008-09-25 16:30:04,041 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
0 on 33327: exiting
    [junit] 2008-09-25 16:30:04,041 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
1 on 33327: exiting
    [junit] 2008-09-25 16:30:04,041 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
4 on 33327: exiting
    [junit] 2008-09-25 16:30:04,041 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
3 on 33327: exiting
    [junit] 2008-09-25 16:30:04,042 INFO  ipc.Server (Server.java:run(330)) - Stopping IPC
Server listener on 33327
    [junit] 2008-09-25 16:30:04,042 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
2 on 33327: exiting
    [junit] 2008-09-25 16:30:04,042 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
8 on 33327: exiting
    [junit] 2008-09-25 16:30:04,043 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
5 on 33327: exiting
    [junit] 2008-09-25 16:30:04,043 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
6 on 33327: exiting
    [junit] 2008-09-25 16:30:04,043 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
9 on 33327: exiting
    [junit] 2008-09-25 16:30:04,043 INFO  ipc.Server (Server.java:run(920)) - IPC Server handler
7 on 33327: exiting
    [junit] 2008-09-25 16:30:04,044 INFO  ipc.Server (Server.java:run(502)) - Stopping IPC
Server Responder
    [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 13.774 sec
    [junit] Running org.apache.hadoop.security.TestUnixUserGroupInformation
    [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.508 sec
    [junit] Running org.apache.hadoop.util.TestGenericsUtil
    [junit] 2008-09-25 16:30:05,777 WARN  util.GenericOptionsParser (GenericOptionsParser.java:parseGeneralOptions(348))
- 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.191 sec
    [junit] Running org.apache.hadoop.util.TestIndexedSort
    [junit] sortRandom seed: 202165718887400273(org.apache.hadoop.util.QuickSort)
    [junit] testSorted seed: 2220577932275200250(org.apache.hadoop.util.QuickSort)
    [junit] testAllEqual setting min/max at 427/292(org.apache.hadoop.util.QuickSort)
    [junit] sortWritable seed: -8746593912886791740(org.apache.hadoop.util.QuickSort)
    [junit] QuickSort degen cmp/swp: 23252/3713(org.apache.hadoop.util.QuickSort)
    [junit] sortRandom seed: 6490199471831054688(org.apache.hadoop.util.HeapSort)
    [junit] testSorted seed: 9024855287865964432(org.apache.hadoop.util.HeapSort)
    [junit] testAllEqual setting min/max at 349/455(org.apache.hadoop.util.HeapSort)
    [junit] sortWritable seed: -7033638624410766886(org.apache.hadoop.util.HeapSort)
    [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 1.406 sec
    [junit] Running org.apache.hadoop.util.TestProcfsBasedProcessTree
    [junit] 2008-09-25 16:30:08,439 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.061 sec
    [junit] Running org.apache.hadoop.util.TestReflectionUtils
    [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.806 sec
    [junit] Running org.apache.hadoop.util.TestShell
    [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.27 sec
    [junit] Running org.apache.hadoop.util.TestStringUtils
    [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.089 sec

BUILD FAILED
/zonestorage/hudson/home/hudson/hudson/jobs/Hadoop-trunk/workspace/trunk/build.xml:661: Tests
failed!

Total time: 107 minutes 57 seconds
Recording fingerprints
Publishing Javadoc
Recording test results


Mime
View raw message