"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 3/5) 2025/09/26 02:20:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zijiduy2xeda" 2025/09/26 02:20:54 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/26 02:20:54 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Has cached credentials 2025/09/26 02:20:56 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:20:56 DEBUG : Creating backend with remote "/tmp/rclone1791401465" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:21:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yoluger9sage" 2025/09/26 02:21:01 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Has cached credentials 2025/09/26 02:21:02 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-zijiduy2xeda' -> proton drive root link ID 'rclone-test-yoluger9sage' 2025/09/26 02:21:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/26 02:21:03 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Waiting for checks to finish 2025/09/26 02:21:03 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Waiting for transfers to finish 2025/09/26 02:21:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/26 02:21:08 INFO : sub dir/hello world: Copied (new) 2025/09/26 02:21:10.278250 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/09/26 02:21:10.278274 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/09/26 02:21:13 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Using server-side directory move 2025/09/26 02:21:13 INFO : proton drive root link ID 'rclone-test-yoluger9sage': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/26 02:21:14 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/26 02:21:14 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Waiting for checks to finish 2025/09/26 02:21:14 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Waiting for transfers to finish 2025/09/26 02:21:14 INFO : sub dir/hello world: Deleted 2025/09/26 02:21:15.629058 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F74zHV952xDfXd1nD3Mvu9YTAu2fMNutNNdViagPdnR8AnIdZoLqX7-Ek5x52N74v2FaKWSyeME6kpg2xI_PnQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:21:15.629081 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F74zHV952xDfXd1nD3Mvu9YTAu2fMNutNNdViagPdnR8AnIdZoLqX7-Ek5x52N74v2FaKWSyeME6kpg2xI_PnQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:15 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F74zHV952xDfXd1nD3Mvu9YTAu2fMNutNNdViagPdnR8AnIdZoLqX7-Ek5x52N74v2FaKWSyeME6kpg2xI_PnQ==/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/F74zHV952xDfXd1nD3Mvu9YTAu2fMNutNNdViagPdnR8AnIdZoLqX7-Ek5x52N74v2FaKWSyeME6kpg2xI_PnQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/26 02:21:15 DEBUG : proton drive root link ID 'rclone-test-yoluger9sage': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.73s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/26 02:21:18 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:18 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:18 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:18 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/26 02:21:18 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/26 02:21:18 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:18 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:20 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/26 02:21:20 INFO : potato: Copied (new) 2025/09/26 02:21:20 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:20 INFO : yam: Copied (new) 2025/09/26 02:21:20 DEBUG : Waiting for deletions to finish 2025/09/26 02:21:22 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/26 02:21:22 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:22 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:22 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:22 DEBUG : potato: Unchanged skipping 2025/09/26 02:21:22 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:22.962131 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qtmDkkCda_qSo0Bg9VSUslRRNk82uaM-WfiPIellyuvx7J08ljaHqNfhAx8zu0_01vCoz7mtl4ivLb2iHR1sQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:21:22.962153 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qtmDkkCda_qSo0Bg9VSUslRRNk82uaM-WfiPIellyuvx7J08ljaHqNfhAx8zu0_01vCoz7mtl4ivLb2iHR1sQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:22 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qtmDkkCda_qSo0Bg9VSUslRRNk82uaM-WfiPIellyuvx7J08ljaHqNfhAx8zu0_01vCoz7mtl4ivLb2iHR1sQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:22 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qtmDkkCda_qSo0Bg9VSUslRRNk82uaM-WfiPIellyuvx7J08ljaHqNfhAx8zu0_01vCoz7mtl4ivLb2iHR1sQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:22 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/26 02:21:22 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:24 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:24 INFO : yaml: Copied (new) 2025/09/26 02:21:24 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': not deleting files as there were IO errors 2025/09/26 02:21:24 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': 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.12s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/26 02:21:27 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:27 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:27 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:27 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/26 02:21:27 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/26 02:21:27 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:27 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/26 02:21:29 INFO : potato: Copied (new) 2025/09/26 02:21:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:29 INFO : yam: Copied (new) 2025/09/26 02:21:29 DEBUG : Waiting for deletions to finish 2025/09/26 02:21:31 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/26 02:21:31 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:31 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:31 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:31 DEBUG : potato: Unchanged skipping 2025/09/26 02:21:31 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:31.903641 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ODbXcDUk1V1BYbjy0DFZFWQ7r1Gd89vFQ_g8DFMtsQ2pgCT0r7UXuEGWwHCfVDuoHe4pJg8te5wdgp1aHGGdXA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:21:31.903657 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ODbXcDUk1V1BYbjy0DFZFWQ7r1Gd89vFQ_g8DFMtsQ2pgCT0r7UXuEGWwHCfVDuoHe4pJg8te5wdgp1aHGGdXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:31 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ODbXcDUk1V1BYbjy0DFZFWQ7r1Gd89vFQ_g8DFMtsQ2pgCT0r7UXuEGWwHCfVDuoHe4pJg8te5wdgp1aHGGdXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:31 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ODbXcDUk1V1BYbjy0DFZFWQ7r1Gd89vFQ_g8DFMtsQ2pgCT0r7UXuEGWwHCfVDuoHe4pJg8te5wdgp1aHGGdXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:31 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/26 02:21:31 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:34 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:34 INFO : yaml: Copied (new) 2025/09/26 02:21:34 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': not deleting files as there were IO errors 2025/09/26 02:21:34 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': 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 (8.92s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/26 02:21:36 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:36 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:36 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/26 02:21:36 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/26 02:21:36 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:36 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:39 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/26 02:21:39 INFO : potato: Copied (new) 2025/09/26 02:21:39 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:39 INFO : sub/yam: Copied (new) 2025/09/26 02:21:39 DEBUG : Waiting for deletions to finish 2025/09/26 02:21:41 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/26 02:21:41 DEBUG : potato: Unchanged skipping 2025/09/26 02:21:41 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Making map for --track-renames 2025/09/26 02:21:41 INFO : proton drive root link ID 'rclone-test-zijiduy2xeda': Finished making map for --track-renames 2025/09/26 02:21:41 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:41 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for renames to finish 2025/09/26 02:21:42.364050 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WIjXgxOlI-p51myzHKfXOkG-pTAucK7dA9MpTHqo8xYI8jncmtV6f5XuuKCcbjX6hMyOxGVeiHAx9koDvXO_Mg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:21:42.364120 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WIjXgxOlI-p51myzHKfXOkG-pTAucK7dA9MpTHqo8xYI8jncmtV6f5XuuKCcbjX6hMyOxGVeiHAx9koDvXO_Mg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:42 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WIjXgxOlI-p51myzHKfXOkG-pTAucK7dA9MpTHqo8xYI8jncmtV6f5XuuKCcbjX6hMyOxGVeiHAx9koDvXO_Mg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:42 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WIjXgxOlI-p51myzHKfXOkG-pTAucK7dA9MpTHqo8xYI8jncmtV6f5XuuKCcbjX6hMyOxGVeiHAx9koDvXO_Mg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:21:42 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/26 02:21:42 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/26 02:21:44 INFO : yam: Copied (new) 2025/09/26 02:21:44 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': not deleting files as there were IO errors 2025/09/26 02:21:44 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': 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 (11.28s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:21:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/26 02:21:47 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/26 02:21:47 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for checks to finish 2025/09/26 02:21:47 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Waiting for transfers to finish 2025/09/26 02:21:52 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/26 02:21:52 INFO : sub dir/hello world: Copied (new) 2025/09/26 02:21:52 INFO : sub dir/hello world: Deleted 2025/09/26 02:21:52 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/26 02:21:52 INFO : nested/sub dir/file: Copied (new) 2025/09/26 02:21:52 INFO : nested/sub dir/file: Deleted 2025/09/26 02:21:52 ERROR : Local file system at /tmp/rclone1791401465: 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 (8.37s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:21:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mawufod7wefu" 2025/09/26 02:21:56 DEBUG : Config file has changed externally - reloading 2025/09/26 02:21:56 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Has cached credentials 2025/09/26 02:21:57 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zijiduy2xeda' -> proton drive root link ID 'rclone-test-mawufod7wefu' 2025/09/26 02:22:10 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Using server-side directory move 2025/09/26 02:22:10 INFO : proton drive root link ID 'rclone-test-mawufod7wefu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/26 02:22:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/26 02:22:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/26 02:22:10 DEBUG : empty space: Unchanged skipping 2025/09/26 02:22:10 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Waiting for checks to finish 2025/09/26 02:22:10 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/26 02:22:11 INFO : empty space: Deleted 2025/09/26 02:22:11 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Waiting for transfers to finish 2025/09/26 02:22:11 INFO : potato3: Deleted 2025/09/26 02:22:11.616906 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wKBrvrpcht5l3QPFSQJ_nUR72U4Of4WWKi6uh8_KiGYk-h8eDuEZDOtXsExiuZDB4Kx_NCK_np14b-JDt1zEng==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:11.616962 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wKBrvrpcht5l3QPFSQJ_nUR72U4Of4WWKi6uh8_KiGYk-h8eDuEZDOtXsExiuZDB4Kx_NCK_np14b-JDt1zEng==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:11 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wKBrvrpcht5l3QPFSQJ_nUR72U4Of4WWKi6uh8_KiGYk-h8eDuEZDOtXsExiuZDB4Kx_NCK_np14b-JDt1zEng==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:11.948929 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/a1En_hwGE13I4CuuOBEfOS5mIzjyVCk4rVDJGpZ_W8htyvb_S2damn89p-Xc7d45cOpCjsECbulRgtJOWgxYaQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:11.948976 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/a1En_hwGE13I4CuuOBEfOS5mIzjyVCk4rVDJGpZ_W8htyvb_S2damn89p-Xc7d45cOpCjsECbulRgtJOWgxYaQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:11 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/a1En_hwGE13I4CuuOBEfOS5mIzjyVCk4rVDJGpZ_W8htyvb_S2damn89p-Xc7d45cOpCjsECbulRgtJOWgxYaQ==/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/a1En_hwGE13I4CuuOBEfOS5mIzjyVCk4rVDJGpZ_W8htyvb_S2damn89p-Xc7d45cOpCjsECbulRgtJOWgxYaQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/26 02:22:11 DEBUG : proton drive root link ID 'rclone-test-mawufod7wefu': Purge remote --- FAIL: TestServerSideMove (18.41s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:22:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-satipeg5xeci" 2025/09/26 02:22:14 DEBUG : proton drive root link ID 'rclone-test-satipeg5xeci': Has cached credentials 2025/09/26 02:22:15 DEBUG : proton drive root link ID 'rclone-test-satipeg5xeci': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zijiduy2xeda' -> proton drive root link ID 'rclone-test-satipeg5xeci' 2025/09/26 02:22:29 DEBUG : empty space: Excluded (Size Filter) 2025/09/26 02:22:29 DEBUG : empty space: Excluded 2025/09/26 02:22:29 DEBUG : empty space: Excluded (Size Filter) 2025/09/26 02:22:29 DEBUG : empty space: Excluded 2025/09/26 02:22:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/26 02:22:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/26 02:22:29 DEBUG : proton drive root link ID 'rclone-test-satipeg5xeci': Waiting for checks to finish 2025/09/26 02:22:29 DEBUG : proton drive root link ID 'rclone-test-satipeg5xeci': Waiting for transfers to finish 2025/09/26 02:22:30 INFO : potato3: Deleted 2025/09/26 02:22:30.341414 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qhSEfxJHN8SPC1v-UDuL2KtHRf8bA7kpe41PsrfWBuQuqnigybmzVfz_9LSdgpEWFH2b_YpmH78awyEyRKzbgQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:30.341443 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qhSEfxJHN8SPC1v-UDuL2KtHRf8bA7kpe41PsrfWBuQuqnigybmzVfz_9LSdgpEWFH2b_YpmH78awyEyRKzbgQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:30 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qhSEfxJHN8SPC1v-UDuL2KtHRf8bA7kpe41PsrfWBuQuqnigybmzVfz_9LSdgpEWFH2b_YpmH78awyEyRKzbgQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:30.647915 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oqDxJpWnacxuyC9jF8bRLjB2iZarW_3wY2YHPw9cvr8PBg7tgcOCr5wiOr-pGgi3i1vOcje0TuLujO1Hop_taw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:30.647958 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oqDxJpWnacxuyC9jF8bRLjB2iZarW_3wY2YHPw9cvr8PBg7tgcOCr5wiOr-pGgi3i1vOcje0TuLujO1Hop_taw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oqDxJpWnacxuyC9jF8bRLjB2iZarW_3wY2YHPw9cvr8PBg7tgcOCr5wiOr-pGgi3i1vOcje0TuLujO1Hop_taw==/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/oqDxJpWnacxuyC9jF8bRLjB2iZarW_3wY2YHPw9cvr8PBg7tgcOCr5wiOr-pGgi3i1vOcje0TuLujO1Hop_taw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/26 02:22:30 DEBUG : proton drive root link ID 'rclone-test-satipeg5xeci': Purge remote --- FAIL: TestServerSideMoveWithFilter (19.37s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:22:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tegaduy1luma" 2025/09/26 02:22:33 DEBUG : Config file has changed externally - reloading 2025/09/26 02:22:33 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Has cached credentials 2025/09/26 02:22:35 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:22:41 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zijiduy2xeda' -> proton drive root link ID 'rclone-test-tegaduy1luma' 2025/09/26 02:22:48 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Using server-side directory move 2025/09/26 02:22:48 INFO : proton drive root link ID 'rclone-test-tegaduy1luma': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/26 02:22:49 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/26 02:22:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/26 02:22:49 DEBUG : empty space: Unchanged skipping 2025/09/26 02:22:49 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/26 02:22:49 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Waiting for checks to finish 2025/09/26 02:22:50 INFO : potato3: Deleted 2025/09/26 02:22:50 INFO : empty space: Deleted 2025/09/26 02:22:50 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Waiting for transfers to finish 2025/09/26 02:22:50.702864 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fme-zsudX_BtMm5VX-cee9W256MuI8jbp_jYGQVxkHzwJk3w6ZR8dUcwaLY_ywg66ahibjnuhYPs05RtdzyPTg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:50.702935 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fme-zsudX_BtMm5VX-cee9W256MuI8jbp_jYGQVxkHzwJk3w6ZR8dUcwaLY_ywg66ahibjnuhYPs05RtdzyPTg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:50 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fme-zsudX_BtMm5VX-cee9W256MuI8jbp_jYGQVxkHzwJk3w6ZR8dUcwaLY_ywg66ahibjnuhYPs05RtdzyPTg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:50.851022 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/W2QD9pOLsUXfJOoqzh8ILevbsEcDcK8flTlJQCMjuNhLe3JuXhGWuCQnOuzLm9-uumQjTxoW-hYVHEn29HfNqA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:22:50.851055 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/W2QD9pOLsUXfJOoqzh8ILevbsEcDcK8flTlJQCMjuNhLe3JuXhGWuCQnOuzLm9-uumQjTxoW-hYVHEn29HfNqA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:50 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/W2QD9pOLsUXfJOoqzh8ILevbsEcDcK8flTlJQCMjuNhLe3JuXhGWuCQnOuzLm9-uumQjTxoW-hYVHEn29HfNqA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:22:50 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/09/26 02:22:50 DEBUG : proton drive root link ID 'rclone-test-tegaduy1luma': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (20.37s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:23:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zijiduy2xeda/dst" 2025/09/26 02:23:02 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Has cached credentials 2025/09/26 02:23:03 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:25:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zijiduy2xeda/backup" 2025/09/26 02:25:00 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/backup': Has cached credentials 2025/09/26 02:25:01 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/backup': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:28:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/26 02:28:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/26 02:28:53 DEBUG : two: Unchanged skipping 2025/09/26 02:28:53 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Waiting for checks to finish 2025/09/26 02:28:54.969786 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/t21vnZ9Zwx72L3i9ILd_oXrYF5yV5Vg_7MVNQQZGqQ9PJaOaGuq_NUlzm-Cjg5fgsikd_5mEqhbMo_D5c45nzw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:28:54.969821 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/t21vnZ9Zwx72L3i9ILd_oXrYF5yV5Vg_7MVNQQZGqQ9PJaOaGuq_NUlzm-Cjg5fgsikd_5mEqhbMo_D5c45nzw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:28:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/t21vnZ9Zwx72L3i9ILd_oXrYF5yV5Vg_7MVNQQZGqQ9PJaOaGuq_NUlzm-Cjg5fgsikd_5mEqhbMo_D5c45nzw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:28:54 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Waiting for transfers to finish 2025/09/26 02:28:54 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': not deleting files as there were IO errors 2025/09/26 02:28:54 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda/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/t21vnZ9Zwx72L3i9ILd_oXrYF5yV5Vg_7MVNQQZGqQ9PJaOaGuq_NUlzm-Cjg5fgsikd_5mEqhbMo_D5c45nzw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (364.79s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-zijiduy2xeda'", Local "Local file system at /tmp/rclone1791401465", Modify Window "1s" 2025/09/26 02:29:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zijiduy2xeda/dst" 2025/09/26 02:29:07 DEBUG : Config file has changed externally - reloading 2025/09/26 02:29:07 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Has cached credentials 2025/09/26 02:29:08 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:31:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zijiduy2xeda/backup" 2025/09/26 02:31:04 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/backup': Has cached credentials 2025/09/26 02:31:06 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/backup': Used cached credential to initialize the ProtonDrive API 2025/09/26 02:35:03 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/26 02:35:03 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/26 02:35:03 DEBUG : two: Unchanged skipping 2025/09/26 02:35:03 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Waiting for checks to finish 2025/09/26 02:35:05.787981 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L0eUjJn6oh0KNOzHyGEyjQowDUHin75mLDmdz_QfbcezzUDTlBdPyps-hjtHOurkl9chUZls8-UwW-Im1RGGUg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/26 02:35:05.788030 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L0eUjJn6oh0KNOzHyGEyjQowDUHin75mLDmdz_QfbcezzUDTlBdPyps-hjtHOurkl9chUZls8-UwW-Im1RGGUg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:35:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L0eUjJn6oh0KNOzHyGEyjQowDUHin75mLDmdz_QfbcezzUDTlBdPyps-hjtHOurkl9chUZls8-UwW-Im1RGGUg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/26 02:35:05 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': Waiting for transfers to finish 2025/09/26 02:35:05 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda/dst': not deleting files as there were IO errors 2025/09/26 02:35:05 ERROR : proton drive root link ID 'rclone-test-zijiduy2xeda/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/L0eUjJn6oh0KNOzHyGEyjQowDUHin75mLDmdz_QfbcezzUDTlBdPyps-hjtHOurkl9chUZls8-UwW-Im1RGGUg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (370.73s) FAIL 2025/09/26 02:35:09 DEBUG : proton drive root link ID 'rclone-test-zijiduy2xeda': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 14m15.602087349s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix]