Our Products:   CompleteFTP  edtFTPnet/Free  edtFTPnet/PRO  edtFTPj/Free  edtFTPj/PRO
0 votes
646 views
in Java FTP by (120 points)
I am tring to read the file from sftp server, But getting timeout exeception from front side and internal these many things are happening as the following log depicts.

But i am not able to get the root cause for this scenario.

DEBUG 03.04.18 18:57:05,183 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   Name=SSH_MSG_CHANNEL_DATA,MessageId=94

DEBUG 03.04.18 18:57:05,183 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolOutputStream Sent message. Seq no=121, msg=94

DEBUG 03.04.18 18:57:05,183 [IS-CL00029.e-ssi.net--MThread-46] ConnectionProtocol        Sent 69 bytes (69 total) for channel id 38

DEBUG 03.04.18 18:57:05,183 [IS-CL00029.e-ssi.net--MThread-46] ConnectionProtocol        Sent total bytes 69 for channel id 38

DEBUG 03.04.18 18:57:05,184 [IS-CL00029.e-ssi.net--MThread-46] SftpSubsystemClient       Waiting for response

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] SftpSubsystemClient       Received response

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] FTPConnector              Quit client.

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                quit() called

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] Channel                   close() called

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] ConnectionProtocol        Local computer has closed channel 38[sftp]

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   Name=SSH_MSG_CHANNEL_CLOSE,MessageId=97

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolOutputStream Sent message. Seq no=122, msg=97

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] Channel                   Connection is connected

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] ChannelDataWindow         Stopped channel data window

DEBUG 03.04.18 18:57:05,204 [IS-CL00029.e-ssi.net--MThread-46] ChannelDataWindow         Stopped channel data window

DEBUG 03.04.18 18:57:05,305 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,335 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,435 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,535 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,635 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,735 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,835 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:08,935 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,036 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,136 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,236 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,336 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,436 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,536 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,636 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,736 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,837 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:09,937 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:10,037 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:10,137 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:10,204 [ssh-connection 27] SshMessageStore           Timeout retrieving message

FATAL 03.04.18 18:57:10,204 [ssh-connection 27] AsyncService              Service message loop failed!

com.enterprisedt.net.j2ssh.transport.MessageNotAvailableException: The message is not available

at com.enterprisedt.net.j2ssh.transport.SshMessageStore.getMessage(SshMessageStore.java:168)

at com.enterprisedt.net.j2ssh.transport.AsyncService.run(AsyncService.java:109)

at java.lang.Thread.run(Thread.java:748)

DEBUG 03.04.18 18:57:10,239 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Waiting for close channel ack

DEBUG 03.04.18 18:57:10,239 [IS-CL00029.e-ssi.net--MThread-46] SftpClient                Channel close ack received

DEBUG 03.04.18 18:57:10,239 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   Disconnect: Terminating connection

DEBUG 03.04.18 18:57:10,239 [IS-CL00029.e-ssi.net--MThread-46] State                     Updated state to 5

DEBUG 03.04.18 18:57:10,239 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   sendDisconnect(11,'Terminating connection')

DEBUG 03.04.18 18:57:10,243 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   Name=SSH_MSG_DISCONNECT,MessageId=1

ERROR 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolOutputStream sendMessage() failed: Socket closed (state=5)

 WARN 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   Failed to send disconnect

 com.enterprisedt.net.j2ssh.transport.TransportProtocolException: IO Error on socket: Socket closed

at com.enterprisedt.net.j2ssh.transport.b.a(TransportProtocolOutputStream.java:217)

at com.enterprisedt.net.j2ssh.transport.TransportProtocolCommon.sendMessage(TransportProtocolCommon.java:476)

at com.enterprisedt.net.j2ssh.transport.TransportProtocolCommon.sendDisconnect(TransportProtocolCommon.java:804)

at com.enterprisedt.net.j2ssh.transport.TransportProtocolCommon.disconnect(TransportProtocolCommon.java:256)

at com.enterprisedt.net.j2ssh.SshClient.disconnect(SshClient.java:700)

at com.enterprisedt.net.ftp.ssh.SSHFTPClient.quit(SSHFTPClient.java:1881)

at com.inubit.ibis.plugins.ftp.FTPConnector.execute(FTPConnector.java:957)

at com.inubit.ibis.server.IBISPluginExecutorThread.execute(IBISPluginExecutorThread.java:221)

at com.inubit.ibis.server.IBISPluginExecutorThread.run(IBISPluginExecutorThread.java:150)

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] TransportProtocolCommon   stop() called

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] Channel                   Remote side is closing channel

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] Channel                   close() called

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] ChannelDataWindow         Stopped channel data window

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] ChannelDataWindow         Stopped channel data window

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] SshClient                 Setting maxpacketsize=32648

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] FTPConnector              Quit client finished.

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] IBISPluginExecutorThread  execute: after plugin execute  [processId=96653850, module=UGC_DMZ_SFTP_Honeywell_FR_TEST-2, thread=IS-CL00029.e-ssi.net--MThread-46, state=RUNNABLE, pluginClassName=FTPConnector] moduleExecutionTime = 7684

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] IBISPluginExecutorThread  run: module execution OK

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] IBISPluginExecutorThread  run: data synchronized, notify

DEBUG 03.04.18 18:57:10,244 [IS-CL00029.e-ssi.net--MThread-46] IBISPluginExecutorThread  run: start wait for job...
by (162k points)
No idea sorry. Please open a support ticket and provide more details about what you are doing.

https://enterprisedt.com/help

Please log in or register to answer this question.

Categories

...