[jboss-user] [JBoss Messaging] New message: "Remote JmsProvider - Server restarts, client stops"

Thu Jan 28 08:43:50 EST 2010

User development,

A new message was posted in the thread "Remote JmsProvider - Server restarts, client stops":

http://community.jboss.org/message/522743#522743

Author  : Pedro Gontijo
Profile : http://community.jboss.org/people/pedrong

Message:
--------------------------------------------------------------
I dont know if this is a JBM or Remoting issue, but here it goes...

The client is AS 4.2.3.GA with JBM 1.4.5.GA and remoting 2.2.3.SP1
The server is a clustered AS 5.1.0.GA with JBM 1.4.3.GA and remoting 2.5.2.SP1

In the client (4.2.3) there is a JMS provider which jndi properties is set to the server. And a connection manager using this provider so a could have XA transactions. (Works just fine)

When the server is restarted, remoting logs the following:

{noformat}
2010-01-28 11:02:34,656 DEBUG [org.jboss.remoting.transport.socket.MicroSocketClientInvoker] SocketClientInvoker[191b73f, bisocket://172.20.37.19:4757] got java.net.ConnectException: Connection refused: connect: Connection refused: connect
2010-01-28 11:02:34,656 DEBUG [org.jboss.remoting.LeasePinger] org.jboss.remoting.LeasePinger$LeaseTimerTask at 1ac0080 failed to ping to server
org.jboss.remoting.CannotConnectException: Can not get connection to server. Problem establishing socket connection for InvokerLocator [bisocket://172.20.37.19:4757/?JBM_clientMaxPoolSize=200&clientLeasePeriod=10000&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper&connectionWait=10&dataType=jms&marshaller=org.jboss.jms.wireformat.JMSWireFormat&numberOfCallRetries=1&pingFrequency=214748364&pingWindowFactor=10&socket.check_connection=false&stopLeaseOnFailure=true&timeout=0&unmarshaller=org.jboss.jms.wireformat.JMSWireFormat&validatorPingPeriod=10000&validatorPingTimeout=5000]
    at org.jboss.remoting.transport.socket.MicroSocketClientInvoker.transport(MicroSocketClientInvoker.java:613)
    at org.jboss.remoting.transport.bisocket.BisocketClientInvoker.transport(BisocketClientInvoker.java:458)
    at org.jboss.remoting.MicroRemoteClientInvoker.invoke(MicroRemoteClientInvoker.java:141)
    at org.jboss.remoting.LeasePinger.sendClientPing(LeasePinger.java:375)
    at org.jboss.remoting.LeasePinger.access$000(LeasePinger.java:20)
    at org.jboss.remoting.LeasePinger$LeaseTimerTask.run(LeasePinger.java:403)
    at java.util.TimerThread.mainLoop(Timer.java:512)
    at java.util.TimerThread.run(Timer.java:462)
Caused by: java.net.ConnectException: Connection refused: connect
    at java.net.PlainSocketImpl.socketConnect(Native Method)
    at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333)
    at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195)
    at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182)
    at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366)
    at java.net.Socket.connect(Socket.java:520)
    at org.jboss.remoting.transport.socket.SocketClientInvoker.createSocket(SocketClientInvoker.java:192)
    at org.jboss.remoting.transport.bisocket.BisocketClientInvoker.createSocket(BisocketClientInvoker.java:465)
    at org.jboss.remoting.transport.socket.MicroSocketClientInvoker.getConnection(MicroSocketClientInvoker.java:913)
    at org.jboss.remoting.transport.socket.MicroSocketClientInvoker.transport(MicroSocketClientInvoker.java:602)
    ... 7 more
