"./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 2/5) 2025/05/04 07:03:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-temopey6maki" 2025/05/04 07:03:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/04 07:03:27 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Has cached credentials 2025/05/04 07:03:29 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Used cached credential to initialize the ProtonDrive API 2025/05/04 07:03:29 DEBUG : Creating backend with remote "/tmp/rclone2959467910" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:03:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-suvukeq6gova" 2025/05/04 07:03:33 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Has cached credentials 2025/05/04 07:03:35 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-temopey6maki' -> proton drive root link ID 'rclone-test-suvukeq6gova' 2025/05/04 07:03:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/04 07:03:36 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Waiting for checks to finish 2025/05/04 07:03:36 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Waiting for transfers to finish 2025/05/04 07:03:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/04 07:03:40 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:03:42.366010 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/05/04 07:03:42.366043 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/05/04 07:03:44 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Using server-side directory move 2025/05/04 07:03:44 INFO : proton drive root link ID 'rclone-test-suvukeq6gova': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/04 07:03:45 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/04 07:03:45 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Waiting for checks to finish 2025/05/04 07:03:45 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Waiting for transfers to finish 2025/05/04 07:03:46 INFO : sub dir/hello world: Deleted 2025/05/04 07:03:46.978050 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3wDycOSz7x0q4DGhdh0BOGu9N9KxipwugUu2apPk7b0LOuszhbF2KAPFPqcHQ5oUTtk6e2-iCZH2-tGGHYfOWA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:03:46.978089 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3wDycOSz7x0q4DGhdh0BOGu9N9KxipwugUu2apPk7b0LOuszhbF2KAPFPqcHQ5oUTtk6e2-iCZH2-tGGHYfOWA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:03:46 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3wDycOSz7x0q4DGhdh0BOGu9N9KxipwugUu2apPk7b0LOuszhbF2KAPFPqcHQ5oUTtk6e2-iCZH2-tGGHYfOWA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3wDycOSz7x0q4DGhdh0BOGu9N9KxipwugUu2apPk7b0LOuszhbF2KAPFPqcHQ5oUTtk6e2-iCZH2-tGGHYfOWA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/05/04 07:03:46 DEBUG : proton drive root link ID 'rclone-test-suvukeq6gova': Purge remote --- FAIL: TestServerSideMoveOverSelf (20.76s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/05/04 07:03:50 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:03:50 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:03:50 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:03:50 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/04 07:03:50 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:03:50 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/04 07:03:50 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:03:52 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:03:52 INFO : yam: Copied (new) 2025/05/04 07:03:52 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/04 07:03:52 INFO : potato: Copied (new) 2025/05/04 07:03:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:03:53 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/04 07:03:53 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:03:53 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:03:53 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:03:53 DEBUG : potato: Unchanged skipping 2025/05/04 07:03:53 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:03:54.140091 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FH4BbRhB4AM2CUPTXlXmKz3gaaYfLnR0aeYv9AQHUCQHDNDOOAd_E3S0nmfHJnXxf1o4brJciX6ZnQCVeTAtfA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:03:54.140127 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FH4BbRhB4AM2CUPTXlXmKz3gaaYfLnR0aeYv9AQHUCQHDNDOOAd_E3S0nmfHJnXxf1o4brJciX6ZnQCVeTAtfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:03:54 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FH4BbRhB4AM2CUPTXlXmKz3gaaYfLnR0aeYv9AQHUCQHDNDOOAd_E3S0nmfHJnXxf1o4brJciX6ZnQCVeTAtfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:03:54 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FH4BbRhB4AM2CUPTXlXmKz3gaaYfLnR0aeYv9AQHUCQHDNDOOAd_E3S0nmfHJnXxf1o4brJciX6ZnQCVeTAtfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:03:54 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/04 07:03:54 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:03:55 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:03:55 INFO : yaml: Copied (new) 2025/05/04 07:03:55 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting files as there were IO errors 2025/05/04 07:03:55 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.27s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/05/04 07:03:58 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:03:58 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:03:58 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:03:58 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/04 07:03:58 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/04 07:03:58 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:03:58 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:04:00 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/04 07:04:00 INFO : potato: Copied (new) 2025/05/04 07:04:00 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:04:00 INFO : yam: Copied (new) 2025/05/04 07:04:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:04:02 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/04 07:04:02 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:04:02 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:04:02 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:04:02 DEBUG : potato: Unchanged skipping 2025/05/04 07:04:02 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:04:03.485054 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2eS2tSoehH9kQ-hYxEO7mzUvVIk-ciMZpzIghIPxe58yqW6bGC62H-ddTc-EoiLilT9Cs4cDTesIECg9nK_KdA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:03.485092 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2eS2tSoehH9kQ-hYxEO7mzUvVIk-ciMZpzIghIPxe58yqW6bGC62H-ddTc-EoiLilT9Cs4cDTesIECg9nK_KdA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:03 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2eS2tSoehH9kQ-hYxEO7mzUvVIk-ciMZpzIghIPxe58yqW6bGC62H-ddTc-EoiLilT9Cs4cDTesIECg9nK_KdA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:03 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2eS2tSoehH9kQ-hYxEO7mzUvVIk-ciMZpzIghIPxe58yqW6bGC62H-ddTc-EoiLilT9Cs4cDTesIECg9nK_KdA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:03 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/04 07:04:03 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:04:04 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:04:04 INFO : yaml: Copied (new) 2025/05/04 07:04:04 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting files as there were IO errors 2025/05/04 07:04:04 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (9.44s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/05/04 07:04:08 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:04:08 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:04:08 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:04:08 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/04 07:04:08 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:04:08 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/05/04 07:04:08 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:04:10 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/04 07:04:10 INFO : potato: Copied (new) 2025/05/04 07:04:10 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:04:10 INFO : sub/yam: Copied (new) 2025/05/04 07:04:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:04:12 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/04 07:04:12 DEBUG : potato: Unchanged skipping 2025/05/04 07:04:12 INFO : proton drive root link ID 'rclone-test-temopey6maki': Making map for --track-renames 2025/05/04 07:04:12 INFO : proton drive root link ID 'rclone-test-temopey6maki': Finished making map for --track-renames 2025/05/04 07:04:12 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:04:12 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for renames to finish 2025/05/04 07:04:13.505003 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7vch6LnSRDRpOIqF7DvC_0sWC7oi0H2bh1tlTFQxMbQrQxJQ7akHAYM6LjlaxKG2WGleyMe62gNUSVbGr0paw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:13.505037 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7vch6LnSRDRpOIqF7DvC_0sWC7oi0H2bh1tlTFQxMbQrQxJQ7akHAYM6LjlaxKG2WGleyMe62gNUSVbGr0paw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:13 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7vch6LnSRDRpOIqF7DvC_0sWC7oi0H2bh1tlTFQxMbQrQxJQ7akHAYM6LjlaxKG2WGleyMe62gNUSVbGr0paw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:13 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z7vch6LnSRDRpOIqF7DvC_0sWC7oi0H2bh1tlTFQxMbQrQxJQ7akHAYM6LjlaxKG2WGleyMe62gNUSVbGr0paw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:13 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/04 07:04:13 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:04:14 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/04 07:04:14 INFO : yam: Copied (new) 2025/05/04 07:04:14 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting files as there were IO errors 2025/05/04 07:04:14 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (11.13s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:04:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/04 07:04:19 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/05/04 07:04:19 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for checks to finish 2025/05/04 07:04:19 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Waiting for transfers to finish 2025/05/04 07:04:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/04 07:04:23 INFO : sub dir/hello world: Copied (new) 2025/05/04 07:04:23 INFO : sub dir/hello world: Deleted 2025/05/04 07:04:23 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/05/04 07:04:23 INFO : nested/sub dir/file: Copied (new) 2025/05/04 07:04:23 INFO : nested/sub dir/file: Deleted 2025/05/04 07:04:23 ERROR : Local file system at /tmp/rclone2959467910: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (7.92s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:04:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gigexov5lavi" 2025/05/04 07:04:27 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Has cached credentials 2025/05/04 07:04:28 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-temopey6maki' -> proton drive root link ID 'rclone-test-gigexov5lavi' 2025/05/04 07:04:39 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Using server-side directory move 2025/05/04 07:04:39 INFO : proton drive root link ID 'rclone-test-gigexov5lavi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/04 07:04:39 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/04 07:04:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/04 07:04:39 DEBUG : empty space: Unchanged skipping 2025/05/04 07:04:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/04 07:04:39 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Waiting for checks to finish 2025/05/04 07:04:40 INFO : empty space: Deleted 2025/05/04 07:04:40 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Waiting for transfers to finish 2025/05/04 07:04:40 INFO : potato3: Deleted 2025/05/04 07:04:40.576526 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oEl8tvaRKpn5_blKHaJt2HBbCD4V8IKugl3dTxTMvkv5efxxlMWuw_qaLGPIvKCk_LYUitrNB5JGBp2I-KnIqg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:40.576564 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oEl8tvaRKpn5_blKHaJt2HBbCD4V8IKugl3dTxTMvkv5efxxlMWuw_qaLGPIvKCk_LYUitrNB5JGBp2I-KnIqg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:40 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oEl8tvaRKpn5_blKHaJt2HBbCD4V8IKugl3dTxTMvkv5efxxlMWuw_qaLGPIvKCk_LYUitrNB5JGBp2I-KnIqg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:40.809215 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3k8Dy72s8cWaqJuXgCdt3i38cRYADKhHfOtp1P_kPTd2PgM2lCVoZ6CcoyG5Ll6bGQKOCNHPl00n_Tatv5Z2HA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:40.809244 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3k8Dy72s8cWaqJuXgCdt3i38cRYADKhHfOtp1P_kPTd2PgM2lCVoZ6CcoyG5Ll6bGQKOCNHPl00n_Tatv5Z2HA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:40 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3k8Dy72s8cWaqJuXgCdt3i38cRYADKhHfOtp1P_kPTd2PgM2lCVoZ6CcoyG5Ll6bGQKOCNHPl00n_Tatv5Z2HA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3k8Dy72s8cWaqJuXgCdt3i38cRYADKhHfOtp1P_kPTd2PgM2lCVoZ6CcoyG5Ll6bGQKOCNHPl00n_Tatv5Z2HA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/05/04 07:04:40 DEBUG : proton drive root link ID 'rclone-test-gigexov5lavi': Purge remote --- FAIL: TestServerSideMove (16.97s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:04:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yirajiy2hapa" 2025/05/04 07:04:44 DEBUG : proton drive root link ID 'rclone-test-yirajiy2hapa': Has cached credentials 2025/05/04 07:04:45 DEBUG : proton drive root link ID 'rclone-test-yirajiy2hapa': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-temopey6maki' -> proton drive root link ID 'rclone-test-yirajiy2hapa' 2025/05/04 07:04:56 DEBUG : empty space: Excluded (Size Filter) 2025/05/04 07:04:56 DEBUG : empty space: Excluded 2025/05/04 07:04:56 DEBUG : empty space: Excluded (Size Filter) 2025/05/04 07:04:56 DEBUG : empty space: Excluded 2025/05/04 07:04:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/04 07:04:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/04 07:04:56 DEBUG : proton drive root link ID 'rclone-test-yirajiy2hapa': Waiting for checks to finish 2025/05/04 07:04:56 DEBUG : proton drive root link ID 'rclone-test-yirajiy2hapa': Waiting for transfers to finish 2025/05/04 07:04:56 INFO : potato3: Deleted 2025/05/04 07:04:57.056523 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sMvwogf9PjoFPpVVlu6IbBv5jvF8eCcjaPJC_TbKP3xMgGgp81zWVEbugE3Egmg3KLISR9WveC71GOAgyu35lA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:57.056583 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sMvwogf9PjoFPpVVlu6IbBv5jvF8eCcjaPJC_TbKP3xMgGgp81zWVEbugE3Egmg3KLISR9WveC71GOAgyu35lA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sMvwogf9PjoFPpVVlu6IbBv5jvF8eCcjaPJC_TbKP3xMgGgp81zWVEbugE3Egmg3KLISR9WveC71GOAgyu35lA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:57.442123 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O3e_duiZ5MriKSgIefQwRHjcSBUNYixTEzXGZYep2Qs38_Hx6EG-FnoZF6KR1ne7D0vap2KA3GC8xGTNXTO54g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:04:57.442153 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O3e_duiZ5MriKSgIefQwRHjcSBUNYixTEzXGZYep2Qs38_Hx6EG-FnoZF6KR1ne7D0vap2KA3GC8xGTNXTO54g==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:04:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O3e_duiZ5MriKSgIefQwRHjcSBUNYixTEzXGZYep2Qs38_Hx6EG-FnoZF6KR1ne7D0vap2KA3GC8xGTNXTO54g==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O3e_duiZ5MriKSgIefQwRHjcSBUNYixTEzXGZYep2Qs38_Hx6EG-FnoZF6KR1ne7D0vap2KA3GC8xGTNXTO54g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/05/04 07:04:57 DEBUG : proton drive root link ID 'rclone-test-yirajiy2hapa': Purge remote --- FAIL: TestServerSideMoveWithFilter (16.70s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lawoqot9yido" 2025/05/04 07:05:00 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Has cached credentials 2025/05/04 07:05:02 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Used cached credential to initialize the ProtonDrive API 2025/05/04 07:05:07 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-temopey6maki' -> proton drive root link ID 'rclone-test-lawoqot9yido' 2025/05/04 07:05:13 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Using server-side directory move 2025/05/04 07:05:13 INFO : proton drive root link ID 'rclone-test-lawoqot9yido': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/04 07:05:14 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/04 07:05:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/04 07:05:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/04 07:05:14 DEBUG : empty space: Unchanged skipping 2025/05/04 07:05:14 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Waiting for checks to finish 2025/05/04 07:05:14 INFO : potato3: Deleted 2025/05/04 07:05:14 INFO : empty space: Deleted 2025/05/04 07:05:14 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Waiting for transfers to finish 2025/05/04 07:05:15.075668 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7cztSrlikvLXpZLN9P3TwYRf8F0Cwf0LNeUnc8uHLrdn5gs2t3X7Ke59hRB7Y9VzFYB8sv4A8zoLFzIkmfBb1A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:05:15.075692 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7cztSrlikvLXpZLN9P3TwYRf8F0Cwf0LNeUnc8uHLrdn5gs2t3X7Ke59hRB7Y9VzFYB8sv4A8zoLFzIkmfBb1A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:05:15 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7cztSrlikvLXpZLN9P3TwYRf8F0Cwf0LNeUnc8uHLrdn5gs2t3X7Ke59hRB7Y9VzFYB8sv4A8zoLFzIkmfBb1A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:05:15.310915 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Th7ao16QJhED5p10pGXzgDpyLFEAvFRu1xctEVRMY8gfooAGG35Lt0YIiw-55Maq28AYfzyTNpx_E5j4uoGxyQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/04 07:05:15.310953 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Th7ao16QJhED5p10pGXzgDpyLFEAvFRu1xctEVRMY8gfooAGG35Lt0YIiw-55Maq28AYfzyTNpx_E5j4uoGxyQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:05:15 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Th7ao16QJhED5p10pGXzgDpyLFEAvFRu1xctEVRMY8gfooAGG35Lt0YIiw-55Maq28AYfzyTNpx_E5j4uoGxyQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/04 07:05:15 ERROR : proton drive root link ID 'rclone-test-temopey6maki': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/05/04 07:05:15 DEBUG : proton drive root link ID 'rclone-test-lawoqot9yido': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (17.77s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-temopey6maki/dst" 2025/05/04 07:05:25 DEBUG : proton drive root link ID 'rclone-test-temopey6maki/dst': Has cached credentials 2025/05/04 07:05:27 DEBUG : proton drive root link ID 'rclone-test-temopey6maki/dst': Used cached credential to initialize the ProtonDrive API 2025/05/04 07:05:37.256146 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=35&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:37.256196 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=35&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:37.438389 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:37.438416 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:37 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Config file has changed externally - reloading 2025/05/04 07:05:37 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file sync_test.go:2381: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2381 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: couldn't initialize a new root remote: 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: TestSyncBackupDir 2025/05/04 07:05:37.550931 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:37.550961 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:37.670351 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:37.670387 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:37 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Config file has changed externally - reloading 2025/05/04 07:05:37 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2025/05/04 07:05:37 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2381 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 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: TestSyncBackupDir --- FAIL: TestSyncBackupDir (19.13s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:37.840443 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:37.840478 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:37.998219 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:37.998259 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-temopey6maki'": 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/05/04 07:05:38.137054 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:38.137084 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:38.254200 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:38.254231 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:38 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /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:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 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 (0.58s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:38.369361 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:38.369400 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:38.496342 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:38.496400 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-temopey6maki'": 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/05/04 07:05:38.597407 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:38.597446 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:38.723534 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:38.723565 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:38 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /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:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 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-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:38.833685 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:38.833721 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:38.966531 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:38.966570 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-temopey6maki'": 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/05/04 07:05:39.098574 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:39.098605 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:39.214913 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:39.214955 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:39 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /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:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 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.49s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:39.326880 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:39.326916 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:39.509843 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:39.509886 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-temopey6maki'": 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/05/04 07:05:39.621754 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:39.621793 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:39.731490 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:39.731521 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:39 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /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:2458 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 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.52s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-temopey6maki'", Local "Local file system at /tmp/rclone2959467910", Modify Window "1s" 2025/05/04 07:05:39.878170 WARN RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:39.878204 ERROR RESTY 401 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/o7f-7XWA36LTnzqaNmTchPFiLjpPE8aFrxJpOZlSdfP7JZAgf27iCOTc-SVIzIDr0EmOAvbtmW3Vljt72mPx9Q==/checkAvailableHashes: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:39.986907 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:39.986943 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-temopey6maki'": 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/05/04 07:05:40.098688 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:40.098719 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==/children?Page=0&PageSize=150&ShowAll=1: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:40.222044 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:40.222083 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:40 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 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /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:2458 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 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/05/04 07:05:40 DEBUG : proton drive root link ID 'rclone-test-temopey6maki': Purge remote 2025/05/04 07:05:40.322002 WARN RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==: Invalid access token (Code=401, Status=401), Attempt 1 2025/05/04 07:05:40.322046 ERROR RESTY 401 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-cHAJwxg7HsPEYMcayRfNqkGB6cfcjMQQ3Fo4Pqpr4ilqFvFSmw_Xhg4nWzLAvnc2xLIcKtMcmBxvSUeWSMbqg==: Invalid access token (Code=401, Status=401) 2025/05/04 07:05:40.449925 WARN RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400), Attempt 1 2025/05/04 07:05:40.449957 ERROR RESTY 400 POST https://mail.proton.me/api/auth/v4/refresh: Invalid refresh token (Code=10013, Status=400) 2025/05/04 07:05:40 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 2m12.698529021s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]