[Bug]: Syncing of files bigger than about 20M stalls and ends in a timeout.

Volker-K commented 1 year ago

⚠️ Before submitting, please verify the following: ⚠️

[X] This is a bug, not a question or a configuration issue.
[X] This issue is not already reported on Github (I've searched it).
[X] Nextcloud Server and Desktop Client are up to date. See Server Maintenance and Release Schedule and Desktop Releases for supported versions.
[X] I agree to follow Nextcloud's Code of Conduct

Bug description

After installing Desktop Client 3.9.1 freshly on Windows 11, sync of locally stored files as well as download of virtual files with a size larger than approximately 20M stalls and ends in a timeout that stops the whole client to work for a while.

Downloading the respective file from the cloud using any browser works. Copying the file when the cloud account is mounted via WebDAV works.

Similar problems found: https://github.com/nextcloud/desktop/issues/5028 (Win 11, Client 3.6) https://github.com/nextcloud/desktop/issues/5779 (Problem found with file datetime, checked it, no problem here) https://github.com/nextcloud/desktop/issues/5394 (Win 10, Client 3.6.6)

With earlier versions we encountered a similar problem that was obviously caused by some unidentified windows routine that possibly tried to scan files. Windows Defender was deactivated as well as we reproduced it w/o our own malware protection bein installed. After adding the URL of the Nextcloud server to the list of trusted zones in Window's internet settings the problem disappeared. The URL is currently included in this list.

Steps to reproduce

Install Sync Client on Windows 11, connect to a NC Instance. When using local storage the syncing will stall at the first file > 20M and continue with an error message concerning the timeout after a long timeout period (several minutes), and stall again at the next bigger file. When using virtual files, the progress bar while downloading the file will stall and end in a timeout. In this case it takes a long time for the client to be able to sync again oder even download files of 100k.

Expected behavior

Syncing and downloading should work with files of any size (that Windows can handle...)

Which files are affected by this bug

IT.NRW - Zwei-Faktor-Authentisierung-Setup (x64).msi, Nextcloud-3.9.1-x64.msi

Operating system

Windows

Which version of the operating system you are running.

Windows 11

Package

Appimage/MSI file

Nextcloud Server version

26.0.2.1

Nextcloud Desktop Client version

3.9.1

Is this bug present after an update or on a fresh install?

Fresh desktop client install

Are you using the Nextcloud Server Encryption module?

Encryption is Disabled

Are you using an external user-backend?

[ ] Default internal user-backend
[X] LDAP/ Active Directory
[ ] SSO - SAML
[ ] Other

Nextcloud Server logs

Nothing found in the server logs.

Client Debug-Log: debug.zip

Additional info

No response

Volker-K commented 1 year ago

Additional Info: I've let the VM with this installation running for the weekend with files on local storage and finally all files were on the VM, because the client continues downloading the files with the timeout at every sync interval. But that is not acceptable für users (they don't want to always wait some days until a file is synced and don't want to get bothered by tons off error messages. Also, with virtual files this "workaround" doesn't work.

Volker-K commented 1 year ago

Meanwhile we've tried:

Using the same machine in our domain network (error) and behind a standard route for home use (no error!)
Disabling proxy settings in windows settings for direct access to the NC Server (no success)
Tracing traffic on the firewall in or network (no traffic detected that gives a hint for the timeout)
Disabling Windws/Defender Firewall (no success)

Windows errorcode = 0x80070185 There are several links showing the same error on DropBox and even OneDrive and Sharepoint, have a look here: https://techcommunity.microsoft.com/t5/onedrive/error-code-0x80070185-when-opening-sharepoint-files-via-onedrive/m-p/378592

Seems to be an old problem with Windows settings?!?

Volker-K commented 1 year ago

Possibly a new occurence of https://github.com/nextcloud/desktop/issues/3495?

Volker-K commented 11 months ago

Still there, no changes after several Win 11 fixpacks. Error while using virtual files: Error 0x800701AA is reported for several cloud clients, even for OneDrive. A WebDAV-Drive of the same cloud acount on the same PC works fine. Until last week we only had problems with Win11 installations that were installed from scratch. PCs migrated from Win10 to Win11 didn't get this error until KB5032190 was installed (2023-11 Kumulatives Update für Windows 11 Version 22H2 für x64-basierte Systeme (KB5032190)). I am currently checking whether this is a comparable effect or a completely new thing.

Volker-K commented 11 months ago

Test with client 3.11.0

No changes on a freshly installed Windows 11.

On a Win11 that was migrated from Win10, there are still inexplicable waiting times, but at first glance they are much less serious than before (no synchronization of new files lasting several hours due to pauses). So this seems to be a different problem.

This leaves us with the error situation that occurs on a freshly installed Windows 11. Another error code can be generated by repeated retries: 0x80070185

The problem solutions for this error also appear similarly helpless and desperate as those for the first error code. A hint "Dance around a campfire at night and sing to fix the error" would no longer stand out in this collection.

Volker-K commented 10 months ago

No change with Win11-Update KB5033375

Volker-K commented 9 months ago

And still no change with Windows 11 updates KB5033920 and KB5034123.

Volker-K commented 9 months ago

After freshly installing my machine and Update KB5034123 the filesize changes in each synchonization-try between 50M and 11G. For most users it will be ok as long as they ignore the error message. But no solution.

bigretromike commented 2 months ago

client 3.12.2 also affected with files 2MB+

Volker-K commented 2 months ago

Last week we apparently managed to fix the problem at least at our site.

To access the cloud from the company intranet, you had to use a proxy and the load balancer. The IP address of the cloud server did not resolve to the private network 10.x.x.x but was the same IP that was also accessed from the Internet.

To keep the growing load away from the proxy, especially for the sync clients, we switched to a split DNS solution last week. The cloud will now also be accessed from our private network via an address in the private network with 10.x.x.x.

At the beginning, the proxy configuration settings on the desktops still forced access via the proxy and the external address; only the IP of the cloud resolved locally to an address on the intranet.

But the moment the DNS delivered the internal address, the problem was solved, even if the actual access path was unchanged. My guess is that some component in Windows thought that access from our domain network to the Internet required some protection although Window Defender was deactivated due to our own protection Software. As the error did not occur on desktops that had been migrated from Windows 10 and could also be reproduced with the Windows firewall etc. deactivated, it seems to be a bug like one we have already experienced in a similar way under Windows 7. For the old bug we just had to include the clouds address to the trusted sites in the windows configuration, where it still ist listed, so that wasn't the solution in this case.

As soon as the desktop and cloud work with a 10.x.x.x address, Windows seems to consider this to be access in the LAN (which it ultimately is) and the error no longer occurs.

bigretromike commented 2 months ago

I our case, we use external IP for self-hosted cloud. If people are inside network the firewall redirect them to internal IP, if they are outside, the Firewall use NAT.

Currently the only workaround I found is marking file that is not open to be storage always on this machine, the client is stuck on "preparing to sync" so you need to shutdown client, open client, it will sync file without issue, and I'm able to open that file. But its not a solution, because making each client store every file from cloud just to access it is no go.

bigretromike commented 2 months ago

Before we started to have 0x800701AA we had 0x8007017c, which was fixed here: https://github.com/nextcloud/desktop/issues/6891 , maybe its some kind of regression ?

edit: also there is https://github.com/nextcloud/desktop/issues/5695 which was before 3.12.2

bigretromike commented 2 months ago

It's also on files that are smaller than 100KB obraz

joshtrichards commented 2 months ago

So this sounds like some sort of local matter? I'm not sure really sure there's much we could do about any of that within the client itself.

Put another way: what would you have us do within the client itself to make this better (if anything)? :-)

