joplin icon indicating copy to clipboard operation
joplin copied to clipboard

Published 20 hours ago • verified publisher icon laurent22

Sync reports success, but syncs nothing

Open jlschrag opened this issue 1 year ago • 1 comments

I have three existing clients (two Windows portable, one Ubuntu) syncing via a network share. On Ubuntu this is used via a mapped drive (/mnt/...). Those clients are syncing properly.

I have now added a third client (PopOS - Joplin v2.8.8) and set up the same mapped drive arrangement & sync path in Joplin. The new client reports that it is syncing successfully, but it pulls nothing from the other clients and new notes I create locally don't end up on the other clients. I have confirmed that the share path is accessible via the OS console.

I have also tried uninstalling, deleting ~/.config/joplin-desktop, & reinstalling but got the same result.

Environment

Joplin version: 2.8.8 Platform: Linux OS specifics: PopOS (an Ubuntu child)

Steps to reproduce

  1. Set up a client on Windows or Ubuntu syncing to a windows share
  2. On PopOS, Download Joplin 2.8.8 from the PopOS Pop!_shop OR using wget -O - https://raw.githubusercontent.com/laurent22/joplin/dev/Joplin_install_and_update.sh | bash
  3. map a folder to the network share from step 1 using https://wiki.ubuntu.com/MountWindowsSharesPermanently
  4. Delete the "getting started" notes
  5. Put the path to that share into the "Directory to synchronize" in Joplin
  6. Syncronize

Describe what you expected to happen

I expect to see the notes come in from other clients, then two way syncing work properly

Debugging Console Window Output

main-html.js:59 Environment: prod main-html.js:80 appId: net.cozic.joplin-desktop main-html.js:81 appType: desktop Logger.ts:219 13:09:29: App: Profile directory: /home/jschrag/.config/joplin-desktop Logger.ts:219 13:09:29: App: Root profile directory: /home/jschrag/.config/joplin-desktop Logger.ts:219 13:09:29: Database was open successfully Logger.ts:219 13:09:29: Checking for database schema update... Logger.ts:219 13:09:29: Current database version Object Logger.ts:219 13:09:29: Upgrading database from version 41 Logger.ts:219 13:09:29: New version: 41. Previously recorded version: 41 Logger.ts:219 13:09:29: KeychainService: checking if keychain supported Logger.ts:219 13:09:29: KeychainService: check was already done - skipping. Supported: 0 Logger.ts:219 13:09:29: e2ee/utils: Master password is not set - trying to get it from the active master key... Logger.ts:219 13:09:29: handleSyncStartupOperation: Processing operation: 0 Logger.ts:219 13:09:29: App: Client ID: fcb6a293527b4e6eba8b914fd30323ee Logger.ts:219 13:09:29: models/Setting: Applying default migrations... Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: ResourceFetcher: Auto-add resources: Mode: always Logger.ts:219 13:09:29: ResourceFetcher: Auto-added resources: 0 Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: Setting up recurrent sync with interval 300 Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: app.start: doing regular boot Logger.ts:219 13:09:29: App: Refreshing notes: null null Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: Setting up recurrent sync with interval 300 Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: App: "syncInfoCache" was changed - setting up encryption related code Logger.ts:219 13:09:29: e2ee/utils: Trying to load 0 master keys... Logger.ts:219 13:09:29: e2ee/utils: Loaded master keys: 0 Logger.ts:219 13:09:29: Scheduling sync operation... 10000 Logger.ts:219 13:09:29: App: Refreshing notes: null null Logger.ts:219 13:09:29: Scheduling sync operation... 1000 Logger.ts:219 13:09:29: RevisionService: runInBackground: Starting background service with revision collection interval 600000 Logger.ts:219 13:09:29: SpellCheckerServiceDriverNative: Set effective language from "en-US" to "en-US" /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 Warning: componentWillReceiveProps has been renamed, and is not recommended for use. See https://fb.me/react-async-component-lifecycle-hooks for details.

  • Move data fetching code or side effects to componentDidUpdate.
  • If you're updating state whenever props change, refactor your code to use memoization techniques or move it to static getDerivedStateFromProps. Learn more at: https://fb.me/react-derived-state
  • Rename componentWillReceiveProps to UNSAFE_componentWillReceiveProps to suppress this warning in non-strict mode. In React 17.x, only the UNSAFE_ name will work. To rename all deprecated lifecycles to their new names, you can run npx react-codemod rename-unsafe-lifecycles in your project source folder.

Please update the following components: Connect(MainScreenComponent), Connect(MenuBar), Connect(NavigatorComponent), Connect(RootComponent), Provider printWarning @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 Warning: componentWillUpdate has been renamed, and is not recommended for use. See https://fb.me/react-async-component-lifecycle-hooks for details.

  • Move data fetching code or side effects to componentDidUpdate.
  • Rename componentWillUpdate to UNSAFE_componentWillUpdate to suppress this warning in non-strict mode. In React 17.x, only the UNSAFE_ name will work. To rename all deprecated lifecycles to their new names, you can run npx react-codemod rename-unsafe-lifecycles in your project source folder.

Please update the following components: Connect(MainScreenComponent), Connect(MenuBar), Connect(NavigatorComponent), Connect(RootComponent) printWarning @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 Warning: componentWillReceiveProps has been renamed, and is not recommended for use. See https://fb.me/react-async-component-lifecycle-hooks for details.

  • Move data fetching code or side effects to componentDidUpdate.
  • If you're updating state whenever props change, refactor your code to use memoization techniques or move it to static getDerivedStateFromProps. Learn more at: https://fb.me/react-derived-state
  • Rename componentWillReceiveProps to UNSAFE_componentWillReceiveProps to suppress this warning in non-strict mode. In React 17.x, only the UNSAFE_ name will work. To rename all deprecated lifecycles to their new names, you can run npx react-codemod rename-unsafe-lifecycles in your project source folder.

