425 error reading from file 5

Need help with FileZilla Server? Something does not work as expected? In this forum you may find an answer.

Moderator: Project members

Post Reply
Message
Author
cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

425 error reading from file 5

#1 Post by cheidler » 2023-11-20 14:53

Filezilla Server V1.8.0.rc.2 / Server 2019 / Windows Firewall off / Windows Defender off / Own windows exclusive Server / 10GB Internet Connection
Installed FZ on a local Drive B / 5TB free Space / Filezilla is running as SYSTEM / All Users and System Rights are ok
Client 3.66.1 / Passiv transfer / No errors / VDSL 250MBit / 50MBit / Single File Transfer
Transfering a 330GB File / Tested two times / Connection is lost at 195GB and 197GB transferd
Reconnect to the transferd file
425 error reading from file 5
Any help?

User avatar
botg
Site Admin
Posts: 35527
Joined: 2004-02-23 20:49
First name: Tim
Last name: Kosse

Re: 425 error reading from file 5

#2 Post by botg » 2023-11-20 15:06

Could you please provide a complete log showing the error?

Please elaborate, what do you mean by "Reconnect to the transferd file"?

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#3 Post by oibaf » 2023-11-20 15:13

When the transfer stops, what does the client say? Does the server send any reasons for that?

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#4 Post by cheidler » 2023-11-20 16:38

Log is @work
The only error is 425 error reading from file5

Please elaborate, what do you mean by "Reconnect to the transferd file"?
"continue transmission" to a existing file

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#5 Post by oibaf » 2023-11-21 13:41

cheidler wrote:
2023-11-20 16:38
Log is @work
The only error is 425 error reading from file5
There must be something in the log about the interrupted transfer, before you restart it.

Can you please paste the log here?

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#6 Post by cheidler » 2023-11-29 09:49

Here some more infos
Update client and server with the lastest updates
Connection to the server from client will be able with passiv and activ connection
There is no problem with free space or user access rights
Upload is disconnected while upload a file (DB-Dump) with 330GB, filesize von server 194.733.456.886 Byte
Filesize on a local device 333.877.976.401 Byte
Reconnect to Server to upload file, error 425 error writing to file: 5

