Hudson executes Test target twice and hangs to infinity
-------------------------------------------------------
Key: HAMA-384
URL: https://issues.apache.org/jira/browse/HAMA-384
Project: Hama
Issue Type: Bug
Components: test
Affects Versions: 0.3.0
Environment: solaris / apache's hudson
Reporter: Thomas Jungblut
Priority: Blocker
Fix For: 0.3.0
E.G:
https://builds.apache.org/hudson/job/Hama-Patch/332/console
You see that TEST target get executed twice, the first time it runs great. The
second attempt hangs with timeout problems in the test
"org.apache.hama.bsp.TestBSPMasterGroomServer".
Some Exceptions:
11/05/07 07:01:11 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x12fca1dfc830003 type:create
cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/bsp
Error:KeeperErrorCode = NodeExists for /bsp
11/05/07 07:01:11 ERROR server.NIOServerCnxn: Unexpected Exception:
java.nio.channels.CancelledKeyException
at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:55)
at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:59)
at
org.apache.zookeeper.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:417)
at
org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1508)
at
org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:367)
at
org.apache.zookeeper.server.SyncRequestProcessor.flush(SyncRequestProcessor.java:161)
at
org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:98)
11/05/07 07:01:11 INFO server.NIOServerCnxn: Closed socket connection for
client /127.0.0.1:34147 which had sessionid 0x12fca1dfc830009
11/05/07 07:01:11 INFO zookeeper.ClientCnxn: Opening socket connection to
server localhost/127.0.0.1:21810 11/05/07 07:01:11 INFO zookeeper.ClientCnxn:
Socket connection established to localhost/127.0.0.1:21810, initiating session
11/05/07 07:01:11 INFO server.NIOServerCnxn: Accepted socket connection from
/127.0.0.1:34150 11/05/07 07:01:11 INFO server.NIOServerCnxn: Client attempting
to establish new session at /127.0.0.1:34150 11/05/07 07:01:11 INFO
server.NIOServerCnxn: Established session 0x12fca1dfc83000a with negotiated
timeout 4000 for client /127.0.0.1:34150 11/05/07 07:01:11 INFO
zookeeper.ClientCnxn: Session establishment complete on server
localhost/127.0.0.1:21810, sessionid = 0x12fca1dfc83000a, negotiated timeout =
4000 11/05/07 07:01:12 INFO ipc.Client: Retrying connect to server:
localhost/127.0.0.1:40000. Already tried 9 time(s). 11/05/07 07:01:12 INFO
ipc.RPC: Server at localhost/127.0.0.1:40000 not available yet, Zzzzz...
11/05/07 07:01:12 INFO zookeeper.ClientCnxn: Opening socket connection to
server localhost/127.0.0.1:21810 11/05/07 07:01:12 INFO zookeeper.ClientCnxn:
Socket connection established to localhost/127.0.0.1:21810, initiating session
11/05/07 07:01:12 INFO server.NIOServerCnxn: Accepted socket connection from
/127.0.0.1:34152
11/05/07 07:01:12 INFO server.NIOServerCnxn: Client attempting to establish new
session at /127.0.0.1:34152 11/05/07 07:01:12 INFO server.NIOServerCnxn:
Established session 0x12fca1dfc83000b with negotiated timeout 4000 for client
/127.0.0.1:34152 11/05/07 07:01:12 INFO zookeeper.ClientCnxn: Session
establishment complete on server localhost/127.0.0.1:21810, sessionid =
0x12fca1dfc83000b, negotiated timeout = 4000
11/05/07 07:01:14 INFO ipc.Client: Retrying connect to server:
localhost/127.0.0.1:40000. Already tried 0 time(s).
11/05/07 07:01:15 INFO ipc.Client: Retrying connect to server:
localhost/127.0.0.1:40000. Already tried 1 time(s). 11/05/07 07:01:16 INFO
server.ZooKeeperServer: Expiring session 0x12fca1dfc830009, timeout of 4000ms
exceeded 11/05/07 07:01:16 INFO server.ZooKeeperServer: Expiring session
0x12fca1dfc830006, timeout of 4000ms exceeded 11/05/07 07:01:16 INFO
server.ZooKeeperServer: Expiring session 0x12fca1dfc830008, timeout of 4000ms
exceeded 11/05/07 07:01:16 INFO server.ZooKeeperServer: Expiring session
0x12fca1dfc830007, timeout of 4000ms exceeded 11/05/07 07:01:16 INFO
server.PrepRequestProcessor: Processed session termination for sessionid:
0x12fca1dfc830009 11/05/07 07:01:16 INFO server.PrepRequestProcessor: Processed
session termination for sessionid: 0x12fca1dfc830006 11/05/07 07:01:16 INFO
server.PrepRequestProcessor: Processed session termination for sessionid:
0x12fca1dfc830008 11/05/07 07:01:16 INFO server.PrepRequestProcessor: Processed
session termination for sessionid: 0x12fca1dfc830007 11/05/07 07:01:16 INFO
ipc.Client: Retrying connect to server: localhost/127.0.0.1:40000. Already
tried 2 time(s).
11/05/07 07:01:17 INFO ipc.Client: Retrying connect to server:
localhost/127.0.0.1:40000. Already tried 3 time(s).
11/05/07 07:01:18 INFO ipc.Client: Retrying connect to server:
localhost/127.0.0.1:40000. Already tried 4 time(s).
etc.
--
This message is automatically generated by JIRA.
For more information on JIRA, see: http://www.atlassian.com/software/jira
