Page 1 of 2

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

Posted: 2021-10-15 05:03
by vinix
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?

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

Posted: 2021-10-15 05:23
by oibaf
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?

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

Posted: 2021-10-15 06:26
by vinix
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?

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

Posted: 2021-10-15 07:52
by botg
What exactly is entered under mount points for the user you are connecting with? Please don't obfuscate this information.

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

Posted: 2021-10-15 07:59
by vinix
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

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

Posted: 2021-10-15 08:05
by botg
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.

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

Posted: 2021-10-15 08:15
by vinix
It's created automatically when upgrade:
mountpoint.png
mountpoint.png (10.97 KiB) Viewed 6433 times

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

Posted: 2021-10-15 09:51
by botg
Does the native directory exist? Is it on an actual device inside the server's computer, or is it a mapped network resource?

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

Posted: 2021-10-15 10:37
by vinix
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.

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

Posted: 2021-10-15 10:50
by vinix
I uninstalled 1.0.1 and reinstalled 0.96.0. Everything worked again.

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

Posted: 2021-10-15 13:23
by oibaf
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"?

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

Posted: 2021-10-18 03:37
by vinix
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 6329 times
The installer is run under admin privilege.

The target directory has ACL as below:
acl.png
acl.png (29.48 KiB) Viewed 6329 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

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

Posted: 2021-10-18 04:53
by boco
What about Windows' "Controlled Folder Access" feature? Is it enabled?

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

Posted: 2021-10-18 07:02
by vinix
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

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

Posted: 2021-10-20 06:28
by vinix
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. :?