2010-01-28 11:02:34,656 WARN  [org.jboss.remoting.LeasePinger] org.jboss.remoting.LeasePinger$LeaseTimerTask at 1ac0080 failed to ping to server: Can not get connection to server. Problem establishing socket connection for InvokerLocator [bisocket://172.20.37.19:4757/?JBM_clientMaxPoolSize=200&clientLeasePeriod=10000&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper&connectionWait=10&dataType=jms&marshaller=org.jboss.jms.wireformat.JMSWireFormat&numberOfCallRetries=1&pingFrequency=214748364&pingWindowFactor=10&socket.check_connection=false&stopLeaseOnFailure=true&timeout=0&unmarshaller=org.jboss.jms.wireformat.JMSWireFormat&validatorPingPeriod=10000&validatorPingTimeout=5000]
{noformat}

Thats ok, but when the server is up again and the client sends a message, remoting (in debug) logs the following and freezes the thread!

{noformat}
2010-01-28 11:08:48,484 DEBUG [org.jboss.remoting.Client] Client[10530691:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u].connect(ConsolidatedListener(UNINITIALIZED))
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.Client] Client[10530691:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u] connected to InvokerLocator [bisocket://172.20.37.19:4757/?JBM_clientMaxPoolSize=200&clientLeasePeriod=10000&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper&connectionWait=10&dataType=jms&marshaller=org.jboss.jms.wireformat.JMSWireFormat&numberOfCallRetries=1&pingFrequency=214748364&pingWindowFactor=10&socket.check_connection=false&stopLeaseOnFailure=true&timeout=0&unmarshaller=org.jboss.jms.wireformat.JMSWireFormat&validatorPingPeriod=10000&validatorPingTimeout=5000]
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.Client] Client[22181209:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2v].connect(null)
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.Client] Client[22181209:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2v] connected to InvokerLocator [bisocket://172.20.37.19:4757/?JBM_clientMaxPoolSize=200&clientLeasePeriod=10000&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper&connectionWait=10&dataType=jms&marshaller=org.jboss.jms.wireformat.JMSWireFormat&numberOfCallRetries=1&pingFrequency=214748364&pingWindowFactor=10&socket.check_connection=false&stopLeaseOnFailure=true&timeout=0&unmarshaller=org.jboss.jms.wireformat.JMSWireFormat&validatorPingPeriod=10000&validatorPingTimeout=5000]
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.Client] starting callback Connector: InvokerLocator [bisocket://172.20.37.46:1137718937/callback?serverSocketClass=org.jboss.jms.server.remoting.ServerSocketWrapper&isCallbackServer=true&callbackServerProtocol=bisocket&datatype=jms&guid=4sk111a-vja37y-g4y5zhk0-1-g4zk9ywk-2w&callbackServerHost=172.20.37.46&callbackServerPort=1137718937&clientMaxPoolSize=1&onewayThreadPool=org.jboss.jms.server.remoting.DirectThreadPool&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper]
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.transport.bisocket.BisocketServerInvoker] SocketServerInvoker[UNINITIALIZED] setting pingFrequency to 214748364
2010-01-28 11:08:48,500 DEBUG [org.jboss.remoting.transport.bisocket.BisocketServerInvoker] SocketServerInvoker[UNINITIALIZED] setting pingWindowFactor to 10
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.ServerInvoker] SocketServerInvoker[UNINITIALIZED] did not find server socket factory configuration as mbean service or classname. Creating default server socket factory.
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.ServerInvoker] SocketServerInvoker[UNINITIALIZED] created server socket factory javax.net.DefaultServerSocketFactory at e34726
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.transport.Connector] org.jboss.remoting.transport.Connector at d5be9a started
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.Client] Client[7971413:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u].connect(null)
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.Client] Client[7971413:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u] connected to InvokerLocator [bisocket://172.20.37.46:1137718937/callback?callbackServerHost=172.20.37.46&callbackServerPort=1137718937&callbackServerProtocol=bisocket&clientMaxPoolSize=1&clientSocketClass=org.jboss.jms.client.remoting.ClientSocketWrapper&datatype=jms&guid=4sk111a-vja37y-g4y5zhk0-1-g4zk9ywk-2w&isCallbackServer=true&onewayThreadPool=org.jboss.jms.server.remoting.DirectThreadPool&serverSocketClass=org.jboss.jms.server.remoting.ServerSocketWrapper]
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.ServerInvoker] ServerInvoker (SocketServerInvoker[UNINITIALIZED]) added client callback handler CallbackManager[9651d2] with session id of 4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u+4sk111a-vja37y-g4y5zhk0-1-g4zk9ywz-2x and callback handle object of null.
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.InvokerRegistry] removed org.jboss.remoting.transport.local.LocalClientInvoker at 1908e2e from registry
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.Client] Client[7971413:4sk111a-vja37y-g4y5zhk0-1-g4zk9yw4-2u] is disconnected
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.transport.bisocket.BisocketClientInvoker] getting secondary locator
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.transport.bisocket.BisocketClientInvoker] secondary locator: InvokerLocator [null://172.20.37.19:30520/?]
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.transport.bisocket.BisocketServerInvoker] creating control connection: InvokerLocator [null://172.20.37.19:30520/?]
2010-01-28 11:08:48,515 DEBUG [org.jboss.remoting.transport.bisocket.BisocketServerInvoker] SocketServerInvoker[UNINITIALIZED] created control connection (4sk111a-vja37y-g4y5zhk0-1-g4zk9ywz-2x): Socket[addr=/172.20.37.19,port=30520,localport=4996]
{noformat}

After a few tries, my pool AvailableConnectionCount is 0 and the No ManagedConnections available is throw.

Appreciate any help!

P.S. I am using ServiceBindingManager in the client and already updated the bisocket config em sample-bindings.xml.

--------------------------------------------------------------

To reply to this message visit the message page: http://community.jboss.org/message/522743#522743