Our Products:   CompleteFTP  edtFTPnet/Free  edtFTPnet/PRO  edtFTPj/Free  edtFTPj/PRO
0 votes
5.1k views
in Java FTP by (240 points)
Hello,

i use the edFTP free Edition for Java, when ich dowload more than 12 File from the FTP Server,
the link will remain for about one minute and then continues,
here is no matter how big the files are, it happens only after twelfe files.

Did you here might have an idea?

Thanks

7 Answers

0 votes
by (51.6k points)
Can you please post a log (DEBUG level) showing this happening?

- Hans (EnterpriseDT)
0 votes
by (240 points)
Hello,

here ist the Log File:

DEBUG [FileTransferClient] 13 Jun 2013 10:16:50.754 : Configured client
DEBUG [FTPClient] 13 Jun 2013 10:16:50.919 : Connecting to ctack.de/0.0.0.0:21
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.116 : 220 Welcome to ctack FTP
DEBUG [FileTransferClient] 13 Jun 2013 10:16:51.126 : Client connected
DEBUG [FileTransferClient] 13 Jun 2013 10:16:51.130 : Logging in
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.133 : ---> USER scan00Test
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.189 : 331 Password required for scan00test
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.191 : ---> PASS ********
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.305 : 230 Logged on
DEBUG [FileTransferClient] 13 Jun 2013 10:16:51.310 : Logged in
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.314 : ---> TYPE A
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.370 : 200 Type set to A
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.375 : ---> SYST
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.473 : 215 UNIX emulated by FileZilla
DEBUG [FTPFileFactory] 13 Jun 2013 10:16:51.517 : Selected Unix parser
DEBUG [MVSFileParser] 13 Jun 2013 10:16:51.553 : Ignoring the set locale.
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.555 : ---> PWD
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.606 : 257 "/" is current directory.
DEBUG [FTPClient] 13 Jun 2013 10:16:51.607 : setupDirDetails(AAAA1) returning: //AAAA1
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.609 : ListenOnAllInterfaces=true
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.611 : ---> PORT 192,168,140,103,172,168
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.665 : 200 Port command successful
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.667 : ---> LIST AAAA1
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.720 : 150 Opening data channel for directory list.
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:51.722 : Calling accept()
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:51.767 : accept() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:51.771 : closeChild() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:51.774 : close() succeeded
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.777 : 226 Transfer OK
DEBUG [FTPFileFactory] 13 Jun 2013 10:16:51.780 : Confirmed format UNIX
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.794 : ---> CDUP
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.875 : 200 CDUP successful. "/" is current directory.
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.878 : ---> CWD AAAA1\aus
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.971 : 250 CWD successful. "/AAAA1/aus" is current directory.
DEBUG [MVSFileParser] 13 Jun 2013 10:16:51.988 : Ignoring the set locale.
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:51.989 : ---> PWD
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.095 : 257 "/AAAA1/aus" is current directory.
DEBUG [FTPClient] 13 Jun 2013 10:16:52.095 : setupDirDetails() returning: /AAAA1/aus
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.097 : ListenOnAllInterfaces=true
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.097 : ---> PORT 192,168,140,103,161,19
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.209 : 200 Port command successful
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.211 : ---> LIST
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.325 : 150 Opening data channel for directory list.
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.327 : Calling accept()
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.399 : accept() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.411 : closeChild() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.414 : close() succeeded
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.418 : 226 Transfer OK
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.519 : ---> PWD
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.605 : 257 "/AAAA1/aus" is current directory.
DEBUG [FTPClient] 13 Jun 2013 10:16:52.608 : Attempt #1
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.611 : ListenOnAllInterfaces=true
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.613 : ---> PORT 192,168,140,103,193,203
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.740 : 200 Port command successful
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.744 : ---> RETR D-00020-50474.pdf
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:52.797 : 150 Opening data channel for file transfer.
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.800 : Calling accept()
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:52.835 : accept() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:53.325 : closeChild() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:53.326 : close() succeeded
DEBUG [FTPClient] 13 Jun 2013 10:16:53.326 : Transferred 89684 bytes from remote host
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.330 : 226 Transfer OK
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.332 : ---> DELE D-00020-50474.pdf
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.421 : 250 File deleted successfully
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.430 : ---> PWD
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.555 : 257 "/AAAA1/aus" is current directory.
DEBUG [FTPClient] 13 Jun 2013 10:16:53.560 : Attempt #1
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.566 : ListenOnAllInterfaces=true
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.570 : ---> PORT 192,168,140,103,167,16
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.642 : 200 Port command successful
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.644 : ---> RETR D-00020-50475.pdf
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:53.780 : 150 Opening data channel for file transfer.
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:53.788 : Calling accept()
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:54.004 : accept() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:54.792 : closeChild() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:54.794 : close() succeeded
DEBUG [FTPClient] 13 Jun 2013 10:16:54.795 : Transferred 89913 bytes from remote host
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:54.796 : 226 Transfer OK
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:54.797 : ---> DELE D-00020-50475.pdf
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.005 : 250 File deleted successfully
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.008 : ---> PWD
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.190 : 257 "/AAAA1/aus" is current directory.
DEBUG [FTPClient] 13 Jun 2013 10:16:55.196 : Attempt #1
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.207 : ListenOnAllInterfaces=true
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.214 : ---> PORT 192,168,140,103,183,197
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.378 : 200 Port command successful
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.382 : ---> RETR D-00020-50476.pdf
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:55.560 : 150 Opening data channel for file transfer.
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:55.563 : Calling accept()
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:55.745 : accept() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:57.432 : closeChild() succeeded
DEBUG [FTPActiveDataSocket] 13 Jun 2013 10:16:57.436 : close() succeeded
DEBUG [FTPClient] 13 Jun 2013 10:16:57.440 : Transferred 89923 bytes from remote host
DEBUG [FTPControlSocket] 13 Jun 2013 10:16:57.446 : 226 Transfer OK
DEBUG [FTPControlSocket] 13 Jun
0 votes
by (51.6k points)
It looks like the server is kicking you off. Are you able to look at the server logs? They might show a reason why the client is being kicked off.

