Our Products:   CompleteFTP  edtFTPnet/Free  edtFTPnet/PRO  edtFTPj/Free  edtFTPj/PRO
0 votes
10.5k views
in .NET FTP by (420 points)
I'm attempting to write a program that will upload an entire directory, and all the subdirectories. For the most part, everything works fine. However, I'm getting all "Error code 550. Access denied" from my home when I attept to create directories or upload files ( but not when I change directories ). I can log into the FTP site ( via IE 7 ) using the same credentials as the program is using, and Create / Delete and upload files. The same program at another location works all fine and dandy, creating directories and uploading everything. Both places are using the Free version 2.0.0. This was also occuring with version 1.3.?.

In both cases, I'm uploading the same files ( test directory I've created ). I'm using the same credentials. Both places are behind an ISA firewall. The location that fails is using XP Pro, with one being a wireless connection, and one being wired. The location that works is also XP Pro, as well as Vista. I also have had someone successfully use the program at another location with ISA on paranoid lockdown mode, so I'm pretty sure its not the firewall. Especially since I can go thru IE 7's FTP and do everything manually.

Any suggestions? I've been at this for about a week now, and am stumped.

Thanks
Geoff Hilyard

11 Answers

0 votes
by (162k points)
It's a server error - do you have access to the FTP server log files? They should give you an idea what is causing the error.

You could also post a snippet of a working log file and of one that fails (client log files - set to debug level).
0 votes
by (420 points)
Here is working logs for this ( Please note the non working stuff is at home, and so I have no access to it from here ):

FTP Server Log:


(000222) 2/20/2009 9:31:00 AM - fireangelbackup (67.130.39.195)> 230 Logged on
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> opts utf8 on
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 200 UTF8 mode enabled
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> PWD
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 257 "/" is current directory.
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> CWD /
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 250 CWD successful. "/" is current directory.
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> PWD
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 257 "/" is current directory.
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> CWD ES44DC_001
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 250 CWD successful. "/ES44DC_001" is current directory.
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> TYPE A
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 200 Type set to A
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> PASV
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 227 Entering Passive Mode (174,133,1,27,11,43)
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> LIST
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 150 Connection accepted
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 226 Transfer OK
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> PWD
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 257 "/ES44DC_001" is current directory.
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> CWD _sgvault
(000222) 2/20/2009 9:31:01 AM - fireangelbackup (67.130.39.195)> 250 CWD successful. "/ES44DC_001/_sgvault" is current directory.