bigretromike commented 2 months ago

So this sounds like some sort of local matter? I'm not sure really sure there's much we could do about any of that within the client itself.

Put another way: what would you have us do within the client itself to make this better (if anything)? :-)

If you are asking me, if I knew what should be fix I would PR that already. We used to have OneDrive and it wouldn't throw that error, syncthing (which is something else) also nothing, from my end it looks like server/client has some issues - can't tell if its only for special characters ( #5695 ) because from I remembered there where few that didn't had those, but I don't beat my life on that.

Currently I know that if person is affected he need to set that files as "always local", shutdown nextcloud client, start nextcloud client and now you can access that file that other way for some strange reason he couldn't, which is something unwanted.

If I can provide you with any logs, time frames or anything that could help resolve this issue just tell.

jlangbour commented 2 months ago

Hi,

We see the same issue with a customer. We try to reproduce the issue inside a Win11 VM and we can reproduce the issue with PDF files.

In the log I think there is something weird when this happens, I don't know how to explain, so here is some logs if this can help you (and we have HAproxy as reverse proxy in front) :

2024-09-04 10:14:13:420 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:13:420 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:13:420 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:13:420 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:13:420 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:13:420 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:13:436 [ info nextcloud.gui.folder.manager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\folderman.cpp:959 ]: Etag poll timer timeout
2024-09-04 10:14:13:436 [ info nextcloud.gui.folder.manager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\folderman.cpp:963 ]: Folders to sync: 1
2024-09-04 10:14:13:436 [ info nextcloud.gui.folder.manager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\folderman.cpp:973 ]: Number of folders that don't use push notifications: 1
2024-09-04 10:14:13:436 [ info nextcloud.gui.folder.manager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\folderman.cpp:990 ]: Run etag job on folder OCC::Folder(0x2031c319e60)
2024-09-04 10:14:13:436 [ info nextcloud.gui.folder.manager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\folderman.cpp:996 ]: Can not run etag job: Sync is running
2024-09-04 10:14:13:467 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "b16c9ec7-1ef9-4540-adaa-82e97081d04e"
2024-09-04 10:14:13:467 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:13:483 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/ocs/v2.php/apps/notifications/api/v2/notifications?format=json" has X-Request-ID "a3785e3f-9448-4841-935c-3816a8600df5"
2024-09-04 10:14:13:483 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::JsonApiJob created for "https://nextcloud-instance.example.org" + "ocs/v2.php/apps/notifications/api/v2/notifications" "OCC::ServerNotificationHandler"
2024-09-04 10:14:13:880 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:13:880 [ info nextcloud.sync.networkjob.jsonapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\networkjobs.cpp:966 ]:  JsonApiJob of QUrl("https://nextcloud-instance.example.org/ocs/v2.php/apps/notifications/api/v2/notifications?format=json") FINISHED WITH STATUS "OK"
2024-09-04 10:14:13:880 [ info nextcloud.gui.activity C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\tray\usermodel.cpp:222 ]:  Activity already notified, skip
2024-09-04 10:14:13:912 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:13:912 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:13:912 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:13:912 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:13:912 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:14:420 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:14:420 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:14:420 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:14:420 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:14:467 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "05db8a79-a87c-4b19-a964-21cef8d1e3a3"
2024-09-04 10:14:14:467 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:14:530 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:14:530 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:14:530 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:14:530 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:14:530 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:14:545 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:15:258 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:15:258 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:15:258 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:15:258 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:15:306 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "b930f292-17cf-4de3-a8e2-7dd247f76f36"
2024-09-04 10:14:15:306 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:15:374 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:15:374 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:15:374 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:15:374 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:15:374 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:15:481 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:16:077 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:16:077 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:16:077 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:16:077 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:16:124 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "d689bb9d-5428-45ff-ac8d-2e4937ce6c36"
2024-09-04 10:14:16:124 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:16:186 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:16:186 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:16:186 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:16:186 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:16:202 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:16:890 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:16:890 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:16:890 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:16:890 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:16:936 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "a1bab09d-76dc-4d93-9350-bf686df1d0c1"
2024-09-04 10:14:16:936 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:16:999 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:16:999 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:16:999 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:16:999 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:16:999 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:17:014 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:17:717 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:17:717 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:17:717 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:17:717 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:17:764 [ info nextcloud.sync.accessmanager C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\accessmanager.cpp:78 ]:  2 "" "https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96" has X-Request-ID "c85f895b-de06-45a8-913a-fc98794fbb5b"
2024-09-04 10:14:17:764 [ info nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:311 ]:   OCC::SimpleNetworkJob created for "https://nextcloud-instance.example.org" + "" ""
2024-09-04 10:14:17:827 [ info nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:405 ]:    request finished
2024-09-04 10:14:17:827 [ warning nextcloud.sync.networkjob C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\abstractnetworkjob.cpp:226 ]:    QNetworkReply::ContentNotFoundError "Le serveur a répondu \"404 Not Found\"  à \"GET https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96\"" QVariant(int, 404)
2024-09-04 10:14:17:827 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:207 ]: QNetworkReply::ContentNotFoundError
2024-09-04 10:14:17:827 [ warning nextcloud.sync.credentials.webflow C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\creds\webflowcredentials.cpp:208 ]: "Error transferring https://nextcloud-instance.example.org/index.php/core/preview?fileId=00019508oczvsof9pth1&x=96&y=96 - server replied: Not Found"
2024-09-04 10:14:17:843 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:17:936 [ info nextcloud.gui.shellextensions.server C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\gui\shellextensionsserver.cpp:126 ]: "Commun/DIVERS/Carte Quartiers Metz.pdf"  record._lastShareStateFetchedTimestamp has less than  120000  ms difference with QDateTime::currentMSecsSinceEpoch(). Returning data from SyncJournal.
2024-09-04 10:14:18:624 [ info nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:417 ]:   Received request to hydrate "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"
2024-09-04 10:14:18:624 [ warning nextcloud.sync.vfs.cfapi C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\vfs_cfapi.cpp:466 ]:    The OS submitted again a hydration request which is already on-going "1dafe96cb5054fb" "Commun/DIVERS/Carte Quartiers Metz.pdf"
2024-09-04 10:14:18:624 [ info nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:204 ]:    VFS replied for hydration of "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb" status was: false
2024-09-04 10:14:18:624 [ critical nextcloud.sync.vfs.cfapi.wrapper C:\Users\User\AppData\Local\Temp\windows-25179\client-building\desktop\src\libsync\vfs\cfapi\cfapiwrapper.cpp:206 ]:    Failed to trigger hydration for "C:\\Users\\user\\Nextcloud\\SOME\\PATH\\Carte Quartiers Metz.pdf" "1dafe96cb5054fb"

