"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 4/5) 2025/10/23 04:34:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo" 2025/10/23 04:34:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/23 04:34:52 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Has cached credentials 2025/10/23 04:34:53 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:34:54 DEBUG : Creating backend with remote "/tmp/rclone494788505" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:34:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tihiquk7xoha" 2025/10/23 04:34:56 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Has cached credentials 2025/10/23 04:34:57 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-sabutik5yolo' -> proton drive root link ID 'rclone-test-tihiquk7xoha' 2025/10/23 04:34:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/23 04:34:58 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Waiting for checks to finish 2025/10/23 04:34:58 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Waiting for transfers to finish 2025/10/23 04:35:01 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/23 04:35:01 INFO : sub dir/hello world: Copied (new) 2025/10/23 04:35:02.382276 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/10/23 04:35:02.382362 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/10/23 04:35:04 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Using server-side directory move 2025/10/23 04:35:04 INFO : proton drive root link ID 'rclone-test-tihiquk7xoha': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:35:04 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/23 04:35:04 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Waiting for checks to finish 2025/10/23 04:35:04 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Waiting for transfers to finish 2025/10/23 04:35:04 INFO : sub dir/hello world: Deleted 2025/10/23 04:35:05.453854 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r5nJJSO1rBiqAXdj6CdWyyQ7spk9o3Rjmweop-3J6aJccrZV7ZZPFXqVCB_4LS7QYkEG0ixV7NK6Rty8yZcQDQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:05.453887 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r5nJJSO1rBiqAXdj6CdWyyQ7spk9o3Rjmweop-3J6aJccrZV7ZZPFXqVCB_4LS7QYkEG0ixV7NK6Rty8yZcQDQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:05 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r5nJJSO1rBiqAXdj6CdWyyQ7spk9o3Rjmweop-3J6aJccrZV7ZZPFXqVCB_4LS7QYkEG0ixV7NK6Rty8yZcQDQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r5nJJSO1rBiqAXdj6CdWyyQ7spk9o3Rjmweop-3J6aJccrZV7ZZPFXqVCB_4LS7QYkEG0ixV7NK6Rty8yZcQDQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/10/23 04:35:05 DEBUG : proton drive root link ID 'rclone-test-tihiquk7xoha': Purge remote --- FAIL: TestServerSideMoveOverSelf (12.89s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/10/23 04:35:07 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:07 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:07 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:07 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:07 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:35:07 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:35:07 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:08 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:08 INFO : yam: Copied (new) 2025/10/23 04:35:08 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:35:08 INFO : potato: Copied (new) 2025/10/23 04:35:08 DEBUG : Waiting for deletions to finish 2025/10/23 04:35:09 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:35:09 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:09 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:09 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:09 DEBUG : potato: Unchanged skipping 2025/10/23 04:35:09 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:09.593558 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ty_dYdc_OGeawNQNIdf91sP0R2NVxTAR3Zw9N8DrtoD5Tp7gJY84uwundlBfUMBnFQlTER0igSevfKzLNJ-oHg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:09.593593 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ty_dYdc_OGeawNQNIdf91sP0R2NVxTAR3Zw9N8DrtoD5Tp7gJY84uwundlBfUMBnFQlTER0igSevfKzLNJ-oHg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:09 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ty_dYdc_OGeawNQNIdf91sP0R2NVxTAR3Zw9N8DrtoD5Tp7gJY84uwundlBfUMBnFQlTER0igSevfKzLNJ-oHg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:09 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ty_dYdc_OGeawNQNIdf91sP0R2NVxTAR3Zw9N8DrtoD5Tp7gJY84uwundlBfUMBnFQlTER0igSevfKzLNJ-oHg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:09 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/23 04:35:09 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:10 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:10 INFO : yaml: Copied (new) 2025/10/23 04:35:10 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting files as there were IO errors 2025/10/23 04:35:10 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (4.83s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/10/23 04:35:11 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:11 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:11 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:11 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:35:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:35:11 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:11 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:13 INFO : yam: Copied (new) 2025/10/23 04:35:13 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:35:13 INFO : potato: Copied (new) 2025/10/23 04:35:13 DEBUG : Waiting for deletions to finish 2025/10/23 04:35:13 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:35:13 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:13 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:13 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:13 DEBUG : potato: Unchanged skipping 2025/10/23 04:35:13 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:14.207798 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HUhllssknfhBH6jJAyap2n3LeFoIdXVWVMYhY8uaOiUsyWYiX0aXz6DkG_8CaE3bHiUt-gOLQbKpf89fQm0AhQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:14.207847 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HUhllssknfhBH6jJAyap2n3LeFoIdXVWVMYhY8uaOiUsyWYiX0aXz6DkG_8CaE3bHiUt-gOLQbKpf89fQm0AhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:14 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HUhllssknfhBH6jJAyap2n3LeFoIdXVWVMYhY8uaOiUsyWYiX0aXz6DkG_8CaE3bHiUt-gOLQbKpf89fQm0AhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:14 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HUhllssknfhBH6jJAyap2n3LeFoIdXVWVMYhY8uaOiUsyWYiX0aXz6DkG_8CaE3bHiUt-gOLQbKpf89fQm0AhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:14 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/23 04:35:14 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:15 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:15 INFO : yaml: Copied (new) 2025/10/23 04:35:15 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting files as there were IO errors 2025/10/23 04:35:15 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (4.75s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/10/23 04:35:16 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:16 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:16 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:16 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/10/23 04:35:16 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:35:16 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:16 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:18 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:18 INFO : sub/yam: Copied (new) 2025/10/23 04:35:18 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:35:18 INFO : potato: Copied (new) 2025/10/23 04:35:18 DEBUG : Waiting for deletions to finish 2025/10/23 04:35:19 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:35:19 DEBUG : potato: Unchanged skipping 2025/10/23 04:35:19 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Making map for --track-renames 2025/10/23 04:35:19 INFO : proton drive root link ID 'rclone-test-sabutik5yolo': Finished making map for --track-renames 2025/10/23 04:35:19 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:19 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for renames to finish 2025/10/23 04:35:19.919928 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R2r0sDZX8ECQfjVNtFVrZLfqNTsKLGzoUZA_9Mb1hpMZ8WA7Pvl8jPXrFBydg0Gqa9G3ul9tMkpJn-klfvjQiQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:19.919965 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R2r0sDZX8ECQfjVNtFVrZLfqNTsKLGzoUZA_9Mb1hpMZ8WA7Pvl8jPXrFBydg0Gqa9G3ul9tMkpJn-klfvjQiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:19 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R2r0sDZX8ECQfjVNtFVrZLfqNTsKLGzoUZA_9Mb1hpMZ8WA7Pvl8jPXrFBydg0Gqa9G3ul9tMkpJn-klfvjQiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:19 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R2r0sDZX8ECQfjVNtFVrZLfqNTsKLGzoUZA_9Mb1hpMZ8WA7Pvl8jPXrFBydg0Gqa9G3ul9tMkpJn-klfvjQiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:19 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:35:19 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:35:21 INFO : yam: Copied (new) 2025/10/23 04:35:21 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting files as there were IO errors 2025/10/23 04:35:21 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (6.63s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:35:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/23 04:35:23 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/10/23 04:35:23 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for checks to finish 2025/10/23 04:35:23 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Waiting for transfers to finish 2025/10/23 04:35:25 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/23 04:35:25 INFO : sub dir/hello world: Copied (new) 2025/10/23 04:35:25 INFO : sub dir/hello world: Deleted 2025/10/23 04:35:25 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/10/23 04:35:25 INFO : nested/sub dir/file: Copied (new) 2025/10/23 04:35:25 INFO : nested/sub dir/file: Deleted 2025/10/23 04:35:25 ERROR : Local file system at /tmp/rclone494788505: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (4.55s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:35:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-duxoram5vime" 2025/10/23 04:35:27 DEBUG : Config file has changed externally - reloading 2025/10/23 04:35:27 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Has cached credentials 2025/10/23 04:35:28 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-sabutik5yolo' -> proton drive root link ID 'rclone-test-duxoram5vime' 2025/10/23 04:35:35 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Using server-side directory move 2025/10/23 04:35:35 INFO : proton drive root link ID 'rclone-test-duxoram5vime': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:35:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:35:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/23 04:35:36 DEBUG : empty space: Unchanged skipping 2025/10/23 04:35:36 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Waiting for checks to finish 2025/10/23 04:35:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:35:36 INFO : potato3: Deleted 2025/10/23 04:35:36 INFO : empty space: Deleted 2025/10/23 04:35:36 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Waiting for transfers to finish 2025/10/23 04:35:36.815353 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f3fNMXfFeDy5sY1Ynw2BRCLNwF07igiXMnwA09vwEPAk4DfT3rcLb6JT2cEXQUNfABLJTw4gsbIUfr7cijqdCg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:36.815385 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f3fNMXfFeDy5sY1Ynw2BRCLNwF07igiXMnwA09vwEPAk4DfT3rcLb6JT2cEXQUNfABLJTw4gsbIUfr7cijqdCg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:36 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f3fNMXfFeDy5sY1Ynw2BRCLNwF07igiXMnwA09vwEPAk4DfT3rcLb6JT2cEXQUNfABLJTw4gsbIUfr7cijqdCg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:36.935552 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eSMeSw_nik_E1s4Gt6NaA7bWtR6RXCFGe-jhXHNb82gzNAuTu4sZ4rK7jUnEM8T-oJflsIzmXL9avj0xZqzARA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:36.935584 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eSMeSw_nik_E1s4Gt6NaA7bWtR6RXCFGe-jhXHNb82gzNAuTu4sZ4rK7jUnEM8T-oJflsIzmXL9avj0xZqzARA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:36 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eSMeSw_nik_E1s4Gt6NaA7bWtR6RXCFGe-jhXHNb82gzNAuTu4sZ4rK7jUnEM8T-oJflsIzmXL9avj0xZqzARA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1911 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eSMeSw_nik_E1s4Gt6NaA7bWtR6RXCFGe-jhXHNb82gzNAuTu4sZ4rK7jUnEM8T-oJflsIzmXL9avj0xZqzARA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/10/23 04:35:36 DEBUG : proton drive root link ID 'rclone-test-duxoram5vime': Purge remote --- FAIL: TestServerSideMove (10.73s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:35:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zakofum6yihe" 2025/10/23 04:35:38 DEBUG : proton drive root link ID 'rclone-test-zakofum6yihe': Has cached credentials 2025/10/23 04:35:39 DEBUG : proton drive root link ID 'rclone-test-zakofum6yihe': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-sabutik5yolo' -> proton drive root link ID 'rclone-test-zakofum6yihe' 2025/10/23 04:35:46 DEBUG : empty space: Excluded (Size Filter) 2025/10/23 04:35:46 DEBUG : empty space: Excluded 2025/10/23 04:35:47 DEBUG : empty space: Excluded (Size Filter) 2025/10/23 04:35:47 DEBUG : empty space: Excluded 2025/10/23 04:35:47 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:35:47 DEBUG : proton drive root link ID 'rclone-test-zakofum6yihe': Waiting for checks to finish 2025/10/23 04:35:47 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:35:47 DEBUG : proton drive root link ID 'rclone-test-zakofum6yihe': Waiting for transfers to finish 2025/10/23 04:35:47 INFO : potato3: Deleted 2025/10/23 04:35:47.443986 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/--QlGus_ZJTu8buZ-t2IKDa2f7GKhZhg5DdwtATkQA_Nou3_MEhb9qjMvAeYW9BqGBSRwnqO02IgBe9FPce6Wg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:47.444030 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/--QlGus_ZJTu8buZ-t2IKDa2f7GKhZhg5DdwtATkQA_Nou3_MEhb9qjMvAeYW9BqGBSRwnqO02IgBe9FPce6Wg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:47 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/--QlGus_ZJTu8buZ-t2IKDa2f7GKhZhg5DdwtATkQA_Nou3_MEhb9qjMvAeYW9BqGBSRwnqO02IgBe9FPce6Wg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:47.530155 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pkJbZBgD8MFHBUORtzqGkz5eHtROZj4aukkmzgqEryT3Smju49_g53RhR7BYp7YysgTQLYdNv75nQLwGpg9tcg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:47.530192 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pkJbZBgD8MFHBUORtzqGkz5eHtROZj4aukkmzgqEryT3Smju49_g53RhR7BYp7YysgTQLYdNv75nQLwGpg9tcg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:47 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pkJbZBgD8MFHBUORtzqGkz5eHtROZj4aukkmzgqEryT3Smju49_g53RhR7BYp7YysgTQLYdNv75nQLwGpg9tcg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1924 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pkJbZBgD8MFHBUORtzqGkz5eHtROZj4aukkmzgqEryT3Smju49_g53RhR7BYp7YysgTQLYdNv75nQLwGpg9tcg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/10/23 04:35:47 DEBUG : proton drive root link ID 'rclone-test-zakofum6yihe': Purge remote --- FAIL: TestServerSideMoveWithFilter (10.76s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:35:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuhonub4xiga" 2025/10/23 04:35:49 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Has cached credentials 2025/10/23 04:35:50 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:35:53 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-sabutik5yolo' -> proton drive root link ID 'rclone-test-wuhonub4xiga' 2025/10/23 04:35:57 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Using server-side directory move 2025/10/23 04:35:57 INFO : proton drive root link ID 'rclone-test-wuhonub4xiga': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:35:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:35:57 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/23 04:35:57 DEBUG : empty space: Unchanged skipping 2025/10/23 04:35:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:35:57 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Waiting for checks to finish 2025/10/23 04:35:58 INFO : empty space: Deleted 2025/10/23 04:35:58 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Waiting for transfers to finish 2025/10/23 04:35:58 INFO : potato3: Deleted 2025/10/23 04:35:58.232140 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vyLtIjpoSQqBfwL7vDumGfFTKaMqHCqhB7YKqVCU97ABfZ0Ao0o6M4_VhYd8f74G2eitGnfS1tnxBIWkcJcRZw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:58.232171 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vyLtIjpoSQqBfwL7vDumGfFTKaMqHCqhB7YKqVCU97ABfZ0Ao0o6M4_VhYd8f74G2eitGnfS1tnxBIWkcJcRZw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vyLtIjpoSQqBfwL7vDumGfFTKaMqHCqhB7YKqVCU97ABfZ0Ao0o6M4_VhYd8f74G2eitGnfS1tnxBIWkcJcRZw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:58.539195 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YSjua26tQCD1RUpED20mOTW6UfanXWaUlGO-FyTHPTUGoscWsdV8MKaWU6h8NDmZC4UtCAhTL04Tt03zYnD0Gg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:35:58.539224 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YSjua26tQCD1RUpED20mOTW6UfanXWaUlGO-FyTHPTUGoscWsdV8MKaWU6h8NDmZC4UtCAhTL04Tt03zYnD0Gg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YSjua26tQCD1RUpED20mOTW6UfanXWaUlGO-FyTHPTUGoscWsdV8MKaWU6h8NDmZC4UtCAhTL04Tt03zYnD0Gg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:35:58 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/10/23 04:35:58 DEBUG : proton drive root link ID 'rclone-test-wuhonub4xiga': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (10.94s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:36:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/dst" 2025/10/23 04:36:04 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Has cached credentials 2025/10/23 04:36:05 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:37:48 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/backup" 2025/10/23 04:37:48 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Has cached credentials 2025/10/23 04:37:49 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:41:11 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 04:41:11 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:41:11 DEBUG : two: Unchanged skipping 2025/10/23 04:41:11 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for checks to finish 2025/10/23 04:41:12.058349 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qezd14IgwAuMvBrRfFpgJfSbu8aYP87_fg4P5dClLE882sHtMmoWZCWL0e26ye6k9gfu84BC4d-yUAz5UZ0PeQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:41:12.058422 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qezd14IgwAuMvBrRfFpgJfSbu8aYP87_fg4P5dClLE882sHtMmoWZCWL0e26ye6k9gfu84BC4d-yUAz5UZ0PeQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:41:12 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qezd14IgwAuMvBrRfFpgJfSbu8aYP87_fg4P5dClLE882sHtMmoWZCWL0e26ye6k9gfu84BC4d-yUAz5UZ0PeQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:41:12 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for transfers to finish 2025/10/23 04:41:12 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting files as there were IO errors 2025/10/23 04:41:12 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qezd14IgwAuMvBrRfFpgJfSbu8aYP87_fg4P5dClLE882sHtMmoWZCWL0e26ye6k9gfu84BC4d-yUAz5UZ0PeQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (313.94s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:41:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/dst" 2025/10/23 04:41:18 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Has cached credentials 2025/10/23 04:41:19 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:42:57 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/backup" 2025/10/23 04:42:57 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Has cached credentials 2025/10/23 04:42:58 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:46:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 04:46:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:46:14 DEBUG : two: Unchanged skipping 2025/10/23 04:46:14 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for checks to finish 2025/10/23 04:46:15.371216 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SVpRKqkSCnW7JvSqRUQ4Xp552559lVorek_Q-_N2ZzYDNFU2znbIjRNgsRTs5Ks2wzUKJmyg6CRapl1bJB0HYg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:46:15.371269 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SVpRKqkSCnW7JvSqRUQ4Xp552559lVorek_Q-_N2ZzYDNFU2znbIjRNgsRTs5Ks2wzUKJmyg6CRapl1bJB0HYg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:46:15 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SVpRKqkSCnW7JvSqRUQ4Xp552559lVorek_Q-_N2ZzYDNFU2znbIjRNgsRTs5Ks2wzUKJmyg6CRapl1bJB0HYg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:46:15 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for transfers to finish 2025/10/23 04:46:15 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting files as there were IO errors 2025/10/23 04:46:15 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SVpRKqkSCnW7JvSqRUQ4Xp552559lVorek_Q-_N2ZzYDNFU2znbIjRNgsRTs5Ks2wzUKJmyg6CRapl1bJB0HYg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (303.30s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:46:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/dst" 2025/10/23 04:46:22 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Has cached credentials 2025/10/23 04:46:23 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:47:58 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/backup" 2025/10/23 04:47:58 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Has cached credentials 2025/10/23 04:47:59 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:51:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 04:51:13 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:51:13 DEBUG : two: Unchanged skipping 2025/10/23 04:51:13 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for checks to finish 2025/10/23 04:51:14.000603 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mAp3jiizRBRGUFUTUpcAigKQRklTifGGJr7LEJ0oiuJc0ooNrQ1kxEL-uXLYpylf6uG6TQSmBwx2tpwa19ssaw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:51:14.000698 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mAp3jiizRBRGUFUTUpcAigKQRklTifGGJr7LEJ0oiuJc0ooNrQ1kxEL-uXLYpylf6uG6TQSmBwx2tpwa19ssaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:51:14 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mAp3jiizRBRGUFUTUpcAigKQRklTifGGJr7LEJ0oiuJc0ooNrQ1kxEL-uXLYpylf6uG6TQSmBwx2tpwa19ssaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:51:14 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for transfers to finish 2025/10/23 04:51:14 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting files as there were IO errors 2025/10/23 04:51:14 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mAp3jiizRBRGUFUTUpcAigKQRklTifGGJr7LEJ0oiuJc0ooNrQ1kxEL-uXLYpylf6uG6TQSmBwx2tpwa19ssaw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (298.90s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-sabutik5yolo'", Local "Local file system at /tmp/rclone494788505", Modify Window "1s" 2025/10/23 04:51:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sabutik5yolo/dst" 2025/10/23 04:51:20 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Has cached credentials 2025/10/23 04:51:21 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:53:01 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 04:53:01 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for checks to finish 2025/10/23 04:53:01 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:53:01 DEBUG : two: Unchanged skipping 2025/10/23 04:53:01.668025 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dYIVXdHjbydrSm9V8z4fC7GXfdCmsLJUzwkQt8ZaM2r98Jp9ZWOsmU3A5ksNdK8VpEo8sJ_bEOmldZW8YZUn6w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:53:01.668091 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dYIVXdHjbydrSm9V8z4fC7GXfdCmsLJUzwkQt8ZaM2r98Jp9ZWOsmU3A5ksNdK8VpEo8sJ_bEOmldZW8YZUn6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:01 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dYIVXdHjbydrSm9V8z4fC7GXfdCmsLJUzwkQt8ZaM2r98Jp9ZWOsmU3A5ksNdK8VpEo8sJ_bEOmldZW8YZUn6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:01 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo/dst': Waiting for transfers to finish 2025/10/23 04:53:01 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting files as there were IO errors 2025/10/23 04:53:01 ERROR : proton drive root link ID 'rclone-test-sabutik5yolo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dYIVXdHjbydrSm9V8z4fC7GXfdCmsLJUzwkQt8ZaM2r98Jp9ZWOsmU3A5ksNdK8VpEo8sJ_bEOmldZW8YZUn6w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (107.23s) FAIL 2025/10/23 04:53:03 DEBUG : proton drive root link ID 'rclone-test-sabutik5yolo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 18m11.163394201s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]