Re: SFTP Error Downloading FIle
"James Camire" <[email protected]>
| Newsgroups | gmane.comp.java.sshtools.user |
|---|---|
| Message-ID | <008901c74585$2b0a2300$070aa8c0@chip> |
Here is the trace. The weird thing is this error is only showing up on some servers (GlobalScape Secure FTP Server). The server logs show that the entire the file was sent to the user. 2007-01-31 15:07:29,137 156 [main] INFO com.sshtools.j2ssh.transport.cipher.SshCipherFactory:? - Loading supported cipher algorithms 2007-01-31 15:07:29,199 218 [main] INFO com.sshtools.j2ssh.transport.kex.SshKeyExchangeFactory:? - Loading key exchange methods 2007-01-31 15:07:29,199 218 [main] INFO com.sshtools.j2ssh.configuration.ConfigurationLoader:? - JAVA version is 1.5.0_07 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.configuration.ConfigurationLoader:? - Extension D:\Java\jre1.5.0_07\lib\ext\dnsns.jar being added to classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.util.ExtensionClassLoader:? - Adding D:\Java\jre1.5.0_07\lib\ext\dnsns.jar to the extension classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.configuration.ConfigurationLoader:? - Extension D:\Java\jre1.5.0_07\lib\ext\localedata.jar being added to classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.util.ExtensionClassLoader:? - Adding D:\Java\jre1.5.0_07\lib\ext\localedata.jar to the extension classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.configuration.ConfigurationLoader:? - Extension D:\Java\jre1.5.0_07\lib\ext\sunjce_provider.jar being added to classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.util.ExtensionClassLoader:? - Adding D:\Java\jre1.5.0_07\lib\ext\sunjce_provider.jar to the extension classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.configuration.ConfigurationLoader:? - Extension D:\Java\jre1.5.0_07\lib\ext\sunpkcs11.jar being added to classpath 2007-01-31 15:07:29,215 234 [main] INFO com.sshtools.j2ssh.util.ExtensionClassLoader:? - Adding D:\Java\jre1.5.0_07\lib\ext\sunpkcs11.jar to the extension classpath 2007-01-31 15:07:29,215 234 [main] DEBUG com.sshtools.j2ssh.transport.kex.SshKeyExchangeFactory:? - The default key exchange is not set! using first in list 2007-01-31 15:07:29,231 250 [main] INFO com.sshtools.j2ssh.transport.publickey.SshKeyPairFactory:? - Loading public key algorithms 2007-01-31 15:07:29,231 250 [main] DEBUG com.sshtools.j2ssh.transport.publickey.SshKeyPairFactory:? - The default public key is not set! using first in list 2007-01-31 15:07:29,246 265 [main] INFO com.sshtools.j2ssh.transport.compression.SshCompressionFactory:? - Loading compression methods 2007-01-31 15:07:29,246 265 [main] INFO com.sshtools.j2ssh.transport.hmac.SshHmacFactory:? - Loading message authentication methods 2007-01-31 15:07:29,293 312 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Starting transport protocol 2007-01-31 15:07:29,293 312 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Registering transport protocol messages with inputstream 2007-01-31 15:07:29,652 671 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Negotiating protocol version 2007-01-31 15:07:29,652 671 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Local identification: SSH-2.0-http://www.sshtools.com J2SSH [CLIENT] 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - EOL is guessed at CR+LF 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Remote identification: SSH-2.0-1.36 sshlib: GlobalScape 2007-01-31 15:07:29,668 687 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Protocol negotiation complete 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - SshMsgKexInit: Supported Kex [diffie-hellman-group1-sha1] Supported Public Keys [ssh-dss, ssh-rsa] Supported Encryption Client->Server [blowfish-cbc, 3des-cbc] Supported Encryption Server->Client [blowfish-cbc, 3des-cbc] Supported Mac Client->Server [hmac-sha1, hmac-md5-96, hmac-md5, hmac-sha1-96] Supported Mac Server->Client [hmac-sha1, hmac-md5-96, hmac-md5, hmac-sha1-96] Supported Compression Client->Server [none] Supported Compression Server->Client [none] Supported Languages Client->Server [] Supported Languages Server->Client [] First Kex Packet Follows [FALSE] 2007-01-31 15:07:29,668 687 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_KEX_INIT 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_KEX_INIT 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received remote key exchange init message 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - SshMsgKexInit: Supported Kex [diffie-hellman-group1-sha1] Supported Public Keys [ssh-dss] Supported Encryption Client->Server [twofish-cbc, twofish128-cbc, blowfish-cbc, 3des-cbc, arcfour, cast128-cbc, aes256-cbc, twofish256-cbc, aes128-cbc] Supported Encryption Server->Client [twofish-cbc, twofish128-cbc, blowfish-cbc, 3des-cbc, arcfour, cast128-cbc, aes256-cbc, twofish256-cbc, aes128-cbc] Supported Mac Client->Server [hmac-sha1, hmac-md5, hmac-sha1-96, hmac-md5-96] Supported Mac Server->Client [hmac-sha1, hmac-md5, hmac-sha1-96, hmac-md5-96] Supported Compression Client->Server [zlib, none] Supported Compression Server->Client [zlib, none] Supported Languages Client->Server [] Supported Languages Server->Client [] First Kex Packet Follows [FALSE] 2007-01-31 15:07:29,668 687 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Starting key exchange 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [diffie-hellman-group1-sha1] 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [diffie-hellman-group1-sha1] 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning diffie-hellman-group1-sha1 2007-01-31 15:07:29,668 687 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Key exchange algorithm: diffie-hellman-group1-sha1 2007-01-31 15:07:29,684 703 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.kex.DhGroup1Sha1:? - Starting client side key exchange. 2007-01-31 15:07:29,824 843 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_KEXDH_INIT 2007-01-31 15:07:29,840 859 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Processing SSH_MSG_KEXDH_REPLY 2007-01-31 15:07:29,887 906 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [ssh-dss, ssh-rsa] 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [ssh-dss] 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning ssh-dss 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.publickey.dsa.SshDssPublicKey:? - Header is ssh-dss 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.publickey.dsa.SshDssPublicKey:? - Verifying host key signature 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.publickey.dsa.SshDssPublicKey:? - Signature length is 40 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.publickey.dsa.SshDssPublicKey:? - SSH: 76 4b 2b 42 97 e0 ec cf c5 81 c 68 f9 54 2c a8 69 64 e b6 6a ae a 90 ca 1f 19 b4 9c 96 72 85 13 77 7b 40 76 be e0 3f 2007-01-31 15:07:29,902 921 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.publickey.dsa.SshDssPublicKey:? - Encoded: 30 2c 2 14 76 4b 2b 42 97 e0 ec cf c5 81 c 68 f9 54 2c a8 69 64 e b6 2 14 6a ae a 90 ca 1f 19 b4 9c 96 72 85 13 77 7b 40 76 be e0 3f 2007-01-31 15:07:29,918 937 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - The host key signature is valid 2007-01-31 15:07:29,934 953 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_NEWKEYS 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_NEWKEYS 2007-01-31 15:07:29,934 953 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Completing key exchange 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Making keys from key exchange output 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Creating algorithm objects 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [blowfish-cbc, 3des-cbc] 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [twofish-cbc, twofish128-cbc, blowfish-cbc, 3des-cbc, arcfour, cast128-cbc, aes256-cbc, twofish256-cbc, aes128-cbc] 2007-01-31 15:07:29,934 953 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning blowfish-cbc 2007-01-31 15:07:29,934 953 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.cipher.SshCipherFactory:? - Creating new blowfish-cbc cipher instance 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [blowfish-cbc, 3des-cbc] 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [twofish-cbc, twofish128-cbc, blowfish-cbc, 3des-cbc, arcfour, cast128-cbc, aes256-cbc, twofish256-cbc, aes128-cbc] 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning blowfish-cbc 2007-01-31 15:07:29,981 1000 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.cipher.SshCipherFactory:? - Creating new blowfish-cbc cipher instance 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [hmac-sha1, hmac-md5-96, hmac-md5, hmac-sha1-96] 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [hmac-sha1, hmac-md5, hmac-sha1-96, hmac-md5-96] 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning hmac-sha1 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Determine Algorithm 2007-01-31 15:07:29,981 1000 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Client Algorithms: [hmac-sha1, hmac-md5-96, hmac-md5, hmac-sha1-96] 2007-01-31 15:07:29,996 1015 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Server Algorithms: [hmac-sha1, hmac-md5, hmac-sha1-96, hmac-md5-96] 2007-01-31 15:07:29,996 1015 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Returning hmac-sha1 2007-01-31 15:07:29,996 1015 [Transport protocol 1] DEBUG com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending queued messages 2007-01-31 15:07:30,012 1031 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_SERVICE_REQUEST 2007-01-31 15:07:30,012 1031 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_SERVICE_ACCEPT 2007-01-31 15:07:30,012 1031 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_USERAUTH_BANNER 2007-01-31 15:07:30,043 1062 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_USERAUTH_REQUEST 2007-01-31 15:07:30,043 1062 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_USERAUTH_SUCCESS 2007-01-31 15:07:30,043 1062 [main] INFO com.sshtools.j2ssh.connection.ConnectionProtocol:? - Registering connection protocol messages 2007-01-31 15:07:30,059 1078 [main] INFO com.sshtools.j2ssh.transport.Service:? - ssh-connection has been requested 2007-01-31 15:07:30,059 1078 [main] INFO com.sshtools.j2ssh.transport.Service:? - Starting ssh-connection service thread 2007-01-31 15:07:30,074 1093 [main] DEBUG com.sshtools.j2ssh.connection.ChannelDataWindow:? - Increasing window space by 32648 2007-01-31 15:07:30,090 1109 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_OPEN 2007-01-31 15:07:30,090 1109 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_OPEN_CONFIRMATION 2007-01-31 15:07:30,090 1109 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Initiating channel 2007-01-31 15:07:30,090 1109 [main] DEBUG com.sshtools.j2ssh.connection.ChannelDataWindow:? - Increasing window space by 16384 2007-01-31 15:07:30,090 1109 [main] INFO com.sshtools.j2ssh.connection.ConnectionProtocol:? - Channel 0 is open [session] 2007-01-31 15:07:30,121 1140 [main] DEBUG com.sshtools.j2ssh.connection.ChannelDataWindow:? - Increasing window space by 131070 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_OPEN 2007-01-31 15:07:30,137 1156 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_OPEN_CONFIRMATION 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Initiating channel 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ChannelDataWindow:? - Increasing window space by 16384 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.connection.ConnectionProtocol:? - Channel 1 is open [sftp] 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.sftp.SftpSubsystemClient:? - Initializing SFTP protocol version 3 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Starting sftp subsystem 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending subsystem request for the session channel 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_REQUEST 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Waiting for channel request reply 2007-01-31 15:07:30,137 1156 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_SUCCESS 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Channel request succeeded 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_INIT subsystem message 2007-01-31 15:07:30,137 1156 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,137 1156 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 5 bytes for channel id 1 2007-01-31 15:07:30,152 1171 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 9 bytes of data for channel id 1 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 9 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 5 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_INIT subsystem message 2007-01-31 15:07:30,152 1171 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [main] INFO com.sshtools.j2ssh.sftp.SftpSubsystemClient:? - Server responded with version 3 2007-01-31 15:07:30,152 1171 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_READPATH subsystem message 2007-01-31 15:07:30,152 1171 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,152 1171 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 9 bytes for channel id 1 2007-01-31 15:07:30,152 1171 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,152 1171 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,168 1187 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 49 bytes of data for channel id 1 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 49 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 45 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_NAME subsystem message 2007-01-31 15:07:30,168 1187 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,168 1187 [main] WARN com.depuy.datafeed.tms.AbstractDataFeedVO:244 - changing directory to: Depuy_Codman 2007-01-31 15:07:30,168 1187 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_READPATH subsystem message 2007-01-31 15:07:30,168 1187 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,168 1187 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,168 1187 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 34 bytes for channel id 1 2007-01-31 15:07:30,184 1203 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,184 1203 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 75 bytes of data for channel id 1 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 75 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 71 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_NAME subsystem message 2007-01-31 15:07:30,184 1203 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_STAT subsystem message 2007-01-31 15:07:30,184 1203 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,184 1203 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 34 bytes for channel id 1 2007-01-31 15:07:30,184 1203 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,184 1203 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,184 1203 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 25 bytes of data for channel id 1 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 25 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 21 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_ATTRS subsystem message 2007-01-31 15:07:30,199 1218 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,199 1218 [main] WARN com.depuy.datafeed.tms.AbstractDataFeedVO:248 - getting file data: DePuy_SMT_01302007test.xml.pgp Retrieving file: DePuy_SMT_01302007test.xml.pgp 2007-01-31 15:07:30,262 1281 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_STAT subsystem message 2007-01-31 15:07:30,262 1281 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,262 1281 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,262 1281 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 65 bytes for channel id 1 2007-01-31 15:07:30,262 1281 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,262 1281 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,262 1281 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 33 bytes of data for channel id 1 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 33 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 29 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_ATTRS subsystem message 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_OPEN subsystem message 2007-01-31 15:07:30,277 1296 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,277 1296 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 77 bytes for channel id 1 2007-01-31 15:07:30,277 1296 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,277 1296 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 14 bytes of data for channel id 1 2007-01-31 15:07:30,277 1296 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,293 1312 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 14 2007-01-31 15:07:30,293 1312 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Buffer size: 32768 2007-01-31 15:07:30,293 1312 [ssh-connection 1] DEBUG com.sshtools.j2ssh.io.DynamicBuffer:? - Unread data: 10 2007-01-31 15:07:30,293 1312 [ssh-connection 1] DEBUG com.sshtools.j2ssh.subsystem.SubsystemMessageStore:? - Received SSH_FXP_HANDLE subsystem message 2007-01-31 15:07:30,293 1312 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Finished processing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,293 1312 [main] DEBUG com.sshtools.j2ssh.subsystem.SubsystemChannel:? - Sending SSH_FXP_READ subsystem message 2007-01-31 15:07:30,293 1312 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 4 bytes for channel id 1 2007-01-31 15:07:30,356 1375 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,356 1375 [main] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Sending 22 bytes for channel id 1 2007-01-31 15:07:30,356 1375 [main] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Sending SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,356 1375 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages 2007-01-31 15:07:30,387 1406 [Transport protocol 1] INFO com.sshtools.j2ssh.transport.TransportProtocolCommon:? - Received SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,387 1406 [ssh-connection 1] DEBUG com.sshtools.j2ssh.transport.Service:? - Routing SSH_MSG_CHANNEL_DATA 2007-01-31 15:07:30,387 1406 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Received 65548 bytes of data for channel id 1 2007-01-31 15:07:30,387 1406 [ssh-connection 1] FATAL com.sshtools.j2ssh.transport.Service:? - Service message loop failed! java.lang.ArrayIndexOutOfBoundsException at java.lang.System.arraycopy(Native Method) at com.sshtools.j2ssh.io.DynamicBuffer.write(Unknown Source) at com.sshtools.j2ssh.io.DynamicBuffer$DynamicBufferOutputStream.write(Unknown Source) at java.io.OutputStream.write(Unknown Source) at com.sshtools.j2ssh.subsystem.SubsystemChannel.onChannelData(Unknown Source) at com.sshtools.j2ssh.connection.Channel.processChannelData(Unknown Source) at com.sshtools.j2ssh.connection.ConnectionProtocol.onMsgChannelData(Unknown Source) at com.sshtools.j2ssh.connection.ConnectionProtocol.onMessageReceived(Unknown Source) at com.sshtools.j2ssh.transport.AsyncService.run(Unknown Source) at java.lang.Thread.run(Unknown Source) 2007-01-31 15:07:30,387 1406 [ssh-connection 1] INFO com.sshtools.j2ssh.connection.ConnectionProtocol:? - Closing all active channels 2007-01-31 15:07:30,387 1406 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.ConnectionProtocol:? - Closing sftp id=1 2007-01-31 15:07:30,387 1406 [ssh-connection 1] DEBUG com.sshtools.j2ssh.connection.Channel:? - Connection is not connected 2007-01-31 15:07:30,402 1421 [ssh-connection 1] INFO com.sshtools.j2ssh.connection.Channel:? - Finializing channel close 2007-01-31 15:07:30,402 1421 [ssh-connection 1] INFO com.sshtools.j2ssh.connection.ConnectionProtocol:? - Freeing channel 1 [sftp] 2007-01-31 15:07:30,402 1421 [ssh-connection 1] INFO com.sshtools.j2ssh.transport.Service:? - ssh-connection thread is exiting 2007-01-31 15:07:35,356 6375 [main] DEBUG com.sshtools.j2ssh.sftp.SftpMessageStore:? - Waiting for new messages -----Original Message----- From: Bernardo F Costa [mailto:[email protected]] Sent: Wednesday, January 31, 2007 2:48 PM To: James Camire; [email protected] Subject: Re: [Sshtools-users] SFTP Error Downloading FIle Did you got another exception like "connection reset" before this one ? I had lots o problems due to connection resets, and interrupted threads. Such exceptions may cause others not directly linked to it, because it may, for example, not copy the entire array of data to a particular structure. I suggest that you run your j2ssh enabling debug verbosity level, and if you already have such a log, post here, even if the log has a more resctrictive level o logging. --- James Camire <[email protected]> escreveu: > I'm using J2SSH version 0.2.7. Can can login and > navigate an SFTP server. > However, I get the following error when I try and > download a file: > > - Service message loop failed! > java.lang.ArrayIndexOutOfBoundsException > at java.lang.System.arraycopy(Native Method) > at > com.sshtools.j2ssh.io.DynamicBuffer.write(Unknown > Source) > at > com.sshtools.j2ssh.io.DynamicBuffer$DynamicBufferOutputStream.write(Unknown > Source) > at java.io.OutputStream.write(Unknown Source) > at > com.sshtools.j2ssh.subsystem.SubsystemChannel.onChannelData(Unknown > Source) > at > com.sshtools.j2ssh.connection.Channel.processChannelData(Unknown > Source) > at > com.sshtools.j2ssh.connection.ConnectionProtocol.onMsgChannelData(Unknown > Source) > at > com.sshtools.j2ssh.connection.ConnectionProtocol.onMessageReceived(Unknown > Source) > at > com.sshtools.j2ssh.transport.AsyncService.run(Unknown > Source) > at java.lang.Thread.run(Unknown Source) > > Any help is appreciated > > > ------------------------------------------------------------------------- > Using Tomcat but need to do more? Need to support > web services, security? > Get stuff done quickly with pre-integrated > technology to make your job easier. > Download IBM WebSphere Application Server v.1.0.1 > based on Apache Geronimo > http://sel.as-us.falkag.net/sel?cmd=lnk&kid=120709&bid=263057&dat=121642 > _______________________________________________ > Sshtools-users mailing list > [email protected] > https://lists.sourceforge.net/lists/listinfo/sshtools-users > __________________________________________________ Fale com seus amigos de graça com o novo Yahoo! Messenger http://br.messenger.yahoo.com/ ------------------------------------------------------------------------- Using Tomcat but need to do more? Need to support web services, security? Get stuff done quickly with pre-integrated technology to make your job easier. Download IBM WebSphere Application Server v.1.0.1 based on Apache Geronimo http://sel.as-us.falkag.net/sel?cmd=lnk&kid=120709&bid=263057&dat=121642