"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 5/5) 2025/10/27 03:18:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho" 2025/10/27 03:18:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/27 03:18:03 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Has cached credentials 2025/10/27 03:18:04 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:18:05 DEBUG : Creating backend with remote "/tmp/rclone261078194" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:18:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-fuqadib7gemu" 2025/10/27 03:18:07 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Has cached credentials 2025/10/27 03:18:08 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-pikugiz1laho' -> proton drive root link ID 'rclone-test-fuqadib7gemu' 2025/10/27 03:18:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/27 03:18:09 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Waiting for checks to finish 2025/10/27 03:18:09 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Waiting for transfers to finish 2025/10/27 03:18:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/27 03:18:11 INFO : sub dir/hello world: Copied (new) 2025/10/27 03:18:12.660910 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/10/27 03:18:12.660950 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/10/27 03:18:14 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Using server-side directory move 2025/10/27 03:18:14 INFO : proton drive root link ID 'rclone-test-fuqadib7gemu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/27 03:18:14 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/27 03:18:14 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Waiting for checks to finish 2025/10/27 03:18:14 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Waiting for transfers to finish 2025/10/27 03:18:15 INFO : sub dir/hello world: Deleted 2025/10/27 03:18:15.616861 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ftvT7VZqtERcYiec4ZGbgrGn30_rxRW6medEIMWQId2x4GoMa23-fp3GPjt9rmkK8rU8qr34Az7rWd1n6Idj0g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:15.616896 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ftvT7VZqtERcYiec4ZGbgrGn30_rxRW6medEIMWQId2x4GoMa23-fp3GPjt9rmkK8rU8qr34Az7rWd1n6Idj0g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:15 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ftvT7VZqtERcYiec4ZGbgrGn30_rxRW6medEIMWQId2x4GoMa23-fp3GPjt9rmkK8rU8qr34Az7rWd1n6Idj0g==/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/ftvT7VZqtERcYiec4ZGbgrGn30_rxRW6medEIMWQId2x4GoMa23-fp3GPjt9rmkK8rU8qr34Az7rWd1n6Idj0g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/10/27 03:18:15 DEBUG : proton drive root link ID 'rclone-test-fuqadib7gemu': Purge remote --- FAIL: TestServerSideMoveOverSelf (12.28s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/10/27 03:18:17 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:17 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:17 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:17 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/27 03:18:17 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/27 03:18:17 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:17 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:18 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/27 03:18:18 INFO : potato: Copied (new) 2025/10/27 03:18:18 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:18 INFO : yam: Copied (new) 2025/10/27 03:18:18 DEBUG : Waiting for deletions to finish 2025/10/27 03:18:19 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:18:19 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:19 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:19 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:19 DEBUG : potato: Unchanged skipping 2025/10/27 03:18:19 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:19.959171 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keLnF_BEPGO1_IrHeNXnOh-fX9FtLay04k5FHsmgiagj1dJPeD7z99AxmAhpdJewOhWS6nwRHZK_G0SZtzU03A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:19.959210 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keLnF_BEPGO1_IrHeNXnOh-fX9FtLay04k5FHsmgiagj1dJPeD7z99AxmAhpdJewOhWS6nwRHZK_G0SZtzU03A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:19 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keLnF_BEPGO1_IrHeNXnOh-fX9FtLay04k5FHsmgiagj1dJPeD7z99AxmAhpdJewOhWS6nwRHZK_G0SZtzU03A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:19 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keLnF_BEPGO1_IrHeNXnOh-fX9FtLay04k5FHsmgiagj1dJPeD7z99AxmAhpdJewOhWS6nwRHZK_G0SZtzU03A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:19 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/27 03:18:19 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:21 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:21 INFO : yaml: Copied (new) 2025/10/27 03:18:21 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': not deleting files as there were IO errors 2025/10/27 03:18:21 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': 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.11s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/10/27 03:18:22 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:22 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:22 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:22 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/27 03:18:22 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/27 03:18:22 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:22 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:23 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:23 INFO : yam: Copied (new) 2025/10/27 03:18:23 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/27 03:18:23 INFO : potato: Copied (new) 2025/10/27 03:18:23 DEBUG : Waiting for deletions to finish 2025/10/27 03:18:24 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:18:24 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:24 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:24 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:24 DEBUG : potato: Unchanged skipping 2025/10/27 03:18:24 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:25.072696 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7Q7v9-CM8pFxRpoPciizXInxHpb9YdkyF-jmUoeQZFgWzk6qZWpeJN4llnH9u494J-k3F1K7ymi6FAB1aoMpnA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:25.072765 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7Q7v9-CM8pFxRpoPciizXInxHpb9YdkyF-jmUoeQZFgWzk6qZWpeJN4llnH9u494J-k3F1K7ymi6FAB1aoMpnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:25 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7Q7v9-CM8pFxRpoPciizXInxHpb9YdkyF-jmUoeQZFgWzk6qZWpeJN4llnH9u494J-k3F1K7ymi6FAB1aoMpnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:25 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7Q7v9-CM8pFxRpoPciizXInxHpb9YdkyF-jmUoeQZFgWzk6qZWpeJN4llnH9u494J-k3F1K7ymi6FAB1aoMpnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:25 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/27 03:18:25 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:26 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:26 INFO : yaml: Copied (new) 2025/10/27 03:18:26 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': not deleting files as there were IO errors 2025/10/27 03:18:26 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': 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.26s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/10/27 03:18:27 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:27 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:27 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:27 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/27 03:18:27 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/10/27 03:18:27 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:27 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/27 03:18:29 INFO : potato: Copied (new) 2025/10/27 03:18:29 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:29 INFO : sub/yam: Copied (new) 2025/10/27 03:18:29 DEBUG : Waiting for deletions to finish 2025/10/27 03:18:30 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:18:30 DEBUG : potato: Unchanged skipping 2025/10/27 03:18:30 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Making map for --track-renames 2025/10/27 03:18:30 INFO : proton drive root link ID 'rclone-test-pikugiz1laho': Finished making map for --track-renames 2025/10/27 03:18:30 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:30 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for renames to finish 2025/10/27 03:18:30.863908 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f45lpiOM1VKMD6AzbDkxHni2a0oppSjrIj4JRfvTkjM8YUlcVkEAmSHGW0PGwgW97osToCOE8SbOgNmlSLyI0w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:30.863949 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f45lpiOM1VKMD6AzbDkxHni2a0oppSjrIj4JRfvTkjM8YUlcVkEAmSHGW0PGwgW97osToCOE8SbOgNmlSLyI0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:30 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f45lpiOM1VKMD6AzbDkxHni2a0oppSjrIj4JRfvTkjM8YUlcVkEAmSHGW0PGwgW97osToCOE8SbOgNmlSLyI0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:30 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f45lpiOM1VKMD6AzbDkxHni2a0oppSjrIj4JRfvTkjM8YUlcVkEAmSHGW0PGwgW97osToCOE8SbOgNmlSLyI0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:30 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/27 03:18:30 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:31 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/27 03:18:31 INFO : yam: Copied (new) 2025/10/27 03:18:31 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': not deleting files as there were IO errors 2025/10/27 03:18:31 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': 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.39s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:18:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/27 03:18:34 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/10/27 03:18:34 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for checks to finish 2025/10/27 03:18:34 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Waiting for transfers to finish 2025/10/27 03:18:36 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/10/27 03:18:36 INFO : nested/sub dir/file: Copied (new) 2025/10/27 03:18:36 INFO : nested/sub dir/file: Deleted 2025/10/27 03:18:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/27 03:18:36 INFO : sub dir/hello world: Copied (new) 2025/10/27 03:18:36 INFO : sub dir/hello world: Deleted 2025/10/27 03:18:36 ERROR : Local file system at /tmp/rclone261078194: 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.65s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:18:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hahecif7fija" 2025/10/27 03:18:38 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Has cached credentials 2025/10/27 03:18:39 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pikugiz1laho' -> proton drive root link ID 'rclone-test-hahecif7fija' 2025/10/27 03:18:46 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Using server-side directory move 2025/10/27 03:18:46 INFO : proton drive root link ID 'rclone-test-hahecif7fija': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/27 03:18:47 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/27 03:18:47 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/27 03:18:47 DEBUG : empty space: Unchanged skipping 2025/10/27 03:18:47 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Waiting for checks to finish 2025/10/27 03:18:47 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/27 03:18:47 INFO : empty space: Deleted 2025/10/27 03:18:47 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Waiting for transfers to finish 2025/10/27 03:18:47 INFO : potato3: Deleted 2025/10/27 03:18:47.597977 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00vDmnHx3fWlzHK3h6IZGjoLRg5UrXcmLBzzk0I610lQdmjDhUiAIUkFad6xNfvPv92zjdFo6bdwQBvmboDt3Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:47.598016 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00vDmnHx3fWlzHK3h6IZGjoLRg5UrXcmLBzzk0I610lQdmjDhUiAIUkFad6xNfvPv92zjdFo6bdwQBvmboDt3Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:47 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00vDmnHx3fWlzHK3h6IZGjoLRg5UrXcmLBzzk0I610lQdmjDhUiAIUkFad6xNfvPv92zjdFo6bdwQBvmboDt3Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:47.639689 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I2eRsr37KWhjBxePHyJN_FOe1iKrmTdbsGen--9Wl5cQfXubyJTZDXj1TVhtFmMVA6hC2NKNrrMgevjjWUBLCQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:47.639774 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I2eRsr37KWhjBxePHyJN_FOe1iKrmTdbsGen--9Wl5cQfXubyJTZDXj1TVhtFmMVA6hC2NKNrrMgevjjWUBLCQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:47 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I2eRsr37KWhjBxePHyJN_FOe1iKrmTdbsGen--9Wl5cQfXubyJTZDXj1TVhtFmMVA6hC2NKNrrMgevjjWUBLCQ==/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/I2eRsr37KWhjBxePHyJN_FOe1iKrmTdbsGen--9Wl5cQfXubyJTZDXj1TVhtFmMVA6hC2NKNrrMgevjjWUBLCQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/10/27 03:18:47 DEBUG : proton drive root link ID 'rclone-test-hahecif7fija': Purge remote --- FAIL: TestServerSideMove (10.54s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:18:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-liyapaf8xaki" 2025/10/27 03:18:49 DEBUG : proton drive root link ID 'rclone-test-liyapaf8xaki': Has cached credentials 2025/10/27 03:18:50 DEBUG : proton drive root link ID 'rclone-test-liyapaf8xaki': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pikugiz1laho' -> proton drive root link ID 'rclone-test-liyapaf8xaki' 2025/10/27 03:18:57 DEBUG : empty space: Excluded (Size Filter) 2025/10/27 03:18:57 DEBUG : empty space: Excluded 2025/10/27 03:18:57 DEBUG : empty space: Excluded (Size Filter) 2025/10/27 03:18:57 DEBUG : empty space: Excluded 2025/10/27 03:18:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/27 03:18:57 DEBUG : proton drive root link ID 'rclone-test-liyapaf8xaki': Waiting for checks to finish 2025/10/27 03:18:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/27 03:18:57 DEBUG : proton drive root link ID 'rclone-test-liyapaf8xaki': Waiting for transfers to finish 2025/10/27 03:18:58 INFO : potato3: Deleted 2025/10/27 03:18:58.404279 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M6aNF-RMdrzI0JCyT1antQwqWG-S6I0x-NLxG5NfhSczAj5FfwVzGXc3J4UbjzVn36glhGVN_5XP-xWvehmGbw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:58.404336 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M6aNF-RMdrzI0JCyT1antQwqWG-S6I0x-NLxG5NfhSczAj5FfwVzGXc3J4UbjzVn36glhGVN_5XP-xWvehmGbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M6aNF-RMdrzI0JCyT1antQwqWG-S6I0x-NLxG5NfhSczAj5FfwVzGXc3J4UbjzVn36glhGVN_5XP-xWvehmGbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:58.494964 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u_vWxUlnXyZm7h5yjjuYyxRFzslXQU-PZQjRvcMyaXtFrJuxbUPXhPTMYOYY0eIJyUthuFW4jQ2dfEBmqB4A4Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:18:58.495000 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u_vWxUlnXyZm7h5yjjuYyxRFzslXQU-PZQjRvcMyaXtFrJuxbUPXhPTMYOYY0eIJyUthuFW4jQ2dfEBmqB4A4Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:18:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u_vWxUlnXyZm7h5yjjuYyxRFzslXQU-PZQjRvcMyaXtFrJuxbUPXhPTMYOYY0eIJyUthuFW4jQ2dfEBmqB4A4Q==/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/u_vWxUlnXyZm7h5yjjuYyxRFzslXQU-PZQjRvcMyaXtFrJuxbUPXhPTMYOYY0eIJyUthuFW4jQ2dfEBmqB4A4Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/10/27 03:18:58 DEBUG : proton drive root link ID 'rclone-test-liyapaf8xaki': Purge remote --- FAIL: TestServerSideMoveWithFilter (10.90s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:19:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bayawok2caki" 2025/10/27 03:19:00 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Has cached credentials 2025/10/27 03:19:01 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:19:04 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pikugiz1laho' -> proton drive root link ID 'rclone-test-bayawok2caki' 2025/10/27 03:19:08 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Using server-side directory move 2025/10/27 03:19:08 INFO : proton drive root link ID 'rclone-test-bayawok2caki': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/27 03:19:09 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/27 03:19:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/27 03:19:09 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/27 03:19:09 DEBUG : empty space: Unchanged skipping 2025/10/27 03:19:09 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Waiting for checks to finish 2025/10/27 03:19:09 INFO : potato3: Deleted 2025/10/27 03:19:09 INFO : empty space: Deleted 2025/10/27 03:19:09 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Waiting for transfers to finish 2025/10/27 03:19:09.537033 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/09--_64a694Iz9ZpB05Lgq_jeNz-Mi3RWMTnjBL8GySVU0xHCr_xPVIg0-4Zsn-G72w7skVMWX7h7kLYXqhRFA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:19:09.537060 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/09--_64a694Iz9ZpB05Lgq_jeNz-Mi3RWMTnjBL8GySVU0xHCr_xPVIg0-4Zsn-G72w7skVMWX7h7kLYXqhRFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:19:09 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/09--_64a694Iz9ZpB05Lgq_jeNz-Mi3RWMTnjBL8GySVU0xHCr_xPVIg0-4Zsn-G72w7skVMWX7h7kLYXqhRFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:19:09.638554 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EkNkyxKg3CCwDKFLItd_IHyVMDCwh4x_-wf4HD6GdUrz9m6jNGX7D85bP2UFDpi2XjbWCx52Q_oBsqpSyMyceA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:19:09.638584 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EkNkyxKg3CCwDKFLItd_IHyVMDCwh4x_-wf4HD6GdUrz9m6jNGX7D85bP2UFDpi2XjbWCx52Q_oBsqpSyMyceA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:19:09 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EkNkyxKg3CCwDKFLItd_IHyVMDCwh4x_-wf4HD6GdUrz9m6jNGX7D85bP2UFDpi2XjbWCx52Q_oBsqpSyMyceA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:19:09 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/10/27 03:19:09 DEBUG : proton drive root link ID 'rclone-test-bayawok2caki': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (11.56s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:19:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/dst" 2025/10/27 03:19:16 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Has cached credentials 2025/10/27 03:19:17 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:20:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/backup" 2025/10/27 03:20:53 DEBUG : Config file has changed externally - reloading 2025/10/27 03:20:53 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Has cached credentials 2025/10/27 03:20:54 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:24:08 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for checks to finish 2025/10/27 03:24:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/27 03:24:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:24:08 DEBUG : two: Unchanged skipping 2025/10/27 03:24:09.566962 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EQkg3luEcGrbckC0uLCiNZkx1B5iStFcToGC4qs6iz_bkDsxuKfejX948mlUxmO4ubMLS7dT3ThcwBngzGuC9Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:24:09.566993 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EQkg3luEcGrbckC0uLCiNZkx1B5iStFcToGC4qs6iz_bkDsxuKfejX948mlUxmO4ubMLS7dT3ThcwBngzGuC9Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:24:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EQkg3luEcGrbckC0uLCiNZkx1B5iStFcToGC4qs6iz_bkDsxuKfejX948mlUxmO4ubMLS7dT3ThcwBngzGuC9Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:24:09 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for transfers to finish 2025/10/27 03:24:09 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/dst': not deleting files as there were IO errors 2025/10/27 03:24:09 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/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/EQkg3luEcGrbckC0uLCiNZkx1B5iStFcToGC4qs6iz_bkDsxuKfejX948mlUxmO4ubMLS7dT3ThcwBngzGuC9Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (300.16s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:24:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/dst" 2025/10/27 03:24:16 DEBUG : Config file has changed externally - reloading 2025/10/27 03:24:16 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Has cached credentials 2025/10/27 03:24:17 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:25:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/backup" 2025/10/27 03:25:55 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Has cached credentials 2025/10/27 03:25:56 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:29:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/27 03:29:13 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:29:13 DEBUG : two: Unchanged skipping 2025/10/27 03:29:13 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for checks to finish 2025/10/27 03:29:14.713293 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xzUvu7W6aiW7xe9I3O5Jle62PVkSnsC2Pn1_VA0eKCawXCozBCDxj_zbJtTwHwrBkUVXGC34vRBOmJqsS3XDPA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:29:14.713338 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xzUvu7W6aiW7xe9I3O5Jle62PVkSnsC2Pn1_VA0eKCawXCozBCDxj_zbJtTwHwrBkUVXGC34vRBOmJqsS3XDPA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:29:14 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xzUvu7W6aiW7xe9I3O5Jle62PVkSnsC2Pn1_VA0eKCawXCozBCDxj_zbJtTwHwrBkUVXGC34vRBOmJqsS3XDPA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:29:14 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for transfers to finish 2025/10/27 03:29:14 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/dst': not deleting files as there were IO errors 2025/10/27 03:29:14 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/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/xzUvu7W6aiW7xe9I3O5Jle62PVkSnsC2Pn1_VA0eKCawXCozBCDxj_zbJtTwHwrBkUVXGC34vRBOmJqsS3XDPA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (305.05s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:29:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/dst" 2025/10/27 03:29:21 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Has cached credentials 2025/10/27 03:29:22 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:31:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/backup" 2025/10/27 03:31:03 DEBUG : Config file has changed externally - reloading 2025/10/27 03:31:03 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Has cached credentials 2025/10/27 03:31:04 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/backup': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:34:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/27 03:34:19 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:34:19 DEBUG : two: Unchanged skipping 2025/10/27 03:34:19 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for checks to finish 2025/10/27 03:34:20.058991 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CFLfm4Qrld18Z1LHpNeASwf-coMOXBvQjBB3ly3bDrCNI4qYHroAURR6sP9_-aQRm8E9BLxLWodZMjNjUFWfJg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:34:20.059013 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CFLfm4Qrld18Z1LHpNeASwf-coMOXBvQjBB3ly3bDrCNI4qYHroAURR6sP9_-aQRm8E9BLxLWodZMjNjUFWfJg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:34:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CFLfm4Qrld18Z1LHpNeASwf-coMOXBvQjBB3ly3bDrCNI4qYHroAURR6sP9_-aQRm8E9BLxLWodZMjNjUFWfJg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:34:20 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for transfers to finish 2025/10/27 03:34:20 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/dst': not deleting files as there were IO errors 2025/10/27 03:34:20 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/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/CFLfm4Qrld18Z1LHpNeASwf-coMOXBvQjBB3ly3bDrCNI4qYHroAURR6sP9_-aQRm8E9BLxLWodZMjNjUFWfJg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (305.32s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-pikugiz1laho'", Local "Local file system at /tmp/rclone261078194", Modify Window "1s" 2025/10/27 03:34:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pikugiz1laho/dst" 2025/10/27 03:34:26 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Has cached credentials 2025/10/27 03:34:27 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Used cached credential to initialize the ProtonDrive API 2025/10/27 03:36:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/27 03:36:04 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/27 03:36:04 DEBUG : two: Unchanged skipping 2025/10/27 03:36:04 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for checks to finish 2025/10/27 03:36:05.351253 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bh0io9v8g8TN74tjvNSLbRLTU543D7_-p_nkZUFFgWjp3iOZAKfnRiTOR--_CiqcLioZubz9R0sVsTY9u-SH5g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/27 03:36:05.351319 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bh0io9v8g8TN74tjvNSLbRLTU543D7_-p_nkZUFFgWjp3iOZAKfnRiTOR--_CiqcLioZubz9R0sVsTY9u-SH5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:36:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bh0io9v8g8TN74tjvNSLbRLTU543D7_-p_nkZUFFgWjp3iOZAKfnRiTOR--_CiqcLioZubz9R0sVsTY9u-SH5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/27 03:36:05 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho/dst': Waiting for transfers to finish 2025/10/27 03:36:05 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/dst': not deleting files as there were IO errors 2025/10/27 03:36:05 ERROR : proton drive root link ID 'rclone-test-pikugiz1laho/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/Bh0io9v8g8TN74tjvNSLbRLTU543D7_-p_nkZUFFgWjp3iOZAKfnRiTOR--_CiqcLioZubz9R0sVsTY9u-SH5g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (104.97s) FAIL 2025/10/27 03:36:07 DEBUG : proton drive root link ID 'rclone-test-pikugiz1laho': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 18m3.899202667s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]