"./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 4/5) 2025/08/02 03:55:12 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-safiwuq5wohi" 2025/08/02 03:55:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/02 03:55:12 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Has cached credentials 2025/08/02 03:55:14 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Used cached credential to initialize the ProtonDrive API 2025/08/02 03:55:15 DEBUG : Creating backend with remote "/tmp/rclone3037103700" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:55:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-legulew4yula" 2025/08/02 03:55:20 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Has cached credentials 2025/08/02 03:55:22 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-safiwuq5wohi' -> proton drive root link ID 'rclone-test-legulew4yula' 2025/08/02 03:55:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/02 03:55:24 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Waiting for checks to finish 2025/08/02 03:55:24 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Waiting for transfers to finish 2025/08/02 03:55:29 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/02 03:55:29 INFO : sub dir/hello world: Copied (new) 2025/08/02 03:55:31.919964 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/08/02 03:55:31.920002 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/08/02 03:55:34 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Using server-side directory move 2025/08/02 03:55:34 INFO : proton drive root link ID 'rclone-test-legulew4yula': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/02 03:55:36 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/02 03:55:36 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Waiting for checks to finish 2025/08/02 03:55:36 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Waiting for transfers to finish 2025/08/02 03:55:36 INFO : sub dir/hello world: Deleted 2025/08/02 03:55:38.291928 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GcpkfaLIq0IerRHQQMUala8qfJOPxvKpcbmVCHaD5dciAUu1uSRWQMCYMSq8mf8cCEZHtdE3WiTihrs1kslHGQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:55:38.291971 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GcpkfaLIq0IerRHQQMUala8qfJOPxvKpcbmVCHaD5dciAUu1uSRWQMCYMSq8mf8cCEZHtdE3WiTihrs1kslHGQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:38 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GcpkfaLIq0IerRHQQMUala8qfJOPxvKpcbmVCHaD5dciAUu1uSRWQMCYMSq8mf8cCEZHtdE3WiTihrs1kslHGQ==/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/GcpkfaLIq0IerRHQQMUala8qfJOPxvKpcbmVCHaD5dciAUu1uSRWQMCYMSq8mf8cCEZHtdE3WiTihrs1kslHGQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/02 03:55:38 DEBUG : proton drive root link ID 'rclone-test-legulew4yula': Purge remote --- FAIL: TestServerSideMoveOverSelf (26.71s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/02 03:55:42 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:55:42 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:55:42 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:55:42 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/02 03:55:42 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/02 03:55:42 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:55:42 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:55:43 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/02 03:55:43 INFO : potato: Copied (new) 2025/08/02 03:55:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:55:44 INFO : yam: Copied (new) 2025/08/02 03:55:44 DEBUG : Waiting for deletions to finish 2025/08/02 03:55:46 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/02 03:55:46 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:55:46 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:55:46 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:55:46 DEBUG : potato: Unchanged skipping 2025/08/02 03:55:46 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:55:47.168498 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LCY7bSYfpo66fzJZgRZ2J0gfJr3mAvL52ooDQ-RTjOFhMnifL2sQi9dn1pV2EcWBn9JkTOMbE7Xl1l3I06zidg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:55:47.168521 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LCY7bSYfpo66fzJZgRZ2J0gfJr3mAvL52ooDQ-RTjOFhMnifL2sQi9dn1pV2EcWBn9JkTOMbE7Xl1l3I06zidg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:47 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LCY7bSYfpo66fzJZgRZ2J0gfJr3mAvL52ooDQ-RTjOFhMnifL2sQi9dn1pV2EcWBn9JkTOMbE7Xl1l3I06zidg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:47 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LCY7bSYfpo66fzJZgRZ2J0gfJr3mAvL52ooDQ-RTjOFhMnifL2sQi9dn1pV2EcWBn9JkTOMbE7Xl1l3I06zidg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:47 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/02 03:55:47 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:55:48 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:55:48 INFO : yaml: Copied (new) 2025/08/02 03:55:48 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': not deleting files as there were IO errors 2025/08/02 03:55:48 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': 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 (9.98s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/02 03:55:52 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:55:52 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:55:52 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:55:52 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:55:52 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/02 03:55:52 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/02 03:55:52 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:55:54 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:55:54 INFO : yam: Copied (new) 2025/08/02 03:55:54 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/02 03:55:54 INFO : potato: Copied (new) 2025/08/02 03:55:54 DEBUG : Waiting for deletions to finish 2025/08/02 03:55:56 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/02 03:55:56 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:55:56 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:55:56 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:55:56 DEBUG : potato: Unchanged skipping 2025/08/02 03:55:56 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:55:56.939219 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T71XoQGbV0dHVEk7XtF8E9PqMOTGCG08owUVO91OcucIb7xf72JOcfrO-CEY6MMbZgh8IN9WPBnoXTU2cK80bQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:55:56.939247 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T71XoQGbV0dHVEk7XtF8E9PqMOTGCG08owUVO91OcucIb7xf72JOcfrO-CEY6MMbZgh8IN9WPBnoXTU2cK80bQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:56 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T71XoQGbV0dHVEk7XtF8E9PqMOTGCG08owUVO91OcucIb7xf72JOcfrO-CEY6MMbZgh8IN9WPBnoXTU2cK80bQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:56 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T71XoQGbV0dHVEk7XtF8E9PqMOTGCG08owUVO91OcucIb7xf72JOcfrO-CEY6MMbZgh8IN9WPBnoXTU2cK80bQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:55:56 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/02 03:55:56 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:55:58 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:55:58 INFO : yaml: Copied (new) 2025/08/02 03:55:58 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': not deleting files as there were IO errors 2025/08/02 03:55:58 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': 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.99s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/02 03:56:02 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:56:02 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:56:02 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:56:02 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/02 03:56:02 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/02 03:56:02 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:56:02 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:56:04 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/02 03:56:04 INFO : potato: Copied (new) 2025/08/02 03:56:05 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:56:05 INFO : sub/yam: Copied (new) 2025/08/02 03:56:05 DEBUG : Waiting for deletions to finish 2025/08/02 03:56:07 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/02 03:56:07 DEBUG : potato: Unchanged skipping 2025/08/02 03:56:08 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Making map for --track-renames 2025/08/02 03:56:08 INFO : proton drive root link ID 'rclone-test-safiwuq5wohi': Finished making map for --track-renames 2025/08/02 03:56:08 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:56:08 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for renames to finish 2025/08/02 03:56:09.249937 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CG_5a5lOIr6t3j7zLCH8KjfusTKNUFLbDSOEohUkq3HX3wMTtKZPJLSpIEyfW53lvA1nzSM1POB3nohHfkIwSw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:56:09.249982 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CG_5a5lOIr6t3j7zLCH8KjfusTKNUFLbDSOEohUkq3HX3wMTtKZPJLSpIEyfW53lvA1nzSM1POB3nohHfkIwSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:09 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CG_5a5lOIr6t3j7zLCH8KjfusTKNUFLbDSOEohUkq3HX3wMTtKZPJLSpIEyfW53lvA1nzSM1POB3nohHfkIwSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:09 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CG_5a5lOIr6t3j7zLCH8KjfusTKNUFLbDSOEohUkq3HX3wMTtKZPJLSpIEyfW53lvA1nzSM1POB3nohHfkIwSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:09 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/02 03:56:09 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:56:10 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/02 03:56:10 INFO : yam: Copied (new) 2025/08/02 03:56:10 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': not deleting files as there were IO errors 2025/08/02 03:56:10 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': 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 (13.27s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:56:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/02 03:56:15 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/02 03:56:15 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for checks to finish 2025/08/02 03:56:15 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Waiting for transfers to finish 2025/08/02 03:56:20 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/02 03:56:20 INFO : nested/sub dir/file: Copied (new) 2025/08/02 03:56:20 INFO : nested/sub dir/file: Deleted 2025/08/02 03:56:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/02 03:56:20 INFO : sub dir/hello world: Copied (new) 2025/08/02 03:56:20 INFO : sub dir/hello world: Deleted 2025/08/02 03:56:20 ERROR : Local file system at /tmp/rclone3037103700: 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.13s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:56:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lokakav7suze" 2025/08/02 03:56:25 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Has cached credentials 2025/08/02 03:56:27 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-safiwuq5wohi' -> proton drive root link ID 'rclone-test-lokakav7suze' 2025/08/02 03:56:39 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Using server-side directory move 2025/08/02 03:56:39 INFO : proton drive root link ID 'rclone-test-lokakav7suze': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/02 03:56:40 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/02 03:56:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/02 03:56:40 DEBUG : empty space: Unchanged skipping 2025/08/02 03:56:40 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/02 03:56:40 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Waiting for checks to finish 2025/08/02 03:56:41 INFO : empty space: Deleted 2025/08/02 03:56:41 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Waiting for transfers to finish 2025/08/02 03:56:41 INFO : potato3: Deleted 2025/08/02 03:56:41.885162 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IsjERdM2QVZ0nZ96GtSw1EUWsfu8GuE3zDOcu4q7F2m0Mw_tziOOKZHCYZVSD2ewvGnfZsfXanDclKpE1h_8EA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:56:41.885208 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IsjERdM2QVZ0nZ96GtSw1EUWsfu8GuE3zDOcu4q7F2m0Mw_tziOOKZHCYZVSD2ewvGnfZsfXanDclKpE1h_8EA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:41 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IsjERdM2QVZ0nZ96GtSw1EUWsfu8GuE3zDOcu4q7F2m0Mw_tziOOKZHCYZVSD2ewvGnfZsfXanDclKpE1h_8EA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:42.390705 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u-79M7iPH_q2VoUtLlTPbVihJxbbbxisLjMVi5L4d5RApyY4e-GkBP25C4UKC8wzadomiImgc-yMaD1sChbVjg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:56:42.390746 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u-79M7iPH_q2VoUtLlTPbVihJxbbbxisLjMVi5L4d5RApyY4e-GkBP25C4UKC8wzadomiImgc-yMaD1sChbVjg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:56:42 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/u-79M7iPH_q2VoUtLlTPbVihJxbbbxisLjMVi5L4d5RApyY4e-GkBP25C4UKC8wzadomiImgc-yMaD1sChbVjg==/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/u-79M7iPH_q2VoUtLlTPbVihJxbbbxisLjMVi5L4d5RApyY4e-GkBP25C4UKC8wzadomiImgc-yMaD1sChbVjg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/02 03:56:42 DEBUG : proton drive root link ID 'rclone-test-lokakav7suze': Purge remote --- FAIL: TestServerSideMove (20.55s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:56:46 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qirubis3guta" 2025/08/02 03:56:46 DEBUG : proton drive root link ID 'rclone-test-qirubis3guta': Has cached credentials 2025/08/02 03:56:48 DEBUG : proton drive root link ID 'rclone-test-qirubis3guta': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-safiwuq5wohi' -> proton drive root link ID 'rclone-test-qirubis3guta' 2025/08/02 03:57:01 DEBUG : empty space: Excluded (Size Filter) 2025/08/02 03:57:01 DEBUG : empty space: Excluded 2025/08/02 03:57:01 DEBUG : empty space: Excluded (Size Filter) 2025/08/02 03:57:01 DEBUG : empty space: Excluded 2025/08/02 03:57:01 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/02 03:57:01 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/02 03:57:01 DEBUG : proton drive root link ID 'rclone-test-qirubis3guta': Waiting for checks to finish 2025/08/02 03:57:01 DEBUG : proton drive root link ID 'rclone-test-qirubis3guta': Waiting for transfers to finish 2025/08/02 03:57:01 INFO : potato3: Deleted 2025/08/02 03:57:02.274526 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Fz64_ZYG5QtMG8PtwZKNpnMEtbThxtj1s_FSFrPQmhaoOGRy14TE6OLesHhawBF2eJrUqI5GiiTr7gC_G5BuXw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:57:02.274561 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Fz64_ZYG5QtMG8PtwZKNpnMEtbThxtj1s_FSFrPQmhaoOGRy14TE6OLesHhawBF2eJrUqI5GiiTr7gC_G5BuXw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:02 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Fz64_ZYG5QtMG8PtwZKNpnMEtbThxtj1s_FSFrPQmhaoOGRy14TE6OLesHhawBF2eJrUqI5GiiTr7gC_G5BuXw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:02.736532 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MXzrp1J6JplxVy7Prxo1dZJICXrZFM8TSk-lALeQfMkDVfUgOQ7hi0pC0GatjV7eUqNXzCAQAxkCEyxlPRQNag==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:57:02.736566 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MXzrp1J6JplxVy7Prxo1dZJICXrZFM8TSk-lALeQfMkDVfUgOQ7hi0pC0GatjV7eUqNXzCAQAxkCEyxlPRQNag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:02 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MXzrp1J6JplxVy7Prxo1dZJICXrZFM8TSk-lALeQfMkDVfUgOQ7hi0pC0GatjV7eUqNXzCAQAxkCEyxlPRQNag==/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/MXzrp1J6JplxVy7Prxo1dZJICXrZFM8TSk-lALeQfMkDVfUgOQ7hi0pC0GatjV7eUqNXzCAQAxkCEyxlPRQNag==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/02 03:57:02 DEBUG : proton drive root link ID 'rclone-test-qirubis3guta': Purge remote --- FAIL: TestServerSideMoveWithFilter (21.24s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:57:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rokonaw8voge" 2025/08/02 03:57:07 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Has cached credentials 2025/08/02 03:57:09 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Used cached credential to initialize the ProtonDrive API 2025/08/02 03:57:14 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-safiwuq5wohi' -> proton drive root link ID 'rclone-test-rokonaw8voge' 2025/08/02 03:57:22 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Using server-side directory move 2025/08/02 03:57:22 INFO : proton drive root link ID 'rclone-test-rokonaw8voge': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/02 03:57:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/02 03:57:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/02 03:57:23 DEBUG : empty space: Unchanged skipping 2025/08/02 03:57:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/02 03:57:23 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Waiting for checks to finish 2025/08/02 03:57:23 INFO : potato3: Deleted 2025/08/02 03:57:23 INFO : empty space: Deleted 2025/08/02 03:57:23 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Waiting for transfers to finish 2025/08/02 03:57:24.283253 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/66-QI7udOoo82OJaKYsbaGQJ3oXICR2OzG2-WlJ0DNHwWu0MR351yM1n0qNfCJS9DkSOAfT0sERXuzPc8lKESQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:57:24.283282 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/66-QI7udOoo82OJaKYsbaGQJ3oXICR2OzG2-WlJ0DNHwWu0MR351yM1n0qNfCJS9DkSOAfT0sERXuzPc8lKESQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:24 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/66-QI7udOoo82OJaKYsbaGQJ3oXICR2OzG2-WlJ0DNHwWu0MR351yM1n0qNfCJS9DkSOAfT0sERXuzPc8lKESQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:24.576311 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJdesrNSxgVyyEoFN8zDWB99VGFOj8QQuLz1dCZJB06qQZxdv884B5msOO3ke-MU9uPqNgCm2Cc9n7dDb6ASsQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 03:57:24.576343 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJdesrNSxgVyyEoFN8zDWB99VGFOj8QQuLz1dCZJB06qQZxdv884B5msOO3ke-MU9uPqNgCm2Cc9n7dDb6ASsQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:24 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJdesrNSxgVyyEoFN8zDWB99VGFOj8QQuLz1dCZJB06qQZxdv884B5msOO3ke-MU9uPqNgCm2Cc9n7dDb6ASsQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 03:57:24 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi': 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/08/02 03:57:24 DEBUG : proton drive root link ID 'rclone-test-rokonaw8voge': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (21.77s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 03:57:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-safiwuq5wohi/dst" 2025/08/02 03:57:36 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Has cached credentials 2025/08/02 03:57:38 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/02 03:59:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-safiwuq5wohi/backup" 2025/08/02 03:59:02 DEBUG : Config file has changed externally - reloading 2025/08/02 03:59:02 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/backup': Has cached credentials 2025/08/02 03:59:04 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/backup': Used cached credential to initialize the ProtonDrive API 2025/08/02 04:01:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/02 04:01:50 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/02 04:01:50 DEBUG : two: Unchanged skipping 2025/08/02 04:01:50 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Waiting for checks to finish 2025/08/02 04:01:52.727891 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sy-hQJwAyHbXGfRYbg1emlVC5S_QZuHjjYTTMqVh_RlffXPUBaKNG-OcpA_qcN3iGfsxJGpv-BxPPBtOAu94ag==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 04:01:52.727973 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sy-hQJwAyHbXGfRYbg1emlVC5S_QZuHjjYTTMqVh_RlffXPUBaKNG-OcpA_qcN3iGfsxJGpv-BxPPBtOAu94ag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 04:01:52 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sy-hQJwAyHbXGfRYbg1emlVC5S_QZuHjjYTTMqVh_RlffXPUBaKNG-OcpA_qcN3iGfsxJGpv-BxPPBtOAu94ag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 04:01:52 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Waiting for transfers to finish 2025/08/02 04:01:52 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': not deleting files as there were IO errors 2025/08/02 04:01:52 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi/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/sy-hQJwAyHbXGfRYbg1emlVC5S_QZuHjjYTTMqVh_RlffXPUBaKNG-OcpA_qcN3iGfsxJGpv-BxPPBtOAu94ag==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (269.16s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 04:02:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-safiwuq5wohi/dst" 2025/08/02 04:02:05 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Has cached credentials 2025/08/02 04:02:08 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/02 04:03:27.344048 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=181&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:03:27.344086 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=181&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:03:27 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/08/02 04:03:27 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/08/02 04:03:27 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/08/02 04:03:27 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2025/08/02 04:03:31 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-safiwuq5wohi/backup" 2025/08/02 04:03:31 DEBUG : Config file has changed externally - reloading 2025/08/02 04:03:31 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/backup': Using username and password to log in 2025/08/02 04:03:35 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/backup': Used username and password to initialize the ProtonDrive API 2025/08/02 04:03:35 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/08/02 04:03:35 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/08/02 04:03:35 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/08/02 04:03:35 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2025/08/02 04:06:22 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/02 04:06:22 DEBUG : two: Unchanged skipping 2025/08/02 04:06:22 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/02 04:06:22 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Waiting for checks to finish 2025/08/02 04:06:25.042568 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kMIMAxQsRHUWsTH7aqL4RiYKQGjkVcDkV_nW93PNp5zRJaAyQVXKc6sGOxkf2Ona2HAHXLyvOqQcYaeJUJHpbg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/02 04:06:25.042597 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kMIMAxQsRHUWsTH7aqL4RiYKQGjkVcDkV_nW93PNp5zRJaAyQVXKc6sGOxkf2Ona2HAHXLyvOqQcYaeJUJHpbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 04:06:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kMIMAxQsRHUWsTH7aqL4RiYKQGjkVcDkV_nW93PNp5zRJaAyQVXKc6sGOxkf2Ona2HAHXLyvOqQcYaeJUJHpbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/02 04:06:25 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': Waiting for transfers to finish 2025/08/02 04:06:25 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi/dst': not deleting files as there were IO errors 2025/08/02 04:06:25 ERROR : proton drive root link ID 'rclone-test-safiwuq5wohi/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/kMIMAxQsRHUWsTH7aqL4RiYKQGjkVcDkV_nW93PNp5zRJaAyQVXKc6sGOxkf2Ona2HAHXLyvOqQcYaeJUJHpbg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix 2025/08/02 04:06:25.176879 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:25.176910 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:25.295603 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:25.295632 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:25 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/08/02 04:06:25 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/08/02 04:06:25 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/08/02 04:06:25 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2025/08/02 04:06:25 ERROR : error listing: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:164: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:164 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /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: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (267.08s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 04:06:25.369890 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:25.369925 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:25.478633 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:25.478668 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:285: Failed to put "dst/one" to "proton drive root link ID 'rclone-test-safiwuq5wohi'": failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:25.617919 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:25.617965 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:25.781175 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:25.781205 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:25 ERROR : error listing: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:164: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:164 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2401 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (0.47s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 04:06:25.848028 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:25.848051 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:25.957779 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:25.957893 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:285: Failed to put "dst/one" to "proton drive root link ID 'rclone-test-safiwuq5wohi'": failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:26.090360 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:26.090387 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:26.199324 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:26.199381 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:26 ERROR : error listing: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:164: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:164 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2401 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (0.42s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 04:06:26.309649 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:26.309672 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:26.510978 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:26.511275 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:285: Failed to put "dst/one" to "proton drive root link ID 'rclone-test-safiwuq5wohi'": failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:26.644101 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:26.644132 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:26.838280 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:26.838351 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:26 ERROR : error listing: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:164: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:164 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2488 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (0.64s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-safiwuq5wohi'", Local "Local file system at /tmp/rclone3037103700", Modify Window "1s" 2025/08/02 04:06:26.901250 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:26.901284 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R9CIe_Ye-EGuX1_4D-ordjiuzIZ7cDo2ZVwyZS17_umnLJo_-Aj9GadTqcqFeVN-DTQU9YfF7V3VBtH2N0a-8Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:27.048369 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:27.048401 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:285: Failed to put "dst/one" to "proton drive root link ID 'rclone-test-safiwuq5wohi'": failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:27.181854 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:27.181882 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:27.326671 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:27.326703 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:27 ERROR : error listing: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) run.go:164: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:164 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2488 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (0.49s) FAIL 2025/08/02 04:06:27 DEBUG : proton drive root link ID 'rclone-test-safiwuq5wohi': Purge remote 2025/08/02 04:06:27.520814 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==: Invalid access token (Code=401, Status=401), Attempt 1 2025/08/02 04:06:27.520902 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VtjknaqrkMwM1qdH_xhKcb0KVgfEOSlYtrFMtYvM1Chv8gKZysbH1DnrSR85nehaJe3AqUgHhHkpXa85EyytkQ==: Invalid access token (Code=401, Status=401) 2025/08/02 04:06:27.626865 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/08/02 04:06:27.626905 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/08/02 04:06:27 NOTICE: purge failed: failed to refresh auth: failed to refresh auth, de-auth: 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) "./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 11m15.279742376s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]