FtpServer
  1. FtpServer
  2. FTPSERVER-319

Uploads from FireFTP failing with "java.io.EOFException: Unexpected end of ZLIB input stream"

    Details

    • Type: Bug Bug
    • Status: Open
    • Priority: Minor Minor
    • Resolution: Unresolved
    • Affects Version/s: 1.0.2
    • Fix Version/s: None
    • Component/s: Core, Server
    • Labels:
      None
    • Environment:

      Description

      Uploads from FireFTP are failing frequently for me with "java.io.EOFException: Unexpected end of ZLIB input stream".

      FireFTP then stalls for about 30 seconds before disconnecting, reconnecting, and retrying the upload (this time via 'APPE' rather than 'STOR'), which then works.

      Transmit and Interarchy clients for OS X seem to work fine, but they do not appear to send 'MODE Z'.

      1. FTPServerLog.txt
        9 kB
        Roger Marshall

        Activity

        Roger Marshall created issue -
        Roger Marshall made changes -
        Field Original Value New Value
        Description Uploads from FireFTP are failing frequently for me with "java.io.EOFException: Unexpected end of ZLIB input stream".

        FireFTP then stalls for about 30 seconds before disconnecting, reconnecting, and retrying the upload (this time via 'APPE' rather than 'STOR'), which then works.

        Transmit and Interarchy clients for OS X seem to work fine, but they do not appear to send 'MODE Z'.

        Server Log:

        [ INFO] 2009-07-28 18:03:52,251 [] [] Refreshing org.springframework.context.support.FileSystemXmlApplicationContext@724a9d: display name [org.springframework.context.support.FileSystemXmlApplicationContext@724a9d]; startup date [Tue Jul 28 18:03:52 BST 2009]; root of context hierarchy
        [ INFO] 2009-07-28 18:03:52,324 [] [] Loading XML bean definitions from file [/Users/roger/Projects/apache-ftpserver-1.0.2/res/conf/ftpd-typical.xml]
        [ INFO] 2009-07-28 18:03:52,699 [] [] Bean factory for application context [org.springframework.context.support.FileSystemXmlApplicationContext@724a9d]: org.springframework.beans.factory.support.DefaultListableBeanFactory@b0d33c
        [ INFO] 2009-07-28 18:03:52,719 [] [] Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@b0d33c: defining beans [org.apache.ftpserver.listener.ListenerFactory#0,org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0,org.apache.ftpserver.FtpServerFactory#0,myServer]; root of factory hierarchy
        [ INFO] 2009-07-28 18:03:52,996 [] [] FTP server started
        [ INFO] 2009-07-28 18:04:03,449 [] [192.168.2.120] CREATED
        [ INFO] 2009-07-28 18:04:03,458 [] [192.168.2.120] OPENED
        [ INFO] 2009-07-28 18:04:03,479 [] [192.168.2.120] SENT: 220 Service ready for new user.


        [ INFO] 2009-07-28 18:04:03,484 [] [192.168.2.120] RECEIVED: USER admin
        [ INFO] 2009-07-28 18:04:03,491 [admin] [192.168.2.120] SENT: 331 User name okay, need password for admin.


        [ INFO] 2009-07-28 18:04:03,581 [admin] [192.168.2.120] RECEIVED: PASS *****
        [ INFO] 2009-07-28 18:04:03,602 [admin] [192.168.2.120] Login success - admin
        [ INFO] 2009-07-28 18:04:03,603 [admin] [192.168.2.120] SENT: 230 User logged in, proceed.


        [ INFO] 2009-07-28 18:04:03,603 [admin] [192.168.2.120] RECEIVED: FEAT
        [ INFO] 2009-07-28 18:04:03,605 [admin] [192.168.2.120] SENT: 211-Extensions supported

        SIZE

        MDTM

        REST STREAM

        LANG en;zh-tw;ja;is

        MLST Size;Modify;Type;Perm

        AUTH SSL

        AUTH TLS

        MODE Z

        UTF8

        TVFS

        MD5

        MMD5

        MFMT

        211 End


        [ INFO] 2009-07-28 18:04:03,606 [admin] [192.168.2.120] RECEIVED: PWD
        [ INFO] 2009-07-28 18:04:03,607 [admin] [192.168.2.120] SENT: 257 "/" is current directory.


        [ INFO] 2009-07-28 18:04:08,593 [admin] [192.168.2.120] RECEIVED: TYPE I
        [ INFO] 2009-07-28 18:04:08,596 [admin] [192.168.2.120] SENT: 200 Command TYPE okay.


        [ INFO] 2009-07-28 18:04:08,674 [admin] [192.168.2.120] RECEIVED: MODE Z
        [ INFO] 2009-07-28 18:04:08,680 [admin] [192.168.2.120] SENT: 200 Command MODE okay.


        [ INFO] 2009-07-28 18:04:08,680 [admin] [192.168.2.120] RECEIVED: PASV
        [ INFO] 2009-07-28 18:04:08,684 [admin] [192.168.2.120] SENT: 227 Entering Passive Mode (192,168,2,111,242,122)


        [ INFO] 2009-07-28 18:04:08,687 [admin] [192.168.2.120] RECEIVED: STOR some_file.flv
        [ INFO] 2009-07-28 18:04:10,593 [admin] [192.168.2.120] File uploaded /some_file.flv
        [ INFO] 2009-07-28 18:04:10,594 [admin] [192.168.2.120] SENT: 150 File status okay; about to open data connection.


        [ INFO] 2009-07-28 18:04:10,594 [admin] [192.168.2.120] SENT: 226 Transfer complete.

        .
        .
        .

        [ INFO] 2009-07-28 18:05:14,886 [admin] [192.168.2.120] RECEIVED: TYPE I
        [ INFO] 2009-07-28 18:05:14,887 [admin] [192.168.2.120] SENT: 200 Command TYPE okay.


        [ INFO] 2009-07-28 18:05:14,888 [admin] [192.168.2.120] RECEIVED: PASV
        [ INFO] 2009-07-28 18:05:14,889 [admin] [192.168.2.120] SENT: 227 Entering Passive Mode (192,168,2,111,242,132)


        [ INFO] 2009-07-28 18:05:14,892 [admin] [192.168.2.120] RECEIVED: STOR WM Components 2.2.2.3.dmg
        [ WARN] 2009-07-28 18:06:14,893 [admin] [192.168.2.120] Exception during data transfer, closing data connection socket
        java.io.EOFException: Unexpected end of ZLIB input stream
        at java.util.zip.InflaterInputStream.fill(InflaterInputStream.java:216)
        at java.util.zip.InflaterInputStream.read(InflaterInputStream.java:134)
        at java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
        at java.io.BufferedInputStream.read1(BufferedInputStream.java:256)
        at java.io.BufferedInputStream.read(BufferedInputStream.java:313)
        at java.io.FilterInputStream.read(FilterInputStream.java:90)
        at org.apache.ftpserver.impl.IODataConnection.transfer(IODataConnection.java:243)
        at org.apache.ftpserver.impl.IODataConnection.transferFromClient(IODataConnection.java:136)
        at org.apache.ftpserver.command.impl.STOR.execute(STOR.java:146)
        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:613)
        [ INFO] 2009-07-28 18:06:14,897 [admin] [192.168.2.120] SENT: 150 File status okay; about to open data connection.


        [ INFO] 2009-07-28 18:06:14,897 [admin] [192.168.2.120] RECEIVED: QUIT
        [ INFO] 2009-07-28 18:06:14,898 [admin] [192.168.2.120] CLOSED
        [ INFO] 2009-07-28 18:06:24,896 [] [192.168.2.120] CREATED
        [ INFO] 2009-07-28 18:06:24,896 [admin] [192.168.2.120] OPENED
        [ INFO] 2009-07-28 18:06:24,897 [admin] [192.168.2.120] SENT: 220 Service ready for new user.


        [ INFO] 2009-07-28 18:06:24,901 [] [192.168.2.120] RECEIVED: USER admin
        [ INFO] 2009-07-28 18:06:24,902 [admin] [192.168.2.120] SENT: 331 User name okay, need password for admin.


        [ INFO] 2009-07-28 18:06:24,935 [admin] [192.168.2.120] RECEIVED: PASS *****
        [ INFO] 2009-07-28 18:06:24,936 [admin] [192.168.2.120] Login success - admin
        [ INFO] 2009-07-28 18:06:24,944 [admin] [192.168.2.120] SENT: 230 User logged in, proceed.


        [ INFO] 2009-07-28 18:06:24,967 [admin] [192.168.2.120] RECEIVED: CWD /
        [ INFO] 2009-07-28 18:06:24,968 [admin] [192.168.2.120] SENT: 250 Directory changed to /


        [ INFO] 2009-07-28 18:06:25,067 [admin] [192.168.2.120] RECEIVED: TYPE I
        [ INFO] 2009-07-28 18:06:25,068 [admin] [192.168.2.120] SENT: 200 Command TYPE okay.


        [ INFO] 2009-07-28 18:06:25,072 [admin] [192.168.2.120] RECEIVED: SIZE WM Components 2.2.2.3.dmg
        [ INFO] 2009-07-28 18:06:25,073 [admin] [192.168.2.120] SENT: 213 10104832


        [ INFO] 2009-07-28 18:06:25,087 [admin] [192.168.2.120] RECEIVED: MODE Z
        [ INFO] 2009-07-28 18:06:25,088 [admin] [192.168.2.120] SENT: 200 Command MODE okay.


        [ INFO] 2009-07-28 18:06:25,091 [admin] [192.168.2.120] RECEIVED: PASV
        [ INFO] 2009-07-28 18:06:25,093 [admin] [192.168.2.120] SENT: 227 Entering Passive Mode (192,168,2,111,242,133)


        [ INFO] 2009-07-28 18:06:25,095 [admin] [192.168.2.120] RECEIVED: APPE WM Components 2.2.2.3.dmg
        [ INFO] 2009-07-28 18:06:25,168 [admin] [192.168.2.120] File uploaded /WM Components 2.2.2.3.dmg
        [ INFO] 2009-07-28 18:06:25,168 [admin] [192.168.2.120] SENT: 150 File status okay; about to open data connection.


        [ INFO] 2009-07-28 18:06:25,169 [admin] [192.168.2.120] SENT: 226 Transfer complete.
        Uploads from FireFTP are failing frequently for me with "java.io.EOFException: Unexpected end of ZLIB input stream".

        FireFTP then stalls for about 30 seconds before disconnecting, reconnecting, and retrying the upload (this time via 'APPE' rather than 'STOR'), which then works.

        Transmit and Interarchy clients for OS X seem to work fine, but they do not appear to send 'MODE Z'.
        Roger Marshall made changes -
        Attachment FTPServerLog.txt [ 12414871 ]

          People

          • Assignee:
            Unassigned
            Reporter:
            Roger Marshall
          • Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

            • Created:
              Updated:

              Development