PB38: FTP Transfer failes

Try the latest development release to test new features and bug fixes even before beta version release. Please use this section to discuss features and problems of this Preview Build version.
Forum rules
Please read forum rules and a few additional rules for this section:
1. Please take into account that Preview Build versions of Salamander and plugins could contain serious bugs. Don't use them in production environments.
2. All problems or comments regarding Preview Build versions please insert into this section of forum.
3. Each new topic mark with PB abbreviation and Preview Build number, for example "PB22: inactive panel below mouse cursor doesn't scroll while mouse wheel tilting".
User avatar
SvA
Posts: 483
Joined: 29 Mar 2006, 02:41
Location: DE

PB38: FTP Transfer failes

Post by SvA »

Tonight I had troubles uploading a file to an FTP server with Salamander:
(AS 2.53 beta 1 (PB 38); FTP Client 1.31 beta 1 (PB 38))

Somehow the server closed a connection early. AS started a new connection and failed again. Filezilla logged the closed connection, but, without logging any measures it took, continued to transfer and succeeded.
Sorry, filezilla's status messages are in German, but I think you should still get what's going on.
I added some comments denoted by the string <==. Furthermore i changes server name, server IP and user name.

Code: Select all

Connecting to "ftp.server.ip" (266.266.266.266) on port 21.
Log UID is 0, time is 31.01.2010 - 21:34:47.

220-FTP server ready.
220 This is a private system - No anonymous login
USER #####
331 User ##### OK. Password required
PASS (hidden)
230-OK. Current restricted directory is /
230 2593155 Kbytes used (25%) - authorized: 10240000 Kb
(21:34:47): Logged in successfully, getting system information...
SYST
215 UNIX Type: L8
PWD
257 "/" is your current location
(21:34:47): Changing path to "/"...
CWD /
250 OK. Current directory is /
PWD
257 "/" is your current location
(21:34:48): Listing path "/"...
PORT 192,168,2,129,215,171
200 PORT command successful
TYPE A
200 TYPE is now ASCII
LIST
150 Connecting to port 55211
226-Options: -a -l 
226 147 matches total
(21:34:48): Text listing was parsed by "UNIX1" server type...

(21:35:22): Connection was detached from panel to be used for operation...

Code: Select all

Copy 2 Files to ftp.server.ip
Host: "ftp.server.ip", port: 21.
Log UID is 1, time is 31.01.2010 - 21:35:22.

(21:35:22): Using connection from panel...

(21:35:22): Uploading file "2010-01-30.zip"...  <== this file preexisted and was skipped
(21:35:22): Uploading file "2010-01-31.zip"...
TYPE I
200 TYPE is now 8-bit binary
PORT 192,168,2,129,215,172
200 PORT command successful
STOR 2010-01-31.zip
150 Connecting to port 55212
(21:41:39): Data connection error: (10054) Eine vorhandene Verbindung wurde vom Remotehost geschlossen.
(21:42:09): Sending of FTP command has timed out.

-----

Reconnecting to "ftp.server.ip" (266.266.266.266) on port 21 (attempt no. 2).
Time is 31.01.2010 - 21:42:09.

220-FTP server ready.
220 This is a private system - No anonymous login
USER #####
331 User ##### OK. Password required
PASS (hidden)
230-OK. Current restricted directory is /
230 2609171 Kbytes used (25%) - authorized: 10240000 Kb
(21:42:09): Logged in successfully, getting system information...
SYST
215 UNIX Type: L8
(21:42:09): Uploading file "2010-01-31.zip"...
(21:42:09): Listing path "/"...
CWD /
250 OK. Current directory is /
PORT 192,168,2,129,215,208
200 PORT command successful
TYPE A
200 TYPE is now ASCII
LIST
150 Connecting to port 55248
226-Options: -a -l 
226 148 matches total
(21:42:10): Uploading file "2010-01-31.zip"...
CWD /
250 OK. Current directory is /
TYPE I
200 TYPE is now 8-bit binary
SIZE 2010-01-31.zip
213 16400384
PORT 192,168,2,129,215,209
200 PORT command successful
APPE 2010-01-31.zip
150 Connecting to port 55249
(21:47:36): Data connection error: (10054) Eine vorhandene Verbindung wurde vom Remotehost geschlossen.
(21:48:06): Sending of FTP command has timed out.

-----

Reconnecting to "ftp.server.ip" (266.266.266.266) on port 21 (attempt no. 2).   <== 2nd Attempt no. 2
Time is 31.01.2010 - 21:48:06.

220-FTP server ready.
220 This is a private system - No anonymous login
USER #####
331 User ##### OK. Password required
PASS (hidden)
230-OK. Current restricted directory is /
230 2623051 Kbytes used (25%) - authorized: 10240000 Kb
(21:48:06): Logged in successfully, getting system information...
SYST
215 UNIX Type: L8
(21:48:06): Uploading file "2010-01-31.zip"...
(21:48:06): Listing path "/"...
CWD /
250 OK. Current directory is /
PORT 192,168,2,129,215,215
200 PORT command successful
TYPE A
200 TYPE is now ASCII
LIST
150 Connecting to port 55255
226-Options: -a -l 
226 148 matches total
(21:48:07): Uploading file "2010-01-31.zip"...
CWD /
250 OK. Current directory is /
TYPE I
200 TYPE is now 8-bit binary
SIZE 2010-01-31.zip
213 14213120                                <== This is the server's fault. It does not APPEnd but overwrites
PORT 192,168,2,129,215,216
200 PORT command successful
APPE 2010-01-31.zip
150 Connecting to port 55256
(21:53:35): Data connection error: (10054) Eine vorhandene Verbindung wurde vom Remotehost geschlossen.
(21:54:05): Sending of FTP command has timed out.