Please update the following components: Connect(NoteEditor), Connect(NoteListComponent), Connect(NoteListControls), Connect(SearchBar), Connect(SidebarComponent) printWarning @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 Warning: componentWillUpdate has been renamed, and is not recommended for use. See https://fb.me/react-async-component-lifecycle-hooks for details.

  • Move data fetching code or side effects to componentDidUpdate.
  • Rename componentWillUpdate to UNSAFE_componentWillUpdate to suppress this warning in non-strict mode. In React 17.x, only the UNSAFE_ name will work. To rename all deprecated lifecycles to their new names, you can run npx react-codemod rename-unsafe-lifecycles in your project source folder.

Please update the following components: Connect(NoteEditor), Connect(NoteListComponent), Connect(NoteListControls), Connect(SearchBar), Connect(SidebarComponent) printWarning @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11494 Logger.ts:219 13:09:30: DecryptionWorker: cannot start because no master key is currently loaded. Logger.ts:219 13:09:30: Preparing scheduled sync Logger.ts:219 13:09:30: Starting scheduled sync Logger.ts:219 13:09:30: Synchronizer: Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257770490] Logger.ts:219 13:09:30: Synchronizer: Indexing resources... Logger.ts:219 13:09:30: ResourceService::indexNoteResources: Start Logger.ts:219 13:09:30: models/Setting: Saving settings... Logger.ts:219 13:09:30: models/Setting: Settings have been saved. Logger.ts:219 13:09:30: ResourceService::indexNoteResources: Completed Logger.ts:219 13:09:30: models/Folder: updateFolderShareIds: {shareUpdateCount: 0, unshareUpdateCount: 0} Logger.ts:219 13:09:30: models/Folder: updateNoteShareIds: notes to update: 0 Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/info.json Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/.sync/version.txt Logger.ts:219 13:09:30: Synchronizer: Sync target remote info: SyncInfo {version_: 0, masterKeys_: Array(0), e2ee_: {…}, activeMasterKeyId_: {…}, ppk_: {…}}activeMasterKeyId_: {value: '', updatedTime: 0}e2ee_: {value: false, updatedTime: 0}masterKeys_: []ppk_: {value: null, updatedTime: 0}version_: 0activeMasterKeyId: (...)e2ee: (...)masterKeys: (...)ppk: (...)version: (...)[[Prototype]]: Object Logger.ts:219 13:09:30: Synchronizer: Sync target is new - setting it up... Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/info.json Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/.sync/version.txt Logger.ts:219 13:09:30: MigrationHandler: Sync target version is 0 or 1 - creating "locks" and "temp" directory: {version: 0} Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/locks Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/temp Logger.ts:219 13:09:30: MigrationHandler: Acquiring exclusive lock Logger.ts:219 13:09:30: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/temp/timeCheck434825.txt null Logger.ts:219 13:09:30: FileApi: stat /mnt/windows/documents/Joplin/temp/timeCheck434825.txt Logger.ts:219 13:09:30: FileApi: delete /mnt/windows/documents/Joplin/temp/timeCheck434825.txt Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json null Logger.ts:219 13:09:30: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json null Logger.ts:219 13:09:30: MigrationHandler: Acquired exclusive lock: {id: null, type: 2, clientType: 1, clientId: 'fcb6a293527b4e6eba8b914fd30323ee', updatedTime: 1658257770606} Logger.ts:219 13:09:30: MigrationHandler: Migrating from version 0 to version 1 Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/.resource Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/.sync Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/.lock Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/.sync/version.txt null Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/info.json null Logger.ts:219 13:09:30: MigrationHandler: Done migrating from version 0 to version 1 Logger.ts:219 13:09:30: MigrationHandler: Migrating from version 1 to version 2 Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/.sync/version.txt null Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/.sync/readme.txt null Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/locks Logger.ts:219 13:09:30: FileApi: mkdir /mnt/windows/documents/Joplin/temp Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/info.json null Logger.ts:219 13:09:30: MigrationHandler: Done migrating from version 1 to version 2 Logger.ts:219 13:09:30: MigrationHandler: Migrating from version 2 to version 3 Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/info.json null Logger.ts:219 13:09:30: MigrationHandler: Done migrating from version 2 to version 3 Logger.ts:219 13:09:30: MigrationHandler: Releasing exclusive lock Logger.ts:219 13:09:30: FileApi: delete /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/info.json Logger.ts:219 13:09:30: Synchronizer: Sync target is already setup - checking it... Logger.ts:219 13:09:30: Synchronizer: Sync target local info: SyncInfo {version_: 3, masterKeys_: Array(0), e2ee_: {…}, activeMasterKeyId_: {…}, ppk_: {…}} Logger.ts:219 13:09:30: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:30: FileApi: put /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json null Logger.ts:219 13:09:30: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:30: FileApi: delta /mnt/windows/documents/Joplin Logger.ts:219 13:09:30: Synchronizer: BasicDelta: Report: {"timestamp":1658257554195,"older":0,"newer":1,"equal":0} Logger.ts:219 13:09:30: Synchronizer: Sync: fetchingTotal: Fetching delta items from sync target Logger.ts:219 13:09:30: FileApi: get /mnt/windows/documents/Joplin/info.json Logger.ts:219 13:09:30: Synchronizer: Sync: fetchingProcessed: Processing fetched item Logger.ts:219 13:09:30: FileApi: delete /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json Logger.ts:219 13:09:30: Synchronizer: Sync: finished: Synchronisation finished [1658257770490] Logger.ts:219 13:09:30: Synchronizer: Operations completed: Logger.ts:219 13:09:30: Synchronizer: fetchingTotal: 1 Logger.ts:219 13:09:30: Synchronizer: fetchingProcessed: 1 Logger.ts:219 13:09:30: Synchronizer: Total folders: 0 Logger.ts:219 13:09:30: Synchronizer: Total notes: 0 Logger.ts:219 13:09:30: Synchronizer: Total resources: 0 Logger.ts:219 13:09:30: Setting up recurrent sync with interval 300 Logger.ts:219 13:09:30: Updating all notifications... Logger.ts:219 13:09:30: Garbage collecting alarms... Logger.ts:219 13:09:30: Sync has finished and note has never been changed - reloading it Logger.ts:219 13:09:30: Trying to reload note that has been deleted: null log @ Logger.ts:219 warn @ Logger.ts:92 (anonymous) @ useFormNote.ts:129 fulfilled @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:5 processTicksAndRejections @ internal/process/task_queues.js:95 Promise.then (async) step @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:7 (anonymous) @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:8 awaiter @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:4 loadNote @ useFormNote.ts:121 (anonymous) @ useFormNote.ts:136 commitHookEffectList @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:19986 commitPassiveHookEffects @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:20016 callCallback @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:347 invokeGuardedCallbackDev @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:397 invokeGuardedCallback @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:454 flushPassiveEffectsImpl @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22868 unstable_runWithPriority @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:643 runWithPriority$2 @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11305 flushPassiveEffects @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22841 (anonymous) @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22419 scheduler_flushTaskAtPriority_Normal @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:436 flushTask @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:482 flushWork @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:607 performWorkUntilDeadline @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:231 Logger.ts:219 13:09:31: models/Setting: Saving settings... Logger.ts:219 13:09:31: models/Setting: Settings have been saved. Logger.ts:219 13:09:31: DecryptionWorker: cannot start because no master key is currently loaded. Logger.ts:219 13:09:33: RevisionService: maintenance: Starting... Logger.ts:219 13:09:33: RevisionService: maintenance: Service is enabled Logger.ts:219 13:09:33: RevisionService: collectRevisions: Created revisions for 0 notes Logger.ts:219 13:09:33: RevisionService: maintenance: Done in 107ms Logger.ts:219 13:09:39: SearchEngine: Updating FTS table... Logger.ts:219 13:09:39: SearchEngine: Updated FTS table in 3ms. Inserted: 0. Deleted: 0 Logger.ts:219 13:09:51: CommandService::execute: synchronize false Logger.ts:219 13:09:51: Scheduling sync operation... 0 Logger.ts:219 13:09:51: Preparing scheduled sync Logger.ts:219 13:09:51: Starting scheduled sync Logger.ts:219 13:09:51: Synchronizer: Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257791290] Logger.ts:219 13:09:51: Synchronizer: Indexing resources... Logger.ts:219 13:09:51: ResourceService::indexNoteResources: Start Logger.ts:219 13:09:51: ResourceService::indexNoteResources: Completed Logger.ts:219 13:09:51: models/Folder: updateFolderShareIds: {shareUpdateCount: 0, unshareUpdateCount: 0} Logger.ts:219 13:09:51: models/Folder: updateNoteShareIds: notes to update: 0 Logger.ts:219 13:09:51: FileApi: get /mnt/windows/documents/Joplin/info.json Logger.ts:219 13:09:51: Synchronizer: Sync target remote info: SyncInfo {version: 3, masterKeys: Array(0), e2ee_: {…}, activeMasterKeyId_: {…}, ppk_: {…}} Logger.ts:219 13:09:51: Synchronizer: Sync target is already setup - checking it... Logger.ts:219 13:09:51: Synchronizer: Sync target local info: SyncInfo {version_: 3, masterKeys_: Array(0), e2ee_: {…}, activeMasterKeyId_: {…}, ppk_: {…}} Logger.ts:219 13:09:51: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:51: FileApi: put /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json null Logger.ts:219 13:09:51: FileApi: list /mnt/windows/documents/Joplin Logger.ts:219 13:09:51: Synchronizer: TaskQueue.stop: syncDownload: waiting for tasks to complete: 0 Logger.ts:219 13:09:51: Synchronizer: TaskQueue.stop: syncDownload: Done, waited for 0 Logger.ts:219 13:09:51: FileApi: delta /mnt/windows/documents/Joplin Logger.ts:219 13:09:51: Synchronizer: BasicDelta: Report: {"timestamp":1658257770714,"older":0,"newer":0,"equal":1} Logger.ts:219 13:09:51: Synchronizer: Sync: fetchingTotal: Fetching delta items from sync target Logger.ts:219 13:09:51: FileApi: delete /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json Logger.ts:219 13:09:51: Synchronizer: Sync: finished: Synchronisation finished [1658257791290] Logger.ts:219 13:09:51: Synchronizer: Operations completed: Logger.ts:219 13:09:51: Synchronizer: fetchingTotal: - Logger.ts:219 13:09:51: Synchronizer: Total folders: 0 Logger.ts:219 13:09:51: Synchronizer: Total notes: 0 Logger.ts:219 13:09:51: Synchronizer: Total resources: 0 Logger.ts:219 13:09:51: Setting up recurrent sync with interval 300 Logger.ts:219 13:09:51: Sync has finished and note has never been changed - reloading it Logger.ts:219 13:09:51: Trying to reload note that has been deleted: null log @ Logger.ts:219 warn @ Logger.ts:92 (anonymous) @ useFormNote.ts:129 fulfilled @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:5 processTicksAndRejections @ internal/process/task_queues.js:95 Promise.then (async) step @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:7 (anonymous) @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:8 __awaiter @ /app/joplin-desktop/resources/app/gui/NoteEditor/utils/useFormNote.js:4 loadNote @ useFormNote.ts:121 (anonymous) @ useFormNote.ts:136 commitHookEffectList @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:19986 commitPassiveHookEffects @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:20016 callCallback @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:347 invokeGuardedCallbackDev @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:397 invokeGuardedCallback @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:454 flushPassiveEffectsImpl @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22868 unstable_runWithPriority @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:643 runWithPriority$2 @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:11305 flushPassiveEffects @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22841 (anonymous) @ /app/joplin-desktop/resources/app/node_modules/react-dom/cjs/react-dom.development.js:22419 scheduler_flushTaskAtPriority_Normal @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:436 flushTask @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:482 flushWork @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:607 performWorkUntilDeadline @ /app/joplin-desktop/resources/app/node_modules/scheduler/cjs/scheduler.development.js:231 Logger.ts:219 13:09:51: models/Setting: Saving settings... Logger.ts:219 13:09:51: models/Setting: Settings have been saved. Logger.ts:219 13:09:52: DecryptionWorker: cannot start because no master key is currently loaded. Logger.ts:219 13:09:59: ResourceService::indexNoteResources: Start Logger.ts:219 13:09:59: ResourceService::indexNoteResources: Completed Logger.ts:219 13:09:59: ResourceService::deleteOrphanResources:

