"./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 3/5) 2025/09/11 06:14:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore" 2025/09/11 06:14:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/11 06:14:43 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Has cached credentials 2025/09/11 06:14:45 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:14:45 DEBUG : Creating backend with remote "/tmp/rclone3417499240" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:14:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-reguzad9nupa" 2025/09/11 06:14:50 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Has cached credentials 2025/09/11 06:14:52 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-mijogam7lore' -> proton drive root link ID 'rclone-test-reguzad9nupa' 2025/09/11 06:14:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/11 06:14:54 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Waiting for checks to finish 2025/09/11 06:14:54 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Waiting for transfers to finish 2025/09/11 06:14:59 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/11 06:14:59 INFO : sub dir/hello world: Copied (new) 2025/09/11 06:15:02.305017 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/09/11 06:15:02.305053 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/09/11 06:15:05 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Using server-side directory move 2025/09/11 06:15:05 INFO : proton drive root link ID 'rclone-test-reguzad9nupa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/11 06:15:07 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/11 06:15:07 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Waiting for checks to finish 2025/09/11 06:15:07 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Waiting for transfers to finish 2025/09/11 06:15:07 INFO : sub dir/hello world: Deleted 2025/09/11 06:15:09.044189 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WRFECuWq0DK0pNEgMZTtdreM411jgF52qrb82yVs4M5k4h0qPf3IuYFgC6fouFmnBPSnBJDxGVIfrutTO0EyuA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:15:09.044227 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WRFECuWq0DK0pNEgMZTtdreM411jgF52qrb82yVs4M5k4h0qPf3IuYFgC6fouFmnBPSnBJDxGVIfrutTO0EyuA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:09 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WRFECuWq0DK0pNEgMZTtdreM411jgF52qrb82yVs4M5k4h0qPf3IuYFgC6fouFmnBPSnBJDxGVIfrutTO0EyuA==/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/WRFECuWq0DK0pNEgMZTtdreM411jgF52qrb82yVs4M5k4h0qPf3IuYFgC6fouFmnBPSnBJDxGVIfrutTO0EyuA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/11 06:15:09 DEBUG : proton drive root link ID 'rclone-test-reguzad9nupa': Purge remote --- FAIL: TestServerSideMoveOverSelf (27.58s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/11 06:15:13 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:13 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:13 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:13 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:13 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/11 06:15:13 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/11 06:15:13 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:15 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:15 INFO : yam: Copied (new) 2025/09/11 06:15:15 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/11 06:15:15 INFO : potato: Copied (new) 2025/09/11 06:15:15 DEBUG : Waiting for deletions to finish 2025/09/11 06:15:17 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:15:17 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:17 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:17 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:17 DEBUG : potato: Unchanged skipping 2025/09/11 06:15:17 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:18.642274 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XeoosleJlrXgVHvlLXtvlR9V0W-WIEFafmZopSNP-QAeoM01CcCnpU0V5aRLpJnl0g0Uwl17Z1LyfXTd4870QQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:15:18.642331 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XeoosleJlrXgVHvlLXtvlR9V0W-WIEFafmZopSNP-QAeoM01CcCnpU0V5aRLpJnl0g0Uwl17Z1LyfXTd4870QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:18 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XeoosleJlrXgVHvlLXtvlR9V0W-WIEFafmZopSNP-QAeoM01CcCnpU0V5aRLpJnl0g0Uwl17Z1LyfXTd4870QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:18 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XeoosleJlrXgVHvlLXtvlR9V0W-WIEFafmZopSNP-QAeoM01CcCnpU0V5aRLpJnl0g0Uwl17Z1LyfXTd4870QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:18 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/11 06:15:18 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:20 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:20 INFO : yaml: Copied (new) 2025/09/11 06:15:20 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': not deleting files as there were IO errors 2025/09/11 06:15:20 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': 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 (10.46s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/11 06:15:24 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:24 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:24 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:24 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:24 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/11 06:15:24 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/11 06:15:24 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:25 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/11 06:15:25 INFO : potato: Copied (new) 2025/09/11 06:15:25 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:25 INFO : yam: Copied (new) 2025/09/11 06:15:25 DEBUG : Waiting for deletions to finish 2025/09/11 06:15:27 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:15:27 DEBUG : potato: Unchanged skipping 2025/09/11 06:15:27 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:27 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:27 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:27 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:28.870847 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cA1QioiU1QDBbPeiuHpgN-Yki5K8KPRRqbSe3brzJrQNBXrU8krFMwZEVkYCRT0J1EVFM8VuUnnF_1YQKkzbw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:15:28.870883 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cA1QioiU1QDBbPeiuHpgN-Yki5K8KPRRqbSe3brzJrQNBXrU8krFMwZEVkYCRT0J1EVFM8VuUnnF_1YQKkzbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:28 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cA1QioiU1QDBbPeiuHpgN-Yki5K8KPRRqbSe3brzJrQNBXrU8krFMwZEVkYCRT0J1EVFM8VuUnnF_1YQKkzbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:28 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cA1QioiU1QDBbPeiuHpgN-Yki5K8KPRRqbSe3brzJrQNBXrU8krFMwZEVkYCRT0J1EVFM8VuUnnF_1YQKkzbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:28 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/11 06:15:28 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:30 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:30 INFO : yaml: Copied (new) 2025/09/11 06:15:30 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': not deleting files as there were IO errors 2025/09/11 06:15:30 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': 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 (9.91s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/11 06:15:34 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:34 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:34 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:34 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/11 06:15:34 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/11 06:15:34 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:34 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:36 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/11 06:15:36 INFO : potato: Copied (new) 2025/09/11 06:15:36 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:36 INFO : sub/yam: Copied (new) 2025/09/11 06:15:36 DEBUG : Waiting for deletions to finish 2025/09/11 06:15:38 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:15:38 DEBUG : potato: Unchanged skipping 2025/09/11 06:15:39 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Making map for --track-renames 2025/09/11 06:15:39 INFO : proton drive root link ID 'rclone-test-mijogam7lore': Finished making map for --track-renames 2025/09/11 06:15:39 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:39 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for renames to finish 2025/09/11 06:15:40.397868 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fBRXTYQoqzSD9dSGKvpfwhg4lK1xeAbL1sKtxLtMS1olRS-4s4jhH5wNUpWpExQEx8rCF5CpxrIxFu3jSgEmhA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:15:40.397923 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fBRXTYQoqzSD9dSGKvpfwhg4lK1xeAbL1sKtxLtMS1olRS-4s4jhH5wNUpWpExQEx8rCF5CpxrIxFu3jSgEmhA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:40 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fBRXTYQoqzSD9dSGKvpfwhg4lK1xeAbL1sKtxLtMS1olRS-4s4jhH5wNUpWpExQEx8rCF5CpxrIxFu3jSgEmhA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:40 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fBRXTYQoqzSD9dSGKvpfwhg4lK1xeAbL1sKtxLtMS1olRS-4s4jhH5wNUpWpExQEx8rCF5CpxrIxFu3jSgEmhA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:15:40 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/11 06:15:40 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:42 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/11 06:15:42 INFO : yam: Copied (new) 2025/09/11 06:15:42 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': not deleting files as there were IO errors 2025/09/11 06:15:42 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': 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 (12.85s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:15:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/11 06:15:47 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/11 06:15:47 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for checks to finish 2025/09/11 06:15:47 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': Waiting for transfers to finish 2025/09/11 06:15:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/11 06:15:51 INFO : sub dir/hello world: Copied (new) 2025/09/11 06:15:51 INFO : sub dir/hello world: Deleted 2025/09/11 06:15:51 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/11 06:15:51 INFO : nested/sub dir/file: Copied (new) 2025/09/11 06:15:51 INFO : nested/sub dir/file: Deleted 2025/09/11 06:15:51 ERROR : Local file system at /tmp/rclone3417499240: 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 (10.08s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:15:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pitucof6xawi" 2025/09/11 06:15:56 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Has cached credentials 2025/09/11 06:15:59 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mijogam7lore' -> proton drive root link ID 'rclone-test-pitucof6xawi' 2025/09/11 06:16:10 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Using server-side directory move 2025/09/11 06:16:10 INFO : proton drive root link ID 'rclone-test-pitucof6xawi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/11 06:16:12 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/11 06:16:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/11 06:16:12 DEBUG : empty space: Unchanged skipping 2025/09/11 06:16:12 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Waiting for checks to finish 2025/09/11 06:16:12 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/11 06:16:12 INFO : empty space: Deleted 2025/09/11 06:16:12 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Waiting for transfers to finish 2025/09/11 06:16:12 INFO : potato3: Deleted 2025/09/11 06:16:13.126216 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5ZBDRftg_pbokWkhp9kuDEPiZFI8yRvwOZR5HQvdaqmzcPe-S3m0Tipzwx_tAXzit2MO-YKCvkJLUW1vN6PQSA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:13.126263 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5ZBDRftg_pbokWkhp9kuDEPiZFI8yRvwOZR5HQvdaqmzcPe-S3m0Tipzwx_tAXzit2MO-YKCvkJLUW1vN6PQSA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:13 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5ZBDRftg_pbokWkhp9kuDEPiZFI8yRvwOZR5HQvdaqmzcPe-S3m0Tipzwx_tAXzit2MO-YKCvkJLUW1vN6PQSA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:13.573152 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RigM61j6DwTknobzbawNMXbLiVFcwt__7FRoNZKIO4PXFVTLwW4EEBItGObvrd-SNpePIDAnqPr1bL0c9vq0uw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:13.573198 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RigM61j6DwTknobzbawNMXbLiVFcwt__7FRoNZKIO4PXFVTLwW4EEBItGObvrd-SNpePIDAnqPr1bL0c9vq0uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:13 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RigM61j6DwTknobzbawNMXbLiVFcwt__7FRoNZKIO4PXFVTLwW4EEBItGObvrd-SNpePIDAnqPr1bL0c9vq0uw==/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/RigM61j6DwTknobzbawNMXbLiVFcwt__7FRoNZKIO4PXFVTLwW4EEBItGObvrd-SNpePIDAnqPr1bL0c9vq0uw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/11 06:16:13 DEBUG : proton drive root link ID 'rclone-test-pitucof6xawi': Purge remote --- FAIL: TestServerSideMove (20.64s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:16:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yoyitow2role" 2025/09/11 06:16:17 DEBUG : proton drive root link ID 'rclone-test-yoyitow2role': Has cached credentials 2025/09/11 06:16:19 DEBUG : proton drive root link ID 'rclone-test-yoyitow2role': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mijogam7lore' -> proton drive root link ID 'rclone-test-yoyitow2role' 2025/09/11 06:16:32 DEBUG : empty space: Excluded (Size Filter) 2025/09/11 06:16:32 DEBUG : empty space: Excluded 2025/09/11 06:16:32 DEBUG : empty space: Excluded (Size Filter) 2025/09/11 06:16:32 DEBUG : empty space: Excluded 2025/09/11 06:16:32 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/11 06:16:32 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/11 06:16:32 DEBUG : proton drive root link ID 'rclone-test-yoyitow2role': Waiting for checks to finish 2025/09/11 06:16:32 DEBUG : proton drive root link ID 'rclone-test-yoyitow2role': Waiting for transfers to finish 2025/09/11 06:16:33 INFO : potato3: Deleted 2025/09/11 06:16:33.517852 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N7OqlWT8HoVDc1tkfuQIdl8YQxTzI3bZmoWvssaZo-U0jiFk7hE34gnoRfrAromrF9Qf6lSPVizUcyWmRWSrFg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:33.517894 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N7OqlWT8HoVDc1tkfuQIdl8YQxTzI3bZmoWvssaZo-U0jiFk7hE34gnoRfrAromrF9Qf6lSPVizUcyWmRWSrFg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:33 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N7OqlWT8HoVDc1tkfuQIdl8YQxTzI3bZmoWvssaZo-U0jiFk7hE34gnoRfrAromrF9Qf6lSPVizUcyWmRWSrFg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:33.662659 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8VrZ_rG85k4xB1qgKCx8MOFN4HJX5uLjHSgjZMi095nQfaUAZQsaNGuyBxzGK9L-m-cvRw7tpHnuUlB7_vqA1Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:33.662681 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8VrZ_rG85k4xB1qgKCx8MOFN4HJX5uLjHSgjZMi095nQfaUAZQsaNGuyBxzGK9L-m-cvRw7tpHnuUlB7_vqA1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:33 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8VrZ_rG85k4xB1qgKCx8MOFN4HJX5uLjHSgjZMi095nQfaUAZQsaNGuyBxzGK9L-m-cvRw7tpHnuUlB7_vqA1Q==/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/8VrZ_rG85k4xB1qgKCx8MOFN4HJX5uLjHSgjZMi095nQfaUAZQsaNGuyBxzGK9L-m-cvRw7tpHnuUlB7_vqA1Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/11 06:16:33 DEBUG : proton drive root link ID 'rclone-test-yoyitow2role': Purge remote --- FAIL: TestServerSideMoveWithFilter (20.53s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:16:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mozajek9yemi" 2025/09/11 06:16:37 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Has cached credentials 2025/09/11 06:16:39 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:16:44 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mijogam7lore' -> proton drive root link ID 'rclone-test-mozajek9yemi' 2025/09/11 06:16:52 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Using server-side directory move 2025/09/11 06:16:52 INFO : proton drive root link ID 'rclone-test-mozajek9yemi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/11 06:16:53 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/11 06:16:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/11 06:16:53 DEBUG : empty space: Unchanged skipping 2025/09/11 06:16:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/11 06:16:53 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Waiting for checks to finish 2025/09/11 06:16:54 INFO : potato3: Deleted 2025/09/11 06:16:54 INFO : empty space: Deleted 2025/09/11 06:16:54 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Waiting for transfers to finish 2025/09/11 06:16:54.300568 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ztGXHEwJgmnX3166_L6wI8pesjvhUhEqjkH2qI_Lbf-uIpvVpRjq_5mWfzc7pt1BMoG2k6Bblb_JusiIgCd1QQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:54.300616 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ztGXHEwJgmnX3166_L6wI8pesjvhUhEqjkH2qI_Lbf-uIpvVpRjq_5mWfzc7pt1BMoG2k6Bblb_JusiIgCd1QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:54 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ztGXHEwJgmnX3166_L6wI8pesjvhUhEqjkH2qI_Lbf-uIpvVpRjq_5mWfzc7pt1BMoG2k6Bblb_JusiIgCd1QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:54.780319 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bQkUJhBaxHTpWyqIh4fML4Rmx1-Qt3lFb7wfR5GuBT72aQ2oDcFcX9S-Dfwwco9e8MqrQWND5V6FbQJujncgVA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:16:54.780386 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bQkUJhBaxHTpWyqIh4fML4Rmx1-Qt3lFb7wfR5GuBT72aQ2oDcFcX9S-Dfwwco9e8MqrQWND5V6FbQJujncgVA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:54 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bQkUJhBaxHTpWyqIh4fML4Rmx1-Qt3lFb7wfR5GuBT72aQ2oDcFcX9S-Dfwwco9e8MqrQWND5V6FbQJujncgVA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:16:54 ERROR : proton drive root link ID 'rclone-test-mijogam7lore': 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/09/11 06:16:54 DEBUG : proton drive root link ID 'rclone-test-mozajek9yemi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (21.30s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:17:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:17:06 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:17:09 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:18:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/backup" 2025/09/11 06:18:41 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Has cached credentials 2025/09/11 06:18:43 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:21:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:21:46 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for checks to finish 2025/09/11 06:21:46 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:21:46 DEBUG : two: Unchanged skipping 2025/09/11 06:21:48.266433 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yysHCU2fMz1jI_dSdy3QAMvK6EhYqL6t5JQbw2LcYlU1PNghAn1LMXchPrU4q75WmV49_U9Y9EcvkLa4DTEq-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:21:48.266489 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yysHCU2fMz1jI_dSdy3QAMvK6EhYqL6t5JQbw2LcYlU1PNghAn1LMXchPrU4q75WmV49_U9Y9EcvkLa4DTEq-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:21:48 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yysHCU2fMz1jI_dSdy3QAMvK6EhYqL6t5JQbw2LcYlU1PNghAn1LMXchPrU4q75WmV49_U9Y9EcvkLa4DTEq-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:21:48 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for transfers to finish 2025/09/11 06:21:48 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/dst': not deleting files as there were IO errors 2025/09/11 06:21:48 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/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/yysHCU2fMz1jI_dSdy3QAMvK6EhYqL6t5JQbw2LcYlU1PNghAn1LMXchPrU4q75WmV49_U9Y9EcvkLa4DTEq-w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (294.70s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:22:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:22:01 DEBUG : Config file has changed externally - reloading 2025/09/11 06:22:01 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:22:03 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:23:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/backup" 2025/09/11 06:23:34 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Has cached credentials 2025/09/11 06:23:36 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:26:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:26:45 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:26:45 DEBUG : two: Unchanged skipping 2025/09/11 06:26:45 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for checks to finish 2025/09/11 06:26:47.744608 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QEp13RtEbbQoYwuK6x_rnDqR-4uBKPfFO7Afmp1SqV1Bnnc3mvLlF-SGzRgIx1C_wpMFPCKC0SNxMNcOtbl-QA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:26:47.744649 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QEp13RtEbbQoYwuK6x_rnDqR-4uBKPfFO7Afmp1SqV1Bnnc3mvLlF-SGzRgIx1C_wpMFPCKC0SNxMNcOtbl-QA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:26:47 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QEp13RtEbbQoYwuK6x_rnDqR-4uBKPfFO7Afmp1SqV1Bnnc3mvLlF-SGzRgIx1C_wpMFPCKC0SNxMNcOtbl-QA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:26:47 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for transfers to finish 2025/09/11 06:26:47 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/dst': not deleting files as there were IO errors 2025/09/11 06:26:47 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/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/QEp13RtEbbQoYwuK6x_rnDqR-4uBKPfFO7Afmp1SqV1Bnnc3mvLlF-SGzRgIx1C_wpMFPCKC0SNxMNcOtbl-QA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (298.97s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:27:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:27:00 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:27:02 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:28:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/backup" 2025/09/11 06:28:34 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Has cached credentials 2025/09/11 06:28:36 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/backup': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:31:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:31:39 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:31:39 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for checks to finish 2025/09/11 06:31:39 DEBUG : two: Unchanged skipping 2025/09/11 06:31:41.262161 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/walHbsARagPOKcTiN-QXpSqdxCz3y2xdAVSCH3zz0PsiOH8Pe8xX72cEzmmXvpnZarHUlMtlTpPRhrs50IEyWg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:31:41.262196 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/walHbsARagPOKcTiN-QXpSqdxCz3y2xdAVSCH3zz0PsiOH8Pe8xX72cEzmmXvpnZarHUlMtlTpPRhrs50IEyWg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:31:41 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/walHbsARagPOKcTiN-QXpSqdxCz3y2xdAVSCH3zz0PsiOH8Pe8xX72cEzmmXvpnZarHUlMtlTpPRhrs50IEyWg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:31:41 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for transfers to finish 2025/09/11 06:31:41 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/dst': not deleting files as there were IO errors 2025/09/11 06:31:41 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/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/walHbsARagPOKcTiN-QXpSqdxCz3y2xdAVSCH3zz0PsiOH8Pe8xX72cEzmmXvpnZarHUlMtlTpPRhrs50IEyWg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (293.41s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:31:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:31:52 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:31:55 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:33:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:33:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/11 06:33:27 DEBUG : two: Unchanged skipping 2025/09/11 06:33:27 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for checks to finish 2025/09/11 06:33:28.698821 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fHtTRAeaw9MosEse-lemhbnffFqC8H0jJ0clNYASSUZTrZfKXRf0Uuybr0N8G7PKBlWVP9e7nKWZbb4umipKCw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:33:28.698864 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fHtTRAeaw9MosEse-lemhbnffFqC8H0jJ0clNYASSUZTrZfKXRf0Uuybr0N8G7PKBlWVP9e7nKWZbb4umipKCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:33:28 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fHtTRAeaw9MosEse-lemhbnffFqC8H0jJ0clNYASSUZTrZfKXRf0Uuybr0N8G7PKBlWVP9e7nKWZbb4umipKCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:33:28 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Waiting for transfers to finish 2025/09/11 06:33:28 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/dst': not deleting files as there were IO errors 2025/09/11 06:33:28 ERROR : proton drive root link ID 'rclone-test-mijogam7lore/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/fHtTRAeaw9MosEse-lemhbnffFqC8H0jJ0clNYASSUZTrZfKXRf0Uuybr0N8G7PKBlWVP9e7nKWZbb4umipKCw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (107.28s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:33:40 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:33:40 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:33:43 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:35:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:35:17.186385 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_fmoqQPXef7DFF10Ph_irqKttSbrLXK69Ta3Jm4rbKsNpuQcxFlj3Yub0-3V6m-Ha52hX2jM2_icTGoZIaY7g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:35:17.186427 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_fmoqQPXef7DFF10Ph_irqKttSbrLXK69Ta3Jm4rbKsNpuQcxFlj3Yub0-3V6m-Ha52hX2jM2_icTGoZIaY7g==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:35:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_fmoqQPXef7DFF10Ph_irqKttSbrLXK69Ta3Jm4rbKsNpuQcxFlj3Yub0-3V6m-Ha52hX2jM2_icTGoZIaY7g==/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/B_fmoqQPXef7DFF10Ph_irqKttSbrLXK69Ta3Jm4rbKsNpuQcxFlj3Yub0-3V6m-Ha52hX2jM2_icTGoZIaY7g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (108.45s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mijogam7lore'", Local "Local file system at /tmp/rclone3417499240", Modify Window "1s" 2025/09/11 06:35:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mijogam7lore/dst" 2025/09/11 06:35:29 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Has cached credentials 2025/09/11 06:35:32 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore/dst': Used cached credential to initialize the ProtonDrive API 2025/09/11 06:37:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/11 06:37:05.750675 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WXOwSguaWrImBtiID-X91p2Y9itwthz1B6v3eqb5LHtC9GpyAzOWeiRukYrX7KAjFj6ktHPS4P7JX1wOIynnDw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/11 06:37:05.750758 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WXOwSguaWrImBtiID-X91p2Y9itwthz1B6v3eqb5LHtC9GpyAzOWeiRukYrX7KAjFj6ktHPS4P7JX1wOIynnDw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/11 06:37:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WXOwSguaWrImBtiID-X91p2Y9itwthz1B6v3eqb5LHtC9GpyAzOWeiRukYrX7KAjFj6ktHPS4P7JX1wOIynnDw==/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/WXOwSguaWrImBtiID-X91p2Y9itwthz1B6v3eqb5LHtC9GpyAzOWeiRukYrX7KAjFj6ktHPS4P7JX1wOIynnDw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (108.51s) FAIL 2025/09/11 06:37:10 DEBUG : proton drive root link ID 'rclone-test-mijogam7lore': 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 22m28.235090507s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]