Topic "Upload timeout (not WinSCP's fault)"

Author Message
geedamed
[View user's profile]

Joined: 2016-09-27
Posts: 2
Location: Bucharest
Hi,

I banged my head against the desk for the last couple of days with this problem, but could not solve it.
A few days ago, uploading started to fail. I don't recall anything that could cause it. I can connect, create new folders, delete files. But uploading starts, the progress bar fills up to the end or almost, then it stops until the timeout occurs.

I tried (I'm on Windows 10):
- Filezilla: same behaviour
- Cyberduck: worked first time, then the same behaviour
- Classic FTP: same behaviour
- command prompt (Windows 10): works
- safe mode with networking: works
- Filezilla/Ubuntu (dual boot on the same machine) works and is much faster

Cyberduck working-first-time-then-fail made me think about viruses, but after scanning with 3 antiviruses nothing came up.
I'm tempted to switch to Linux, but I tried it before and couldn't get used with the constant struggle to do little things I take for granted in Windows (like automatically upload changed files, PopTray email notifier, desktop shortcuts and other insignificant-but-important-to-me thingies).
I really would like to not change much in my ways of doing things at this moment, so, please, share your thoughts.

Anyways, here it is:

- an animated GIF capture showing the failure

- a text comparison between the log from the safe mode and the log from the normal mode

- the log taken in safe mode (upload succeded):
Code:
--------------------------------------------------------------------------
WinSCP Version 5.9.2 (Build 6958) (OS 10.0.10586 - Windows 10 Pro)
Configuration: D:\apps\comm\WinSCP\WinSCP.ini
Log level: Debug 2
Local account: PCID\windows-user
Working directory: D:\apps\comm\WinSCP
Process ID: 3564
Command-line: "D:\apps\comm\WinSCP\WinSCP.exe"
Time zone: Current: GMT+3, [...]
Login time: Tuesday, 27 September 2016 13:13:49
--------------------------------------------------------------------------
Session name: host/domain.com (Site)
Host name: ftp.domain.com (Port: 21)
User name: username (Password: Yes, Key file: No)
Transfer Protocol: FTP
Ping type: Dummy, Ping interval: 30 sec; Timeout: 15 sec
Disable Nagle: No
Proxy: None
Send buffer: 262144
UTF: Auto
FTPS: None [Client certificate: No]
FTP: Passive: Yes [Force IP: Auto]; MLSD: Auto [List all: Auto]; HOST: Auto
Local directory: D:\tmp, Remote directory: /backup, Update: Yes, Cache: Yes
Cache directory changes: Yes, Permanent: Yes
Recycle bin: Delete to: No, Overwritten to: No, Bin path:
Timezone offset: 0h 0m
--------------------------------------------------------------------------
Session upkeep
Connecting to ftp.domain.com ...
Connected with ftp.domain.com. Waiting for welcome message...
220---------- Welcome to Pure-FTPd [privsep] [TLS] ----------
220-You are user number 7 of 50 allowed.
220-Local time is now 13:13. Server port: 21.
220-This is a private system - No anonymous login
220-IPv6 connections are also welcome on this server.
220 You will be disconnected after 15 minutes of inactivity.
USER username
331 User username OK. Password required
PASS *************
230 OK. Current restricted directory is /
SYST
215 UNIX Type: L8
FEAT
211-Extensions supported:
EPRT
IDLE
MDTM
SIZE
MFMT
REST STREAM
MLST type*;size*;sizd*;modify*;UNIX.mode*;UNIX.uid*;UNIX.gid*;unique*;
MLSD
AUTH TLS
PBSZ
PROT
UTF8
TVFS
ESTA
PASV
EPSV
SPSV
ESTP
211 End.
OPTS UTF8 ON
200 OK, UTF-8 enabled
Session upkeep
Connected
Got reply 1 to the command 1
--------------------------------------------------------------------------
Using FTP protocol.
Doing startup conversation with host.
PWD
257 "/" is your current location
Got reply 1 to the command 16
Changing directory to "/backup".
CWD /backup
250 OK. Current directory is /backup
Got reply 1 to the command 16
Getting current directory name.
PWD
257 "/backup" is your current location
Got reply 1 to the command 16
Retrieving directory listing...
TYPE A
200 TYPE is now ASCII
PASV
227 Entering Passive Mode (5,154,178,88,60,153)
MLSD
Connecting to 5.154.178.88:15513 ...
Data connection opened
150 Accepted data connection

Data connection closed
226-Options: -a -l
226 12 matches total
[…]
Directory listing successful
Got reply 1 to the command 2
..;D;0;1899-12-30T02:00:00.000Z;0;"" [0];"" [0];---------;0
[…]
Startup conversation with host finished.
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Copying 1 files/directories to remote directory "/backup/"
PrTime: Yes; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: S (102400); CalcS: Yes; Mask: *.*
TM: M; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: ; ResumeL: 0
AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
File: 'D:\tmp\order-carrier.tpl' [2016-09-22T14:56:14.993Z] [17577]
Copying "D:\tmp\order-carrier.tpl" to remote directory started.
Binary transfer mode selected.
Starting upload of D:\tmp\order-carrier.tpl
TYPE I
200 TYPE is now 8-bit binary
PASV
227 Entering Passive Mode (5,154,178,88,156,122)
STOR order-carrier.tpl
Data connection opened
150 Accepted data connection
Data connection opened
226-File successfully transferred
226 0.049 seconds (measured here), 349.36 Kbytes per second
MFMT 20160922145614 order-carrier.tpl
213 UTIME OK
Upload successful
Got reply 1 to the command 4
Transfer done: 'D:\tmp\order-carrier.tpl' [17577]
Retrieving directory listing...
TYPE A
200 TYPE is now ASCII
PASV
227 Entering Passive Mode (5,154,178,88,120,186)
MLSD
Connecting to 5.154.178.88:30906 ...
Data connection opened
150 Accepted data connection
226-Options: -a -l
226 13 matches total
Data connection closed
type=cdir;sizd=4096;modify=20160927101351;UNIX.mode=0755;UNIX.uid=1523;UNIX.gid=1524;unique=901gb410b8; .
type=pdir;sizd=4096;modify=20160926153246;UNIX.mode=0711;UNIX.uid=1523;UNIX.gid=1524;unique=901gb41047; ..
[…]
Directory listing successful
Got reply 1 to the command 2
..;D;0;1899-12-30T02:00:00.000Z;0;"" [0];"" [0];---------;0
[…]
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Got reply 1004 to the command 2
Disconnected from server


and the log taken in normal mode (upload failed):
Code:
--------------------------------------------------------------------------
WinSCP Version 5.9.2 (Build 6958) (OS 10.0.10586 - Windows 10 Pro)
Configuration: D:\apps\comm\WinSCP\WinSCP.ini
Log level: Debug 2
Local account: PCID\windows-user
Working directory: D:\apps\comm\WinSCP
Process ID: 6100
Command-line: "D:\apps\comm\WinSCP\WinSCP.exe"
Time zone: Current: GMT+3, [...]
Login time: Tuesday, 27 September 2016 13:15:43
--------------------------------------------------------------------------
Session name: host/domain.com (Site)
Host name: ftp.domain.com (Port: 21)
User name: username (Password: Yes, Key file: No)
Transfer Protocol: FTP
Ping type: Dummy, Ping interval: 30 sec; Timeout: 15 sec
Disable Nagle: No
Proxy: None
Send buffer: 262144
UTF: Auto
FTPS: None [Client certificate: No]
FTP: Passive: Yes [Force IP: Auto]; MLSD: Auto [List all: Auto]; HOST: Auto
Local directory: D:\tmp, Remote directory: /backup, Update: Yes, Cache: Yes
Cache directory changes: Yes, Permanent: Yes
Recycle bin: Delete to: No, Overwritten to: No, Bin path:
Timezone offset: 0h 0m
--------------------------------------------------------------------------
Session upkeep
Connecting to ftp.domain.com ...
Connected with ftp.domain.com. Waiting for welcome message...
220---------- Welcome to Pure-FTPd [privsep] [TLS] ----------
220-You are user number 4 of 50 allowed.
220-Local time is now 13:15. Server port: 21.
220-This is a private system - No anonymous login
220-IPv6 connections are also welcome on this server.
220 You will be disconnected after 15 minutes of inactivity.
USER username
331 User username OK. Password required
PASS *************
230 OK. Current restricted directory is /
SYST
215 UNIX Type: L8
FEAT
211-Extensions supported:
EPRT
IDLE
MDTM
SIZE
MFMT
REST STREAM
MLST type*;size*;sizd*;modify*;UNIX.mode*;UNIX.uid*;UNIX.gid*;unique*;
MLSD
AUTH TLS
PBSZ
PROT
UTF8
TVFS
ESTA
PASV
EPSV
SPSV
ESTP
211 End.
OPTS UTF8 ON
200 OK, UTF-8 enabled

Connected
Got reply 1 to the command 1
--------------------------------------------------------------------------
Using FTP protocol.
Doing startup conversation with host.
PWD
257 "/" is your current location
Got reply 1 to the command 16
Changing directory to "/backup".
CWD /backup
250 OK. Current directory is /backup
Got reply 1 to the command 16
Getting current directory name.
PWD
257 "/backup" is your current location
Got reply 1 to the command 16
Retrieving directory listing...
TYPE A
200 TYPE is now ASCII
PASV
227 Entering Passive Mode (5,154,178,88,48,75)
MLSD
Connecting to 5.154.178.88:12363 ...
Data connection opened
150 Accepted data connection
Session upkeep
Data connection closed
226-Options: -a -l
226 12 matches total
[…]
Directory listing successful
Got reply 1 to the command 2
..;D;0;1899-12-30T02:00:00.000Z;0;"" [0];"" [0];---------;0
[…]
Startup conversation with host finished.
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Session upkeep
Copying 1 files/directories to remote directory "/backup/"
PrTime: Yes; PrRO: No; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 0100; Resume: S (102400); CalcS: Yes; Mask: *.*
TM: M; ClAr: No; RemEOF: No; RemBOM: No; CPS: 0; NewerOnly: No; InclM: ; ResumeL: 0
AscM: *.*html; *.htm; *.txt; *.php; *.php3; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
File: 'D:\tmp\order-carrier.tpl' [2016-09-22T14:56:14.993Z] [17577]
Copying "D:\tmp\order-carrier.tpl" to remote directory started.
Binary transfer mode selected.
Starting upload of D:\tmp\order-carrier.tpl
TYPE I
200 TYPE is now 8-bit binary
PASV
227 Entering Passive Mode (5,154,178,88,121,16)
STOR order-carrier.tpl
Data connection opened
150 Accepted data connection
Data connection opened
Timeout detected. (control connection)
Copying files to remote side failed.
Got reply 1004 to the command 4
Connection was lost, asking what to do.
Asking user:
Lost connection. ("Timeout detected. (control connection)","Copying files to remote side failed.")
(ESshFatal) **Lost connection.**
Timeout detected. (control connection)
Copying files to remote side failed.
Copying files to remote side failed.


Thank you.
martin
[View user's profile]
Site Admin
Joined: 2002-12-10
Posts: 24994
Location: Prague, Czechia
Try disabling stateful FTP filtering using:

netsh advfirewall set global StatefulFTP disable

See https://technet.microsoft.com/en-us/library/dd421710.aspx
geedamed
[View user's profile]

Joined: 2016-09-27
Posts: 2
Location: Bucharest
Thank you for replying.

I think i did disable stateful FTP filtering among many other things i tried, but I cannot verify it, as I did a clean reinstall of Windows and this solved my problem.
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