Hi All,
I am load testing Apache FTP with 10 concurrent users. After some time, I
see all threads in my load test client are stuck and see this on the server
side:
INFO 2011-11-03 12:18:43,056 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - RECEIVED: LIST
WARN 2011-11-03 12:23:43,053 pool-3-thread-6 D- U- S-
org.apache.ftpserver.impl.IODataConnectionFactory -
FtpDataConnection.getDataSocket()
java.net.SocketTimeoutException: Accept timed out
at java.net.PlainSocketImpl.socketAccept(Native Method)
at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
at java.net.ServerSocket.implAccept(ServerSocket.java:453)
at java.net.ServerSocket.accept(ServerSocket.java:421)
at
org.apache.ftpserver.impl.IODataConnectionFactory.createDataSocket(IODataCon
nectionFactory.java:356)
at
org.apache.ftpserver.impl.IODataConnectionFactory.openConnection(IODataConne
ctionFactory.java:259)
at org.apache.ftpserver.command.impl.LIST.execute(LIST.java:115)
at
org.apache.ftpserver.impl.DefaultFtpHandler.messageReceived(DefaultFtpHandle
r.java:211)
at
org.apache.ftpserver.listener.nio.FtpHandlerAdapter.messageReceived(FtpHandl
erAdapter.java:62)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageRece
ived(DefaultIoFilterChain.java:716)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceive
d(DefaultIoFilterChain.java:434)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoF
ilterChain.java:46)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageRec
eived(DefaultIoFilterChain.java:796)
at
org.apache.ftpserver.listener.nio.FtpLoggingFilter.messageReceived(FtpLoggin
gFilter.java:85)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceive
d(DefaultIoFilterChain.java:434)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoF
ilterChain.java:46)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageRec
eived(DefaultIoFilterChain.java:796)
at
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:75)
at
org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.
java:136)
at
org.apache.mina.filter.util.CommonEventFilter.messageReceived(CommonEventFil
ter.java:70)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceive
d(DefaultIoFilterChain.java:434)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoF
ilterChain.java:46)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageRec
eived(DefaultIoFilterChain.java:796)
at
org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.f
lush(ProtocolCodecFilter.java:427)
at
org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCod
ecFilter.java:245)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceive
d(DefaultIoFilterChain.java:434)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoF
ilterChain.java:46)
at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageRec
eived(DefaultIoFilterChain.java:796)
at
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:75)
at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
at
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTask(Ord
eredThreadPoolExecutor.java:780)
at
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTasks(Or
deredThreadPoolExecutor.java:772)
at
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.run(Ordered
ThreadPoolExecutor.java:714)
at java.lang.Thread.run(Thread.java:619)
INFO 2011-11-03 12:23:43,054 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - SENT: 227 Entering
Passive Mode (192,168,2,64,7,210)^M
INFO 2011-11-03 12:23:43,054 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - SENT: 150 File status
okay; about to open data connection.^M
INFO 2011-11-03 12:23:43,054 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - RECEIVED: CWD /Shared
INFO 2011-11-03 12:23:43,065 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - RECEIVED: CWD /Shared
INFO 2011-11-03 12:23:43,073 pool-3-thread-6 D- U- S-
org.apache.ftpserver.listener.nio.FtpLoggingFilter - SENT: 425 Can't open
data connection.^M
