Syncronization folder don't reach 100% on QNAP

[marziom]

Hello,

I have a QNAP NAS with Resilio Sync running on it, i use the software to synchronize my laptop folder with NAS and portable USB HD attached to the NAS.

BTW, i was very satisfied by Resilio functions, it worked great for a long time, but starting from few months ago i encountered some problem that still persist.

Some months ago the system start to show warning messages due to strange characters and/or problems on syncronization, after a while i read somewhere on internet (maybe on this forum) that i could reset the syncronization by remove the folder .sync.

I did this... but after that the synchronization still remained freezend on a certain percentage and didn't increase.

I looked at the log but i don't find nothing relevant... a lot of errors but i don't know if it is normal or not.

Can anyone suggest me something? also a way to make a secure reset of the syncronization could be ok.

Thanks

[marziom]

I am focusing on one file that doean't syncronize, i got this log every time:

 

Quote

 

[20221117 13:02:26.024] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", in failed downloads

[20221117 13:02:27.988] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: created
[20221117 13:02:27.988] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: aggregation=0, range_span=0, piece_size=131072, have=0/716
[20221117 13:02:27.988] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: change state from "INVALID" to "LOAD"
[20221117 13:02:27.988] SF[3363:CB47] [81C8]: Going to connect to peer 93.45.60.38:44889 for file "...myfile..."
[20221117 13:02:27.988] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: Add PC[0x00007ff0a9fccf18] to pending - pending count: 0
[20221117 13:02:27.988] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: Opened outgoing PC[0x00007ff0a9fccf18]
[20221117 13:02:27.989] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: state:LOAD error: meta:1 conns:1 io:1 disk:0% mt:0% net: 0%
[20221117 13:02:27.989] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: change state from "LOAD" to "LOADED"
[20221117 13:02:27.989] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: change state from "LOADED" to "REC_METADATA"
[20221117 13:02:28.358] PC[0x00007ff0a9fccf18][0x00007ff0ab172600] send login - peer:10E84D936DC4C1ECD01905552874C8E97102CB47 share:73A9501002B3C6286F5A565074CB5706B44A3363 info:0C233AF30D25B211A393C35C44B8465C3102D913 file:"...myfile..."
[20221117 13:02:29.143] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: state:REC_METADATA error: meta:0 conns:1 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:30.068] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: state:REC_METADATA error: meta:0 conns:0 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:30.068] TC: Force unloading torrent ...myfile...
[20221117 13:02:30.068] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: removing torrent for file: unloadable, io: 0
[20221117 13:02:30.068] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: check can delete: fs_refs = 0
[20221117 13:02:30.068] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: unloading up:0/0 down:0
[20221117 13:02:30.069] TF[3363:CB47] [0x00007ff0ab172600][...myfile...]: deleted
[20221117 13:02:30.072] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: created
[20221117 13:02:30.072] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: aggregation=0, range_span=0, piece_size=131072, have=0/716
[20221117 13:02:30.072] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: change state from "INVALID" to "LOAD"
[20221117 13:02:30.072] SF[3363:CB47] [81C8]: Going to connect to peer 93.45.60.38:44889 for file "...myfile..."
[20221117 13:02:30.072] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: Add PC[0x00007ff0a9f21108] to pending - pending count: 0
[20221117 13:02:30.072] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: Opened outgoing PC[0x00007ff0a9f21108]
[20221117 13:02:30.077] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: change state from "LOAD" to "LOADED"
[20221117 13:02:30.077] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: change state from "LOADED" to "REC_METADATA"
[20221117 13:02:30.632] PC[0x00007ff0a9f21108][0x00007ff0ab1fbe00] send login - peer:10E84D936DC4C1ECD01905552874C8E97102CB47 share:73A9501002B3C6286F5A565074CB5706B44A3363 info:0C233AF30D25B211A393C35C44B8465C3102D913 file:"...myfile..."
[20221117 13:02:31.031] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:1 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:32.252] SF[3363:CB47] [81C8]: Going to connect to peer 93.45.60.38:44889 for file "...myfile..."
[20221117 13:02:32.252] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: Opened outgoing PC[0x00007ff0a9fce618]
[20221117 13:02:32.253] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:2 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:32.661] PC[0x00007ff0a9fce618][0x00007ff0ab1fbe00] send login - peer:10E84D936DC4C1ECD01905552874C8E97102CB47 share:73A9501002B3C6286F5A565074CB5706B44A3363 info:0C233AF30D25B211A393C35C44B8465C3102D913 file:"...myfile..."
[20221117 13:02:33.162] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:1 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:33.882] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", already connected
[20221117 13:02:33.884] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:1 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:33.903] SP[81C8] Blocked downloading file "...myfile..." due closed virtual socket
[20221117 13:02:34.916] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:1 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:35.990] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", in failed downloads
[20221117 13:02:35.991] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: state:REC_METADATA error: meta:0 conns:0 io:0 disk:0% mt:0% net: 0%
[20221117 13:02:35.991] TC: Force unloading torrent ...myfile...
[20221117 13:02:35.991] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: removing torrent for file: unloadable, io: 0
[20221117 13:02:35.991] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: check can delete: fs_refs = 0
[20221117 13:02:35.991] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: unloading up:0/0 down:0
[20221117 13:02:35.991] TF[3363:CB47] [0x00007ff0ab1fbe00][...myfile...]: deleted
[20221117 13:02:36.998] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", in failed downloads

[20221117 13:02:39.133] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", in failed downloads

[20221117 13:02:42.127] SF[3363:CB47] [81C8]: Won't connect file "...myfile...", in failed downloads

 

 

It seems that the problem is:

 

Blocked downloading file "...myfile..." due closed virtual socket