~~ About the file
:~/public_html/nextcloud$ ./occ info:file 19508
Carte Quartiers Metz.pdf
  fileid: 19508
  mimetype: application/pdf
  modified: 19 juillet 2022, 13:16:15 UTC
  not encrypted
  size: 1.7 MB
  etag: 7655040d67f61f73fe6db47def3db555
  mounted at: /REDACTED/files/Commun/
  groupfolder id: 1

Note : in web browser (through the haproxy like the client on the computer) the header oc-etag match the etag return from occ command.

Best regards,

bigretromike commented 1 month ago

obraz Polish character is name of the folder that this files is present

Volker-K commented 1 month ago

We see the same issue with a customer. We try to reproduce the issue inside a Win11 VM and we can reproduce the issue with PDF files.

Some years ago we had at Win 9 a similar problem with PDF and ZIP files only. At that time we had a look via Wireshark and found timeouts in the TCP stack of te client. Windows Defender was switched off by a rule and our malware suite was deinstalled.

Nevertheless it worked without those timeouts the moment we added the address of our cloud to the list of "trusted sites" in the settings. We found it on MSIE in those days. It's hidden somewere else now.

Seems that not trusted sites were scanned by the disabled Defender. Similar to the solution we found this time: Put server IP and client IP in the same network and it works." It's both the same LAN so it simply must be trustable."

bigretromike commented 1 month ago

This one is without any PL characters in its path: obraz

This one is on different server also.

nextcloud / desktop