Log:
227 Entering Passive Mode (212,??,???,??,210,177)
Trace: CFtpRawTransferOpData::ParseResponse() in state 2
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 3
Befehl: REST 194733456886
Trace: CFtpControlSocket::OnReceive()
Antwort: 350 Restarting at 194733456886
Trace: CFtpRawTransferOpData::ParseResponse() in state 3
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 4
Trace: Binding data connection source IP to control connection source IP 192.168.???.??
Befehl: STOR zentraldb.backup
Trace: CFtpControlSocket::OnReceive()
Antwort: 150 About to start data transfer.
Trace: CFtpRawTransferOpData::ParseResponse() in state 4
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 5
Trace: CTransferSocket::OnConnect
Trace: First EAGAIN in CTransferSocket::OnSend()
Trace: CTransferSocket::OnReceive(), m_transferMode=1
Fehler: Could not read from transfer socket: ECONNABORTED - Verbindung abgebrochen
Trace: CTransferSocket::TransferEnd(3)
Trace: CFtpControlSocket::OnReceive()
Antwort: 425 Error writing to file: 5
Trace: CFtpRawTransferOpData::ParseResponse() in state 5
Trace: CFtpControlSocket::ResetOperation(2)
Trace: CControlSocket::ResetOperation(2)
Trace: CFtpRawTransferOpData::Reset(2) in state 5
Trace: CFtpFileTransferOpData::SubcommandResult(2) in state 7
Trace: CFtpControlSocket::ResetOperation(2)
Trace: CControlSocket::ResetOperation(2)
Trace: CFtpFileTransferOpData::Reset(2) in state 7
Fehler: Dateiübertragung fehlgeschlagen nach Übertragung von 524.288 Bytes in 1 Sekunde
Trace: CFileZillaEnginePrivate::ResetOperation(2)
Trace: CFtpControlSocket::TransferEnd()
Trace: Call to TransferEnd at unusual time, ignoring
Trace: CFtpControlSocket::FileTransfer()
Trace: CControlSocket::SendNextCommand()
Trace: CFtpFileTransferOpData::Send() in state 0
Status: Starte Upload von H:\zentraldb.backup
Trace: CFtpChangeDirOpData::Send() in state 0
Trace: CFtpControlSocket::ResetOperation(0)
Trace: CControlSocket::ResetOperation(0)
Trace: CFtpChangeDirOpData::Reset(0) in state 0
Trace: CFtpFileTransferOpData::SubcommandResult(0) in state 1
Trace: CControlSocket::SendNextCommand()
Trace: CFtpListOpData::Send() in state 0
Status: Empfange Verzeichnisinhalt für "/"...
Trace: CFtpChangeDirOpData::Send() in state 0
Trace: CFtpControlSocket::ResetOperation(0)
Trace: CControlSocket::ResetOperation(0)
Trace: CFtpChangeDirOpData::Reset(0) in state 0
Trace: CFtpListOpData::SubcommandResult(0) in state 1
Trace: CControlSocket::SendNextCommand()
Trace: CFtpListOpData::Send() in state 2
Trace: CFtpRawTransferOpData::Send() in state 0
Trace: CFtpRawTransferOpData::Send() in state 2
Befehl: PASV
Trace: CFtpControlSocket::OnReceive()
Antwort: 227 Entering Passive Mode (212,??,???,??,248,107)
Trace: CFtpRawTransferOpData::ParseResponse() in state 2
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 3
Befehl: REST 0
Trace: CFtpControlSocket::OnReceive()
Antwort: 350 Restarting at 0
Trace: CFtpRawTransferOpData::ParseResponse() in state 3
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 4
Trace: Binding data connection source IP to control connection source IP 192.168.???.??
Befehl: MLSD
Trace: CFtpControlSocket::OnReceive()
Antwort: 150 About to start data transfer.
Trace: CFtpRawTransferOpData::ParseResponse() in state 4
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 5
Trace: CTransferSocket::OnConnect
Trace: CFtpControlSocket::OnReceive()
Antwort: 226 Operation successful
Trace: CFtpRawTransferOpData::ParseResponse() in state 5
Trace: CControlSocket::SendNextCommand()
Trace: CFtpRawTransferOpData::Send() in state 8
Trace: CTransferSocket::OnReceive(), m_transferMode=0
Trace: CTransferSocket::OnReceive(), m_transferMode=0
Trace: CTransferSocket::TransferEnd(1)
Trace: CFtpControlSocket::TransferEnd()
Trace: CFtpControlSocket::ResetOperation(0)
Trace: CControlSocket::ResetOperation(0)
Trace: CFtpRawTransferOpData::Reset(0) in state 8
Trace: CFtpListOpData::SubcommandResult(0) in state 3
Trace: CFtpControlSocket::ResetOperation(0)
Trace: CControlSocket::ResetOperation(0)
Trace: CFtpListOpData::Reset(0) in state 3
Trace: CFtpFileTransferOpData::SubcommandResult(0) in state 2
Trace: CControlSocket::CheckOverwriteFile()
Trace: CFtpControlSocket::SetAsyncRequestReply
Status: Überspringe Upload von H:\zentraldb.backup
Trace: CFtpControlSocket::ResetOperation(0)
Trace: CControlSocket::ResetOperation(0)
Trace: CFtpFileTransferOpData::Reset(0) in state 5
Status: Dateiübertragung erfolgreich, 83 Bytes in 2 Sekunden übertragen
Trace: CFileZillaEnginePrivate::ResetOperation(0)
Trace: CFileZillaEnginePrivate::ResetOperation(0)
Status: Verbindung zum Server getrennt
Trace: CRealControlSocket::DoClose(66)
Trace: CControlSocket::DoClose(66)
Trace: CFtpControlSocket::ResetOperation(66)
Trace: CControlSocket::ResetOperation(66)
Trace: CFileZillaEnginePrivate::ResetOperation(66)
Trace: CRealControlSocket::DoClose(66)
Trace: CControlSocket::DoClose(66)
Trace: CFtpControlSocket::ResetOperation(66)
Trace: CControlSocket::ResetOperation(66)
Trace: CFileZillaEnginePrivate::ResetOperation(66)
Trace: CControlSocket::DoClose(66)
Trace: CControlSocket::ResetOperation(66)
Trace: CFileZillaEnginePrivate::ResetOperation(66)
Trace: CFileZillaEnginePrivate::ResetOperation(0)

