Error in SSH2DataBuffer, corrupt string on read

[KIE EDI-Services]

Hello All,

We are currently using 1 VAN to connect via Business Connect SSHFTP and get the Data from the server location. Now we are adding another VAN to establish connection and get the files from server location. We have got the IP and Port open and are able to connect via SSHFTP without any issue using BC. We have connected the BC to check for every 1 min for files and if files exists they will be fetched into our system. But we are facing 1 peculier issue. Sometimes we are getting the "Ssh transport disconnected due to fatal errors: I/O error - read failed" error randomly while we are connecting to the new VAN Location. And this is happening randomly even though there are no files in mentioned VAN Location for pickup. We are almost getting this error 10 to 15 times per day eventhough our system is checking for every minute through out the day.

Log is given below

 

2020 Jun 12 14:46:49:464 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 FTPGet root directory = '/export/home/xxxxxx/tibco/tra/domain/XXXXXX/application/BusinessConnect/working/tibcobc_temp/Gateway/ABC-VAN/'

2020 Jun 12 14:46:49:484 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 FTPGet using mask '*'

2020 Jun 12 14:46:49:486 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.transmit appended to txQueue: NQueue[stopped=false,queued=0,callback=[sSH2] /11.111.111.11:45263 -> abc.newvan.com/11.123.345.11:22]

2020 Jun 12 14:46:49:710 GMT +0000 BW.BusinessConnect-Interior_Server Error [bw.logger] BW-EXT-LOG-100000 Job-106001-2-5.106009 SshMgr: Ssh transport disconnected due to fatal errors: I/O error - read failed: unknown error [null]. Peer session: 0:0:0:20:ca:c4:84:a1:d3:d7:db:a8:5f:9:f5:c5:b5:85:e2:86:ed:9c:57:f0:59:86:72:56:3b:eb:8e:c7:b8:e8:1a:81

2020 Jun 12 14:46:49:711 GMT +0000 BW.BusinessConnect-Interior_Server Error [bw.logger] BW-EXT-LOG-100000 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.disconnectInternal disconnect: I/O error - read failed: unknown error

2020 Jun 12 14:46:49:713 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.disconnectInternal stopping txQueue: NQueue[stopped=true,queued=0,callback=[sSH2] /11.111.111.11:45263 -> abc.newvan.com/11.123.345.11:22]

2020 Jun 12 14:46:49:716 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.shutdownRx bytes received: 17973 (17973 uncompressed)

2020 Jun 12 14:46:49:716 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.shutdownTx bytes sent: 15548 (15548 uncompressed)

2020 Jun 12 14:46:49:717 GMT +0000 BW.BusinessConnect-Interior_Server Info [bw.logger] BW-EXT-LOG-300000 Job-106001-2-5.106009 [sSHFTP] SSH2SessionChannel session (ch. #0) exit with status -1

2020 Jun 12 14:46:49:717 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Transport.transmit not connected

2020 Jun 12 14:46:49:717 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Connection.killChannel ch. # 0 not present

2020 Jun 12 14:46:49:718 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 [sSHFTP] SSH2Channel closing ch. #0 (session)

2020 Jun 12 14:46:49:725 GMT +0000 BW.BusinessConnect-Interior_Server Error [bw.logger] BW-EXT-LOG-100000 Job-106001-2-5.106009 java.lang.Error: Error in SSH2DataBuffer, corrupt string on read

at com.mindbright.ssh2.SSH2DataBuffer.readString(Unknown Source)

at com.mindbright.ssh2.SSH2SFTPClient.opendir(Unknown Source)

at com.tibco.ax.fw.runtime.transport.sshftp.MTClient.getDir(MTClient.java:107)

at com.tibco.ax.fw.runtime.transport.sshftp.SSHFTPClientImpl.executeCmd(SSHFTPClientImpl.java:764)

at com.tibco.ax.fw.runtime.transport.sshftp.SSHFTPClientImpl.executeListCmd(SSHFTPClientImpl.java:347)

at com.tibco.ax.fw.runtime.transport.sshftp.SSHFTPClientImpl.executeMgetCmd(SSHFTPClientImpl.java:409)

at com.tibco.ax.fw.runtime.transport.sshftp.SSHFTPClientImpl.executeGetOrMgetCmd(SSHFTPClientImpl.java:392)

at com.tibco.ax.fw.runtime.poller.ftp.FTPPoller.doSshFTPGet(FTPPoller.java:1031)

at com.tibco.ax.fw.runtime.poller.ftp.FTPPoller.execute(FTPPoller.java:253)

at com.tibco.ax.fw.util.ThreadPool$ManagedThread.run(ThreadPool.java:269)

 

2020 Jun 12 14:46:49:726 GMT +0000 BW.BusinessConnect-Interior_Server Error [bw.logger] BW-EXT-LOG-100000 Job-106001-2-5.106009 FTPGet Ssh Failure Reply #1: 500: Error in SSH2DataBuffer, corrupt string on read [10] [0]

2020 Jun 12 14:46:49:726 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 DBConnectionPool::asertValid took 885

2020 Jun 12 14:46:49:798 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 Wrote to audit log: Gateway FTP_GET ERROR FTPGet Ssh Failure Reply #1: 500: Error in SSH2DataBuffer, corrupt string on read [10] [0]

2020 Jun 12 14:46:49:800 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 Getting Tibrv BoCommunicator for commID: RV1

2020 Jun 12 14:46:49:801 GMT +0000 BW.BusinessConnect-Interior_Server Debug [bw.logger] BW-EXT-LOG-300002 Job-106001-2-5.106009 Sent rv message with >> 5