And the local snippit:
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.305 : ---> CWD \
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.352 : 250 CWD successful. "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.352 : ---> SYST
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.399 : 215 UNIX emulated by FileZilla
DEBUG [FTPFileFactory] 20 Feb 2009 09:27:45.414 : Selected UNIX parser
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.414 : ---> PWD
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.461 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.461 : ---> PASV
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.524 : 227 Entering Passive Mode (174,133,1,27,10,199)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.524 : Server supplied address=174.133.1.27
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.524 : Server supplied port=2759
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.524 : NewPassiveDataSocket(174.133.1.27,2759)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.571 : ---> LIST
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.617 : 150 Connection accepted
DEBUG [FTPClient] 20 Feb 2009 09:27:45.617 : Reading ASCII listing data
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Jan 30 23:49 CoolZoneGaming
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Feb 20 09:20 ES44DC_001
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 23:00 FireAngel Web Page
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Feb 03 23:13 FireAngel WebDesign
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 22:59 horde
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Jan 28 21:58 JimTheFixer
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Feb 17 07:33 Software
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : -->drwxr-xr-x 1 ftp ftp 0 Jan 22 22:37 Timmins-Construction
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.633 : 226 Transfer OK
DEBUG [FTPClient] 20 Feb 2009 09:27:45.633 : Found 8 listing lines
DEBUG [FTPFileFactory] 20 Feb 2009 09:27:45.633 : Parse() called using culture: Invariant Language (Invariant Country)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.633 : ---> PASV
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.696 : 227 Entering Passive Mode (174,133,1,27,10,200)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.696 : Server supplied address=174.133.1.27
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.696 : Server supplied port=2760
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.696 : NewPassiveDataSocket(174.133.1.27,2760)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.742 : ---> STOR The Railroad Paint Shop EMD Locomotives, Page 2.url.FTU
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.789 : 150 Connection accepted
DEBUG [FTPClient] 20 Feb 2009 09:27:45.789 : Closing source stream
DEBUG [FTPClient] 20 Feb 2009 09:27:45.789 : Transferred 127 bytes to remote host
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.852 : 226 Transfer OK
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.852 : ---> RNFR The Railroad Paint Shop EMD Locomotives, Page 2.url.FTU
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.914 : 350 File exists, ready for destination name.
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.914 : ---> RNTO The Railroad Paint Shop EMD Locomotives, Page 2.url
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.961 : 250 file renamed successfully
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:45.961 : ---> MFMT 20071111132611 The Railroad Paint Shop EMD Locomotives, Page 2.url
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:46.008 : 213 modify=20071111132611; /The Railroad Paint Shop EMD Locomotives, Page 2.url
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.868 : ---> PWD
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.930 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.930 : ---> PASV
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.977 : 227 Entering Passive Mode (174,133,1,27,10,201)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.977 : Server supplied address=174.133.1.27
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.977 : Server supplied port=2761
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:50.977 : NewPassiveDataSocket(174.133.1.27,2761)
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:51.024 : ---> LIST
DEBUG [FTPControlSocket] 20 Feb 2009 09:27:51.086 : 150 Connection accepted
DEBUG [FTPClient] 20 Feb 2009 09:27:51.086 : Reading ASCII listing data
DEBUG [FTPClient] 20 Feb 2009 09:27:51.086 : -->drwxr-xr-x 1 ftp ftp 0 Jan 30 23:49 CoolZoneGaming
DEBUG [FTPClient] 20 Feb 2009 09:27:51.086 : -->drwxr-xr-x 1 ftp ftp 0 Feb 20 09:20 ES44DC_001
DEBUG [FTPClient] 20 Feb 2009 09:27:51.102 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 23:00 FireAngel Web Page
DEBUG [FTPClient] 20 Feb 2009 09:27:51.102 : -->drwxr-xr-x 1 ftp ftp 0 Feb 03 23:13 FireAngel WebDesign
DEBUG [FTPClient] 20 Feb 2009 09:27:51.102 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 22:59 horde
DEBUG [FTPClient] 20 Feb 2009 09:27:51.102 :
0 votes
by (420 points)
I was able to snag some of the logs were it was failing. Note that the target FTP server is FileZilla. I also noticed that the log I posted before from the FTP server was simply browsing the FTP server from IE. So please disregard that. There is a good and bad log in this message. The local log from the previous message is valid.

Here is the failure logs:

(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 230 Logged on
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> TYPE I
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 200 Type set to I
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> CWD \
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 250 CWD successful. "/" is current directory.
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> SYST
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 215 UNIX emulated by FileZilla
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> PWD
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 257 "/" is current directory.
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,19)
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> LIST
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 150 Connection accepted
(000201) 2/20/2009 3:02:50 AM - fireangelbackup (71.179.45.242)> 226 Transfer OK
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> CWD FABackup
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 550 CWD failed. "/FABackup": directory not found.
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> PWD
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 257 "/" is current directory.
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,20)
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> LIST
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 150 Connection accepted
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 226 Transfer OK
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,21)
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,22)
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> REST 0
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 350 Rest supported. Restarting at 0
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:51 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,23)
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> REST 0
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 350 Rest supported. Restarting at 0
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,24)
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> REST 0
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 350 Rest supported. Restarting at 0
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> CWD \
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 250 CWD successful. "/" is current directory.
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> PWD
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 257 "/" is current directory.
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,25)
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> LIST
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 150 Connection accepted
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 226 Transfer OK
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> CWD FABackup
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 550 CWD failed. "/FABackup": directory not found.
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> PWD
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 257 "/" is current directory.
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> PASV
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 227 Entering Passive Mode (174,133,1,27,10,26)
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> LIST
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 150 Connection accepted
(000201) 2/20/2009 3:02:52 AM - fireangelbackup (71.179.45.242)> 226 Transfer OK
(000201) 2/20/2009 3:02:53 AM - fireangelbackup (71.179.45.242)> CWD ES44DC_001
(000201) 2/20/2009 3:02:53 AM - fireangelbackup (71.179.45.242)> 550 CWD failed. "/ES44DC_001": directory not found.