- Hans (EnterpriseDT)
0 votes
by (240 points)
Good day, yes I have access to the server. The server disconnects after 1 minute of inactivity, otherwise the FTP service is running without problems.

(1834137) 13.06.2013 10:17:03 - scan00test (31.17.252.123)> 226 Transfer OK
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> DELE D-00020-50485.pdf
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> 250 File deleted successfully
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> PWD
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> 257 "/AAAA1/aus" is current directory.
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> PORT 31,17,252,123,219,38
(1834137) 13.06.2013 10:17:04 - scan00test (31.17.252.123)> 200 Port command successful
(1834137) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> RETR D-00020-50486.pdf
(1834137) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> 150 Opening data channel for file transfer.
(1834137) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> disconnected.
(1834229) 13.06.2013 10:18:09 - (not logged in) (31.17.252.123)> Connected, sending welcome message...
(1834229) 13.06.2013 10:18:09 - (not logged in) (31.17.252.123)> USER scan00Test
(1834229) 13.06.2013 10:18:09 - (not logged in) (31.17.252.123)> 331 Password required for scan00test
(1834229) 13.06.2013 10:18:09 - (not logged in) (31.17.252.123)> PASS ***********
(1834229) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> 230 Logged on
(1834229) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> TYPE A
(1834229) 13.06.2013 10:18:09 - scan00test (31.17.252.123)> 200 Type set to A
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> CWD /AAAA1/aus
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> 250 CWD successful. "/AAAA1/aus" is current directory.
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> PORT 31,17,252,123,132,176
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> 200 Port command successful
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> RETR D-00020-50486.pdf
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> 150 Opening data channel for file transfer.
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> 226 Transfer OK
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> DELE D-00020-50486.pdf
(1834229) 13.06.2013 10:18:10 - scan00test (31.17.252.123)> 250 File deleted successfully

Sascha
0 votes
by (51.6k points)
OK. I can see that the client is reconnecting, which is good. What is it that you would like to see improved?

- Hans (EnterpriseDT)
0 votes
by (240 points)
That the FTP client reconnects is very good, but why he no longer reacts between and stops data download?

I have the time to disconnect the connection once set to 5 minutes here then reacts the FTP client not the entire time until the server closes the connection.

Sascha
0 votes
by (162k points)
You might be running out of sockets, as in this thread:

http://www.enterprisedt.com/forums/viewtopic.php?t=4306

Categories

...