Logfile

2022-07-19 13:04:17: App: "Profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:04:17: App: "Root profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:04:17: "Database was open successfully" 2022-07-19 13:04:17: "Checking for database schema update..." 2022-07-19 13:04:17: "Current database version", "null" 2022-07-19 13:04:17: "Upgrading database from version 0" 2022-07-19 13:04:17: "Converting database to version 1" 2022-07-19 13:04:17: "Converting database to version 2" 2022-07-19 13:04:17: "Converting database to version 3" 2022-07-19 13:04:17: "Converting database to version 4" 2022-07-19 13:04:17: "Converting database to version 5" 2022-07-19 13:04:17: "Converting database to version 6" 2022-07-19 13:04:17: "Converting database to version 7" 2022-07-19 13:04:18: "Converting database to version 8" 2022-07-19 13:04:18: "Converting database to version 9" 2022-07-19 13:04:18: "Converting database to version 10" 2022-07-19 13:04:18: "Converting database to version 11" 2022-07-19 13:04:18: "Converting database to version 12" 2022-07-19 13:04:18: "Converting database to version 13" 2022-07-19 13:04:18: "Converting database to version 14" 2022-07-19 13:04:18: "Converting database to version 15" 2022-07-19 13:04:18: "Converting database to version 16" 2022-07-19 13:04:18: "Converting database to version 17" 2022-07-19 13:04:18: "Converting database to version 18" 2022-07-19 13:04:18: "Converting database to version 19" 2022-07-19 13:04:18: "Converting database to version 20" 2022-07-19 13:04:18: "Converting database to version 21" 2022-07-19 13:04:18: "Converting database to version 22" 2022-07-19 13:04:18: "Converting database to version 23" 2022-07-19 13:04:18: "Converting database to version 24" 2022-07-19 13:04:18: "Converting database to version 25" 2022-07-19 13:04:18: "Converting database to version 26" 2022-07-19 13:04:18: "Converting database to version 27" 2022-07-19 13:04:18: "Converting database to version 28" 2022-07-19 13:04:18: "Converting database to version 29" 2022-07-19 13:04:18: "Converting database to version 30" 2022-07-19 13:04:18: "Converting database to version 31" 2022-07-19 13:04:18: "Converting database to version 32" 2022-07-19 13:04:18: "Converting database to version 33" 2022-07-19 13:04:18: "Converting database to version 34" 2022-07-19 13:04:18: "Migration failed with fallback and will not be repeated - saving version number" 2022-07-19 13:04:18: "Converting database to version 35" 2022-07-19 13:04:18: "Converting database to version 36" 2022-07-19 13:04:18: "Converting database to version 37" 2022-07-19 13:04:18: "Converting database to version 38" 2022-07-19 13:04:18: "Converting database to version 39" 2022-07-19 13:04:18: "Converting database to version 40" 2022-07-19 13:04:18: "Converting database to version 41" 2022-07-19 13:04:18: "New version: 41. Previously recorded version: 0" 2022-07-19 13:04:18: "Initializing tables..." 2022-07-19 13:04:18: "KeychainService: checking if keychain supported" 2022-07-19 13:04:18: "KeychainService: could not set test password - keychain support will be disabled" 2022-07-19 13:04:18: e2ee/utils: "Master password is not set - trying to get it from the active master key..." 2022-07-19 13:04:18: handleSyncStartupOperation: "Processing operation:", "0" 2022-07-19 13:04:18: App: "Client ID: fcb6a293527b4e6eba8b914fd30323ee" 2022-07-19 13:04:18: "First start: detected locale as en_US" 2022-07-19 13:04:18: models/Setting: "Skipping all default migrations..." 2022-07-19 13:04:18: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:18: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:18: "ResourceFetcher: Auto-add resources: Mode: always" 2022-07-19 13:04:18: "ResourceFetcher: Auto-added resources: 0" 2022-07-19 13:04:18: "Running migration: 20" 2022-07-19 13:04:18: "Running migration: 27" 2022-07-19 13:04:18: "Running migration: 33" 2022-07-19 13:04:18: "SearchEngine: Updating FTS table..." 2022-07-19 13:04:18: "Running migration: 35" 2022-07-19 13:04:18: "SearchEngine: Updating FTS table..." 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: "app.start: doing regular boot" 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:04:19: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:04:19: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:04:19: RevisionService: "runInBackground: Starting background service with revision collection interval 600000" 2022-07-19 13:04:19: SpellCheckerServiceDriverNative: "Set effective language from "en-US" to "en-US"" 2022-07-19 13:04:19: SpellCheckerServiceDriverNative: "Set effective language from "en-US" to "en-US"" 2022-07-19 13:04:20: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:04:23: RevisionService: "maintenance: Starting..." 2022-07-19 13:04:23: RevisionService: "maintenance: Service is enabled" 2022-07-19 13:04:23: RevisionService: "collectRevisions: Created revisions for 0 notes" 2022-07-19 13:04:23: RevisionService: "maintenance: Done in 163ms" 2022-07-19 13:04:28: "SearchEngine: Updating FTS table..." 2022-07-19 13:04:28: "SearchEngine: Updated FTS table in 31ms. Inserted: 0. Deleted: 5" 2022-07-19 13:04:32: RepositoryApi: "findWorkingMirror: Using: https://raw.githubusercontent.com/joplin/plugins/master" 2022-07-19 13:04:49: "ResourceService::indexNoteResources: Start" 2022-07-19 13:04:49: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:04:49: "ResourceService::deleteOrphanResources:", "[]" 2022-07-19 13:04:58: "Preparing scheduled sync" 2022-07-19 13:04:58: "Sync cancelled - no sync target is selected." 2022-07-19 13:05:21: config/lib: "Sync settings have been changed - scheduling a sync" 2022-07-19 13:05:24: "Preparing scheduled sync" 2022-07-19 13:05:24: "Starting scheduled sync" 2022-07-19 13:05:24: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257524650]" 2022-07-19 13:05:24: Synchronizer: "Indexing resources..." 2022-07-19 13:05:24: "ResourceService::indexNoteResources: Start" 2022-07-19 13:05:24: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:05:24: Synchronizer: "Sync target remote info:", "{"version_":0,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:24: Synchronizer: "Sync target is new - setting it up..." 2022-07-19 13:05:24: "MigrationHandler: Sync target version is 0 or 1 - creating "locks" and "temp" directory:", "{"version":0}" 2022-07-19 13:05:24: "MigrationHandler: Acquiring exclusive lock" 2022-07-19 13:05:24: "MigrationHandler: Acquired exclusive lock:", "{"id":null,"type":2,"clientType":1,"clientId":"fcb6a293527b4e6eba8b914fd30323ee","updatedTime":1658257524771}" 2022-07-19 13:05:24: "MigrationHandler: Migrating from version 0 to version 1" 2022-07-19 13:05:24: "MigrationHandler: Done migrating from version 0 to version 1" 2022-07-19 13:05:24: "MigrationHandler: Migrating from version 1 to version 2" 2022-07-19 13:05:24: "MigrationHandler: Done migrating from version 1 to version 2" 2022-07-19 13:05:24: "MigrationHandler: Migrating from version 2 to version 3" 2022-07-19 13:05:24: "MigrationHandler: Done migrating from version 2 to version 3" 2022-07-19 13:05:24: "MigrationHandler: Releasing exclusive lock" 2022-07-19 13:05:24: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:05:24: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:24: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote 81c8b8e8a7f34ed6b35a358c5e9a1d22)" 2022-07-19 13:05:24: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote e4209d63f1ce4d58891c853e260ed6ed)" 2022-07-19 13:05:24: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote 733c6797304b4cc79d814f8e988c3849)" 2022-07-19 13:05:24: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote fff0066989734e11b5f5637829018e4f)" 2022-07-19 13:05:24: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote 39664acea12e449a86af0449c0e28251)" 2022-07-19 13:05:25: Synchronizer: "Sync: deleteRemote: local has been deleted: (Remote 4f79e88abdfe4ba58663d377bd5c385e)" 2022-07-19 13:05:25: Synchronizer: "Sync: createRemote: remote does not exist, and local is new and has never been synced: Resource: (Local cec8a26215724179b266cd52dbb1541c)" 2022-07-19 13:05:25: Synchronizer: "Sync: createRemote: remote does not exist, and local is new and has never been synced: Resource: (Local 55db80848b5d46c6b32c90cd34a64833)" 2022-07-19 13:05:25: Synchronizer: "Sync: createRemote: remote does not exist, and local is new and has never been synced: Resource: (Local 11adb49b384a46379b41c2bfe7fb9c37)" 2022-07-19 13:05:25: Synchronizer: "BasicDelta: Report: {"timestamp":0,"older":0,"newer":4,"equal":0}" 2022-07-19 13:05:25: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:05:25: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:05:25: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:05:25: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:05:25: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:05:25: Synchronizer: "Sync: finished: Synchronisation finished [1658257524650]" 2022-07-19 13:05:25: Synchronizer: "Operations completed: " 2022-07-19 13:05:25: Synchronizer: "deleteRemote: 6" 2022-07-19 13:05:25: Synchronizer: "createRemote: 3" 2022-07-19 13:05:25: Synchronizer: "fetchingTotal: 4" 2022-07-19 13:05:25: Synchronizer: "fetchingProcessed: 4" 2022-07-19 13:05:25: Synchronizer: "Total folders: 0" 2022-07-19 13:05:25: Synchronizer: "Total notes: 0" 2022-07-19 13:05:25: Synchronizer: "Total resources: 3" 2022-07-19 13:05:25: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:05:26: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:05:34: "Preparing scheduled sync" 2022-07-19 13:05:34: "Starting scheduled sync" 2022-07-19 13:05:34: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257534598]" 2022-07-19 13:05:34: Synchronizer: "Indexing resources..." 2022-07-19 13:05:34: "ResourceService::indexNoteResources: Start" 2022-07-19 13:05:34: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:05:34: Synchronizer: "Sync target remote info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:34: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:05:34: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:34: Synchronizer: "TaskQueue.stop: syncDownload: waiting for tasks to complete: 0" 2022-07-19 13:05:34: Synchronizer: "TaskQueue.stop: syncDownload: Done, waited for 0" 2022-07-19 13:05:34: Synchronizer: "BasicDelta: Report: {"timestamp":1658257525079,"older":3,"newer":0,"equal":1}" 2022-07-19 13:05:34: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:05:34: Synchronizer: "Sync: finished: Synchronisation finished [1658257534598]" 2022-07-19 13:05:34: Synchronizer: "Operations completed: " 2022-07-19 13:05:34: Synchronizer: "fetchingTotal: -" 2022-07-19 13:05:34: Synchronizer: "Total folders: 0" 2022-07-19 13:05:34: Synchronizer: "Total notes: 0" 2022-07-19 13:05:34: Synchronizer: "Total resources: 3" 2022-07-19 13:05:34: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:05:35: "Preparing scheduled sync" 2022-07-19 13:05:35: "Starting scheduled sync" 2022-07-19 13:05:35: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257535537]" 2022-07-19 13:05:35: Synchronizer: "Indexing resources..." 2022-07-19 13:05:35: "ResourceService::indexNoteResources: Start" 2022-07-19 13:05:35: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:05:35: Synchronizer: "Sync target remote info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:35: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:05:35: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:35: Synchronizer: "TaskQueue.stop: syncDownload: waiting for tasks to complete: 0" 2022-07-19 13:05:35: Synchronizer: "TaskQueue.stop: syncDownload: Done, waited for 0" 2022-07-19 13:05:35: Synchronizer: "BasicDelta: Report: {"timestamp":1658257525079,"older":3,"newer":0,"equal":1}" 2022-07-19 13:05:35: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:05:35: Synchronizer: "Sync: finished: Synchronisation finished [1658257535537]" 2022-07-19 13:05:35: Synchronizer: "Operations completed: " 2022-07-19 13:05:35: Synchronizer: "fetchingTotal: -" 2022-07-19 13:05:35: Synchronizer: "Total folders: 0" 2022-07-19 13:05:35: Synchronizer: "Total notes: 0" 2022-07-19 13:05:35: Synchronizer: "Total resources: 3" 2022-07-19 13:05:35: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:05:35: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:05:37: RepositoryApi: "findWorkingMirror: Using: https://raw.githubusercontent.com/joplin/plugins/master" 2022-07-19 13:05:52: App: "Profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:05:52: App: "Root profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:05:52: "Database was open successfully" 2022-07-19 13:05:52: "Checking for database schema update..." 2022-07-19 13:05:52: "Current database version", "{"version":41,"table_fields_version":41}" 2022-07-19 13:05:52: "Upgrading database from version 41" 2022-07-19 13:05:52: "New version: 41. Previously recorded version: 41" 2022-07-19 13:05:52: "KeychainService: checking if keychain supported" 2022-07-19 13:05:52: "KeychainService: check was already done - skipping. Supported:", "0" 2022-07-19 13:05:52: e2ee/utils: "Master password is not set - trying to get it from the active master key..." 2022-07-19 13:05:52: handleSyncStartupOperation: "Processing operation:", "2" 2022-07-19 13:05:52: App: "Client ID: fcb6a293527b4e6eba8b914fd30323ee" 2022-07-19 13:05:52: models/Setting: "Applying default migrations..." 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: "ResourceFetcher: Auto-add resources: Mode: always" 2022-07-19 13:05:52: "ResourceFetcher: Auto-added resources: 0" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: "app.start: doing regular boot" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:05:52: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:05:52: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:05:52: RevisionService: "runInBackground: Starting background service with revision collection interval 600000" 2022-07-19 13:05:52: SpellCheckerServiceDriverNative: "Set effective language from "en-US" to "en-US"" 2022-07-19 13:05:53: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:05:53: "Preparing scheduled sync" 2022-07-19 13:05:53: "Starting scheduled sync" 2022-07-19 13:05:53: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257553964]" 2022-07-19 13:05:53: Synchronizer: "Indexing resources..." 2022-07-19 13:05:53: "ResourceService::indexNoteResources: Start" 2022-07-19 13:05:54: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:05:54: Synchronizer: "Sync target remote info:", "{"version_":0,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:54: Synchronizer: "Sync target is new - setting it up..." 2022-07-19 13:05:54: "MigrationHandler: Sync target version is 0 or 1 - creating "locks" and "temp" directory:", "{"version":0}" 2022-07-19 13:05:54: "MigrationHandler: Acquiring exclusive lock" 2022-07-19 13:05:54: "MigrationHandler: Acquired exclusive lock:", "{"id":null,"type":2,"clientType":1,"clientId":"fcb6a293527b4e6eba8b914fd30323ee","updatedTime":1658257554087}" 2022-07-19 13:05:54: "MigrationHandler: Migrating from version 0 to version 1" 2022-07-19 13:05:54: "MigrationHandler: Done migrating from version 0 to version 1" 2022-07-19 13:05:54: "MigrationHandler: Migrating from version 1 to version 2" 2022-07-19 13:05:54: "MigrationHandler: Done migrating from version 1 to version 2" 2022-07-19 13:05:54: "MigrationHandler: Migrating from version 2 to version 3" 2022-07-19 13:05:54: "MigrationHandler: Done migrating from version 2 to version 3" 2022-07-19 13:05:54: "MigrationHandler: Releasing exclusive lock" 2022-07-19 13:05:54: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:05:54: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:54: Synchronizer: "BasicDelta: Report: {"timestamp":0,"older":0,"newer":1,"equal":0}" 2022-07-19 13:05:54: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:05:54: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:05:54: Synchronizer: "Sync: finished: Synchronisation finished [1658257553964]" 2022-07-19 13:05:54: Synchronizer: "Operations completed: " 2022-07-19 13:05:54: Synchronizer: "fetchingTotal: 1" 2022-07-19 13:05:54: Synchronizer: "fetchingProcessed: 1" 2022-07-19 13:05:54: Synchronizer: "Total folders: 0" 2022-07-19 13:05:54: Synchronizer: "Total notes: 0" 2022-07-19 13:05:54: Synchronizer: "Total resources: 0" 2022-07-19 13:05:54: "Updating all notifications..." 2022-07-19 13:05:54: "Garbage collecting alarms..." 2022-07-19 13:05:54: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:05:55: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:05:55: "Preparing scheduled sync" 2022-07-19 13:05:55: "Starting scheduled sync" 2022-07-19 13:05:55: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257555342]" 2022-07-19 13:05:55: Synchronizer: "Indexing resources..." 2022-07-19 13:05:55: "ResourceService::indexNoteResources: Start" 2022-07-19 13:05:55: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:05:55: Synchronizer: "Sync target remote info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:55: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:05:55: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:05:55: Synchronizer: "TaskQueue.stop: syncDownload: waiting for tasks to complete: 0" 2022-07-19 13:05:55: Synchronizer: "TaskQueue.stop: syncDownload: Done, waited for 0" 2022-07-19 13:05:55: Synchronizer: "BasicDelta: Report: {"timestamp":1658257554195,"older":0,"newer":0,"equal":1}" 2022-07-19 13:05:55: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:05:55: Synchronizer: "Sync: finished: Synchronisation finished [1658257555342]" 2022-07-19 13:05:55: Synchronizer: "Operations completed: " 2022-07-19 13:05:55: Synchronizer: "fetchingTotal: -" 2022-07-19 13:05:55: Synchronizer: "Total folders: 0" 2022-07-19 13:05:55: Synchronizer: "Total notes: 0" 2022-07-19 13:05:55: Synchronizer: "Total resources: 0" 2022-07-19 13:05:55: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:05:56: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:05:56: RevisionService: "maintenance: Starting..." 2022-07-19 13:05:56: RevisionService: "maintenance: Service is enabled" 2022-07-19 13:05:57: RevisionService: "collectRevisions: Created revisions for 0 notes" 2022-07-19 13:05:57: RevisionService: "maintenance: Done in 106ms" 2022-07-19 13:06:02: "SearchEngine: Updating FTS table..." 2022-07-19 13:06:03: "SearchEngine: Updated FTS table in 3ms. Inserted: 0. Deleted: 0" 2022-07-19 13:06:23: "ResourceService::indexNoteResources: Start" 2022-07-19 13:06:23: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:06:23: "ResourceService::deleteOrphanResources:", "[]" 2022-07-19 13:09:29: App: "Profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:09:29: App: "Root profile directory: /home/jschrag/.config/joplin-desktop" 2022-07-19 13:09:29: "Database was open successfully" 2022-07-19 13:09:29: "Checking for database schema update..." 2022-07-19 13:09:29: "Current database version", "{"version":41,"table_fields_version":41}" 2022-07-19 13:09:29: "Upgrading database from version 41" 2022-07-19 13:09:29: "New version: 41. Previously recorded version: 41" 2022-07-19 13:09:29: "KeychainService: checking if keychain supported" 2022-07-19 13:09:29: "KeychainService: check was already done - skipping. Supported:", "0" 2022-07-19 13:09:29: e2ee/utils: "Master password is not set - trying to get it from the active master key..." 2022-07-19 13:09:29: handleSyncStartupOperation: "Processing operation:", "0" 2022-07-19 13:09:29: App: "Client ID: fcb6a293527b4e6eba8b914fd30323ee" 2022-07-19 13:09:29: models/Setting: "Applying default migrations..." 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "ResourceFetcher: Auto-add resources: Mode: always" 2022-07-19 13:09:29: "ResourceFetcher: Auto-added resources: 0" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: "Setting up recurrent sync with interval 300" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: "app.start: doing regular boot" 2022-07-19 13:09:29: App: "Refreshing notes:", "null", "null" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: "Setting up recurrent sync with interval 300" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: App: ""syncInfoCache" was changed - setting up encryption related code" 2022-07-19 13:09:29: e2ee/utils: "Trying to load 0 master keys..." 2022-07-19 13:09:29: e2ee/utils: "Loaded master keys: 0" 2022-07-19 13:09:29: "Scheduling sync operation...", "10000" 2022-07-19 13:09:29: App: "Refreshing notes:", "null", "null" 2022-07-19 13:09:29: "Scheduling sync operation...", "1000" 2022-07-19 13:09:29: RevisionService: "runInBackground: Starting background service with revision collection interval 600000" 2022-07-19 13:09:29: SpellCheckerServiceDriverNative: "Set effective language from "en-US" to "en-US"" 2022-07-19 13:09:30: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:09:30: "Preparing scheduled sync" 2022-07-19 13:09:30: "Starting scheduled sync" 2022-07-19 13:09:30: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257770490]" 2022-07-19 13:09:30: Synchronizer: "Indexing resources..." 2022-07-19 13:09:30: "ResourceService::indexNoteResources: Start" 2022-07-19 13:09:30: models/Setting: "Saving settings..." 2022-07-19 13:09:30: models/Setting: "Settings have been saved." 2022-07-19 13:09:30: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:09:30: models/Folder: "updateFolderShareIds:", "{"shareUpdateCount":0,"unshareUpdateCount":0}" 2022-07-19 13:09:30: models/Folder: "updateNoteShareIds: notes to update:", "0" 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/info.json" 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/.sync/version.txt" 2022-07-19 13:09:30: Synchronizer: "Sync target remote info:", "{"version_":0,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:09:30: Synchronizer: "Sync target is new - setting it up..." 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/info.json" 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/.sync/version.txt" 2022-07-19 13:09:30: "MigrationHandler: Sync target version is 0 or 1 - creating "locks" and "temp" directory:", "{"version":0}" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/locks" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/temp" 2022-07-19 13:09:30: "MigrationHandler: Acquiring exclusive lock" 2022-07-19 13:09:30: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/temp/timeCheck434825.txt", "null" 2022-07-19 13:09:30: FileApi: "stat /mnt/windows/documents/Joplin/temp/timeCheck434825.txt" 2022-07-19 13:09:30: FileApi: "delete /mnt/windows/documents/Joplin/temp/timeCheck434825.txt" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json", "null" 2022-07-19 13:09:30: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json", "null" 2022-07-19 13:09:30: "MigrationHandler: Acquired exclusive lock:", "{"id":null,"type":2,"clientType":1,"clientId":"fcb6a293527b4e6eba8b914fd30323ee","updatedTime":1658257770606}" 2022-07-19 13:09:30: "MigrationHandler: Migrating from version 0 to version 1" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/.resource" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/.sync" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/.lock" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/.sync/version.txt", "null" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/info.json", "null" 2022-07-19 13:09:30: "MigrationHandler: Done migrating from version 0 to version 1" 2022-07-19 13:09:30: "MigrationHandler: Migrating from version 1 to version 2" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/.sync/version.txt", "null" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/.sync/readme.txt", "null" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/locks" 2022-07-19 13:09:30: FileApi: "mkdir /mnt/windows/documents/Joplin/temp" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/info.json", "null" 2022-07-19 13:09:30: "MigrationHandler: Done migrating from version 1 to version 2" 2022-07-19 13:09:30: "MigrationHandler: Migrating from version 2 to version 3" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/info.json", "null" 2022-07-19 13:09:30: "MigrationHandler: Done migrating from version 2 to version 3" 2022-07-19 13:09:30: "MigrationHandler: Releasing exclusive lock" 2022-07-19 13:09:30: FileApi: "delete /mnt/windows/documents/Joplin/locks/2_1_fcb6a293527b4e6eba8b914fd30323ee.json" 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/info.json" 2022-07-19 13:09:30: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:09:30: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:09:30: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:30: FileApi: "put /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json", "null" 2022-07-19 13:09:30: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:30: FileApi: "delta /mnt/windows/documents/Joplin" 2022-07-19 13:09:30: Synchronizer: "BasicDelta: Report: {"timestamp":1658257554195,"older":0,"newer":1,"equal":0}" 2022-07-19 13:09:30: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:09:30: FileApi: "get /mnt/windows/documents/Joplin/info.json" 2022-07-19 13:09:30: Synchronizer: "Sync: fetchingProcessed: Processing fetched item" 2022-07-19 13:09:30: FileApi: "delete /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json" 2022-07-19 13:09:30: Synchronizer: "Sync: finished: Synchronisation finished [1658257770490]" 2022-07-19 13:09:30: Synchronizer: "Operations completed: " 2022-07-19 13:09:30: Synchronizer: "fetchingTotal: 1" 2022-07-19 13:09:30: Synchronizer: "fetchingProcessed: 1" 2022-07-19 13:09:30: Synchronizer: "Total folders: 0" 2022-07-19 13:09:30: Synchronizer: "Total notes: 0" 2022-07-19 13:09:30: Synchronizer: "Total resources: 0" 2022-07-19 13:09:30: "Setting up recurrent sync with interval 300" 2022-07-19 13:09:30: "Updating all notifications..." 2022-07-19 13:09:30: "Garbage collecting alarms..." 2022-07-19 13:09:30: "Sync has finished and note has never been changed - reloading it" 2022-07-19 13:09:30: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:09:31: models/Setting: "Saving settings..." 2022-07-19 13:09:31: models/Setting: "Settings have been saved." 2022-07-19 13:09:31: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:09:33: RevisionService: "maintenance: Starting..." 2022-07-19 13:09:33: RevisionService: "maintenance: Service is enabled" 2022-07-19 13:09:33: RevisionService: "collectRevisions: Created revisions for 0 notes" 2022-07-19 13:09:33: RevisionService: "maintenance: Done in 107ms" 2022-07-19 13:09:39: "SearchEngine: Updating FTS table..." 2022-07-19 13:09:39: "SearchEngine: Updated FTS table in 3ms. Inserted: 0. Deleted: 0" 2022-07-19 13:09:51: "CommandService::execute:", "synchronize", "[false]" 2022-07-19 13:09:51: "Scheduling sync operation...", "0" 2022-07-19 13:09:51: "Preparing scheduled sync" 2022-07-19 13:09:51: "Starting scheduled sync" 2022-07-19 13:09:51: Synchronizer: "Sync: starting: Starting synchronisation to target 2... supportsAccurateTimestamp = false; supportsMultiPut = false [1658257791290]" 2022-07-19 13:09:51: Synchronizer: "Indexing resources..." 2022-07-19 13:09:51: "ResourceService::indexNoteResources: Start" 2022-07-19 13:09:51: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:09:51: models/Folder: "updateFolderShareIds:", "{"shareUpdateCount":0,"unshareUpdateCount":0}" 2022-07-19 13:09:51: models/Folder: "updateNoteShareIds: notes to update:", "0" 2022-07-19 13:09:51: FileApi: "get /mnt/windows/documents/Joplin/info.json" 2022-07-19 13:09:51: Synchronizer: "Sync target remote info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:09:51: Synchronizer: "Sync target is already setup - checking it..." 2022-07-19 13:09:51: Synchronizer: "Sync target local info:", "{"version_":3,"masterKeys_":[],"e2ee_":{"value":false,"updatedTime":0},"activeMasterKeyId_":{"value":"","updatedTime":0},"ppk_":{"value":null,"updatedTime":0}}" 2022-07-19 13:09:51: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:51: FileApi: "put /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json", "null" 2022-07-19 13:09:51: FileApi: "list /mnt/windows/documents/Joplin" 2022-07-19 13:09:51: Synchronizer: "TaskQueue.stop: syncDownload: waiting for tasks to complete: 0" 2022-07-19 13:09:51: Synchronizer: "TaskQueue.stop: syncDownload: Done, waited for 0" 2022-07-19 13:09:51: FileApi: "delta /mnt/windows/documents/Joplin" 2022-07-19 13:09:51: Synchronizer: "BasicDelta: Report: {"timestamp":1658257770714,"older":0,"newer":0,"equal":1}" 2022-07-19 13:09:51: Synchronizer: "Sync: fetchingTotal: Fetching delta items from sync target" 2022-07-19 13:09:51: FileApi: "delete /mnt/windows/documents/Joplin/locks/1_1_fcb6a293527b4e6eba8b914fd30323ee.json" 2022-07-19 13:09:51: Synchronizer: "Sync: finished: Synchronisation finished [1658257791290]" 2022-07-19 13:09:51: Synchronizer: "Operations completed: " 2022-07-19 13:09:51: Synchronizer: "fetchingTotal: -" 2022-07-19 13:09:51: Synchronizer: "Total folders: 0" 2022-07-19 13:09:51: Synchronizer: "Total notes: 0" 2022-07-19 13:09:51: Synchronizer: "Total resources: 0" 2022-07-19 13:09:51: "Setting up recurrent sync with interval 300" 2022-07-19 13:09:51: "Sync has finished and note has never been changed - reloading it" 2022-07-19 13:09:51: "Trying to reload note that has been deleted:", "null" 2022-07-19 13:09:51: models/Setting: "Saving settings..." 2022-07-19 13:09:51: models/Setting: "Settings have been saved." 2022-07-19 13:09:52: "DecryptionWorker: cannot start because no master key is currently loaded." 2022-07-19 13:09:59: "ResourceService::indexNoteResources: Start" 2022-07-19 13:09:59: "ResourceService::indexNoteResources: Completed" 2022-07-19 13:09:59: "ResourceService::deleteOrphanResources:", "[]"

jlschrag avatar Jul 19 '22 19:07 jlschrag

I'm experiencing the same issue on Android, syncing from Nextcloud. Its a fresh install, it synced some items but left most unsynced and will not sync them anymore.

kelvinhammond avatar Jul 22 '22 22:07 kelvinhammond

Hey there, it looks like there has been no activity on this issue recently. Has the issue been fixed, or does it still require the community's attention? If you require support or are requesting an enhancement or feature then please create a topic on the Joplin forum. This issue may be closed if no further activity occurs. You may comment on the issue and I will leave it open. Thank you for your contributions.

github-actions[bot] avatar Aug 22 '22 16:08 github-actions[bot]

Closing this issue after a prolonged period of inactivity. If this issue is still present in the latest release, feel free to create a new issue with up-to-date information.

github-actions[bot] avatar Aug 30 '22 16:08 github-actions[bot]