Android: "Sync successful" to Nextcloud but doesn't actually sync anything

Support
1

Hi,

Syncing with Nextcloud 25 -- previously with Nextcloud 19. Same bundle of data between the two servers (I reinstalled, copied my data and re-indexed). Desktop sync clients on the Nextcloud side all work fine, Joplin Desktop syncs fine on Mac, Linux and Windows. I have not been able to get the Android app to sync correctly since whatever version was available in May or June; since then I have updated to 2.8.1 and have the same issue. Sync log attached (hint: "total notes: 12" is extremely wrong and there are 5 notebooks in this Joplin folder!)

Date,Level,Message
12-22T14:28:05,30,"RevisionService: ""maintenance: Done in 143ms""
12-22T14:28:05,30,"RevisionService: ""collectRevisions: Created revisions for 0 notes""
12-22T14:28:05,30,"RevisionService: ""maintenance: Service is enabled""
12-22T14:28:05,30,"RevisionService: ""maintenance: Starting...""
12-22T14:27:13,30,"RevisionService: ""maintenance: Done in 118ms""
12-22T14:27:13,30,"RevisionService: ""collectRevisions: Created revisions for 0 notes""
12-22T14:27:12,30,"RevisionService: ""maintenance: Service is enabled""
12-22T14:27:12,30,"RevisionService: ""maintenance: Starting...""
12-22T14:26:46,30,"""DecryptionWorker: cannot start because no master key is currently loaded.""
12-22T14:26:45,30,"Synchronizer: ""Total folders: 0""
12-22T14:26:45,30,"Synchronizer: ""Total notes: 12""
12-22T14:26:45,30,"Synchronizer: ""Total resources: 3""
12-22T14:26:45,30,"Synchronizer: ""fetchingTotal: -""
12-22T14:26:45,30,"Synchronizer: ""Operations completed: ""
12-22T14:26:45,30,"Synchronizer: ""Sync: finished: Synchronisation finished [1671740799878]""
12-22T14:26:45,30,"Synchronizer: ""Sync: fetchingTotal: Fetching delta items from sync target""
12-22T14:26:45,30,"Synchronizer: ""BasicDelta: Report: {"timestamp":1671740308000,"older":846,"newer":0,"equal":2}""
12-22T14:26:45,30,"Synchronizer: ""TaskQueue.stop: syncDownload: waiting for tasks to complete: 0""
12-22T14:26:45,30,"Synchronizer: ""TaskQueue.stop: syncDownload: Done, waited for 0""
12-22T14:26:44,30,"Synchronizer: ""Sync target local info:", "{"version_":3,"masterKeys_":,"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}""
12-22T14:26:44,30,"Synchronizer: ""Sync target remote info:", "{"version_":3,"masterKeys_":,"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}""
12-22T14:26:44,30,"Synchronizer: ""Sync target is already setup - checking it...""
12-22T14:26:44,30,"""ResourceService::indexNoteResources: Completed""
12-22T14:26:44,30,"RevisionService: ""maintenance: Done in 4401ms""
12-22T14:26:44,30,"RevisionService: ""collectRevisions: Created revisions for 0 notes""
12-22T14:26:39,30,"""ResourceService::indexNoteResources: Start""
12-22T14:26:39,30,"Synchronizer: ""Indexing resources...""
12-22T14:26:39,30,"Synchronizer: ""Sync: starting: Starting synchronisation to target 5... supportsAccurateTimestamp = false; supportsMultiPut = false [1671740799878]""
12-22T14:26:39,30,"""Starting scheduled sync""
12-22T14:26:39,30,"""Preparing scheduled sync""
12-22T14:26:39,30,"""Running background sync on timer...""
12-22T14:26:39,30,"RevisionService: ""maintenance: Service is enabled""
12-22T14:26:39,30,"RevisionService: ""maintenance: Starting...""
12-22T14:20:52,30,"RevisionService: ""maintenance: Done in 118ms""
12-22T14:20:52,30,"RevisionService: ""collectRevisions: Created revisions for 0 notes""
12-22T14:20:52,30,"RevisionService: ""maintenance: Starting...""
12-22T14:20:52,30,"RevisionService: ""maintenance: Service is enabled""
12-22T14:20:44,30,"""SearchEngine: Updated FTS table in 273ms. Inserted: 1. Deleted: 0""
12-22T14:20:43,30,"""SearchEngine: Updating FTS table...""
12-22T14:20:35,30,"""DecryptionWorker: cannot start because no master key is currently loaded.""
12-22T14:20:34,30,"""ResourceFetcher: Auto-added resources: 0""
12-22T14:20:34,30,"""ResourceFetcher: Auto-add resources: Mode: always""
12-22T14:20:34,30,"Synchronizer: ""Total resources: 3""
12-22T14:20:34,30,"Synchronizer: ""Total folders: 0""
12-22T14:20:34,30,"Synchronizer: ""Total notes: 12""
12-22T14:20:34,30,"Synchronizer: ""fetchingTotal: 10""
12-22T14:20:34,30,"Synchronizer: ""fetchingProcessed: 10""
12-22T14:20:34,30,"Synchronizer: ""createLocal: 9""
12-22T14:20:34,30,"Synchronizer: ""updateLocal: 1""
12-22T14:20:34,30,"Synchronizer: ""Operations completed: ""
12-22T14:20:34,30,"Synchronizer: ""Sync: finished: Synchronisation finished [1671740431339]""
12-22T14:20:33,30,"""ResourceFetcher: Auto-added resources: 0""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 6ea8cab4ff52407ca15a00f0e510ef22.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"""ResourceFetcher: Auto-add resources: Mode: always""
12-22T14:20:33,30,"Synchronizer: ""Sync: updateLocal: remote is more recent than local: Note: (Local 3cebdb95530444d38be5e488061f9cb5): (Remote 3cebdb95530444d38be5e488061f9cb5.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote d817f1fdbffd463f962ca841eb4587ed.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 2d5f940011274644b8078d9f1951151d.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 9bc54ce588074244b478f327c624bc40.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 265fa2372b954ff6b8bee9535fabb900.md)""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"""ResourceFetcher: Auto-added resources: 3""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 1d16b1b64e5f40889dda70216ebca904.md)""
12-22T14:20:33,30,"""ResourceFetcher: Auto-add resources: Mode: always""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"""ResourceFetcher: Auto-added resources: 2""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 8bfddde2bcd5426993771ed7c6d20620.md)""
12-22T14:20:33,30,"""ResourceFetcher: Auto-add resources: Mode: always""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"""ResourceFetcher: Auto-added resources: 1""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote 701ca047948846159ecdb759021db3b1.md)""
12-22T14:20:33,30,"""ResourceFetcher: Auto-add resources: Mode: always""
12-22T14:20:33,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:33,30,"Synchronizer: ""Sync: createLocal: remote exists but local does not: (Remote ab021eed5c954ea29c67b6fefad12e83.md)""
12-22T14:20:32,30,"Synchronizer: ""Sync: fetchingProcessed: Processing fetched item""
12-22T14:20:32,30,"Synchronizer: ""Sync: fetchingTotal: Fetching delta items from sync target""
12-22T14:20:32,30,"Synchronizer: ""BasicDelta: Report: {"timestamp":1670369103000,"older":837,"newer":9,"equal":1}""
12-22T14:20:31,30,"Synchronizer: ""Sync target local info:", "{"version_":3,"masterKeys_":,"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}""
12-22T14:20:31,30,"Synchronizer: ""Sync target remote info:", "{"version_":3,"masterKeys_":,"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}""
12-22T14:20:31,30,"Synchronizer: ""Sync target is already setup - checking it...""
12-22T14:20:31,30,"""ResourceService::indexNoteResources: Completed""
12-22T14:20:31,30,"Synchronizer: ""Indexing resources...""
12-22T14:20:31,30,"""ResourceService::indexNoteResources: Start""
12-22T14:20:31,30,"Synchronizer: ""Sync: starting: Starting synchronisation to target 5... supportsAccurateTimestamp = false; supportsMultiPut = false [1671740431339]""
12-22T14:20:31,30,"""Starting scheduled sync""
12-22T14:20:31,30,"""Preparing scheduled sync""
12-22T14:20:21,30,"""ResourceService::deleteOrphanResources:", """
12-22T14:20:21,30,"""ResourceService::indexNoteResources: Completed""
12-22T14:20:21,30,"RevisionService: ""maintenance: Done in 133ms""
12-22T14:20:21,30,"RevisionService: ""collectRevisions: Created revisions for 0 notes""
12-22T14:20:21,30,"config/lib: ""Sync settings have been changed - scheduling a sync""
12-22T14:20:21,30,"RevisionService: ""maintenance: Starting...""
12-22T14:20:21,30,"RevisionService: ""maintenance: Service is enabled""
12-22T14:20:21,30,"""ResourceService::indexNoteResources: Start""

2

So, I solved this by accident. I noticed that new folders were getting synced, and so were new notes. On the desktop side I created new folders and moved existing notes into them, then synced, then synced on the mobile side. Somehow that fixed it. Something about the metadata on old notes was making them invisible to the mobile client; moving them to new folders seems to have fixed this. FYI for anyone else experiencing similar issues.

3

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.