User avatar
botg
Site Admin
Posts: 35527
Joined: 2004-02-23 20:49
First name: Tim
Last name: Kosse

Re: 425 error reading from file 5

#7 Post by botg » 2023-11-29 10:56

Which filesystem are you using on the server to store the file on?

Could the filesystem have an error? Try checking it for errors: Right-click drive letter in Explorer, click Properties, and on the Tools tab, click the Check button.

Maybe the disk itself has a bad sector or something? Try running a long S.M.A.R.T. self-test. No idea how to do that on Windows though, I just boot into Linux for it and use the smartctl command.

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#8 Post by cheidler » 2023-11-29 12:09

No sorry, the server is running on VMWARE 7 HA on a HOST VMFS 6.82 HA Storage. An error on this filesystem would be known. On this filesystem are running more then 100 virtuell HOST's without any problem.
It makes no difference, running the filezilla server on a local based NTFS Partition with a local disk or on a ISCSI Based Partition with NTFS. Error is the same.
Partionblocks are formated with windows standard (512B Sector and 4KB Cluster)

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#9 Post by oibaf » 2023-11-29 13:52

It'd be necessary to look at the log of the server. Can you please set its level to "5 - Debug" and attach the log here after replicated the issue? Thanks.

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#10 Post by cheidler » 2023-11-30 12:00

Here the logfile...
Attachments
filezilla_180_rc2_30112023.log
(139.11 KiB) Downloaded 948 times

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#11 Post by oibaf » 2023-11-30 15:29

I could reproduce the very same error by limiting the space on the filesystem.

Is it possible the space on the destination filesystem has been exhausted, or that there's a quota active?

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#12 Post by cheidler » 2023-12-06 12:23

Free space on the fileystem will be over 1TB

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#13 Post by oibaf » 2023-12-06 14:10

In the log, the part where the file transfer was interrupted for the first time is missing, there are only attempts at restarting the transfer.

The transfer has been interrupted at byte 194733456886, that is at about 18GiB.

It'd be important to see the log of the moment the transfer has failed the first time.
It's important for you to know that "error 5" is an I/O error, which, according to the log, is happening when the file is being written to the filesystem.

That's what the diagnostic says. If you can provide us with the log of the moment the transfer fails the first time, we could try to make a better assessment.

cheidler
504 Command not implemented
Posts: 7
Joined: 2023-11-20 13:47
First name: Christian
Last name: Heidler

Re: 425 error reading from file 5

#14 Post by cheidler » 2023-12-11 08:19

ok, a log at this time isn't available any more. The only thing is, that the filesystem at this time was very busy and the connection was broken.
But this was not my question. Problem is, if i reconnect to the same file, there is no way to continue. I must restart the file from the beginning.

User avatar
oibaf
Contributor
Posts: 401
Joined: 2021-07-16 21:02
First name: Fabio
Last name: Alemagna

Re: 425 error reading from file 5

#15 Post by oibaf » 2023-12-11 08:36

Problem is, if i reconnect to the same file, there is no way to continue. I must restart the file from the beginning.
Most likely for the same reasons that made the "filesystem very busy" to begin with (whatever you mean with that).

As said, there's been a I/O error, hence why I asked for more logs. We know how the program works internally, hence we have precise reasons to ask for what we ask for.

Post Reply