SFTP script stopping at "Looking up host" occaisonally
Hello
I'm having periodic issues with some command line scripts that I use to deliver/download files to/from remote sftp sites. Occasionally the scripts will "hang" at "Looking up host" and not connect to the sftp site. The script will just end there instead of connecting and delivering the files. The issue is not with one particular vendor's sftp site, I use similar scripts to deliver/download files to/from a number of different sites throughout the day and I'm seeing this same issue occur with many different sites. That leads me to believe the problem is something in my environment but not sure if it is something like permissions or something else I haven't considered. I was running an older version of winscp (5.9.3) but recently upgraded to 5.15 and the issue persists. Here's a log of a recent occurence:
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 WinSCP Version 5.15 (Build 9365) (OS 6.3.9600 - Windows Server 2012 R2 Standard)
. 2019-03-28 10:43:20.861 Configuration: HKCU\Software\Martin Prikryl\WinSCP 2\
. 2019-03-28 10:43:20.861 Log level: Debug 1, Logging passwords
. 2019-03-28 10:43:20.861 Local account: domain\domainuser
. 2019-03-28 10:43:20.861 Working directory: E:\Program Files (x86)\WinSCP\Alerts
. 2019-03-28 10:43:20.861 Process ID: 6360
. 2019-03-28 10:43:20.861 Command-line: winscp.exe /console /script=diupada.txt /log=diupada.log
. 2019-03-28 10:43:20.861 Switch: /console
. 2019-03-28 10:43:20.861 Switch: /script=diupada.txt
. 2019-03-28 10:43:20.861 Switch: /log=diupada.log
. 2019-03-28 10:43:20.861 Time zone: Current: GMT-5, Standard: GMT-6 (Central Standard Time), DST: GMT-5 (Central Daylight Time), DST Start: 3/10/2019, DST End: 11/3/2019
. 2019-03-28 10:43:20.861 Login time: Thursday, March 28, 2019 10:43:20 AM
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Script: Retrospectively logging previous script records:
> 2019-03-28 10:43:20.861 Script: option batch abort
> 2019-03-28 10:43:20.861 Script: Parameter: batch
> 2019-03-28 10:43:20.861 Script: Parameter: abort
< 2019-03-28 10:43:20.861 Script: batch abort
> 2019-03-28 10:43:20.861 Script: option confirm off
> 2019-03-28 10:43:20.861 Script: Parameter: confirm
> 2019-03-28 10:43:20.861 Script: Parameter: off
< 2019-03-28 10:43:20.861 Script: confirm off
> 2019-03-28 10:43:20.861 Script: open sftp://user:pass@sftpsiteurl.com
> 2019-03-28 10:43:20.861 Script: Parameter: sftp://user:pass@sftpsiteurl.com
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Session name: user@sftpsiteurl.com (Ad-Hoc site)
. 2019-03-28 10:43:20.861 Host name: sftpsiteurl.com (Port: 22)
. 2019-03-28 10:43:20.861 User name: user (Password: pass, Key file: No, Passphrase: No)
. 2019-03-28 10:43:20.861 Tunnel: No
. 2019-03-28 10:43:20.861 Transfer Protocol: SFTP
. 2019-03-28 10:43:20.861 Ping type: Off, Ping interval: 30 sec; Timeout: 15 sec
. 2019-03-28 10:43:20.861 Disable Nagle: No
. 2019-03-28 10:43:20.861 Proxy: None
. 2019-03-28 10:43:20.861 Send buffer: 262144
. 2019-03-28 10:43:20.861 SSH protocol version: 2; Compression: No
. 2019-03-28 10:43:20.861 Bypass authentication: No
. 2019-03-28 10:43:20.861 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: Yes
. 2019-03-28 10:43:20.861 GSSAPI: Forwarding: No; Libs: gssapi32,sspi,custom; Custom:
. 2019-03-28 10:43:20.861 Ciphers: aes,chacha20,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2019-03-28 10:43:20.861 KEX: ecdh,dh-gex-sha1,dh-group14-sha1,rsa,WARN,dh-group1-sha1
. 2019-03-28 10:43:20.861 SSH Bugs: Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto
. 2019-03-28 10:43:20.861 Simple channel: Yes
. 2019-03-28 10:43:20.861 Return code variable: Autodetect; Lookup user groups: Auto
. 2019-03-28 10:43:20.861 Shell: default
. 2019-03-28 10:43:20.861 EOL: LF, UTF: Auto
. 2019-03-28 10:43:20.861 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes; Follow directory symlinks: No
. 2019-03-28 10:43:20.861 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No; Exit code 1 is error: No
. 2019-03-28 10:43:20.861 SFTP Bugs: Auto,Auto
. 2019-03-28 10:43:20.861 SFTP Server: default
. 2019-03-28 10:43:20.861 Local directory: default, Remote directory: home, Update: Yes, Cache: Yes
. 2019-03-28 10:43:20.861 Cache directory changes: Yes, Permanent: Yes
. 2019-03-28 10:43:20.861 Recycle bin: Delete to: No, Overwritten to: No, Bin path:
. 2019-03-28 10:43:20.861 DST mode: Unix
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Looking up host "sftpsiteurl.com" for SSH connection
I'm having periodic issues with some command line scripts that I use to deliver/download files to/from remote sftp sites. Occasionally the scripts will "hang" at "Looking up host" and not connect to the sftp site. The script will just end there instead of connecting and delivering the files. The issue is not with one particular vendor's sftp site, I use similar scripts to deliver/download files to/from a number of different sites throughout the day and I'm seeing this same issue occur with many different sites. That leads me to believe the problem is something in my environment but not sure if it is something like permissions or something else I haven't considered. I was running an older version of winscp (5.9.3) but recently upgraded to 5.15 and the issue persists. Here's a log of a recent occurence:
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 WinSCP Version 5.15 (Build 9365) (OS 6.3.9600 - Windows Server 2012 R2 Standard)
. 2019-03-28 10:43:20.861 Configuration: HKCU\Software\Martin Prikryl\WinSCP 2\
. 2019-03-28 10:43:20.861 Log level: Debug 1, Logging passwords
. 2019-03-28 10:43:20.861 Local account: domain\domainuser
. 2019-03-28 10:43:20.861 Working directory: E:\Program Files (x86)\WinSCP\Alerts
. 2019-03-28 10:43:20.861 Process ID: 6360
. 2019-03-28 10:43:20.861 Command-line: winscp.exe /console /script=diupada.txt /log=diupada.log
. 2019-03-28 10:43:20.861 Switch: /console
. 2019-03-28 10:43:20.861 Switch: /script=diupada.txt
. 2019-03-28 10:43:20.861 Switch: /log=diupada.log
. 2019-03-28 10:43:20.861 Time zone: Current: GMT-5, Standard: GMT-6 (Central Standard Time), DST: GMT-5 (Central Daylight Time), DST Start: 3/10/2019, DST End: 11/3/2019
. 2019-03-28 10:43:20.861 Login time: Thursday, March 28, 2019 10:43:20 AM
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Script: Retrospectively logging previous script records:
> 2019-03-28 10:43:20.861 Script: option batch abort
> 2019-03-28 10:43:20.861 Script: Parameter: batch
> 2019-03-28 10:43:20.861 Script: Parameter: abort
< 2019-03-28 10:43:20.861 Script: batch abort
> 2019-03-28 10:43:20.861 Script: option confirm off
> 2019-03-28 10:43:20.861 Script: Parameter: confirm
> 2019-03-28 10:43:20.861 Script: Parameter: off
< 2019-03-28 10:43:20.861 Script: confirm off
> 2019-03-28 10:43:20.861 Script: open sftp://user:pass@sftpsiteurl.com
> 2019-03-28 10:43:20.861 Script: Parameter: sftp://user:pass@sftpsiteurl.com
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Session name: user@sftpsiteurl.com (Ad-Hoc site)
. 2019-03-28 10:43:20.861 Host name: sftpsiteurl.com (Port: 22)
. 2019-03-28 10:43:20.861 User name: user (Password: pass, Key file: No, Passphrase: No)
. 2019-03-28 10:43:20.861 Tunnel: No
. 2019-03-28 10:43:20.861 Transfer Protocol: SFTP
. 2019-03-28 10:43:20.861 Ping type: Off, Ping interval: 30 sec; Timeout: 15 sec
. 2019-03-28 10:43:20.861 Disable Nagle: No
. 2019-03-28 10:43:20.861 Proxy: None
. 2019-03-28 10:43:20.861 Send buffer: 262144
. 2019-03-28 10:43:20.861 SSH protocol version: 2; Compression: No
. 2019-03-28 10:43:20.861 Bypass authentication: No
. 2019-03-28 10:43:20.861 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: Yes
. 2019-03-28 10:43:20.861 GSSAPI: Forwarding: No; Libs: gssapi32,sspi,custom; Custom:
. 2019-03-28 10:43:20.861 Ciphers: aes,chacha20,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2019-03-28 10:43:20.861 KEX: ecdh,dh-gex-sha1,dh-group14-sha1,rsa,WARN,dh-group1-sha1
. 2019-03-28 10:43:20.861 SSH Bugs: Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto,Auto
. 2019-03-28 10:43:20.861 Simple channel: Yes
. 2019-03-28 10:43:20.861 Return code variable: Autodetect; Lookup user groups: Auto
. 2019-03-28 10:43:20.861 Shell: default
. 2019-03-28 10:43:20.861 EOL: LF, UTF: Auto
. 2019-03-28 10:43:20.861 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes; Follow directory symlinks: No
. 2019-03-28 10:43:20.861 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No; Exit code 1 is error: No
. 2019-03-28 10:43:20.861 SFTP Bugs: Auto,Auto
. 2019-03-28 10:43:20.861 SFTP Server: default
. 2019-03-28 10:43:20.861 Local directory: default, Remote directory: home, Update: Yes, Cache: Yes
. 2019-03-28 10:43:20.861 Cache directory changes: Yes, Permanent: Yes
. 2019-03-28 10:43:20.861 Recycle bin: Delete to: No, Overwritten to: No, Bin path:
. 2019-03-28 10:43:20.861 DST mode: Unix
. 2019-03-28 10:43:20.861 --------------------------------------------------------------------------
. 2019-03-28 10:43:20.861 Looking up host "sftpsiteurl.com" for SSH connection
