Need help: connection failure after upgrade to WINSCP 4.2.7
I upgraded to WINSCP 4.2.7 from 3.8.2. All of my 3.8.2 connections worked as expected in 4.2.7 except for one SSH connection.
For this one exception I am getting the "incoming packet was garbled on decryption" error. Their server is: SSH-2.0-OpenSSH_4.3
Successful Log (debug level 2):
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 WinSCP Version 3.8.2 (Build 330) (OS 5.2.3790 Service Pack 2)
. 2010-07-01 11:13:31.367 Login time: Thursday, July 01, 2010 11:13:31 AM
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 Session name: ####################
. 2010-07-01 11:13:31.367 Host name: ##################### (Port: 22)
. 2010-07-01 11:13:31.367 User name: #########(Password: Yes, Key file: Yes)
. 2010-07-01 11:13:31.367 Transfer Protocol: SFTP (SCP)
. 2010-07-01 11:13:31.367 SSH protocol version: 2; Compression: No
. 2010-07-01 11:13:31.367 Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2010-07-01 11:13:31.367 Ciphers: aes,blowfish,3des,WARN,des; Ssh2DES: No
. 2010-07-01 11:13:31.367 Ping type: N, Ping interval: 30 sec; Timeout: 15 sec
. 2010-07-01 11:13:31.367 SSH Bugs: -,-,-,-,-,-,-,-
. 2010-07-01 11:13:31.367 SFTP Bugs: -,-,-
. 2010-07-01 11:13:31.367 Proxy: none
. 2010-07-01 11:13:31.367 Return code variable: Autodetect; Lookup user groups: Yes
. 2010-07-01 11:13:31.367 Shell: default, EOL: 0
. 2010-07-01 11:13:31.367 Local directory: C:\Documents and Settings\biadmin\My Documents, Remote directory: /POLP-STKSHK, Update: No, Cache: Yes
. 2010-07-01 11:13:31.367 Cache directory changes: Yes, Permanent: Yes
. 2010-07-01 11:13:31.367 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2010-07-01 11:13:31.367 Alias LS: No, Ign LS warn: Yes, Scp1 Comp: No
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 Looking up host "www.mftcat.firstdataclients.com"
. 2010-07-01 11:13:36.742 Connecting to 216.66.216.10 port 22
. 2010-07-01 11:13:36.774 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.774 Looking for incoming data
. 2010-07-01 11:13:36.867 Select result is 1
. 2010-07-01 11:13:36.867 Server version: SSH-2.0-OpenSSH_4.3
. 2010-07-01 11:13:36.867 We claim version: SSH-2.0-WinSCP_release_3.8.2
. 2010-07-01 11:13:36.867 Using SSH protocol version 2
. 2010-07-01 11:13:36.867 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.867 Looking for incoming data
. 2010-07-01 11:13:36.883 Select result is 1
. 2010-07-01 11:13:36.883 Doing Diffie-Hellman group exchange
. 2010-07-01 11:13:36.883 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.883 Looking for incoming data
. 2010-07-01 11:13:36.930 Select result is 1
. 2010-07-01 11:13:36.930 Doing Diffie-Hellman key exchange
. 2010-07-01 11:13:37.039 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.039 Looking for incoming data
. 2010-07-01 11:13:37.242 Select result is 1
. 2010-07-01 11:13:37.367 Host key fingerprint is:
. 2010-07-01 11:13:37.367 ssh-rsa 2048 10:fc:27:5a:81:33:04:9d:d0:65:72:b2:18:bf:dd:bf
. 2010-07-01 11:13:37.367 Initialised AES-256 client->server encryption
. 2010-07-01 11:13:37.367 Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-07-01 11:13:37.367 Initialised AES-256 server->client encryption
. 2010-07-01 11:13:37.367 Initialised HMAC-SHA1 server->client MAC algorithm
. 2010-07-01 11:13:37.367 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.367 Looking for incoming data
. 2010-07-01 11:13:37.461 Select result is 1
! 2010-07-01 11:13:37.461 Using username "POLP-STKSHK".
. 2010-07-01 11:13:37.461 Reading private key file "YYYYYYYYYYYYYYYYYYYYYYYYYYY.ppk"
. 2010-07-01 11:13:37.461 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.461 Looking for incoming data
. 2010-07-01 11:13:37.492 Select result is 1
! 2010-07-01 11:13:37.492 WARNING! THIS SYSTEM IS FOR AUT
FAILED REQUEST LOG:
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.283 WinSCP Version 4.2.7 (Build 758) (OS 5.2.3790 Service Pack 2)
. 2010-07-01 11:07:56.283 Login time: Thursday, July 01, 2010 11:07:56 AM
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.283 Session name: #####################
. 2010-07-01 11:07:56.283 Host name: #######################.com (Port: 22)
. 2010-07-01 11:07:56.283 User name: YYYYYYYY (Password: Yes, Key file: Yes)
. 2010-07-01 11:07:56.283 Tunnel: No
. 2010-07-01 11:07:56.283 Transfer Protocol: SFTP (SCP)
. 2010-07-01 11:07:56.283 Ping type: -, Ping interval: 30 sec; Timeout: 15 sec
. 2010-07-01 11:07:56.283 Proxy: none
. 2010-07-01 11:07:56.283 SSH protocol version: 2; Compression: No
. 2010-07-01 11:07:56.283 Bypass authentication: No
. 2010-07-01 11:07:56.283 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2010-07-01 11:07:56.283 Ciphers: aes,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2010-07-01 11:07:56.283 SSH Bugs: -,-,-,-,-,-,-,-,-
. 2010-07-01 11:07:56.283 SFTP Bugs: -,-
. 2010-07-01 11:07:56.283 Return code variable: Autodetect; Lookup user groups: Yes
. 2010-07-01 11:07:56.283 Shell: default, EOL: 0
. 2010-07-01 11:07:56.283 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2010-07-01 11:07:56.283 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No
. 2010-07-01 11:07:56.283 Local directory: C:\Documents and Settings\biadmin\My Documents, Remote directory: /xxxxxxxxx, Update: No, Cache: Yes
. 2010-07-01 11:07:56.283 Cache directory changes: Yes, Permanent: Yes
. 2010-07-01 11:07:56.283 DST mode: 1
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.314 Looking up host "###########################.com"
. 2010-07-01 11:07:56.314 Connecting to 216.66.216.10 port 22
. 2010-07-01 11:07:56.330 Selecting events 63 for socket 432
. 2010-07-01 11:07:56.330 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.330 Looking for incoming data
. 2010-07-01 11:07:56.330 Looking for network events
. 2010-07-01 11:07:56.330 Detected network event
. 2010-07-01 11:07:56.330 Enumerating network events for socket 432
. 2010-07-01 11:07:56.330 Enumerated 18 network events making 18 cumulative events for socket 432
. 2010-07-01 11:07:56.330 Handling network write event on socket 432 with error 0
. 2010-07-01 11:07:56.330 Handling network connect event on socket 432 with error 0
. 2010-07-01 11:07:56.330 Looking for network events
. 2010-07-01 11:07:56.424 Detected network event
. 2010-07-01 11:07:56.424 Enumerating network events for socket 432
. 2010-07-01 11:07:56.424 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.424 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.424 Server version: SSH-2.0-OpenSSH_4.3
. 2010-07-01 11:07:56.424 Using SSH protocol version 2
. 2010-07-01 11:07:56.424 We claim version: SSH-2.0-WinSCP_release_4.2.7
. 2010-07-01 11:07:56.424 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.424 Looking for incoming data
. 2010-07-01 11:07:56.424 Looking for network events
. 2010-07-01 11:07:56.439 Detected network event
. 2010-07-01 11:07:56.439 Enumerating network events for socket 432
. 2010-07-01 11:07:56.439 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.439 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.439 Doing Diffie-Hellman group exchange
. 2010-07-01 11:07:56.439 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.439 Looking for incoming data
. 2010-07-01 11:07:56.439 Looking for network events
. 2010-07-01 11:07:56.486 Detected network event
. 2010-07-01 11:07:56.486 Enumerating network events for socket 432
. 2010-07-01 11:07:56.486 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.486 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.486 Doing Diffie-Hellman key exchange with hash SHA-1
. 2010-07-01 11:07:56.564 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.564 Looking for incoming data
. 2010-07-01 11:07:56.564 Looking for network events
. 2010-07-01 11:07:56.768 Detected network event
. 2010-07-01 11:07:56.768 Enumerating network events for socket 432
. 2010-07-01 11:07:56.768 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.768 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.846 Selecting events 63 for socket 432
. 2010-07-01 11:07:56.846 Host key fingerprint is:
. 2010-07-01 11:07:56.846 ssh-rsa 2048 10:fc:27:5a:81:33:04:9d:d0:65:72:b2:18:bf:dd:bf
. 2010-07-01 11:07:56.846 Initialised AES-256 SDCTR client->server encryption
. 2010-07-01 11:07:56.846 Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-07-01 11:07:56.846 Initialised AES-256 SDCTR server->client encryption
. 2010-07-01 11:07:56.846 Initialised HMAC-SHA1 server->client MAC algorithm
. 2010-07-01 11:07:56.846 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.846 Looking for incoming data
. 2010-07-01 11:07:56.846 Looking for network events
. 2010-07-01 11:07:56.940 Detected network event
. 2010-07-01 11:07:56.940 Enumerating network events for socket 432
. 2010-07-01 11:07:56.940 Enumerated 33 network events making 33 cumulative events for socket 432
. 2010-07-01 11:07:56.940 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.940 Selecting events 0 for socket 432
. 2010-07-01 11:07:56.940 Incoming packet was garbled on decryption
* 2010-07-01 11:07:56.940 (ESshFatal) Incoming packet was garbled on decryption
* 2010-07-01 11:07:56.940 Authentication failed.
For this one exception I am getting the "incoming packet was garbled on decryption" error. Their server is: SSH-2.0-OpenSSH_4.3
Successful Log (debug level 2):
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 WinSCP Version 3.8.2 (Build 330) (OS 5.2.3790 Service Pack 2)
. 2010-07-01 11:13:31.367 Login time: Thursday, July 01, 2010 11:13:31 AM
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 Session name: ####################
. 2010-07-01 11:13:31.367 Host name: ##################### (Port: 22)
. 2010-07-01 11:13:31.367 User name: #########(Password: Yes, Key file: Yes)
. 2010-07-01 11:13:31.367 Transfer Protocol: SFTP (SCP)
. 2010-07-01 11:13:31.367 SSH protocol version: 2; Compression: No
. 2010-07-01 11:13:31.367 Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2010-07-01 11:13:31.367 Ciphers: aes,blowfish,3des,WARN,des; Ssh2DES: No
. 2010-07-01 11:13:31.367 Ping type: N, Ping interval: 30 sec; Timeout: 15 sec
. 2010-07-01 11:13:31.367 SSH Bugs: -,-,-,-,-,-,-,-
. 2010-07-01 11:13:31.367 SFTP Bugs: -,-,-
. 2010-07-01 11:13:31.367 Proxy: none
. 2010-07-01 11:13:31.367 Return code variable: Autodetect; Lookup user groups: Yes
. 2010-07-01 11:13:31.367 Shell: default, EOL: 0
. 2010-07-01 11:13:31.367 Local directory: C:\Documents and Settings\biadmin\My Documents, Remote directory: /POLP-STKSHK, Update: No, Cache: Yes
. 2010-07-01 11:13:31.367 Cache directory changes: Yes, Permanent: Yes
. 2010-07-01 11:13:31.367 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2010-07-01 11:13:31.367 Alias LS: No, Ign LS warn: Yes, Scp1 Comp: No
. 2010-07-01 11:13:31.367 --------------------------------------------------------------------------
. 2010-07-01 11:13:31.367 Looking up host "www.mftcat.firstdataclients.com"
. 2010-07-01 11:13:36.742 Connecting to 216.66.216.10 port 22
. 2010-07-01 11:13:36.774 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.774 Looking for incoming data
. 2010-07-01 11:13:36.867 Select result is 1
. 2010-07-01 11:13:36.867 Server version: SSH-2.0-OpenSSH_4.3
. 2010-07-01 11:13:36.867 We claim version: SSH-2.0-WinSCP_release_3.8.2
. 2010-07-01 11:13:36.867 Using SSH protocol version 2
. 2010-07-01 11:13:36.867 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.867 Looking for incoming data
. 2010-07-01 11:13:36.883 Select result is 1
. 2010-07-01 11:13:36.883 Doing Diffie-Hellman group exchange
. 2010-07-01 11:13:36.883 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:36.883 Looking for incoming data
. 2010-07-01 11:13:36.930 Select result is 1
. 2010-07-01 11:13:36.930 Doing Diffie-Hellman key exchange
. 2010-07-01 11:13:37.039 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.039 Looking for incoming data
. 2010-07-01 11:13:37.242 Select result is 1
. 2010-07-01 11:13:37.367 Host key fingerprint is:
. 2010-07-01 11:13:37.367 ssh-rsa 2048 10:fc:27:5a:81:33:04:9d:d0:65:72:b2:18:bf:dd:bf
. 2010-07-01 11:13:37.367 Initialised AES-256 client->server encryption
. 2010-07-01 11:13:37.367 Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-07-01 11:13:37.367 Initialised AES-256 server->client encryption
. 2010-07-01 11:13:37.367 Initialised HMAC-SHA1 server->client MAC algorithm
. 2010-07-01 11:13:37.367 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.367 Looking for incoming data
. 2010-07-01 11:13:37.461 Select result is 1
! 2010-07-01 11:13:37.461 Using username "POLP-STKSHK".
. 2010-07-01 11:13:37.461 Reading private key file "YYYYYYYYYYYYYYYYYYYYYYYYYYY.ppk"
. 2010-07-01 11:13:37.461 Waiting for the server to continue with the initialisation
. 2010-07-01 11:13:37.461 Looking for incoming data
. 2010-07-01 11:13:37.492 Select result is 1
! 2010-07-01 11:13:37.492 WARNING! THIS SYSTEM IS FOR AUT
FAILED REQUEST LOG:
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.283 WinSCP Version 4.2.7 (Build 758) (OS 5.2.3790 Service Pack 2)
. 2010-07-01 11:07:56.283 Login time: Thursday, July 01, 2010 11:07:56 AM
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.283 Session name: #####################
. 2010-07-01 11:07:56.283 Host name: #######################.com (Port: 22)
. 2010-07-01 11:07:56.283 User name: YYYYYYYY (Password: Yes, Key file: Yes)
. 2010-07-01 11:07:56.283 Tunnel: No
. 2010-07-01 11:07:56.283 Transfer Protocol: SFTP (SCP)
. 2010-07-01 11:07:56.283 Ping type: -, Ping interval: 30 sec; Timeout: 15 sec
. 2010-07-01 11:07:56.283 Proxy: none
. 2010-07-01 11:07:56.283 SSH protocol version: 2; Compression: No
. 2010-07-01 11:07:56.283 Bypass authentication: No
. 2010-07-01 11:07:56.283 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2010-07-01 11:07:56.283 Ciphers: aes,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2010-07-01 11:07:56.283 SSH Bugs: -,-,-,-,-,-,-,-,-
. 2010-07-01 11:07:56.283 SFTP Bugs: -,-
. 2010-07-01 11:07:56.283 Return code variable: Autodetect; Lookup user groups: Yes
. 2010-07-01 11:07:56.283 Shell: default, EOL: 0
. 2010-07-01 11:07:56.283 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2010-07-01 11:07:56.283 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No
. 2010-07-01 11:07:56.283 Local directory: C:\Documents and Settings\biadmin\My Documents, Remote directory: /xxxxxxxxx, Update: No, Cache: Yes
. 2010-07-01 11:07:56.283 Cache directory changes: Yes, Permanent: Yes
. 2010-07-01 11:07:56.283 DST mode: 1
. 2010-07-01 11:07:56.283 --------------------------------------------------------------------------
. 2010-07-01 11:07:56.314 Looking up host "###########################.com"
. 2010-07-01 11:07:56.314 Connecting to 216.66.216.10 port 22
. 2010-07-01 11:07:56.330 Selecting events 63 for socket 432
. 2010-07-01 11:07:56.330 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.330 Looking for incoming data
. 2010-07-01 11:07:56.330 Looking for network events
. 2010-07-01 11:07:56.330 Detected network event
. 2010-07-01 11:07:56.330 Enumerating network events for socket 432
. 2010-07-01 11:07:56.330 Enumerated 18 network events making 18 cumulative events for socket 432
. 2010-07-01 11:07:56.330 Handling network write event on socket 432 with error 0
. 2010-07-01 11:07:56.330 Handling network connect event on socket 432 with error 0
. 2010-07-01 11:07:56.330 Looking for network events
. 2010-07-01 11:07:56.424 Detected network event
. 2010-07-01 11:07:56.424 Enumerating network events for socket 432
. 2010-07-01 11:07:56.424 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.424 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.424 Server version: SSH-2.0-OpenSSH_4.3
. 2010-07-01 11:07:56.424 Using SSH protocol version 2
. 2010-07-01 11:07:56.424 We claim version: SSH-2.0-WinSCP_release_4.2.7
. 2010-07-01 11:07:56.424 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.424 Looking for incoming data
. 2010-07-01 11:07:56.424 Looking for network events
. 2010-07-01 11:07:56.439 Detected network event
. 2010-07-01 11:07:56.439 Enumerating network events for socket 432
. 2010-07-01 11:07:56.439 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.439 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.439 Doing Diffie-Hellman group exchange
. 2010-07-01 11:07:56.439 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.439 Looking for incoming data
. 2010-07-01 11:07:56.439 Looking for network events
. 2010-07-01 11:07:56.486 Detected network event
. 2010-07-01 11:07:56.486 Enumerating network events for socket 432
. 2010-07-01 11:07:56.486 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.486 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.486 Doing Diffie-Hellman key exchange with hash SHA-1
. 2010-07-01 11:07:56.564 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.564 Looking for incoming data
. 2010-07-01 11:07:56.564 Looking for network events
. 2010-07-01 11:07:56.768 Detected network event
. 2010-07-01 11:07:56.768 Enumerating network events for socket 432
. 2010-07-01 11:07:56.768 Enumerated 1 network events making 1 cumulative events for socket 432
. 2010-07-01 11:07:56.768 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.846 Selecting events 63 for socket 432
. 2010-07-01 11:07:56.846 Host key fingerprint is:
. 2010-07-01 11:07:56.846 ssh-rsa 2048 10:fc:27:5a:81:33:04:9d:d0:65:72:b2:18:bf:dd:bf
. 2010-07-01 11:07:56.846 Initialised AES-256 SDCTR client->server encryption
. 2010-07-01 11:07:56.846 Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-07-01 11:07:56.846 Initialised AES-256 SDCTR server->client encryption
. 2010-07-01 11:07:56.846 Initialised HMAC-SHA1 server->client MAC algorithm
. 2010-07-01 11:07:56.846 Waiting for the server to continue with the initialisation
. 2010-07-01 11:07:56.846 Looking for incoming data
. 2010-07-01 11:07:56.846 Looking for network events
. 2010-07-01 11:07:56.940 Detected network event
. 2010-07-01 11:07:56.940 Enumerating network events for socket 432
. 2010-07-01 11:07:56.940 Enumerated 33 network events making 33 cumulative events for socket 432
. 2010-07-01 11:07:56.940 Handling network read event on socket 432 with error 0
. 2010-07-01 11:07:56.940 Selecting events 0 for socket 432
. 2010-07-01 11:07:56.940 Incoming packet was garbled on decryption
* 2010-07-01 11:07:56.940 (ESshFatal) Incoming packet was garbled on decryption
* 2010-07-01 11:07:56.940 Authentication failed.