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
lmpx.com only provides a reader for public news (NNTP) servers. It is not affiliated with the servers or forums shown here and is not responsible for the content of articles, which is written by their respective authors.