-----

Reconnecting to "ftp.server.ip" (266.266.266.266) on port 21 (attempt no. 2).   <== 3rd attempt no. 2
Time is 31.01.2010 - 21:54:05.

... Many more attempts. finaly I aborted...

APPE 2010-01-31.zip
150 Connecting to port 55388
226-2734767 Kbytes used (26%) - authorized: 10240000 Kb
226-File successfully transferred
226 97.458 seconds (measured here), 45.72 Kbytes per second  <= this was an average upload rate for this session
(22:36:02): Disconnecting from server...
QUIT
221-Goodbye. You uploaded 4456 and downloaded 0 kbytes.
221 Logout.
Then I tried Filezilla:

Code: Select all

Status:	Auflösen der IP-Adresse für ftp.server.ip
Status:	Verbinde mit 266.266.266.266:21...
Status:	Verbindung hergestellt, warte auf Willkommensnachricht...
Antwort:	220-FTP server ready.
Antwort:	220 This is a private system - No anonymous login
Befehl:	USER #####
Antwort:	331 User ##### OK. Password required
Befehl:	PASS ******
Antwort:	230-OK. Current restricted directory is /
Antwort:	230 2716079 Kbytes used (26%) - authorized: 10240000 Kb
Befehl:	SYST
Antwort:	215 UNIX Type: L8
Befehl:	FEAT
Antwort:	211-Extensions supported:
Antwort:	 EPRT
Antwort:	 IDLE
Antwort:	 MDTM
Antwort:	 SIZE
Antwort:	 REST STREAM
Antwort:	 MLST type*;size*;sizd*;modify*;UNIX.mode*;UNIX.uid*;UNIX.gid*;unique*;
Antwort:	 MLSD
Antwort:	 TVFS
Antwort:	 ESTP
Antwort:	 PASV
Antwort:	 EPSV
Antwort:	 SPSV
Antwort:	 ESTA
Antwort:	 AUTH TLS
Antwort:	 PBSZ
Antwort:	 PROT
Antwort:	211 End.
Status:	Verbunden
Status:	Empfange Verzeichnisinhalt...
Befehl:	PWD
Antwort:	257 "/" is your current location
Befehl:	TYPE I
Antwort:	200 TYPE is now 8-bit binary
Befehl:	PASV
Antwort:	227 Entering Passive Mode (195,42,120,10,231,106)
Befehl:	MLSD
Antwort:	150 Accepted data connection
Antwort:	226-ASCII
Antwort:	226-Options: -a -l 
Antwort:	226 149 matches total
Status:	Anzeigen des Verzeichnisinhalts abgeschlossen
Status:	Empfange Verzeichnisinhalt...
Befehl:	PASV
Antwort:	227 Entering Passive Mode (195,42,120,10,96,52)
Befehl:	MLSD
Antwort:	150 Accepted data connection
Antwort:	226-ASCII
Antwort:	226-Options: -a -l 
Antwort:	226 148 matches total
Status:	Anzeigen des Verzeichnisinhalts abgeschlossen
Status:	Auflösen der IP-Adresse für ftp.server.ip
Status:	Verbinde mit 266.266.266.266:21...
Status:	Verbindung hergestellt, warte auf Willkommensnachricht...
Antwort:	220-FTP server ready.
Antwort:	220 This is a private system - No anonymous login
Befehl:	USER #####
Antwort:	331 User ##### OK. Password required
Befehl:	PASS ******
Antwort:	230-OK. Current restricted directory is /
Antwort:	230 2734767 Kbytes used (26%) - authorized: 10240000 Kb
Status:	Verbunden
Status:	Starte Upload von D:\Dokumente\MZI\Predigt\2010\2010-01-31.zip
Befehl:	CWD /
Antwort:	250 OK. Current directory is /
Befehl:	PWD
Antwort:	257 "/" is your current location
Befehl:	TYPE I
Antwort:	200 TYPE is now 8-bit binary
Befehl:	PASV
Antwort:	227 Entering Passive Mode (195,42,120,10,216,27)
Befehl:	STOR 2010-01-31.zip
Antwort:	150 Accepted data connection
Fehler:	Verbindung vom Server geschlossen           <== even though the connection was closed by the server, filezilla seemd to just contunuing transfering successfully until the end of the file
Antwort:	226-2765122 Kbytes used (27%) - authorized: 10240000 Kb
Antwort:	226-File successfully transferred
Antwort:	226 464.709 seconds (measured here), 65.32 Kbytes per second   <== filezilla's transfer rate was consireably higher
Status:	Dateitransfer erfolgreich
Status:	Verbindung zum Server getrennt
Last edited by Jan Rysavy on 01 Feb 2010, 10:06, edited 1 time in total.
Reason: Updated subject
Jan Patera
Plugin Developer
Plugin Developer
Posts: 707
Joined: 08 Dec 2005, 14:33
Location: Prague, Czech Republic
Contact:

Re: FTP Transfer failes

Post by Jan Patera »

your Filezilla client uses passive mode (PASV), Salamander does not. Does it work when you switch Salamander to use passive mode as well?
User avatar
SvA
Posts: 483
Joined: 29 Mar 2006, 02:41
Location: DE

Re: FTP Transfer failes

Post by SvA »

Jan Patera wrote:your Filezilla client uses passive mode (PASV), Salamander does not. Does it work when you switch Salamander to use passive mode as well?
Unfortunately, today the server did not close the connection, so I could not check it. However, I don't think pasive mode makes much of a difference since both clients complained about a closed connection. In the case of Salamander, this might have been the control connection which I suppose to be idle during transfer. In the case of filezille, the one and only connection must have been closed.

I will try pasive mode later again.
Post Reply