"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 5/5) 2025/07/13 03:59:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo" 2025/07/13 03:59:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/13 03:59:37 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Has cached credentials 2025/07/13 03:59:38 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Used cached credential to initialize the ProtonDrive API 2025/07/13 03:59:38 DEBUG : Creating backend with remote "/tmp/rclone2182635288" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 03:59:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-jojayof4qeba" 2025/07/13 03:59:41 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Has cached credentials 2025/07/13 03:59:42 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-kiximan3gulo' -> proton drive root link ID 'rclone-test-jojayof4qeba' 2025/07/13 03:59:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/13 03:59:43 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Waiting for checks to finish 2025/07/13 03:59:43 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Waiting for transfers to finish 2025/07/13 03:59:45 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/13 03:59:45 INFO : sub dir/hello world: Copied (new) 2025/07/13 03:59:46.701226 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/07/13 03:59:46.701280 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/07/13 03:59:48 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Using server-side directory move 2025/07/13 03:59:48 INFO : proton drive root link ID 'rclone-test-jojayof4qeba': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/13 03:59:49 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Waiting for checks to finish 2025/07/13 03:59:49 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/13 03:59:49 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Waiting for transfers to finish 2025/07/13 03:59:49 INFO : sub dir/hello world: Deleted 2025/07/13 03:59:49.735596 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vnRmM62qprTQ1HdScCDuhqQdZfxGN1_u8MjtuQl7q9ZAv34oG15kQCF_NNa1kbSwtQfUvn0wururm3dVCS6iyg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 03:59:49.735633 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vnRmM62qprTQ1HdScCDuhqQdZfxGN1_u8MjtuQl7q9ZAv34oG15kQCF_NNa1kbSwtQfUvn0wururm3dVCS6iyg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:49 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vnRmM62qprTQ1HdScCDuhqQdZfxGN1_u8MjtuQl7q9ZAv34oG15kQCF_NNa1kbSwtQfUvn0wururm3dVCS6iyg==/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/vnRmM62qprTQ1HdScCDuhqQdZfxGN1_u8MjtuQl7q9ZAv34oG15kQCF_NNa1kbSwtQfUvn0wururm3dVCS6iyg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/13 03:59:49 DEBUG : proton drive root link ID 'rclone-test-jojayof4qeba': Purge remote --- FAIL: TestServerSideMoveOverSelf (12.20s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/07/13 03:59:51 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 03:59:51 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 03:59:51 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 03:59:51 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/13 03:59:51 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 03:59:51 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/13 03:59:51 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 03:59:52 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/13 03:59:52 INFO : potato: Copied (new) 2025/07/13 03:59:52 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 03:59:52 INFO : yam: Copied (new) 2025/07/13 03:59:52 DEBUG : Waiting for deletions to finish 2025/07/13 03:59:53 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 03:59:53 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 03:59:53 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 03:59:53 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 03:59:53 DEBUG : potato: Unchanged skipping 2025/07/13 03:59:53 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 03:59:53.793926 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/foTdy2xRuo2lm08pGqS1Ppr9TIuL4UsiDzkmieHy0IFsc3lvLsl70aE6x7L-T-iwwAk_1_MMLf4iJoW4QKzz6w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 03:59:53.793970 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/foTdy2xRuo2lm08pGqS1Ppr9TIuL4UsiDzkmieHy0IFsc3lvLsl70aE6x7L-T-iwwAk_1_MMLf4iJoW4QKzz6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:53 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/foTdy2xRuo2lm08pGqS1Ppr9TIuL4UsiDzkmieHy0IFsc3lvLsl70aE6x7L-T-iwwAk_1_MMLf4iJoW4QKzz6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:53 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/foTdy2xRuo2lm08pGqS1Ppr9TIuL4UsiDzkmieHy0IFsc3lvLsl70aE6x7L-T-iwwAk_1_MMLf4iJoW4QKzz6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:53 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/13 03:59:53 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 03:59:55 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 03:59:55 INFO : yaml: Copied (new) 2025/07/13 03:59:55 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': not deleting files as there were IO errors 2025/07/13 03:59:55 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': 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 (5.05s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/07/13 03:59:56 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 03:59:56 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 03:59:56 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 03:59:56 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/13 03:59:56 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/13 03:59:56 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 03:59:56 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 03:59:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/13 03:59:57 INFO : potato: Copied (new) 2025/07/13 03:59:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 03:59:57 INFO : yam: Copied (new) 2025/07/13 03:59:57 DEBUG : Waiting for deletions to finish 2025/07/13 03:59:58 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 03:59:58 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 03:59:58 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 03:59:58 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 03:59:58 DEBUG : potato: Unchanged skipping 2025/07/13 03:59:58 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 03:59:58.846858 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OOw3XaD4VOmuQHdcvwIR4EPhKawe1nbq-xe4voLIkKhp0UcncHYJ72Vj_hyOUVXhIPW0kPcFzOAjOGXH25yAkQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 03:59:58.846893 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OOw3XaD4VOmuQHdcvwIR4EPhKawe1nbq-xe4voLIkKhp0UcncHYJ72Vj_hyOUVXhIPW0kPcFzOAjOGXH25yAkQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:58 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OOw3XaD4VOmuQHdcvwIR4EPhKawe1nbq-xe4voLIkKhp0UcncHYJ72Vj_hyOUVXhIPW0kPcFzOAjOGXH25yAkQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:58 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OOw3XaD4VOmuQHdcvwIR4EPhKawe1nbq-xe4voLIkKhp0UcncHYJ72Vj_hyOUVXhIPW0kPcFzOAjOGXH25yAkQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 03:59:58 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/13 03:59:58 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 04:00:00 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 04:00:00 INFO : yaml: Copied (new) 2025/07/13 04:00:00 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': not deleting files as there were IO errors 2025/07/13 04:00:00 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': 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 (5.27s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/07/13 04:00:01 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 04:00:01 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 04:00:01 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 04:00:01 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/13 04:00:01 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/13 04:00:01 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 04:00:01 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 04:00:03 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/13 04:00:03 INFO : potato: Copied (new) 2025/07/13 04:00:03 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 04:00:03 INFO : sub/yam: Copied (new) 2025/07/13 04:00:03 DEBUG : Waiting for deletions to finish 2025/07/13 04:00:04 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 04:00:04 DEBUG : potato: Unchanged skipping 2025/07/13 04:00:04 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Making map for --track-renames 2025/07/13 04:00:04 INFO : proton drive root link ID 'rclone-test-kiximan3gulo': Finished making map for --track-renames 2025/07/13 04:00:04 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 04:00:04 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for renames to finish 2025/07/13 04:00:04.737727 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kqJ7RywZBCRdXtl3bFCpBpV6owrVqr4aYO37LI32BLCShRQgVYYnOvNyPCjbdkB3w6XYPUNucxlEL9nx3qh_YA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:04.737766 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kqJ7RywZBCRdXtl3bFCpBpV6owrVqr4aYO37LI32BLCShRQgVYYnOvNyPCjbdkB3w6XYPUNucxlEL9nx3qh_YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:04 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kqJ7RywZBCRdXtl3bFCpBpV6owrVqr4aYO37LI32BLCShRQgVYYnOvNyPCjbdkB3w6XYPUNucxlEL9nx3qh_YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:04 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kqJ7RywZBCRdXtl3bFCpBpV6owrVqr4aYO37LI32BLCShRQgVYYnOvNyPCjbdkB3w6XYPUNucxlEL9nx3qh_YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:04 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/13 04:00:04 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 04:00:06 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/13 04:00:06 INFO : yam: Copied (new) 2025/07/13 04:00:06 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': not deleting files as there were IO errors 2025/07/13 04:00:06 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': 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.37s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:00:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/13 04:00:07 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/13 04:00:07 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for checks to finish 2025/07/13 04:00:07 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Waiting for transfers to finish 2025/07/13 04:00:10 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/13 04:00:10 INFO : sub dir/hello world: Copied (new) 2025/07/13 04:00:10 INFO : sub dir/hello world: Deleted 2025/07/13 04:00:10 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/13 04:00:10 INFO : nested/sub dir/file: Copied (new) 2025/07/13 04:00:10 INFO : nested/sub dir/file: Deleted 2025/07/13 04:00:10 ERROR : Local file system at /tmp/rclone2182635288: 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.64s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:00:12 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-givumoy6qece" 2025/07/13 04:00:12 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Has cached credentials 2025/07/13 04:00:13 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kiximan3gulo' -> proton drive root link ID 'rclone-test-givumoy6qece' 2025/07/13 04:00:21 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Using server-side directory move 2025/07/13 04:00:21 INFO : proton drive root link ID 'rclone-test-givumoy6qece': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/13 04:00:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/13 04:00:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/13 04:00:21 DEBUG : empty space: Unchanged skipping 2025/07/13 04:00:21 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Waiting for checks to finish 2025/07/13 04:00:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/13 04:00:22 INFO : empty space: Deleted 2025/07/13 04:00:22 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Waiting for transfers to finish 2025/07/13 04:00:22 INFO : potato3: Deleted 2025/07/13 04:00:22.311744 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-OZANUKX6w3bPrnqX3insBKp2-oBbAxGv6GhxO8irVLpWGvw10VzwNC72-Y4jev4TCqX_IV7abCv4wdZrM9FcQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:22.311781 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-OZANUKX6w3bPrnqX3insBKp2-oBbAxGv6GhxO8irVLpWGvw10VzwNC72-Y4jev4TCqX_IV7abCv4wdZrM9FcQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:22 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-OZANUKX6w3bPrnqX3insBKp2-oBbAxGv6GhxO8irVLpWGvw10VzwNC72-Y4jev4TCqX_IV7abCv4wdZrM9FcQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:22.403562 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z8Fi7ZLdfbWo6wSCuWJQCCY-pMGTNWbaadB4zU9dhRotVWN3mre1FrB2pMRxU2581peElfJUlSSt_SZBpbLvrg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:22.403599 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z8Fi7ZLdfbWo6wSCuWJQCCY-pMGTNWbaadB4zU9dhRotVWN3mre1FrB2pMRxU2581peElfJUlSSt_SZBpbLvrg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:22 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z8Fi7ZLdfbWo6wSCuWJQCCY-pMGTNWbaadB4zU9dhRotVWN3mre1FrB2pMRxU2581peElfJUlSSt_SZBpbLvrg==/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/z8Fi7ZLdfbWo6wSCuWJQCCY-pMGTNWbaadB4zU9dhRotVWN3mre1FrB2pMRxU2581peElfJUlSSt_SZBpbLvrg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/13 04:00:22 DEBUG : proton drive root link ID 'rclone-test-givumoy6qece': Purge remote --- FAIL: TestServerSideMove (11.26s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:00:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rosucud0nide" 2025/07/13 04:00:23 DEBUG : proton drive root link ID 'rclone-test-rosucud0nide': Has cached credentials 2025/07/13 04:00:24 DEBUG : proton drive root link ID 'rclone-test-rosucud0nide': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kiximan3gulo' -> proton drive root link ID 'rclone-test-rosucud0nide' 2025/07/13 04:00:33 DEBUG : empty space: Excluded (Size Filter) 2025/07/13 04:00:33 DEBUG : empty space: Excluded 2025/07/13 04:00:33 DEBUG : empty space: Excluded (Size Filter) 2025/07/13 04:00:33 DEBUG : empty space: Excluded 2025/07/13 04:00:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/13 04:00:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/13 04:00:33 DEBUG : proton drive root link ID 'rclone-test-rosucud0nide': Waiting for checks to finish 2025/07/13 04:00:33 DEBUG : proton drive root link ID 'rclone-test-rosucud0nide': Waiting for transfers to finish 2025/07/13 04:00:33 INFO : potato3: Deleted 2025/07/13 04:00:33.479150 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bSE35Gr3o9woTSsz0-Kged2rG0TKyG5uwXbMwdePPcZ1xMYuWOEqm7EjaYbiQ4HTyjd7buoMpNmcdJOtDXqQHA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:33.479183 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bSE35Gr3o9woTSsz0-Kged2rG0TKyG5uwXbMwdePPcZ1xMYuWOEqm7EjaYbiQ4HTyjd7buoMpNmcdJOtDXqQHA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:33 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bSE35Gr3o9woTSsz0-Kged2rG0TKyG5uwXbMwdePPcZ1xMYuWOEqm7EjaYbiQ4HTyjd7buoMpNmcdJOtDXqQHA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:33.613280 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rHWVC8aOwUAJBmucDMdRK7O8lbi0Dfh_9rbEaC8-2x7NenjOhht-SOypi66cOp1n9lWppWPZ7AiWR1HDrlUJVA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:33.613307 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rHWVC8aOwUAJBmucDMdRK7O8lbi0Dfh_9rbEaC8-2x7NenjOhht-SOypi66cOp1n9lWppWPZ7AiWR1HDrlUJVA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:33 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rHWVC8aOwUAJBmucDMdRK7O8lbi0Dfh_9rbEaC8-2x7NenjOhht-SOypi66cOp1n9lWppWPZ7AiWR1HDrlUJVA==/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/rHWVC8aOwUAJBmucDMdRK7O8lbi0Dfh_9rbEaC8-2x7NenjOhht-SOypi66cOp1n9lWppWPZ7AiWR1HDrlUJVA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/13 04:00:33 DEBUG : proton drive root link ID 'rclone-test-rosucud0nide': Purge remote --- FAIL: TestServerSideMoveWithFilter (11.42s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:00:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qisiwem0pohi" 2025/07/13 04:00:35 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Has cached credentials 2025/07/13 04:00:35 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:00:40 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kiximan3gulo' -> proton drive root link ID 'rclone-test-qisiwem0pohi' 2025/07/13 04:00:44 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Using server-side directory move 2025/07/13 04:00:44 INFO : proton drive root link ID 'rclone-test-qisiwem0pohi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/13 04:00:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/13 04:00:44 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/13 04:00:44 DEBUG : empty space: Unchanged skipping 2025/07/13 04:00:44 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/13 04:00:44 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Waiting for checks to finish 2025/07/13 04:00:44 INFO : empty space: Deleted 2025/07/13 04:00:44 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Waiting for transfers to finish 2025/07/13 04:00:44 INFO : potato3: Deleted 2025/07/13 04:00:45.048051 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7sIqGm0SQFu0KlPROqthaeR6LwIEwRFirwk165k6qLE87aFzNs-UfpsuyDvFyephqQjT8WKd6diDSBntzGoGA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:45.048077 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7sIqGm0SQFu0KlPROqthaeR6LwIEwRFirwk165k6qLE87aFzNs-UfpsuyDvFyephqQjT8WKd6diDSBntzGoGA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:45 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7sIqGm0SQFu0KlPROqthaeR6LwIEwRFirwk165k6qLE87aFzNs-UfpsuyDvFyephqQjT8WKd6diDSBntzGoGA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:45.174511 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dQzn2YWCWRmVRG4zOKu8n2-cddyWtVpkqq5IQoSzcTLbQ3a6GDXumfWfyElUxc5kUJcmmD305q6-69eg18XplQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:00:45.174541 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dQzn2YWCWRmVRG4zOKu8n2-cddyWtVpkqq5IQoSzcTLbQ3a6GDXumfWfyElUxc5kUJcmmD305q6-69eg18XplQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:45 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dQzn2YWCWRmVRG4zOKu8n2-cddyWtVpkqq5IQoSzcTLbQ3a6GDXumfWfyElUxc5kUJcmmD305q6-69eg18XplQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:00:45 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo': 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/07/13 04:00:45 DEBUG : proton drive root link ID 'rclone-test-qisiwem0pohi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (11.66s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:00:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:00:51 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:00:52 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:02:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/backup" 2025/07/13 04:02:25 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Has cached credentials 2025/07/13 04:02:26 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:04:38 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:04:38 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for checks to finish 2025/07/13 04:04:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 04:04:38 DEBUG : two: Unchanged skipping 2025/07/13 04:04:38.890032 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hUkGmZz_1nvBYdnIl9y3byaXEeD2UQz0lxayfuDmF8PqYoW8wqpMslA-dndNjmFQatvD8ygD-i7aCpsL6DTPew==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:04:38.890435 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hUkGmZz_1nvBYdnIl9y3byaXEeD2UQz0lxayfuDmF8PqYoW8wqpMslA-dndNjmFQatvD8ygD-i7aCpsL6DTPew==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:04:38 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hUkGmZz_1nvBYdnIl9y3byaXEeD2UQz0lxayfuDmF8PqYoW8wqpMslA-dndNjmFQatvD8ygD-i7aCpsL6DTPew==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:04:38 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for transfers to finish 2025/07/13 04:04:38 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/dst': not deleting files as there were IO errors 2025/07/13 04:04:38 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/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/hUkGmZz_1nvBYdnIl9y3byaXEeD2UQz0lxayfuDmF8PqYoW8wqpMslA-dndNjmFQatvD8ygD-i7aCpsL6DTPew==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (233.99s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:04:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:04:45 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:04:46 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:05:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/backup" 2025/07/13 04:05:52 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Has cached credentials 2025/07/13 04:05:52 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:08:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:08:04 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 04:08:04 DEBUG : two: Unchanged skipping 2025/07/13 04:08:04 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for checks to finish 2025/07/13 04:08:05.198757 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aSxhnFzf6MgYWz9ViVYQ1RscUbRe3Y-qI8yG36-yJPswNPudgXstAkrmmHdeaqB0f57QVzoROdJsFuEfpjyctw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:08:05.198786 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aSxhnFzf6MgYWz9ViVYQ1RscUbRe3Y-qI8yG36-yJPswNPudgXstAkrmmHdeaqB0f57QVzoROdJsFuEfpjyctw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:08:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aSxhnFzf6MgYWz9ViVYQ1RscUbRe3Y-qI8yG36-yJPswNPudgXstAkrmmHdeaqB0f57QVzoROdJsFuEfpjyctw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:08:05 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for transfers to finish 2025/07/13 04:08:05 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/dst': not deleting files as there were IO errors 2025/07/13 04:08:05 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/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/aSxhnFzf6MgYWz9ViVYQ1RscUbRe3Y-qI8yG36-yJPswNPudgXstAkrmmHdeaqB0f57QVzoROdJsFuEfpjyctw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (206.30s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:08:12 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:08:12 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:08:13 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:09:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/backup" 2025/07/13 04:09:17 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Has cached credentials 2025/07/13 04:09:18 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:11:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:11:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 04:11:32 DEBUG : two: Unchanged skipping 2025/07/13 04:11:32 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for checks to finish 2025/07/13 04:11:33.398384 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BowYH7EKSAqC-tKzyZXpDzzoBEpc0lH_vT8JSrq6fFf5E_bo-qCi5UPpqk6PkdgK5objh9M7ju3bbkESNWCbvg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:11:33.398450 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BowYH7EKSAqC-tKzyZXpDzzoBEpc0lH_vT8JSrq6fFf5E_bo-qCi5UPpqk6PkdgK5objh9M7ju3bbkESNWCbvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:11:33 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BowYH7EKSAqC-tKzyZXpDzzoBEpc0lH_vT8JSrq6fFf5E_bo-qCi5UPpqk6PkdgK5objh9M7ju3bbkESNWCbvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:11:33 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for transfers to finish 2025/07/13 04:11:33 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/dst': not deleting files as there were IO errors 2025/07/13 04:11:33 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/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/BowYH7EKSAqC-tKzyZXpDzzoBEpc0lH_vT8JSrq6fFf5E_bo-qCi5UPpqk6PkdgK5objh9M7ju3bbkESNWCbvg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (208.21s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:11:40 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:11:40 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:11:41 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:12:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:12:52 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/13 04:12:52 DEBUG : two: Unchanged skipping 2025/07/13 04:12:52 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for checks to finish 2025/07/13 04:12:52.520141 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v7fNqz11ozS1aV3Z0DfD_26_2Uzx0QOUYRd9jQCiUhrhL3ZcbYq2Cj_1H-_S8m7BZPg4JTNyjZh5zuwSYCnV6w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:12:52.520179 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v7fNqz11ozS1aV3Z0DfD_26_2Uzx0QOUYRd9jQCiUhrhL3ZcbYq2Cj_1H-_S8m7BZPg4JTNyjZh5zuwSYCnV6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:12:52 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v7fNqz11ozS1aV3Z0DfD_26_2Uzx0QOUYRd9jQCiUhrhL3ZcbYq2Cj_1H-_S8m7BZPg4JTNyjZh5zuwSYCnV6w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:12:52 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Waiting for transfers to finish 2025/07/13 04:12:52 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/dst': not deleting files as there were IO errors 2025/07/13 04:12:52 ERROR : proton drive root link ID 'rclone-test-kiximan3gulo/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/v7fNqz11ozS1aV3Z0DfD_26_2Uzx0QOUYRd9jQCiUhrhL3ZcbYq2Cj_1H-_S8m7BZPg4JTNyjZh5zuwSYCnV6w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (78.86s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:12:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:12:59 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:13:00 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:14:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:14:06.754861 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IqJlDxU8Q81ZNu9BxRNuWPcnePFekIw-LHMkXOwjzOG3HSbqtygbVbACx-7qxFCxMvnaZiRf8M2GPiMxKLnbg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:14:06.754905 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IqJlDxU8Q81ZNu9BxRNuWPcnePFekIw-LHMkXOwjzOG3HSbqtygbVbACx-7qxFCxMvnaZiRf8M2GPiMxKLnbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:14:06 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IqJlDxU8Q81ZNu9BxRNuWPcnePFekIw-LHMkXOwjzOG3HSbqtygbVbACx-7qxFCxMvnaZiRf8M2GPiMxKLnbg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IqJlDxU8Q81ZNu9BxRNuWPcnePFekIw-LHMkXOwjzOG3HSbqtygbVbACx-7qxFCxMvnaZiRf8M2GPiMxKLnbg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (74.19s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-kiximan3gulo'", Local "Local file system at /tmp/rclone2182635288", Modify Window "1s" 2025/07/13 04:14:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiximan3gulo/dst" 2025/07/13 04:14:13 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Has cached credentials 2025/07/13 04:14:13 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/13 04:15:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/13 04:15:25.077115 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R17iLoBsGOldB07U585TDhU5xsf-OC33_A2hBDpRyF_YntJHwSOkn5mbpj98pOw8XQbK8F-quSyyv5YbDFEIcQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/13 04:15:25.077157 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R17iLoBsGOldB07U585TDhU5xsf-OC33_A2hBDpRyF_YntJHwSOkn5mbpj98pOw8XQbK8F-quSyyv5YbDFEIcQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/13 04:15:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R17iLoBsGOldB07U585TDhU5xsf-OC33_A2hBDpRyF_YntJHwSOkn5mbpj98pOw8XQbK8F-quSyyv5YbDFEIcQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R17iLoBsGOldB07U585TDhU5xsf-OC33_A2hBDpRyF_YntJHwSOkn5mbpj98pOw8XQbK8F-quSyyv5YbDFEIcQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (78.37s) FAIL 2025/07/13 04:15:26 DEBUG : proton drive root link ID 'rclone-test-kiximan3gulo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 15m49.315831632s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]