Uploaded image for project: 'MINA SSHD'
  1. MINA SSHD
  2. SSHD-228

java.lang.IllegalStateException: Session is closed issue for the two different j2ee application trying to do ssh in websphere Application Server cluster environment.

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Resolved
    • Blocker
    • Resolution: Not A Problem
    • 0.8.0
    • None
    • OS : Unix
      Server : Websphere Application Server 8 (Clustered Environment)

    Description

      In a Websphere Application Server Cluster environment two j2ee application trying to do the copy using rsync. Whichever application first gets the connection will keep on working but the other application is failing and throwing the below exception.

      [4/11/13 15:47:45:231 EDT] 0000003e SystemErr R 229979 [NioProcessor-33] INFO org.apache.sshd.client.session.ClientSessionImpl - Session created...

      [4/11/13 15:47:45:267 EDT] 0000003e SystemErr R 230015 [NioProcessor-33] INFO org.apache.sshd.client.session.ClientSessionImpl - Server version string: SSH-2.0-OpenSSH_5.3

      [4/11/13 15:47:45:269 EDT] 0000003e SystemErr R 230017 [NioProcessor-33] INFO org.apache.sshd.client.session.ClientSessionImpl - Received SSH_MSG_KEXINIT

      [4/11/13 15:47:45:269 EDT] 0000003e SystemErr R 230017 [NioProcessor-33] WARN org.apache.sshd.client.session.ClientSessionImpl - Exception caught

      [4/11/13 15:47:45:269 EDT] 0000003e SystemErr R java.lang.IllegalStateException: Unable to negociate key exchange for item 2
      [4/11/13 15:47:45:270 EDT] 0000003e SystemErr R at org.apache.sshd.common.session.AbstractSession.negociate(AbstractSession.java:903)
      [4/11/13 15:47:45:270 EDT] 0000003e SystemErr R at org.apache.sshd.client.session.ClientSessionImpl.doHandleMessage(ClientSessionImpl.java:291)
      [4/11/13 15:47:45:270 EDT] 0000003e SystemErr R at org.apache.sshd.client.session.ClientSessionImpl.handleMessage(ClientSessionImpl.java:253)
      [4/11/13 15:47:45:271 EDT] 0000003e SystemErr R at org.apache.sshd.common.session.AbstractSession.decode(AbstractSession.java:539)
      [4/11/13 15:47:45:271 EDT] 0000003e SystemErr R at org.apache.sshd.common.session.AbstractSession.messageReceived(AbstractSession.java:232)
      [4/11/13 15:47:45:271 EDT] 0000003e SystemErr R at org.apache.sshd.common.AbstractSessionIoHandler.messageReceived(AbstractSessionIoHandler.java:58)
      [4/11/13 15:47:45:271 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:716)
      [4/11/13 15:47:45:271 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:434)
      [4/11/13 15:47:45:272 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:46)
      [4/11/13 15:47:45:272 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:796)
      [4/11/13 15:47:45:272 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:119)
      [4/11/13 15:47:45:272 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:434)
      [4/11/13 15:47:45:272 EDT] 0000003e SystemErr R at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:426)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:715)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:668)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:657)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1141)
      [4/11/13 15:47:45:273 EDT] 0000003e SystemErr R at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64)
      [4/11/13 15:47:45:274 EDT] 0000003e SystemErr R at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:897)
      [4/11/13 15:47:45:274 EDT] 0000003e SystemErr R at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:919)
      [4/11/13 15:47:45:274 EDT] 0000003e SystemErr R at java.lang.Thread.run(Thread.java:770)
      [4/11/13 15:47:45:275 EDT] 0000003e SystemErr R 230023 [NioProcessor-33] INFO org.apache.sshd.client.session.ClientSessionImpl - Session null@/192.190.152.101:22 closed

      [4/11/13 15:47:45:275 EDT] 0000002c SystemErr R java.lang.IllegalStateException: Session is closed
      [4/11/13 15:47:45:275 EDT] 0000002c SystemErr R at org.apache.sshd.client.session.ClientSessionImpl.authPassword(ClientSessionImpl.java:144)
      [4/11/13 15:47:45:275 EDT] 0000002c SystemErr R at com.test.copy.RemoteCopy.execute(Unknown Source)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at com.test.copy.RemoteCopy.simpleExecute(Unknown Source)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at com.test.copy.RemoteCopy.submitCopy(Unknown Source)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at com.test.copy.RemoteCopyDelegate.submitCopy(Unknown Source)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
      [4/11/13 15:47:45:276 EDT] 0000002c SystemErr R at java.lang.reflect.Method.invoke(Method.java:611)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.jaxws.server.dispatcher.JavaDispatcher.invokeTargetOperation(JavaDispatcher.java:101)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.jaxws.server.dispatcher.JavaBeanDispatcher.invoke(JavaBeanDispatcher.java:118)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.jaxws.server.EndpointController.invoke(EndpointController.java:111)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.jaxws.server.JAXWSMessageReceiver.receive(JAXWSMessageReceiver.java:161)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:208)
      [4/11/13 15:47:45:277 EDT] 0000002c SystemErr R at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:172)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at com.ibm.ws.websvcs.transport.http.WASAxis2Servlet.doPost(WASAxis2Servlet.java:1517)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at javax.servlet.http.HttpServlet.service(HttpServlet.java:595)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at javax.servlet.http.HttpServlet.service(HttpServlet.java:668)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.servlet.ServletWrapper.service(ServletWrapper.java:1224)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.servlet.ServletWrapper.handleRequest(ServletWrapper.java:774)
      [4/11/13 15:47:45:278 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.servlet.ServletWrapper.handleRequest(ServletWrapper.java:456)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.servlet.ServletWrapperImpl.handleRequest(ServletWrapperImpl.java:178)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.filter.WebAppFilterManager.invokeFilters(WebAppFilterManager.java:1032)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.servlet.CacheServletWrapper.handleRequest(CacheServletWrapper.java:87)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.WebContainer.handleRequest(WebContainer.java:895)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.WSWebContainer.handleRequest(WSWebContainer.java:1662)
      [4/11/13 15:47:45:279 EDT] 0000002c SystemErr R at com.ibm.ws.webcontainer.channel.WCChannelLink.ready(WCChannelLink.java:195)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.http.channel.inbound.impl.HttpInboundLink.handleDiscrimination(HttpInboundLink.java:452)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.http.channel.inbound.impl.HttpInboundLink.handleNewRequest(HttpInboundLink.java:511)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.http.channel.inbound.impl.HttpInboundLink.processRequest(HttpInboundLink.java:305)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.http.channel.inbound.impl.HttpInboundLink.ready(HttpInboundLink.java:276)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.tcp.channel.impl.NewConnectionInitialReadCallback.sendToDiscriminators(NewConnectionInitialReadCallback.java:214)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.tcp.channel.impl.NewConnectionInitialReadCallback.complete(NewConnectionInitialReadCallback.java:113)
      [4/11/13 15:47:45:280 EDT] 0000002c SystemErr R at com.ibm.ws.tcp.channel.impl.AioReadCompletionListener.futureCompleted(AioReadCompletionListener.java:165)
      [4/11/13 15:47:45:281 EDT] 0000002c SystemErr R at com.ibm.io.async.AbstractAsyncFuture.invokeCallback(AbstractAsyncFuture.java:217)
      [4/11/13 15:47:45:281 EDT] 0000002c SystemErr R at com.ibm.io.async.AsyncChannelFuture$1.run(AsyncChannelFuture.java:205)
      [4/11/13 15:47:45:281 EDT] 0000002c SystemErr R at com.ibm.ws.util.ThreadPool$Worker.run(ThreadPool.java:1659)

      Attachments

        Issue Links

          is related to

          Improvement - An improvement or enhancement to an existing feature or task. SSHD-233 Provide better error messages instead of "Unable to negociate key exchange for item 2"

          • Minor - Minor loss of function, or other problem where easy workaround is present.
          • Resolved

          Activity

            People

              gnodet Guillaume Nodet
              vijayin Vijay
              Votes:
              0 Vote for this issue
              Watchers:
              3 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: