"425 Error while transfering data: 5" after upgrading to 1.0.1

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

Moderator: Project members

Message
Author
vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

"425 Error while transfering data: 5" after upgrading to 1.0.1

#1 Post by vinix » 2021-10-15 05:03

Hi,

I've upgraded FileZilla Server to 1.0.1 from 0.9.6 today. It took me some time to solve the connection problem because of missing passive mode setting, but I can connect to the server via implicit FTP over TLS, using FileZilla client 3.56.0.

There is another problem: Unable to upload files, log window show something like below:

Code: Select all

Status:	Starting upload of <FILE PATH>
Status:	Server sent passive reply with unroutable address. Using server address instead.
Command:	STOR <FILE NAME>
Response:	150 About to start data transfer.
Response:	425 Error while transfering data: 5
Error:	File transfer failed
After googling about unroutable address, I altered the passive mode setting to set:
Use custom port range: check
From: 49152
To: 65534
Use the following host: <Public IP of server>
Then the line about unroutable address is gone, but I still can't upload files.
The log:

Code: Select all

Status:	Starting upload of <FILE PATH>
Command:	CWD <REMOTE PATH>
Response:	250 CWD command successful
Command:	TYPE A
Response:	200 Type set to A
Command:	PASV
Response:	227 Entering Passive Mode (XX,XX,XX,XX,197,34)
Command:	STOR youtube-autoresizer.js
Response:	150 About to start data transfer.
Response:	425 Error while transfering data: 5
Error:	File transfer failed
Status:	Starting upload of <FILE PATH>
Status:	Retrieving directory listing of "<REMOTE PATH>"...
Command:	TYPE I
Response:	200 Type set to I
Command:	PASV
Response:	227 Entering Passive Mode (XX,XX,XX,XX,239,51)
Command:	MLSD
Response:	150 About to start data transfer.
Response:	226 Operation successful
Command:	TYPE A
Response:	200 Type set to A
Command:	PASV
Response:	227 Entering Passive Mode (XX,XX,XX,XX,211,35)
Command:	STOR youtube-autoresizer.js
Response:	150 About to start data transfer.
Response:	425 Error while transfering data: 5
Error:	File transfer failed
Status:	Starting upload of <FILE PATH>
Status:	Retrieving directory listing of "<REMOTE PATH>"...
Command:	TYPE I
Response:	200 Type set to I
Command:	PASV
Response:	227 Entering Passive Mode (XX,XX,XX,XX,211,11)
Command:	MLSD
Response:	150 About to start data transfer.
Response:	226 Operation successful
Command:	TYPE A
Response:	200 Type set to A
Command:	PASV
Response:	227 Entering Passive Mode (XX,XX,XX,XX,199,195)
Command:	STOR youtube-autoresizer.js
Response:	150 About to start data transfer.
Response:	425 Error while transfering data: 5
Error:	File transfer failed
How to fix this?

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

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#2 Post by oibaf » 2021-10-15 05:23

The error string could be more meaningful, but the error number 5 is EIO, which the server produces only when writing/reading to/from files and cannot gather a more detailed info.

This hints at a problem with your filesystem. Are you able to manually, not through FTP, create and write to the file on the machine you are connecting to?
Could you also please enable logging on the server, setting it to 5 - Debug, and paste here the result?

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#3 Post by vinix » 2021-10-15 06:26

oibaf wrote:
2021-10-15 05:23
The error string could be more meaningful, but the error number 5 is EIO, which the server produces only when writing/reading to/from files and cannot gather a more detailed info.

This hints at a problem with your filesystem. Are you able to manually, not through FTP, create and write to the file on the machine you are connecting to?
Could you also please enable logging on the server, setting it to 5 - Debug, and paste here the result?
I can not create file directly on the server, but I did set full control for SYSTEM. FileZilla Server 0.96.0 functioned normally under the same permission setting.
Anything changed in 1.0.1?

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

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#4 Post by botg » 2021-10-15 07:52

What exactly is entered under mount points for the user you are connecting with? Please don't obfuscate this information.

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#5 Post by vinix » 2021-10-15 07:59

I tried using insecure FTP mode, and the log is below:
Status: Resolving address of <Host Name>
Status: Connecting to <IP>:21...
Status: Connection established, waiting for welcome message...
Status: Plain FTP is insecure. Please switch to FTP over TLS.
Status: Logged in
Status: Retrieving directory listing of "/EdtungWeb"...
Status: Directory listing of "/EdtungWeb" successful
Status: Resolving address of <Host Name>
Status: Connecting to <IP>:21...
Status: Connection established, waiting for welcome message...
Status: Plain FTP is insecure. Please switch to FTP over TLS.
Status: Logged in
Status: Starting upload of D:\Projects\EdtungWeb\EdtungWeb\empty_bk.png
Command: CWD /EdtungWeb
Response: 250 CWD command successful
Command: TYPE I
Response: 200 Type set to I
Command: PASV
Response: 227 Entering Passive Mode (XX,XX,XX,XX,214,227)
Command: STOR empty_bk.png
Response: 550 No such file
Error: Critical file transfer error
Status: Disconnected from server
Last edited by vinix on 2021-10-15 08:18, edited 1 time in total.

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

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#6 Post by botg » 2021-10-15 08:05

Command: STOR empty_bk.png
Response: 550 No such file
Probably the mount points aren't configured correctly. I repeat myself:
botg wrote:
2021-10-15 07:52
What exactly is entered under mount points for the user you are connecting with? Please don't obfuscate this information.

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#7 Post by vinix » 2021-10-15 08:15

It's created automatically when upgrade:
mountpoint.png
mountpoint.png (10.97 KiB) Viewed 10061 times

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

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#8 Post by botg » 2021-10-15 09:51

Does the native directory exist? Is it on an actual device inside the server's computer, or is it a mapped network resource?

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#9 Post by vinix » 2021-10-15 10:37

botg wrote:
2021-10-15 09:51
Does the native directory exist? Is it on an actual device inside the server's computer, or is it a mapped network resource?
The native directory does exist. It's on a physical drive that direct connect to the server's computer. This server is on Azure Cloud.
As I mentioned earlier, I'm upgraded from 0.96.0. It's functional before the upgrade.

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#10 Post by vinix » 2021-10-15 10:50

I uninstalled 1.0.1 and reinstalled 0.96.0. Everything worked again.

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

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#11 Post by oibaf » 2021-10-15 13:23

Is the user you're running the new server under the same as the old one?
Why can't you create the file by hand, as a test, if you're able to install the server?
Could you please attach the server's logs, set to "5 - Debug"?

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#12 Post by vinix » 2021-10-18 03:37

The user to run filezilla-server.exe is SYSTEM(it's the default setting), which has full control of the target directory(ACL see below). And yes, it's the same user to run 0.96.0.
runas.png
runas.png (9.78 KiB) Viewed 9957 times
The installer is run under admin privilege.

The target directory has ACL as below:
acl.png
acl.png (29.48 KiB) Viewed 9957 times
If I logged in as a user with admin privilege using Remote Desktop, I can add files to that directory by copying from local & pasting the file to remote directory, but can not create a txt file by right clicking in File Explorer -> New.

Under the same ACL, I can upload files using 0.96.0, but can not in 1.0.1.

The log is attached below:
2021-10-18T03:16:41.798Z == Settings written to C:\windows\system32\config\systemprofile\AppData\Local\filezilla-server\settings.xml.
2021-10-18T03:17:53.660Z DD [FTP Session 1 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:17:53.660Z DD [FTP Session 1 xx.xx.xx.xx vinix] tls_layer_impl::failure(-110)
2021-10-18T03:17:53.660Z !! [FTP Session 1 xx.xx.xx.xx vinix] GnuTLS error -110 in gnutls_record_recv: The TLS connection was non-properly terminated.
2021-10-18T03:17:53.660Z == [FTP Session 1 xx.xx.xx.xx vinix] Client did not properly shut down TLS connection
2021-10-18T03:17:53.660Z !! [FTP Session 1 xx.xx.xx.xx vinix] Control channel closed with error from source 0. Reason: ECONNABORTED - Connection aborted.
2021-10-18T03:17:53.660Z !! [FTP Server] Session ended with error from source 0. Reason: ECONNABORTED - Connection aborted.
2021-10-18T03:17:53.660Z II [FTP Session 1 xx.xx.xx.xx] Session 0x29f00fe0b10 with ID 1 destroyed.
2021-10-18T03:17:59.492Z II [FTP Session 3 xx.xx.xx.xx] Session 0x29f00fe0b10 with ID 3 created.
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] securer(1) ENTERING state = 0
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] calling tls_layer_->set_certificate_file("F:\Cert\cert.key", "F:\Cert\cert.crt", "****")
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] securer(1) EXITING state = 1
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] ~securer(1) ENTERING state = 1
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] calling tls_layer_->set_alpn("ftp")
2021-10-18T03:17:59.492Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::server_handshake()
2021-10-18T03:17:59.492Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] ~securer(1) EXITING state = 2
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_send()
2021-10-18T03:17:59.492Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:17:59.492Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Received CLIENT HELLO
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Processed CLIENT HELLO
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: About to send SERVER HELLO
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Sent SERVER HELLO
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: About to send ENCRYPTED EXTENSIONS
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Sent ENCRYPTED EXTENSIONS
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: About to send CERTIFICATE
2021-10-18T03:17:59.492Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Sent CERTIFICATE
2021-10-18T03:17:59.507Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: About to send CERTIFICATE VERIFY
2021-10-18T03:17:59.507Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Sent CERTIFICATE VERIFY
2021-10-18T03:17:59.507Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: About to send FINISHED
2021-10-18T03:17:59.507Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Sent FINISHED
2021-10-18T03:17:59.523Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:17:59.523Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:17:59.523Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:17:59.523Z VV [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:17:59.523Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Received FINISHED
2021-10-18T03:17:59.523Z DD [FTP Session 3 xx.xx.xx.xx] TLS handshakep: Processed FINISHED
2021-10-18T03:17:59.523Z II [FTP Session 3 xx.xx.xx.xx] TLS Handshake successful
2021-10-18T03:17:59.523Z II [FTP Session 3 xx.xx.xx.xx] Protocol: TLS1.3, Key exchange: ECDHE-SECP384R1-RSA-PSS-RSAE-SHA384, Cipher: AES-256-GCM, MAC: AEAD
2021-10-18T03:17:59.523Z VV [FTP Session 3 xx.xx.xx.xx] session::on_socket_event(): source = control, flag = 2, error = 0, state = 2
2021-10-18T03:17:59.554Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:17:59.554Z >> [FTP Session 3 xx.xx.xx.xx] USER vinix
2021-10-18T03:17:59.554Z << [FTP Session 3 xx.xx.xx.xx] 331 Please, specify the password.
2021-10-18T03:17:59.570Z DD [FTP Session 3 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:17:59.570Z >> [FTP Session 3 xx.xx.xx.xx] PASS ****
2021-10-18T03:17:59.648Z << [FTP Session 3 xx.xx.xx.xx vinix] 230 Login successful.
2021-10-18T03:17:59.664Z DD [FTP Session 3 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:17:59.664Z >> [FTP Session 3 xx.xx.xx.xx vinix] PBSZ 0
2021-10-18T03:17:59.664Z << [FTP Session 3 xx.xx.xx.xx vinix] 200 PBSZ=0
2021-10-18T03:17:59.679Z DD [FTP Session 3 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:17:59.679Z >> [FTP Session 3 xx.xx.xx.xx vinix] PROT P
2021-10-18T03:17:59.679Z << [FTP Session 3 xx.xx.xx.xx vinix] 200 Protection level set to P
2021-10-18T03:18:02.251Z II [FTP Session 4 xx.xx.xx.xx] Session 0x29f00ff1830 with ID 4 created.
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] securer(1) ENTERING state = 0
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] calling tls_layer_->set_certificate_file("F:\Cert\cert.key", "F:\Cert\cert.crt", "****")
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] securer(1) EXITING state = 1
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] ~securer(1) ENTERING state = 1
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] calling tls_layer_->set_alpn("ftp")
2021-10-18T03:18:02.251Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::server_handshake()
2021-10-18T03:18:02.251Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] ~securer(1) EXITING state = 2
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_send()
2021-10-18T03:18:02.251Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:18:02.251Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Received CLIENT HELLO
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Processed CLIENT HELLO
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: About to send SERVER HELLO
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Sent SERVER HELLO
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: About to send ENCRYPTED EXTENSIONS
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Sent ENCRYPTED EXTENSIONS
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: About to send CERTIFICATE
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Sent CERTIFICATE
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: About to send CERTIFICATE VERIFY
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Sent CERTIFICATE VERIFY
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: About to send FINISHED
2021-10-18T03:18:02.251Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Sent FINISHED
2021-10-18T03:18:02.267Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:18:02.267Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.267Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:18:02.267Z VV [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.267Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Received FINISHED
2021-10-18T03:18:02.267Z DD [FTP Session 4 xx.xx.xx.xx] TLS handshakep: Processed FINISHED
2021-10-18T03:18:02.267Z II [FTP Session 4 xx.xx.xx.xx] TLS Handshake successful
2021-10-18T03:18:02.267Z II [FTP Session 4 xx.xx.xx.xx] Protocol: TLS1.3, Key exchange: ECDHE-SECP384R1-RSA-PSS-RSAE-SHA384, Cipher: AES-256-GCM, MAC: AEAD
2021-10-18T03:18:02.267Z VV [FTP Session 4 xx.xx.xx.xx] session::on_socket_event(): source = control, flag = 2, error = 0, state = 2
2021-10-18T03:18:02.298Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:18:02.298Z >> [FTP Session 4 xx.xx.xx.xx] USER vinix
2021-10-18T03:18:02.298Z << [FTP Session 4 xx.xx.xx.xx] 331 Please, specify the password.
2021-10-18T03:18:02.314Z DD [FTP Session 4 xx.xx.xx.xx] tls_layer_impl::on_read()
2021-10-18T03:18:02.314Z >> [FTP Session 4 xx.xx.xx.xx] PASS ****
2021-10-18T03:18:02.376Z << [FTP Session 4 xx.xx.xx.xx vinix] 230 Login successful.
2021-10-18T03:18:02.392Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.392Z >> [FTP Session 4 xx.xx.xx.xx vinix] PBSZ 0
2021-10-18T03:18:02.392Z << [FTP Session 4 xx.xx.xx.xx vinix] 200 PBSZ=0
2021-10-18T03:18:02.407Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.407Z >> [FTP Session 4 xx.xx.xx.xx vinix] PROT P
2021-10-18T03:18:02.407Z << [FTP Session 4 xx.xx.xx.xx vinix] 200 Protection level set to P
2021-10-18T03:18:02.439Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.439Z >> [FTP Session 4 xx.xx.xx.xx vinix] CWD /EdtungWeb
2021-10-18T03:18:02.439Z << [FTP Session 4 xx.xx.xx.xx vinix] 250 CWD command successful
2021-10-18T03:18:02.454Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.454Z >> [FTP Session 4 xx.xx.xx.xx vinix] TYPE I
2021-10-18T03:18:02.454Z << [FTP Session 4 xx.xx.xx.xx vinix] 200 Type set to I
2021-10-18T03:18:02.470Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.470Z >> [FTP Session 4 xx.xx.xx.xx vinix] PASV
2021-10-18T03:18:02.470Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: About to send NEW SESSION TICKET
2021-10-18T03:18:02.470Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Sent NEW SESSION TICKET
2021-10-18T03:18:02.470Z VV [FTP Session 4 xx.xx.xx.xx vinix] Trying: data_listen_socket_->listen(1, 6027)
2021-10-18T03:18:02.470Z << [FTP Session 4 xx.xx.xx.xx vinix] 227 Entering Passive Mode (10,0,0,7,23,139)
2021-10-18T03:18:02.485Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.485Z >> [FTP Session 4 xx.xx.xx.xx vinix] STOR empty_bk.png
2021-10-18T03:18:02.485Z << [FTP Session 4 xx.xx.xx.xx vinix] 550 No such file
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] session::on_socket_event(): source = data listen, flag = 2, error = 0, state = -1
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] Client wants a secure data connection.
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] securer(1) ENTERING state = 0
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] calling tls_layer_->set_certificate_file("F:\Cert\cert.key", "F:\Cert\cert.crt", "****")
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] securer(1) EXITING state = 1
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] Making the data connection secure.
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] ~securer(1) ENTERING state = 1
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::server_handshake()
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] ~securer(1) EXITING state = 2
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_send()
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::on_read()
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::continue_handshake()
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Received CLIENT HELLO
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Processed CLIENT HELLO
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: About to send SERVER HELLO
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Sent SERVER HELLO
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: About to send ENCRYPTED EXTENSIONS
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Sent ENCRYPTED EXTENSIONS
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: About to send FINISHED
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] TLS handshakep: Sent FINISHED
2021-10-18T03:18:02.501Z DD [FTP Session 4 xx.xx.xx.xx vinix] tls_layer_impl::failure(-110)
2021-10-18T03:18:02.501Z !! [FTP Session 4 xx.xx.xx.xx vinix] GnuTLS error -110: The TLS connection was non-properly terminated.
2021-10-18T03:18:02.501Z == [FTP Session 4 xx.xx.xx.xx vinix] Client did not properly shut down TLS connection
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] session::on_socket_event(): source = data, flag = 2, error = 106, state = 6
2021-10-18T03:18:02.501Z !! [FTP Session 4 xx.xx.xx.xx vinix] Failed connection for data socket. Reason: ECONNABORTED - Connection aborted.
2021-10-18T03:18:02.501Z VV [FTP Session 4 xx.xx.xx.xx vinix] session::close_data_connection() = 1

User avatar
boco
Contributor
Posts: 27108
Joined: 2006-05-01 03:28
Location: Germany

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#13 Post by boco » 2021-10-18 04:53

What about Windows' "Controlled Folder Access" feature? Is it enabled?
No support requests over PM! You will NOT get any reply!!!
FTP connection problems? Please read Network Configuration.
FileZilla connection test: https://filezilla-project.org/conntest.php
FileZilla Pro support: https://customerforum.fileZilla-project.org

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#14 Post by vinix » 2021-10-18 07:02

boco wrote:
2021-10-18 04:53
What about Windows' "Controlled Folder Access" feature? Is it enabled?
That's it! I forgot that 1.0.1 is in different directory than 0.96.0, and there's such a feature.
Thank you very much! :D

vinix
500 Syntax error
Posts: 17
Joined: 2008-04-18 03:13
First name: Vinix
Last name: Wu

Re: "425 Error while transfering data: 5" after upgrading to 1.0.1

#15 Post by vinix » 2021-10-20 06:28

There's a weird situation. The setting of allowed programs for Controlled Folder Access doesn't work sometimes.
I have to remove then re-add filezilla-server.exe to the list to make it work again. :?

Post Reply