WinSCP 99% file transfers but times out and retries

Advertisement

nixius
Guest

WinSCP 99% file transfers but times out and retries

Hello,

I've done a lot of things and searching to try and solve this to no avail. I am using WinSCP 5.7.3 (Build 5348) and have also tried the latest version (at the time of writing 5.7.7 (Build 6257)). I'm using Windows7 and FileZilla for ftp (FileZilla server version 0.9.49.0).

I have a large file (190MB) that I am trying to synchronize via scripting, small files sync fine. It seems to get to 99% and then times out to the set timeout time (2mins in my case). Here is how I attempt to accomplish that via scripts:

WinSCP.com /script=dosync.txt /log="c:\winscp.log" /loglevel=0

option batch continue
option confirm off
open ftp://user:pass@domain.co.uk:21 -explicit -timeout=120 -certificate="00....00" -rawsettings PingType=2
synchronize remote -transfer=automatic -delete -resumesupport=off -filemask="*.png,*.jpg,*.jpeg,*.bmp,*.gif,*.tga,*.mp4" "T:\...\galleries" "galleries"
close
exit

I have tried this with very large timeouts and without -rawsettings PingType=2 which hasn't made a difference.

Here is what the logging says at the point of interest:

Script: Synchronizing...
. 2016-04-28 09:45:22.239 Synchronizing local directory 'T:\...\folder' with remote directory 'galleries...\folder', params = 0x3 (Delete, NoConfirmation)
. 2016-04-28 09:45:22.239 Copying 1 files/directories to remote directory "galleries/.../folder"
. 2016-04-28 09:45:22.239   PrTime: Yes; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: N (102400); CalcS: No; Mask: *.*
. 2016-04-28 09:45:22.239   TM: M; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: *.png,*.jpg,*.jpeg,*.bmp,*.gif,*.tga,*.mp4; ResumeL: 0
. 2016-04-28 09:45:22.239   AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; *.js; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
. 2016-04-28 09:45:22.240 File: 'T:\..\folder\20150315_113449.mp4' [2015-03-15T11:36:22.000Z] [195694794]
< 2016-04-28 09:45:22.240 Script: Local 'T:...\folder\' => Remote 'galleries/../folder'
. 2016-04-28 09:45:22.243 Copying "T:\...\folder\20150315_113449.mp4" to remote directory started.
. 2016-04-28 09:45:22.244 Binary transfer mode selected.
. 2016-04-28 09:45:22.244 Starting upload of T:\...\folder\20150315_113449.mp4
> 2016-04-28 09:45:22.244 CWD /galleries/../folder/
< 2016-04-28 09:45:22.263 250 CWD successful. "/galleries/.../folder" is current directory.
> 2016-04-28 09:45:22.263 PWD
< 2016-04-28 09:45:22.280 257 "/galleries/../folder/" is current directory.
> 2016-04-28 09:45:22.280 TYPE A
< 2016-04-28 09:45:22.304 200 Type set to A
> 2016-04-28 09:45:22.304 PASV
< 2016-04-28 09:45:22.323 227 Entering Passive Mode (ip,ip,ip,ip,181,127)
> 2016-04-28 09:45:22.324 MLSD
< 2016-04-28 09:45:22.369 150 Opening data channel for directory listing of "/galleries/../folder/"
. 2016-04-28 09:45:22.370 Session ID reused
. 2016-04-28 09:45:22.372 TLS connection established
. 2016-04-28 09:45:22.388 type=file;modify=20160329231651;size=139180328; 20150315_111936.mp4
. 2016-04-28 09:45:22.388 type=file;modify=20160329232717;size=163606566; 20150315_125206.mp4
. 2016-04-28 09:45:22.388 type=file;modify=20160330220715;size=16896; Thumbs.db
< 2016-04-28 09:45:22.392 226 Successfully transferred "/galleries/../folder"
> 2016-04-28 09:45:22.393 TYPE I
< 2016-04-28 09:45:22.411 200 Type set to I
> 2016-04-28 09:45:22.411 PASV
< 2016-04-28 09:45:22.427 227 Entering Passive Mode (ip,ip,ip,ip,181,128)
> 2016-04-28 09:45:22.428 STOR 20150315_113449.mp4
< 2016-04-28 09:45:22.471 150 Opening data channel for file upload to server of "/galleries/,.../folder/20150315_113449.mp4"
. 2016-04-28 09:45:22.493 Session ID reused
. 2016-04-28 09:45:22.495 TLS connection established
. 2016-04-28 09:56:32.598 Timeout detected. (control connection)
. 2016-04-28 09:56:32.598 Copying files to remote side failed.
. 2016-04-28 09:56:32.599 Connection was lost, asking what to do.
. 2016-04-28 09:56:32.599 Asking user:
. 2016-04-28 09:56:32.599 Lost connection. ("Timeout detected. (control connection)","Copying files to remote side failed.")
< 2016-04-28 09:56:32.599 Script: Lost connection.
< 2016-04-28 09:56:32.600 Script: Timeout detected. (control connection)
< 2016-04-28 09:56:32.600 Copying files to remote side failed.
< 2016-04-28 09:56:37.610 Script: Connecting to domain.co.uk ...
. 2016-04-28 09:56:37.610 Connecting to domain.co.uk ...
. 2016-04-28 09:56:37.761 Connected with domain.co.uk, negotiating TLS connection...
< 2016-04-28 09:56:37.776 220-FileZilla Server version 0.9.49 beta
< 2016-04-28 09:56:37.776 220-written by Tim Kosse (tim.kosse@filezilla-project.org)
< 2016-04-28 09:56:37.776 220 Please visit https://filezilla-project.org/
> 2016-04-28 09:56:37.776 AUTH TLS

I have auto retry on so this will continue forever. I put a very large timeout in and I can look where the file is syncing too and byte for byte it has transferred successfully however, when it retries the sync it deletes the file and starts over.

Any ideas?

Reply with quote

Advertisement

Guest

Is this a known issue/problem then? Being behind a particular make/model/firmware version of router/routing software etc?

I wonder how one could check this.

Reply with quote

Advertisement

You can post new topics in this forum