Having a timeout problem listing remote directories

Advertisement

JMS
Joined:
Posts:
2

Having a timeout problem listing remote directories

Hello,

So, I've run into a problem doing a sync over FTPS. I can't tell whether it's a problem with the host or with client on my end. Basically, the connection appears to be established fine, but when it goes to list the directory contents on the remote server, it times out. I have a hunch it's probably something to do with how the server being used by the host is talking back, possibly not being what WinSCP is expecting. But I don't know, so I figured I'd see if anyone had any thoughts.

I'm running WinSCP.com version 4.2.3 from the DOS command line on a Windows 2003 server.

Thanks,
Jon

Here's the command line issued at the DOS prompt:
"C:\Program Files\WinSCP\winscp.com" /script=test.txt /log=test.log
Here's the script test.txt:
option echo off
option batch continue
option confirm off
option transfer automatic
option exclude ".svn;_notes/;NOPIC.JPG;*.log;*.LCK;*.tmp;*.url;google_key.txt;phpinfo.php;Thumbs.db;globals.php;uploaded_files/;irm/dacms/documents/;/_*;Templates/;aspnet_client/;*_MMtmp*/;"
open ftps://username:password@home3.kattare.com -passive -explicittls -certificate="ssh-rsa 2048 94:74:f9:7e:0e:3c:5e:3f:e6:1c:04:87:1f:ce:81:4d:af:3c:68:7c"
cd remote_dir
synchronize remote -delete -criteria=time \\server\path\to\files\
close
exit
And here's the log:
. 2009-09-25 11:56:14.372 --------------------------------------------------------------------------
. 2009-09-25 11:56:14.372 WinSCP Version 4.2.3 (Build 494) (OS 5.2.3790 Service Pack 2)
. 2009-09-25 11:56:14.372 Login time: Friday, September 25, 2009 11:56:14 AM
. 2009-09-25 11:56:14.372 --------------------------------------------------------------------------
. 2009-09-25 11:56:14.372 Session name: <USERNAME>@home3.kattare.com
. 2009-09-25 11:56:14.372 Host name: home3.kattare.com (Port: 21)
. 2009-09-25 11:56:14.372 User name: <USERNAME> (Password: Yes, Key file: No)
. 2009-09-25 11:56:14.372 Tunnel: No
. 2009-09-25 11:56:14.372 Transfer Protocol: FTP
. 2009-09-25 11:56:14.372 Ping type: C, Ping interval: 30 sec; Timeout: 15 sec
. 2009-09-25 11:56:14.372 Proxy: none
. 2009-09-25 11:56:14.372 FTP: FTPS: Explicit TLS; Passive: Yes [Force IP: No]
. 2009-09-25 11:56:14.372 Local directory: default, Remote directory: home, Update: No, Cache: Yes
. 2009-09-25 11:56:14.372 Cache directory changes: Yes, Permanent: Yes
. 2009-09-25 11:56:14.372 DST mode: 1
. 2009-09-25 11:56:14.372 --------------------------------------------------------------------------
. 2009-09-25 11:56:14.388 Connecting to home3.kattare.com ...
. 2009-09-25 11:56:14.419 Connected with home3.kattare.com, negotiating SSL connection...
< 2009-09-25 11:56:14.497 220 ProFTPD 1.3.2 Server ready.
> 2009-09-25 11:56:14.497 AUTH TLS
< 2009-09-25 11:56:14.529 234 AUTH TLS successful
. 2009-09-25 11:56:14.825 SSL connection established. Waiting for welcome message...
> 2009-09-25 11:56:14.825 USER <USERNAME>
< 2009-09-25 11:56:14.872 331 Password required for <USERNAME>
> 2009-09-25 11:56:14.872 PASS **********
< 2009-09-25 11:56:15.122 230-
< 2009-09-25 11:56:15.122   ---------------------------------------------------------------
. 2009-09-25 11:56:15.122 Server does not send proper UTF-8, falling back to local charset
< 2009-09-25 11:56:15.122                Welcome to K�ttare Internet Services
< 2009-09-25 11:56:15.122   ---------------------------------------------------------------
< 2009-09-25 11:56:15.122       1.877.KATTARE - www.kattare.com - support@kattare.com    
< 2009-09-25 11:56:15.122   ---------------------------------------------------------------
< 2009-09-25 11:56:15.122     This  computer  system  is  for  authorized  users  only.
< 2009-09-25 11:56:15.122   Individuals using this system without authority or in excess of
< 2009-09-25 11:56:15.122   their authority are subject to having all their activities on
< 2009-09-25 11:56:15.122   this  system  monitored  and  recorded  or  examined  by  any
< 2009-09-25 11:56:15.122   authorized  person,  including  law  enforcement,  as  system
< 2009-09-25 11:56:15.122   personnel  deem  appropriate.  In  the  course  of  monitoring
< 2009-09-25 11:56:15.122   individuals improperly using the system or in the course of
< 2009-09-25 11:56:15.122   system maintenance, the activities of authorized users may also
< 2009-09-25 11:56:15.138   be monitored and recorded.  Any material so recorded may be
< 2009-09-25 11:56:15.138   disclosed as appropriate.  Anyone using this system consents to
< 2009-09-25 11:56:15.138   these terms.
< 2009-09-25 11:56:15.138   ---------------------------------------------------------------
< 2009-09-25 11:56:15.138   Messages: (complete stories at: https://www.kattare.com/news.kvws)
< 2009-09-25 11:56:15.138  
< 2009-09-25 11:56:15.138  Sep 08, 2009: -FTPS now available - 9/9/2009- 
< 2009-09-25 11:56:15.138  FTPS is now available for all FTP accounts.
< 2009-09-25 11:56:15.138  
< 2009-09-25 11:56:15.138  Apr 28, 2009: -DC2 Level 3 Circuit Issues- 
< 2009-09-25 11:56:15.138  Our T3 circuit to Level 3 communications is taking some errors.  An 
< 2009-09-25 11:56:15.138  attempt to debug caused a larger router outage.  We will be working with 
< 2009-09-25 11:56:15.138  L3 over the next couple of days to get to the root cause.
< 2009-09-25 11:56:15.138  
< 2009-09-25 11:56:15.138  Mar 03, 2009: -Software Patch Causes Sporadic Failures- 
< 2009-09-25 11:56:15.138  We had a security patch go out last night for the glibc
< 2009-09-25 11:56:15.138  libs on all of our servers.  The patch changed the libs
< 2009-09-25 11:56:15.169  enough that many daemons running on the servers had to
< 2009-09-25 11:56:15.169  be restarted.  It took us much of the night and until
< 2009-09-25 11:56:15.169  about 9 AM PST to track down and restart the affected
< 2009-09-25 11:56:15.169  daemons.
< 2009-09-25 11:56:15.169  
< 2009-09-25 11:56:15.169   ---------------------------------------------------------------
< 2009-09-25 11:56:15.169  
< 2009-09-25 11:56:15.169 230 User <USERNAME> logged in
> 2009-09-25 11:56:15.169 SYST
< 2009-09-25 11:56:15.216 215 UNIX Type: L8
> 2009-09-25 11:56:15.216 FEAT
< 2009-09-25 11:56:15.247 211-Features:
< 2009-09-25 11:56:15.247  MDTM
< 2009-09-25 11:56:15.247  MFMT
< 2009-09-25 11:56:15.247  AUTH TLS
< 2009-09-25 11:56:15.247  MFF modify;UNIX.group;UNIX.mode;
< 2009-09-25 11:56:15.247  MLST modify*;perm*;size*;type*;unique*;UNIX.group*;UNIX.mode*;UNIX.owner*;
< 2009-09-25 11:56:15.247  PBSZ
< 2009-09-25 11:56:15.247  PROT
< 2009-09-25 11:56:15.247  REST STREAM
< 2009-09-25 11:56:15.247  SIZE
< 2009-09-25 11:56:15.357 211 End
> 2009-09-25 11:56:15.357 PBSZ 0
< 2009-09-25 11:56:15.404 200 PBSZ 0 successful
> 2009-09-25 11:56:15.404 PROT P
< 2009-09-25 11:56:15.435 200 Protection set to Private
. 2009-09-25 11:56:15.435 Connected
. 2009-09-25 11:56:15.435 --------------------------------------------------------------------------
. 2009-09-25 11:56:15.435 Using FTP protocol.
. 2009-09-25 11:56:15.435 Doing startup conversation with host.
> 2009-09-25 11:56:15.435 PWD
< 2009-09-25 11:56:15.482 257 "/" is the current directory
. 2009-09-25 11:56:15.482 Getting current directory name.
. 2009-09-25 11:56:15.482 Startup conversation with host finished.
. 2009-09-25 11:56:15.482 Cached directory change via "remote_dir" to "/remote_dir".
. 2009-09-25 11:56:15.482 Getting current directory name.
. 2009-09-25 11:56:15.482 Collecting synchronization list for local directory '\\server\path\to\files\' and remote directory '/remote_dir', mode = 0, params = 3
. 2009-09-25 11:56:15.497 Retrieving directory listing...
> 2009-09-25 11:56:15.497 CWD /remote_dir/
< 2009-09-25 11:56:15.544 250 CWD command successful
> 2009-09-25 11:56:15.544 PWD
< 2009-09-25 11:56:15.575 257 "/remote_dir" is the current directory
> 2009-09-25 11:56:15.575 TYPE A
< 2009-09-25 11:56:15.622 200 Type set to A
> 2009-09-25 11:56:15.622 PASV
< 2009-09-25 11:56:15.654 227 Entering Passive Mode (65,212,180,47,126,252).
> 2009-09-25 11:56:15.654 LIST -a
. 2009-09-25 11:56:30.466 Timeout detected.
. 2009-09-25 11:56:30.466 Could not retrieve directory listing
I just wanted to add that the GUI responds with
Error listing directory '/'.

Could not retrieve directory listing
Illegal PORT Command
And here's the log from the GUI attempt:
. 2009-09-28 11:59:36.577 --------------------------------------------------------------------------
. 2009-09-28 11:59:36.577 WinSCP Version 4.2.3 (Build 494) (OS 5.2.3790 Service Pack 2)
. 2009-09-28 11:59:36.577 Login time: Monday, September 28, 2009 11:59:36 AM
. 2009-09-28 11:59:36.577 --------------------------------------------------------------------------
. 2009-09-28 11:59:36.577 Session name: <USERNAME>@home3.kattare.com
. 2009-09-28 11:59:36.577 Host name: home3.kattare.com (Port: 21)
. 2009-09-28 11:59:36.577 User name: <USERNAME> (Password: No, Key file: No)
. 2009-09-28 11:59:36.577 Tunnel: No
. 2009-09-28 11:59:36.577 Transfer Protocol: FTP
. 2009-09-28 11:59:36.577 Ping type: C, Ping interval: 30 sec; Timeout: 15 sec
. 2009-09-28 11:59:36.577 Proxy: none
. 2009-09-28 11:59:36.577 FTP: FTPS: Explicit SSL; Passive: No [Force IP: No]
. 2009-09-28 11:59:36.577 Local directory: default, Remote directory: home, Update: No, Cache: Yes
. 2009-09-28 11:59:36.577 Cache directory changes: Yes, Permanent: Yes
. 2009-09-28 11:59:36.577 DST mode: 1
. 2009-09-28 11:59:36.577 --------------------------------------------------------------------------
. 2009-09-28 11:59:36.577 Password prompt (no password provided or last login attempt failed)
. 2009-09-28 11:59:40.671 Connecting to home3.kattare.com ...
. 2009-09-28 11:59:40.734 Connected with home3.kattare.com, negotiating SSL connection...
< 2009-09-28 11:59:40.859 220 ProFTPD 1.3.2 Server ready.
> 2009-09-28 11:59:40.859 AUTH SSL
< 2009-09-28 11:59:40.890 234 AUTH SSL successful
. 2009-09-28 11:59:41.093 SSL connection established. Waiting for welcome message...
> 2009-09-28 11:59:41.093 USER <USERNAME>
< 2009-09-28 11:59:41.140 331 Password required for <USERNAME>
> 2009-09-28 11:59:41.140 PASS **********
< 2009-09-28 11:59:41.249 230-
< 2009-09-28 11:59:41.249   ---------------------------------------------------------------
. 2009-09-28 11:59:41.249 Server does not send proper UTF-8, falling back to local charset
< 2009-09-28 11:59:41.249                Welcome to K�ttare Internet Services
< 2009-09-28 11:59:41.249   ---------------------------------------------------------------
< 2009-09-28 11:59:41.249       1.877.KATTARE - www.kattare.com - support@kattare.com    
< 2009-09-28 11:59:41.249   ---------------------------------------------------------------
< 2009-09-28 11:59:41.249     This  computer  system  is  for  authorized  users  only.
< 2009-09-28 11:59:41.249   Individuals using this system without authority or in excess of
< 2009-09-28 11:59:41.249   their authority are subject to having all their activities on
< 2009-09-28 11:59:41.249   this  system  monitored  and  recorded  or  examined  by  any
< 2009-09-28 11:59:41.249   authorized  person,  including  law  enforcement,  as  system
< 2009-09-28 11:59:41.249   personnel  deem  appropriate.  In  the  course  of  monitoring
< 2009-09-28 11:59:41.249   individuals improperly using the system or in the course of
< 2009-09-28 11:59:41.249   system maintenance, the activities of authorized users may also
< 2009-09-28 11:59:41.249   be monitored and recorded.  Any material so recorded may be
< 2009-09-28 11:59:41.249   disclosed as appropriate.  Anyone using this system consents to
< 2009-09-28 11:59:41.249   these terms.
< 2009-09-28 11:59:41.249   ---------------------------------------------------------------
< 2009-09-28 11:59:41.249   Messages: (complete stories at: https://www.kattare.com/news.kvws)
< 2009-09-28 11:59:41.249  
< 2009-09-28 11:59:41.249  Sep 08, 2009: -FTPS now available - 9/9/2009- 
< 2009-09-28 11:59:41.249  FTPS is now available for all FTP accounts.
< 2009-09-28 11:59:41.249  
< 2009-09-28 11:59:41.249  Apr 28, 2009: -DC2 Level 3 Circuit Issues- 
< 2009-09-28 11:59:41.249  Our T3 circuit to Level 3 communications is taking some errors.  An 
< 2009-09-28 11:59:41.249  attempt to debug caused a larger router outage.  We will be working with 
< 2009-09-28 11:59:41.249  L3 over the next couple of days to get to the root cause.
< 2009-09-28 11:59:41.249  
< 2009-09-28 11:59:41.249  Mar 03, 2009: -Software Patch Causes Sporadic Failures- 
< 2009-09-28 11:59:41.249  We had a security patch go out last night for the glibc
< 2009-09-28 11:59:41.249  libs on all of our servers.  The patch changed the libs
< 2009-09-28 11:59:41.312  enough that many daemons running on the servers had to
< 2009-09-28 11:59:41.312  be restarted.  It took us much of the night and until
< 2009-09-28 11:59:41.312  about 9 AM PST to track down and restart the affected
< 2009-09-28 11:59:41.312  daemons.
< 2009-09-28 11:59:41.312  
< 2009-09-28 11:59:41.312  
< 2009-09-28 11:59:41.312 230 User <USERNAME> logged in
> 2009-09-28 11:59:41.312 SYST
< 2009-09-28 11:59:41.374 215 UNIX Type: L8
> 2009-09-28 11:59:41.374 FEAT
< 2009-09-28 11:59:41.421 211-Features:
< 2009-09-28 11:59:41.421  MDTM
< 2009-09-28 11:59:41.421  MFMT
< 2009-09-28 11:59:41.421  AUTH TLS
< 2009-09-28 11:59:41.421  MFF modify;UNIX.group;UNIX.mode;
< 2009-09-28 11:59:41.421  MLST modify*;perm*;size*;type*;unique*;UNIX.group*;UNIX.mode*;UNIX.owner*;
< 2009-09-28 11:59:41.421  PBSZ
< 2009-09-28 11:59:41.421  PROT
< 2009-09-28 11:59:41.421  REST STREAM
< 2009-09-28 11:59:41.421  SIZE
< 2009-09-28 11:59:41.577 211 End
> 2009-09-28 11:59:41.577 PBSZ 0
< 2009-09-28 11:59:41.624 200 PBSZ 0 successful
> 2009-09-28 11:59:41.624 PROT P
< 2009-09-28 11:59:41.671 200 Protection set to Private
. 2009-09-28 11:59:41.671 Connected
. 2009-09-28 11:59:41.671 --------------------------------------------------------------------------
. 2009-09-28 11:59:41.671 Using FTP protocol.
. 2009-09-28 11:59:41.671 Doing startup conversation with host.
> 2009-09-28 11:59:41.671 PWD
< 2009-09-28 11:59:41.718 257 "/" is the current directory
. 2009-09-28 11:59:41.718 Getting current directory name.
. 2009-09-28 11:59:41.718 Retrieving directory listing...
> 2009-09-28 11:59:41.718 TYPE A
< 2009-09-28 11:59:41.765 200 Type set to A
> 2009-09-28 11:59:41.765 PORT 10,10,96,174,5,201
< 2009-09-28 11:59:41.796 500 Illegal PORT command
. 2009-09-28 11:59:41.796 Could not retrieve directory listing
. 2009-09-28 11:59:41.812 Retrieving directory listing...
> 2009-09-28 11:59:41.812 TYPE A
< 2009-09-28 11:59:41.843 200 Type set to A
> 2009-09-28 11:59:41.843 PORT 10,10,96,174,5,202
< 2009-09-28 11:59:41.874 500 Illegal PORT command
. 2009-09-28 11:59:41.874 Could not retrieve directory listing
* 2009-09-28 11:59:41.874 (ECommand) Error listing directory '/'.
* 2009-09-28 11:59:41.874 Could not retrieve directory listing
* 2009-09-28 11:59:41.874 Illegal PORT command
. 2009-09-28 12:00:31.345 Startup conversation with host finished.
> 2009-09-28 12:00:32.611 TYPE I
< 2009-09-28 12:00:32.611 200 Type set to I
. 2009-09-28 12:00:35.283 Disconnected from server
And I've tried with Explicit TLS and SSL with not difference; and with passive both on and off with each of those, with no difference.

Reply with quote

Advertisement

JMS
Joined:
Posts:
2

Got a little further, but not all the way

Checking that option has given me several attempts that show the directory listing, but time out when I start the sync.
Transfer channel can't be opened. Reason: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
Could not retrieve directory listing
Entering Passive Mode (65,212,180,47,153,45).
The more I look into this, the more I think it has to do with the way the host has their FTPd configured; or maybe a router. I've been finding lots of chatter online about the ProFTPd server they're using having slight configuration nuances that can cause havoc for FTP clients sometimes, especially when it comes to whether or not the data and control communications are both encrypted. Anyway, I'm trying to get some feedback from other users of the host if any have gotten FTPS working with them and what they're doing.

Thanks, I'll update if anything new happens.

Reply with quote

martin
Site Admin
martin avatar

Re: Got a little further, but not all the way

Can you post a log file again? Both showing successful directory listing and failed transfer?

Reply with quote

Advertisement

You can post new topics in this forum