Connection Timed Out Prior to Idle Timeout
------------------------------------------

                 Key: FTPSERVER-333
                 URL: https://issues.apache.org/jira/browse/FTPSERVER-333
             Project: FtpServer
          Issue Type: Bug
    Affects Versions: 1.0.2
            Reporter: Nick Padgett


The connection has timed out (189s) prior to the idle timeout (at 300s) 10 
times in the last 16 days.  Am I misinterpreting which idle timeout value is 
being used, or is something else going on?  Of the 10 times I've seen this 
issue, the connection timed out at exactly 189s +/-1s (188.968, 188.971, 
188.972, 188.971, 188.97, 188.972, 188.971, 188.963, 189.375, 188.97).  189 is 
less than the 300 value configured.

<code>
896164276 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - OPENED
896164277 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 220 Service ready 
for new user. 
896164338 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - RECEIVED: USER npadgett
896164385 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 331 User name okay, 
need password for npadgett. 
896164408 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 230 User logged in, 
proceed. 
896164410 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - RECEIVED: PWD
896164410 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 257 "/" is current 
directory. 
896164411 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - RECEIVED: TYPE A
896164412 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 200 Command TYPE 
okay. 
896164414 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - RECEIVED: LIST
896353789 [pool-2-thread-260] WARN  
org.apache.ftpserver.impl.IODataConnectionFactory  - 
FtpDataConnection.getDataSocket()
java.net.ConnectException: Connection timed out
        at java.net.PlainSocketImpl.socketConnect(Native Method)
        at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333)
        at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195)
        at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182)
        at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366)
        at java.net.Socket.connect(Socket.java:519)
        at java.net.Socket.connect(Socket.java:469)
        at 
org.apache.ftpserver.impl.IODataConnectionFactory.createDataSocket(IODataConnectionFactory.java:314)
        at 
org.apache.ftpserver.impl.IODataConnectionFactory.openConnection(IODataConnectionFactory.java:259)
        at org.apache.ftpserver.command.impl.LIST.execute(LIST.java:114)
        at 
org.apache.ftpserver.impl.DefaultFtpHandler.messageReceived(DefaultFtpHandler.java:210)
        at 
org.apache.ftpserver.listener.nio.FtpHandlerAdapter.messageReceived(FtpHandlerAdapter.java:61)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:721)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:433)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:801)
        at 
org.apache.ftpserver.listener.nio.FtpLoggingFilter.messageReceived(FtpLoggingFilter.java:85)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:433)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:801)
        at 
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:71)
        at 
org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.java:136)
        at 
org.apache.mina.filter.util.CommonEventFilter.messageReceived(CommonEventFilter.java:70)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:433)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:801)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.flush(ProtocolCodecFilter.java:375)
        at 
org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.java:229)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:433)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47)
        at 
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:801)
        at 
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:71)
        at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
        at 
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTask(OrderedThreadPoolExecutor.java:801)
        at 
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTasks(OrderedThreadPoolExecutor.java:793)
        at 
org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.run(OrderedThreadPoolExecutor.java:735)
        at java.lang.Thread.run(Thread.java:619)
896353790 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - SENT: 150 File status 
okay; about to open data connection. 
896353790 [pool-2-thread-260] INFO  
org.apache.ftpserver.listener.nio.FtpLoggingFilter  - CLOSED
</code>

>From spring.xml:
<code>
        <bean id="dataConnectionConfigurationFactory" 
class="org.apache.ftpserver.DataConnectionConfigurationFactory">
                <property name="activeEnabled" value="true" />
                <property name="activeIpCheck" value="false" />
                <property name="idleTime" value="60" />
                ...
        </bean>
        ...
        <bean id="listenerFactory" 
class="org.apache.ftpserver.listener.ListenerFactory">
                <property name="idleTimeout" value="300" />
                ...
        </bean>
        ...
</code>

-- 
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.

Reply via email to