I get the following exception error message with EnterpriseDT .NET when attempting to upload a file to Windows System 7 FTP server
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.157 : ---> STOR _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.251 : 125 Data connection already open; Transfer starting.
DEBUG [FTPActiveDataSocket] 17 Jan 2014 07:48:18.251 : AcceptConnection() succeeded
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : Caught exception Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
NOTE 1: This doesn't exception does not always occur; sometimes the file will be uploaded correctly without exception error above. Full log of when it worked correctly and when it did not work are included below. Usually it fails - more than 9 out of 10 times.
NOTE 2: FileZilla client and WinSCP both work perfectly every time with same file uploading to same directory!
NOTE 3: I ripped out all the EnterpriseDT .NET stuff from my program and put replaced it with built in FtpWebRequest client - Works Perfect every time uploading to same directory!
To be completely honest I'm not real happy with EnterpriseDT right now - I just spent 4 days trying to fix a EnterpriseDT .NET problem; desperately trying to determine what I did wrong.
So below is your detailed log file where you can see where EnterpriseDT .NET worked the day before and then where it did not work the next day:
16 Jan 2014 File Upload succeeds...
DEBUG [FTPConnection] 16 Jan 2014 17:54:28.943 : Set LocalDirectory='C:\DynamicJobs\SV_NYSE'
DEBUG [FTPClient] 16 Jan 2014 17:54:28.943 : Connecting to 172.16.7.137:21
DEBUG [HostNameResolver] 16 Jan 2014 17:54:28.990 : Resolving 172.16.7.137
DEBUG [HostNameResolver] 16 Jan 2014 17:54:28.990 : 172.16.7.137 resolved to 172.16.7.137
INFO [BaseSocket] 16 Jan 2014 17:54:28.990 : Connecting to 172.16.7.137:21 with timeout 60000 ms
DEBUG [BaseSocket] 16 Jan 2014 17:54:29.084 : Successfully connected to 172.16.7.137:21
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.100 : Setting socket timeout=60000
INFO [FTPControlSocket] 16 Jan 2014 17:54:29.115 : Command encoding=System.Text.SBCSCodePageEncoding
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.115 : StrictReturnCodes=False
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.131 : 220 Microsoft FTP Service
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.147 : Connected to 172.16.7.137 (instance=0)
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.193 : ---> USER SV-North
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.240 : 331 Password required for SV-North.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.240 : ---> PASS ********
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.287 : 230 User logged in.
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.287 : Successfully logged in
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.287 : ---> FEAT
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : 211-Extended features supported:
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : LANG EN*
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : UTF8
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : PBSZ
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : PROT C;P;
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : CCC
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : HOST
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : SIZE
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : MDTM
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : REST STREAM
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : 211 END
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.334 : ---> TYPE I
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.381 : 200 Type set to I.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.381 : ---> PWD
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.428 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.428 : ---> TYPE I
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.475 : 200 Type set to I.
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.475 : ChangeWorkingDirectory('/playlist/N-G7')
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.475 : ---> CWD /playlist/N-G7
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.522 : 250 CWD command successful.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.522 : ---> PWD
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.584 : 257 "/playlist/N-G7" is current directory.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.584 : ---> FEAT
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : 211-Extended features supported:
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : LANG EN*
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : UTF8
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : PBSZ
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : PROT C;P;
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : CCC
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : HOST
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : SIZE
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : MDTM
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : REST STREAM
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : 211 END
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.631 : UploadFile(C:\DynamicJobs\SV_NYSE\_SV-NYSE-dyn.qti,_SV-NYSE-dyn.qti,False)
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.631 : ---> SIZE _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.694 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.694 : Expected reply codes = [213] (strict=False)
WARN [FTPConnection] 16 Jan 2014 17:54:29.694 : Could not get size of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.694 : GetLastWriteTime(_SV-NYSE-dyn.qti)
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.694 : ---> MDTM _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.740 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.740 : Expected reply codes = [213] (strict=False)
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.740 : Could not retrieve modified-time of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 16 Jan 2014 17:54:29.772 : Cancel resume
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.772 : ---> REST 0
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.819 : 350 Restarting at 0.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.850 : NewActiveDataSocket(0)
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.897 : ---> PORT 172,16,50,15,16,229
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.944 : 200 PORT command successful.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.959 : Next active port will be: 19041
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:29.959 : ---> STOR _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:30.006 : 125 Data connection already open; Transfer starting.
DEBUG [FTPActiveDataSocket] 16 Jan 2014 17:54:30.022 : AcceptConnection() succeeded
DEBUG [FTPClient] 16 Jan 2014 17:54:34.210 : Closing source stream
DEBUG [FTPClient] 16 Jan 2014 17:54:34.257 : Transferred 559917 bytes to remote host
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:35.288 : 226 Transfer complete.
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:35.304 : ---> SIZE _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:35.335 : 213 559917
DEBUG [FTPConnection] 16 Jan 2014 17:54:35.335 : GetLastWriteTime(_SV-NYSE-dyn.qti)
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:35.335 : ---> MDTM _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 16 Jan 2014 17:54:35.382 : 213 20140117015427
**** ---> Next Morning file upload fails...
DEBUG [FTPConnection] 17 Jan 2014 07:48:08.235 : Set LocalDirectory='C:\DynamicJobs\SV_NYSE'
DEBUG [FTPClient] 17 Jan 2014 07:48:08.251 : Connecting to 172.16.7.137:21
DEBUG [HostNameResolver] 17 Jan 2014 07:48:08.266 : Resolving 172.16.7.137
DEBUG [HostNameResolver] 17 Jan 2014 07:48:08.266 : 172.16.7.137 resolved to 172.16.7.137
INFO [BaseSocket] 17 Jan 2014 07:48:08.266 : Connecting to 172.16.7.137:21 with timeout 60000 ms
DEBUG [BaseSocket] 17 Jan 2014 07:48:17.345 : Successfully connected to 172.16.7.137:21
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.345 : Setting socket timeout=60000
INFO [FTPControlSocket] 17 Jan 2014 07:48:17.345 : Command encoding=System.Text.SBCSCodePageEncoding
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.360 : StrictReturnCodes=False
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.391 : 220 Microsoft FTP Service
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.391 : Connected to 172.16.7.137 (instance=1)
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.438 : ---> USER SV-North
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.485 : 331 Password required for SV-North.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.485 : ---> PASS ********
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.532 : 230 User logged in.
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.532 : Successfully logged in
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.532 : ---> FEAT
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : 211-Extended features supported:
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : LANG EN*
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : UTF8
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : PBSZ
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : PROT C;P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : CCC
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : HOST
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : SIZE
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : MDTM
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : REST STREAM
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : 211 END
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.579 : ---> TYPE I
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.626 : 200 Type set to I.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.626 : ---> PWD
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.673 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.673 : ---> TYPE I
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.704 : 200 Type set to I.
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.704 : ChangeWorkingDirectory('/playlist/N-G7')
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.704 : ---> CWD /playlist/N-G7
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.751 : 250 CWD command successful.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.751 : ---> PWD
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.798 : 257 "/playlist/N-G7" is current directory.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.798 : ---> FEAT
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : 211-Extended features supported:
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : LANG EN*
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : UTF8
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : PBSZ
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : PROT C;P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : CCC
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : HOST
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : SIZE
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : MDTM
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : REST STREAM
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : 211 END
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.845 : UploadFile(C:\DynamicJobs\SV_NYSE\_SV-NYSE-dyn.qti,_SV-NYSE-dyn.qti,False)
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.845 : ---> SIZE _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.891 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.891 : Expected reply codes = [213] (strict=False)
WARN [FTPConnection] 17 Jan 2014 07:48:17.938 : Could not get size of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.938 : GetLastWriteTime(_SV-NYSE-dyn.qti)
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.938 : ---> MDTM _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.985 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:17.985 : Expected reply codes = [213] (strict=False)
DEBUG [FTPConnection] 17 Jan 2014 07:48:17.985 : Could not retrieve modified-time of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 17 Jan 2014 07:48:18.001 : Cancel resume
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.001 : ---> REST 0
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.048 : 350 Restarting at 0.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.063 : NewActiveDataSocket(0)
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.110 : ---> PORT 172,16,50,15,6,177
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.157 : 200 PORT command successful.
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.157 : Next active port will be: 19913
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.157 : ---> STOR _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:48:18.251 : 125 Data connection already open; Transfer starting.
DEBUG [FTPActiveDataSocket] 17 Jan 2014 07:48:18.251 : AcceptConnection() succeeded
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : Caught exception Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
DEBUG [FTPClient] 17 Jan 2014 07:49:20.595 : Closing source stream
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : Caught exception
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : System.IO.IOException: Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : at System.Net.Sockets.NetworkStream.Write(Byte[] buffer, Int32 offset, Int32 size)
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : at System.IO.BufferedStream.Write(Byte[] array, Int32 offset, Int32 count)
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : at EnterpriseDT.Net.Ftp.FTPClient.PutBinary(Stream srcStream, String remoteFile, Boolean append, Boolean alwaysCloseStreams)
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : CAUSED BY - System.Net.Sockets.SocketException: Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : at System.Net.Sockets.Socket.Send(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
ERROR [FTPClient] 17 Jan 2014 07:49:20.595 : at System.Net.Sockets.NetworkStream.Write(Byte[] buffer, Int32 offset, Int32 size)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : SystemException in Put(string,string,bool)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : System.IO.IOException: Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : at EnterpriseDT.Net.Ftp.FTPClient.PutBinary(Stream srcStream, String remoteFile, Boolean append, Boolean alwaysCloseStreams)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : at EnterpriseDT.Net.Ftp.FTPClient.PutBinary(String localPath, String remoteFile, Boolean append)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : at EnterpriseDT.Net.Ftp.FTPClient.Put(String localPath, String remoteFile, Boolean append)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : CAUSED BY - System.Net.Sockets.SocketException: Unable to write data to the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : at System.Net.Sockets.Socket.Send(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
ERROR [FTPClient] 17 Jan 2014 07:49:22.688 : at System.Net.Sockets.NetworkStream.Write(Byte[] buffer, Int32 offset, Int32 size)
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:22.766 : Setting socket timeout=500
ERROR [FTPControlSocket] 17 Jan 2014 07:49:23.813 : Read failed ('' read so far)
WARN [FTPClient] 17 Jan 2014 07:49:24.032 : ReadReply failed
WARN [FTPClient] 17 Jan 2014 07:49:24.032 : EnterpriseDT.Net.Ftp.ControlChannelIOException: Unable to read data from the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
WARN [FTPClient] 17 Jan 2014 07:49:24.032 : at EnterpriseDT.Net.Ftp.FTPControlSocket.ReadLine()
WARN [FTPClient] 17 Jan 2014 07:49:24.032 : at EnterpriseDT.Net.Ftp.FTPControlSocket.ReadReply()
WARN [FTPClient] 17 Jan 2014 07:49:24.032 : at EnterpriseDT.Net.Ftp.FTPClient.ValidateTransfer()
ERROR [FTPClient] 17 Jan 2014 07:49:24.063 : Exception in ValidateTransferOnError())
ERROR [FTPClient] 17 Jan 2014 07:49:24.063 : EnterpriseDT.Net.Ftp.ControlChannelIOException: Unable to read data from the transport connection: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.
ERROR [FTPClient] 17 Jan 2014 07:49:24.063 : at EnterpriseDT.Net.Ftp.FTPClient.ValidateTransfer()
ERROR [FTPClient] 17 Jan 2014 07:49:24.063 : at EnterpriseDT.Net.Ftp.FTPClient.ValidateTransferOnError()
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:24.063 : Setting socket timeout=60000
WARN [FTPConnection] 17 Jan 2014 07:49:24.141 : Could not get size of file _SV-NYSE-dyn.qti - -1 The FTP client has not yet connected to the server. The requested action cannot be performed until after a connection has been established.
DEBUG [FTPConnection] 17 Jan 2014 07:49:24.141 : GetLastWriteTime(_SV-NYSE-dyn.qti)
DEBUG [FTPConnection] 17 Jan 2014 07:49:24.141 : Could not retrieve modified-time of file _SV-NYSE-dyn.qti - -1 The FTP client has not yet connected to the server. The requested action cannot be performed until after a connection has been established.
INFO [FTPConnection] 17 Jan 2014 07:49:35.860 : OS: 5.1.2600.196608, CLR: 4.0.30319.296, DLL: 2.2.3.0
INFO [FTPConnection] 17 Jan 2014 07:49:35.860 : Built: 11-Feb-2013 15:33:49 EST
INFO [FTPConnection] 17 Jan 2014 07:49:35.860 : OS: 5.1.2600.196608, CLR: 4.0.30319.296, DLL: 2.2.3.0
INFO [FTPConnection] 17 Jan 2014 07:49:35.860 : Built: 11-Feb-2013 15:33:49 EST
DEBUG [FTPConnection] 17 Jan 2014 07:49:35.860 : Set LocalDirectory='C:\DynamicJobs\SV_NYSE'
DEBUG [FTPClient] 17 Jan 2014 07:49:35.860 : Connecting to 172.16.7.137:21
DEBUG [HostNameResolver] 17 Jan 2014 07:49:35.860 : Resolving 172.16.7.137
DEBUG [HostNameResolver] 17 Jan 2014 07:49:35.860 : 172.16.7.137 resolved to 172.16.7.137
INFO [BaseSocket] 17 Jan 2014 07:49:35.860 : Connecting to 172.16.7.137:21 with timeout 60000 ms
DEBUG [BaseSocket] 17 Jan 2014 07:49:35.907 : Successfully connected to 172.16.7.137:21
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:35.907 : Setting socket timeout=60000
INFO [FTPControlSocket] 17 Jan 2014 07:49:35.907 : Command encoding=System.Text.SBCSCodePageEncoding
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:35.907 : StrictReturnCodes=False
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:35.954 : 220 Microsoft FTP Service
DEBUG [FTPConnection] 17 Jan 2014 07:49:35.954 : Connected to 172.16.7.137 (instance=2)
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:35.954 : ---> USER SV-North
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.001 : 331 Password required for SV-North.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.001 : ---> PASS ********
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.048 : 230 User logged in.
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.048 : Successfully logged in
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.048 : ---> FEAT
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : 211-Extended features supported:
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : LANG EN*
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : UTF8
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : PBSZ
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : PROT C;P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : CCC
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : HOST
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : SIZE
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : MDTM
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : REST STREAM
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : 211 END
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.095 : ---> TYPE I
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.141 : 200 Type set to I.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.141 : ---> PWD
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.188 : 257 "/" is current directory.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.188 : ---> TYPE I
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.220 : 200 Type set to I.
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.220 : ChangeWorkingDirectory('/playlist/N-G7')
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.220 : ---> CWD /playlist/N-G7
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.266 : 250 CWD command successful.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.266 : ---> PWD
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.313 : 257 "/playlist/N-G7" is current directory.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.313 : ---> FEAT
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : 211-Extended features supported:
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : LANG EN*
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : UTF8
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : AUTH TLS;TLS-C;SSL;TLS-P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : PBSZ
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : PROT C;P;
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : CCC
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : HOST
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : SIZE
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : MDTM
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : REST STREAM
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : 211 END
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.360 : UploadFile(C:\DynamicJobs\SV_NYSE\_SV-NYSE-dyn.qti,_SV-NYSE-dyn.qti,False)
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.360 : ---> SIZE _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.407 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.407 : Expected reply codes = [213] (strict=False)
WARN [FTPConnection] 17 Jan 2014 07:49:36.407 : Could not get size of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.407 : GetLastWriteTime(_SV-NYSE-dyn.qti)
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.407 : ---> MDTM _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.454 : 550 The system cannot find the file specified.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.454 : Expected reply codes = [213] (strict=False)
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.454 : Could not retrieve modified-time of file _SV-NYSE-dyn.qti - 550 The system cannot find the file specified. (code=550)
DEBUG [FTPConnection] 17 Jan 2014 07:49:36.454 : Cancel resume
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.454 : ---> REST 0
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.501 : 350 Restarting at 0.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.501 : NewActiveDataSocket(0)
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.501 : ---> PORT 172,16,50,15,6,180
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.548 : 200 PORT command successful.
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.548 : Next active port will be: 20798
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.548 : ---> STOR _SV-NYSE-dyn.qti
DEBUG [FTPControlSocket] 17 Jan 2014 07:49:36.595 : 125 Data connection already open; Transfer starting.
DEBUG [FTPActiveDataSocket] 17 Jan 2014 07:49:36.595 : AcceptConnection() succeeded
FileZilla Log - FileZilla always worked and so did WinSCP:
Status: Connecting to 172.16.7.137:21...
Status: Connection established, waiting for welcome message...
Response: 220 Microsoft FTP Service
Command: USER SV-North
Response: 331 Password required for SV-North.
Command: PASS ****
Response: 230 User logged in.
Command: SYST
Response: 215 Windows_NT
Command: FEAT
Response: 211-Extended features supported:
Response: LANG EN*
Response: UTF8
Response: AUTH TLS;TLS-C;SSL;TLS-P;
Response: PBSZ
Response: PROT C;P;
Response: CCC
Response: HOST
Response: SIZE
Response: MDTM
Response: REST STREAM
Response: 211 END
Command: OPTS UTF8 ON
Response: 200 OPTS UTF8 command successful - UTF8 encoding now ON.
Status: Connected
Status: Retrieving directory listing...
Command: CWD /scheduled
Response: 250 CWD command successful.
Command: PWD
Response: 257 "/scheduled" is current directory.
Command: TYPE I
Response: 200 Type set to I.
Command: PORT 172,16,50,15,6,185
Response: 200 PORT command successful.
Command: LIST
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: Directory listing successful
Status: Retrieving directory listing...
Command: CWD /
Response: 250 CWD command successful.
Command: PWD
Response: 257 "/" is current directory.
Command: PORT 172,16,50,15,6,186
Response: 200 PORT command successful.
Command: LIST
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: Directory listing successful
Status: Retrieving directory listing...
Command: CWD /playlist
Response: 250 CWD command successful.
Command: PWD
Response: 257 "/playlist" is current directory.
Command: PORT 172,16,50,15,6,187
Response: 200 PORT command successful.
Command: LIST
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: Directory listing successful
Status: Retrieving directory listing...
Command: CWD N-G7
Response: 250 CWD command successful.
Command: PWD
Response: 257 "/playlist/N-G7" is current directory.
Command: PORT 172,16,50,15,6,188
Response: 200 PORT command successful.
Command: LIST
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: Calculating timezone offset of server...
Command: MDTM SV-KWS140102A.qtif
Response: 213 20140103234525
Status: Timezone offsets: Server: -28800 seconds. Local: -28800 seconds. Difference: 0 seconds.
Status: Directory listing successful
Status: Connecting to 172.16.7.137:21...
Status: Connection established, waiting for welcome message...
Response: 220 Microsoft FTP Service
Command: USER SV-North
Response: 331 Password required for SV-North.
Command: PASS ****
Response: 230 User logged in.
Command: OPTS UTF8 ON
Response: 200 OPTS UTF8 command successful - UTF8 encoding now ON.
Status: Connected
Status: Starting upload of C:\DynamicJobs\SV_NYSE\_SV-NYSE-dyn.qti
Command: CWD /playlist/N-G7
Response: 250 CWD command successful.
Command: PWD
Response: 257 "/playlist/N-G7" is current directory.
Command: TYPE I
Response: 200 Type set to I.
Command: PORT 172,16,50,15,6,190
Response: 200 PORT command successful.
Command: STOR _SV-NYSE-dyn.qti
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: File transfer successful, transferred 559,913 bytes in 9 seconds
Status: Retrieving directory listing...
Command: PORT 172,16,50,15,6,191
Response: 200 PORT command successful.
Command: LIST
Response: 125 Data connection already open; Transfer starting.
Response: 226 Transfer complete.
Status: Directory listing successful
Status: Sending keep-alive command
Command: PWD
Response: 257 "/playlist/N-G7" is current directory.
Status: Disconnected from server
Status: Sending keep-alive command
Command: TYPE I
Response: 200 Type set to I.
I probably won't go back an put EnterpriseDT in because I have already ripped it all out and put in FtpWebRequest client code. I do like the way EnterpriseDT works more so than FtpWebRequest; so I would be interested in hearing what you think the problem is and if you get come up with a fix.
Thanks
N Davis