Here are GOOD working logs:

(000202) 2/20/2009 8:28:21 AM - fireangelbackup (67.130.39.195)> 230 Logged on
(000202) 2/20/2009 8:28:21 AM - fireangelbackup (67.130.39.195)> TYPE I
(000202) 2/20/2009 8:28:21 AM - fireangelbackup (67.130.39.195)> 200 Type set to I
(000202) 2/20/2009 8:28:21 AM - fireangelbackup (67.130.39.195)> CWD \
(000202) 2/20/2009 8:28:21 AM - fireangelbackup (67.130.39.195)> 250 CWD successful. "/" is current directory.
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> SYST
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 215 UNIX emulated by FileZilla
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> PWD
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 257 "/" is current directory.
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> PASV
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 227 Entering Passive Mode (174,133,1,27,10,100)
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> LIST
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 150 Connection accepted
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 226 Transfer OK
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> PASV
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 227 Entering Passive Mode (174,133,1,27,10,101)
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> STOR The Railroad Paint Shop EMD Locomotives, Page 2.url.FTU
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 150 Connection accepted
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> 226 Transfer OK
(000202) 2/20/2009 8:28:22 AM - fireangelbackup (67.130.39.195)> RNFR The Railroad Paint Shop EMD Locomotives, Page 2.url.FTU
(000202) 2/20/2009 8:28:22 AM - fireangel
0 votes
by (162k points)
Yes, the working log have "MKD ES44DC_001" before CWD, and the non-working one does not.

The directory doesn't exist in the non-working one.
0 votes
by (420 points)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.532 : ---> CWD \
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.594 : 250 CWD successful. "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.594 : ---> SYST
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.657 : 215 UNIX emulated by FileZilla
DEBUG [FTPFileFactory] 20 Feb 2009 19:33:57.657 : Selected UNIX parser
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.657 : ---> PWD
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.719 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.719 : ---> PASV
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.782 : 227 Entering Passive Mode (174,133,1,27,11,139)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.782 : Server supplied address=174.133.1.27
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.782 : Server supplied port=2955
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.782 : NewPassiveDataSocket(174.133.1.27,2955)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.828 : ---> LIST
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:57.891 : 150 Connection accepted
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : Reading ASCII listing data
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : -->drwxr-xr-x 1 ftp ftp 0 Jan 30 23:49 CoolZoneGaming
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 23:00 FireAngel Web Page
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : -->drwxr-xr-x 1 ftp ftp 0 Feb 03 23:13 FireAngel WebDesign
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : -->drwxr-xr-x 1 ftp ftp 0 Feb 10 22:59 horde
DEBUG [FTPClient] 20 Feb 2009 19:33:57.891 : -->drwxr-xr-x 1 ftp ftp 0 Jan 28 21:58 JimTheFixer
DEBUG [FTPClient] 20 Feb 2009 19:33:57.907 : -->drwxr-xr-x 1 ftp ftp 0 Feb 17 07:33 Software
DEBUG [FTPClient] 20 Feb 2009 19:33:57.907 : -->drwxr-xr-x 1 ftp ftp 0 Jan 22 22:37 Timmins-Construction
DEBUG [FTPClient] 20 Feb 2009 19:33:57.907 : -->drwxr-xr-x 1 ftp ftp 0 Feb 20 09:28 _sgvault
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.063 : 226 Transfer OK
DEBUG [FTPClient] 20 Feb 2009 19:33:58.063 : Found 8 listing lines
DEBUG [FTPFileFactory] 20 Feb 2009 19:33:58.063 : Parse() called using culture: Invariant Language (Invariant Country)
DEBUG [FTPFileFactory] 20 Feb 2009 19:33:58.063 : Confirmed format UNIX
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.063 : ---> MKD FABackup
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.078 : 550 Access is denied.
INFO [FTPControlSocket] 20 Feb 2009 19:33:58.078 : Expected reply codes = [200,250,257] (strict=False)
A first chance exception of type 'EnterpriseDT.Net.Ftp.FTPException' occurred in edtFTPnet.dll
MkDir failed for FABackup with message Access is denied. (code=550)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.078 : ---> CWD FABackup
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.141 : 550 CWD failed. "/FABackup": directory not found.
INFO [FTPControlSocket] 20 Feb 2009 19:33:58.141 : Expected reply codes = [200,250] (strict=False)
A first chance exception of type 'EnterpriseDT.Net.Ftp.FTPException' occurred in edtFTPnet.dll
ChDir failed for FABackup with message CWD failed. "/FABackup": directory not found. (code=550)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.141 : ---> PWD
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.219 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.219 : ---> PASV
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.282 : 227 Entering Passive Mode (174,133,1,27,11,140)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.282 : Server supplied address=174.133.1.27
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.282 : Server supplied port=2956
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.282 : NewPassiveDataSocket(174.133.1.27,2956)
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.328 : ---> LIST
DEBUG [FTPControlSocket] 20 Feb 2009 19:33:58.391 : 150 Connection accepted


