Topic "FTPS large files Timeout detected (control connection)"

Author Message
dweste
[View user's profile]

Joined: 2016-03-14
Posts: 1
When transferring large files to a Filezilla FTPS (Implicit TLS/SSL) server, and the transfer is 99% complete, the control connection times out and the transfer aborts. Small files work like a charm.

I tried about everything I could find on the WinSCP site:
- Increased all timeouts, client and serverside
- Tested other versions of WinSCP (5.76, 5.77, and the latest beta)
- rawsettings: SendBuf=0 SshSimple=0 PingType=2 PingIntervalSecs=15
- Disabled Application Gateway Layer service on the server

Nothing worked so far. After reading this topic, I suspect the control connection is not being kept alive by WinSCP. The large file takes too much time (about 15 minutes), and the control connection times out.

I setup a small test with only the large file, to reduce unnecessary clutter in the logfile. I attached the complete logfile, and this is the part where the problem occurs:

Code:

. 2016-03-14 10:19:57.807 Data connection opened
. 2016-03-14 10:19:57.807 Trying reuse main TLS session ID
. 2016-03-14 10:19:57.807 TLS layer changed state from none to connected
< 2016-03-14 10:19:57.811 150 Opening data channel for directory listing of "/"
. 2016-03-14 10:19:57.812 Session ID reused
. 2016-03-14 10:19:57.813 TLS connection established
. 2016-03-14 10:19:57.819 type=file;modify=20160314091944;size=346072288; Vitrite.rar
< 2016-03-14 10:19:57.819 226 Successfully transferred "/"
. 2016-03-14 10:19:57.819 Directory listing successful
. 2016-03-14 10:19:57.819 Got reply 1 to the command 2
. 2016-03-14 10:19:57.819 ..;D;0;1899-12-30T01:00:00.000Z;"" [0];"" [0];---------;0
. 2016-03-14 10:19:57.819 Vitrite.rar;-;346072288;2016-03-14T09:19:44.000Z;"" [0];"" [0];---------;0
. 2016-03-14 10:19:58.059 Local file 'D:\Backup\Vitrite.rar' [2009-03-03T19:12:26.312Z] [689869262] is modified comparing to remote file '/Vitrite.rar' [2016-03-14T09:19:44.000Z] [346072288]
< 2016-03-14 10:19:58.059 Script: Synchronizing...
. 2016-03-14 10:19:58.060 Synchronizing local directory 'D:\Backup\' with remote directory '/', params = 0x1002 (NoConfirmation, Mirror)
. 2016-03-14 10:19:58.060 Copying 1 files/directories to remote directory "/"
. 2016-03-14 10:19:58.060   PrTime: Yes; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: N (102400); CalcS: No; Mask: *.*
. 2016-03-14 10:19:58.060   TM: B; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: ; ResumeL: 0
. 2016-03-14 10:19:58.060   AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; *.js; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
. 2016-03-14 10:19:58.060 File: 'D:\Backup\Vitrite.rar' [2009-03-03T19:12:26.312Z] [689869262]
< 2016-03-14 10:19:58.061 Script: Local 'D:\Backup' => Remote '/'
. 2016-03-14 10:19:58.061 Copying "D:\Backup\Vitrite.rar" to remote directory started.
. 2016-03-14 10:19:58.061 Binary transfer mode selected.
. 2016-03-14 10:19:58.062 Starting upload of D:\Backup\Vitrite.rar
> 2016-03-14 10:19:58.062 TYPE I
< 2016-03-14 10:19:58.066 200 Type set to I
> 2016-03-14 10:19:58.066 PASV
< 2016-03-14 10:19:58.070 227 Entering Passive Mode (xxx,xxx,xxx,xxx,x,xxx)
> 2016-03-14 10:19:58.071 STOR Vitrite.rar
. 2016-03-14 10:19:58.076 Data connection opened
< 2016-03-14 10:19:58.123 150 Opening data channel for file upload to server of "/Vitrite.rar"
. 2016-03-14 10:19:58.123 Data connection opened
. 2016-03-14 10:19:58.123 Trying reuse main TLS session ID
. 2016-03-14 10:19:58.123 TLS layer changed state from none to connected
. 2016-03-14 10:19:58.128 Session ID reused
. 2016-03-14 10:19:58.129 TLS connection established
. 2016-03-14 10:36:09.552 Timeout detected. (control connection)
. 2016-03-14 10:36:09.552 Copying files to remote side failed.
. 2016-03-14 10:36:09.552 Got reply 1004 to the command 4
. 2016-03-14 10:36:09.553 Connection was lost, asking what to do.
. 2016-03-14 10:36:09.553 Asking user:
. 2016-03-14 10:36:09.553 Lost connection. ("Timeout detected. (control connection)","Copying files to remote side failed.")
< 2016-03-14 10:36:09.553 Script: Lost connection.
< 2016-03-14 10:36:09.553 Script: Timeout detected. (control connection)
< 2016-03-14 10:36:09.553 Copying files to remote side failed.


Any thoughts?
WinSCPScript.log (30.21 KB) Private file

Description: (none)

martin
[View user's profile]
Site Admin
Joined: 2002-12-10
Posts: 25015
Location: Prague, Czechia
Does the file keep uploading? Or dies it hang and then timeout? Do you have the same problem with other FTP clients?

If the first, the problem is typically a broken firewall/proxy/NAT that aborts the FTP control connection as it sees no traffic during the file transfer. There's no way to keep the control connection alive during transfer. It would violate the FTP protocol specification.
_________________
Martin Prikryl
Advertisements

You can post new topics in this forum






Search Site

What is WinSCP?

It is award-winning SFTP client, SCP client, FTPS client and FTP client integrated into one software program for file transfer to FTP server or secure SFTP server. [More]

And it's free!

Donate

About donations

$9   $19   $49   $99

About donations

Recommend

WinSCP Privacy Policy

WinSCP License