Note that this uses the same username and password. The reply code for the MakeDir is always 550 Access Denied...

Any thoughts to try?

Incase I didn't mention, this is in PASV mode.

Thanks
Geoff Hilyard

( and sorry about the useless log earlier... )
0 votes
by (420 points)
I also ran from a new computer at my home. Windows 2003 server. Same result.

I checked the logs for the Firewall. There is alot of "The operation has completed successfully" messages. No failures. There is one message when I kill the FTP connection that says "ISA has closed this connection". Other than that, there is no strange logs or messages anywhere.

All "Operation has completed succesfully" messages are 0kb transfered, except there is one that is 16ms, but no kb. I let 5 files fail this time around before closing things down.

Kids are down for bed, and so am I. I'll check this around 7 am tommorrow.
0 votes
by (162k points)
You need to figure out why the server says access is denied for creating a directory.

Can you create a directory using the same credentials via ftp.exe?
0 votes
by (420 points)
I assume you mean the FTP.exe that comes with Windows.

I made a simple file, and the mkdir command failed again. Error 550.

So now I'm getting desperate.
The work configuration is: Computer(s), ISA Firewall, T3
Home Config 1 is: Computer, Linksys Wireless, ISA Firewall, Verizon DSL Modem, DSL Internet
Home Config 2 is: Computer, ISA Firewall, Verizon DSL Model, DSL Internet

For the Verizon DSL, I have it setup to DMZ so that all incomming traffic goes to the ISA Firewall.

Sometime this weekend I'm going to try another Verizon customer down the street that has NO firewall, but the exact same DSL Model ( Westall 6100, if that makes a difference ). I'm also going to try a Comcast cable customer.

I don't know if its possible, but could the DSL Modem block the FTP mkdir commands. Long story short, I see no mkdir commands from any of the machines that fail on the FTP Server logs, but they do exist from the ones that do work. I'll see if I can bypass the ISA later today as well. Depends on the kids :)

Thanks for you help
0 votes
by (162k points)
This sounds like a similar problem:

http://www.experts-exchange.com/Network ... 60728.html

Take a look at the accept solution (you'll need to scroll down).
0 votes
by (420 points)
I've been hung up with my day job, so I just now got around to it.

The problem at Experts exchange is similar, but I do not have read only checked. I did have an FTP rule for inbound connections that was disabled. I tried enabling that, and still no go.

I've added a rule for outbound FTP, make sure that FTP was NOT read only, and tried again. Still failing with 550.

I've even tried the ISA box itself. Still no go.

It also will not let me delete. Same error message.

And. After an hour of messing. TUrns out in ISA 2000, that I had to UNCHECK, under active directory of the system policy, "Enforce strict RFC compliance". It seams to me that this SHOULD be checked, but if it works, I guess it works...

Thanks for all your help
--Geoff

Categories

...