"./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/08/11 04:31:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu" 2025/08/11 04:31:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/11 04:31:17 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Has cached credentials 2025/08/11 04:31:18 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:31:18 DEBUG : Creating backend with remote "/tmp/rclone1383014859" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:31:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-huhezug8selu" 2025/08/11 04:31:21 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Has cached credentials 2025/08/11 04:31:22 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-wuratiy5rutu' -> proton drive root link ID 'rclone-test-huhezug8selu' 2025/08/11 04:31:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/11 04:31:22 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Waiting for checks to finish 2025/08/11 04:31:22 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Waiting for transfers to finish 2025/08/11 04:31:25 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/11 04:31:25 INFO : sub dir/hello world: Copied (new) 2025/08/11 04:31:26.754668 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/11 04:31:26.754712 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/11 04:31:28 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Using server-side directory move 2025/08/11 04:31:28 INFO : proton drive root link ID 'rclone-test-huhezug8selu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/11 04:31:29 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Waiting for checks to finish 2025/08/11 04:31:29 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/11 04:31:29 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Waiting for transfers to finish 2025/08/11 04:31:29 INFO : sub dir/hello world: Deleted 2025/08/11 04:31:30.057467 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tVLjiC_ysAS1Utjtk535-QarqYRP7CUz2bGt9pHhhdZ3BrXiij-YSl8tWf7hfMLDaMW8666dFxgYorAvS73fUQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:31:30.057526 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tVLjiC_ysAS1Utjtk535-QarqYRP7CUz2bGt9pHhhdZ3BrXiij-YSl8tWf7hfMLDaMW8666dFxgYorAvS73fUQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:30 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tVLjiC_ysAS1Utjtk535-QarqYRP7CUz2bGt9pHhhdZ3BrXiij-YSl8tWf7hfMLDaMW8666dFxgYorAvS73fUQ==/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/tVLjiC_ysAS1Utjtk535-QarqYRP7CUz2bGt9pHhhdZ3BrXiij-YSl8tWf7hfMLDaMW8666dFxgYorAvS73fUQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/11 04:31:30 DEBUG : proton drive root link ID 'rclone-test-huhezug8selu': Purge remote --- FAIL: TestServerSideMoveOverSelf (13.10s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/11 04:31:31 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:31 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:31 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:31 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:31 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/11 04:31:31 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/11 04:31:31 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:33 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/11 04:31:33 INFO : potato: Copied (new) 2025/08/11 04:31:33 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:33 INFO : yam: Copied (new) 2025/08/11 04:31:33 DEBUG : Waiting for deletions to finish 2025/08/11 04:31:34 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:31:34 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:34 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:34 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:34 DEBUG : potato: Unchanged skipping 2025/08/11 04:31:34 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:34.408363 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CQXZe1fCsRXw7HehsG3aOQ7wgyl6qpVknqHi-1R-3D9LYG4X-4rn-3WYD0bUW-4IY9xntZcOveomv1MB0_0Fnw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:31:34.408403 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CQXZe1fCsRXw7HehsG3aOQ7wgyl6qpVknqHi-1R-3D9LYG4X-4rn-3WYD0bUW-4IY9xntZcOveomv1MB0_0Fnw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:34 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CQXZe1fCsRXw7HehsG3aOQ7wgyl6qpVknqHi-1R-3D9LYG4X-4rn-3WYD0bUW-4IY9xntZcOveomv1MB0_0Fnw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:34 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CQXZe1fCsRXw7HehsG3aOQ7wgyl6qpVknqHi-1R-3D9LYG4X-4rn-3WYD0bUW-4IY9xntZcOveomv1MB0_0Fnw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:34 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/11 04:31:34 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:35 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:35 INFO : yaml: Copied (new) 2025/08/11 04:31:35 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting files as there were IO errors 2025/08/11 04:31:35 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (5.30s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/11 04:31:37 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:37 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:37 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:37 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/11 04:31:37 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/11 04:31:37 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:37 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:38 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:38 INFO : yam: Copied (new) 2025/08/11 04:31:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/11 04:31:38 INFO : potato: Copied (new) 2025/08/11 04:31:38 DEBUG : Waiting for deletions to finish 2025/08/11 04:31:39 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:31:39 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:39 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:39 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:39 DEBUG : potato: Unchanged skipping 2025/08/11 04:31:39 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:39.598846 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_srqkwHohQrmUqbwKpwmz9XPs3l9-JZsoW4-pdJpBKc3ZtR9HPS-vgDXMOl2BDndkZtkEfqyn7CYSIDKvJuHIw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:31:39.598885 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_srqkwHohQrmUqbwKpwmz9XPs3l9-JZsoW4-pdJpBKc3ZtR9HPS-vgDXMOl2BDndkZtkEfqyn7CYSIDKvJuHIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:39 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_srqkwHohQrmUqbwKpwmz9XPs3l9-JZsoW4-pdJpBKc3ZtR9HPS-vgDXMOl2BDndkZtkEfqyn7CYSIDKvJuHIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:39 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_srqkwHohQrmUqbwKpwmz9XPs3l9-JZsoW4-pdJpBKc3ZtR9HPS-vgDXMOl2BDndkZtkEfqyn7CYSIDKvJuHIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:39 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/11 04:31:39 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:40 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:40 INFO : yaml: Copied (new) 2025/08/11 04:31:40 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting files as there were IO errors 2025/08/11 04:31:40 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (5.37s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/11 04:31:42 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:42 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:42 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:42 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:42 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/11 04:31:42 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/11 04:31:42 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:44 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/11 04:31:44 INFO : potato: Copied (new) 2025/08/11 04:31:44 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:44 INFO : sub/yam: Copied (new) 2025/08/11 04:31:44 DEBUG : Waiting for deletions to finish 2025/08/11 04:31:45 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:31:45 DEBUG : potato: Unchanged skipping 2025/08/11 04:31:45 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Making map for --track-renames 2025/08/11 04:31:45 INFO : proton drive root link ID 'rclone-test-wuratiy5rutu': Finished making map for --track-renames 2025/08/11 04:31:45 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:45 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for renames to finish 2025/08/11 04:31:45.738992 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NqhdNWKupjplU3Qu3_0ppAH6F7MwmhcRM_0WTp_VNosxYP_J8K4okAOCGSzSXSmPEwfbaJQzTPEPyD9Fx7Mrwg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:31:45.739044 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NqhdNWKupjplU3Qu3_0ppAH6F7MwmhcRM_0WTp_VNosxYP_J8K4okAOCGSzSXSmPEwfbaJQzTPEPyD9Fx7Mrwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:45 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NqhdNWKupjplU3Qu3_0ppAH6F7MwmhcRM_0WTp_VNosxYP_J8K4okAOCGSzSXSmPEwfbaJQzTPEPyD9Fx7Mrwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:45 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NqhdNWKupjplU3Qu3_0ppAH6F7MwmhcRM_0WTp_VNosxYP_J8K4okAOCGSzSXSmPEwfbaJQzTPEPyD9Fx7Mrwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:31:45 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/11 04:31:45 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:47 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/11 04:31:47 INFO : yam: Copied (new) 2025/08/11 04:31:47 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting files as there were IO errors 2025/08/11 04:31:47 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (6.51s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:31:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/11 04:31:49 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/11 04:31:49 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for checks to finish 2025/08/11 04:31:49 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Waiting for transfers to finish 2025/08/11 04:31:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/11 04:31:51 INFO : sub dir/hello world: Copied (new) 2025/08/11 04:31:51 INFO : sub dir/hello world: Deleted 2025/08/11 04:31:51 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/11 04:31:51 INFO : nested/sub dir/file: Copied (new) 2025/08/11 04:31:51 INFO : nested/sub dir/file: Deleted 2025/08/11 04:31:51 ERROR : Local file system at /tmp/rclone1383014859: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (4.87s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:31:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qiroyab0tezu" 2025/08/11 04:31:53 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Has cached credentials 2025/08/11 04:31:54 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wuratiy5rutu' -> proton drive root link ID 'rclone-test-qiroyab0tezu' 2025/08/11 04:32:02 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Using server-side directory move 2025/08/11 04:32:02 INFO : proton drive root link ID 'rclone-test-qiroyab0tezu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/11 04:32:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/11 04:32:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/11 04:32:03 DEBUG : empty space: Unchanged skipping 2025/08/11 04:32:03 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/11 04:32:03 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Waiting for checks to finish 2025/08/11 04:32:03 INFO : empty space: Deleted 2025/08/11 04:32:03 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Waiting for transfers to finish 2025/08/11 04:32:03 INFO : potato3: Deleted 2025/08/11 04:32:03.605065 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9sZmFN3r1rnrg_1fGFbB69Ck12lTGV1lGLYaLnwVWZzaHE-y4tCa09r6qGeyTDtLnlAAFSaa1iyEM-elEtYz6A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:03.605127 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9sZmFN3r1rnrg_1fGFbB69Ck12lTGV1lGLYaLnwVWZzaHE-y4tCa09r6qGeyTDtLnlAAFSaa1iyEM-elEtYz6A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:03 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9sZmFN3r1rnrg_1fGFbB69Ck12lTGV1lGLYaLnwVWZzaHE-y4tCa09r6qGeyTDtLnlAAFSaa1iyEM-elEtYz6A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:03.710847 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wIAwoFGt1xZNTTOoUUHf5084Bufqxbr0Bjm44KZi5Sy39euuiGDjr6dmViP3PdeFZKiw8jz9ZtnUchpXhM3nLQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:03.710888 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wIAwoFGt1xZNTTOoUUHf5084Bufqxbr0Bjm44KZi5Sy39euuiGDjr6dmViP3PdeFZKiw8jz9ZtnUchpXhM3nLQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:03 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wIAwoFGt1xZNTTOoUUHf5084Bufqxbr0Bjm44KZi5Sy39euuiGDjr6dmViP3PdeFZKiw8jz9ZtnUchpXhM3nLQ==/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/wIAwoFGt1xZNTTOoUUHf5084Bufqxbr0Bjm44KZi5Sy39euuiGDjr6dmViP3PdeFZKiw8jz9ZtnUchpXhM3nLQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/11 04:32:03 DEBUG : proton drive root link ID 'rclone-test-qiroyab0tezu': Purge remote --- FAIL: TestServerSideMove (11.44s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:32:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-weyiged2bizo" 2025/08/11 04:32:05 DEBUG : proton drive root link ID 'rclone-test-weyiged2bizo': Has cached credentials 2025/08/11 04:32:05 DEBUG : proton drive root link ID 'rclone-test-weyiged2bizo': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wuratiy5rutu' -> proton drive root link ID 'rclone-test-weyiged2bizo' 2025/08/11 04:32:14 DEBUG : empty space: Excluded (Size Filter) 2025/08/11 04:32:14 DEBUG : empty space: Excluded 2025/08/11 04:32:14 DEBUG : empty space: Excluded (Size Filter) 2025/08/11 04:32:14 DEBUG : empty space: Excluded 2025/08/11 04:32:14 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/11 04:32:14 DEBUG : proton drive root link ID 'rclone-test-weyiged2bizo': Waiting for checks to finish 2025/08/11 04:32:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/11 04:32:14 DEBUG : proton drive root link ID 'rclone-test-weyiged2bizo': Waiting for transfers to finish 2025/08/11 04:32:14 INFO : potato3: Deleted 2025/08/11 04:32:15.025354 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QZRMpyp55Bk2bk7EPro4r2ZXTnLbX_K3JAaK8d46AtC4VOJdXso31hmSd8TXDXFoaSrQYcTs2CkaV4kS9pXiXw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:15.025398 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QZRMpyp55Bk2bk7EPro4r2ZXTnLbX_K3JAaK8d46AtC4VOJdXso31hmSd8TXDXFoaSrQYcTs2CkaV4kS9pXiXw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:15 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/QZRMpyp55Bk2bk7EPro4r2ZXTnLbX_K3JAaK8d46AtC4VOJdXso31hmSd8TXDXFoaSrQYcTs2CkaV4kS9pXiXw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:15.142755 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7xSbtuaPKqst7KBk0-4aBFkwQVvSFIDUG6sQZaQ7OEC0GD5tU8gHkBtL78Sp3sWSbiuwyUesGJoeB3dixKvUPw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:15.142785 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7xSbtuaPKqst7KBk0-4aBFkwQVvSFIDUG6sQZaQ7OEC0GD5tU8gHkBtL78Sp3sWSbiuwyUesGJoeB3dixKvUPw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:15 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7xSbtuaPKqst7KBk0-4aBFkwQVvSFIDUG6sQZaQ7OEC0GD5tU8gHkBtL78Sp3sWSbiuwyUesGJoeB3dixKvUPw==/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/7xSbtuaPKqst7KBk0-4aBFkwQVvSFIDUG6sQZaQ7OEC0GD5tU8gHkBtL78Sp3sWSbiuwyUesGJoeB3dixKvUPw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/11 04:32:15 DEBUG : proton drive root link ID 'rclone-test-weyiged2bizo': Purge remote --- FAIL: TestServerSideMoveWithFilter (11.74s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:32:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lucicut9kece" 2025/08/11 04:32:16 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Has cached credentials 2025/08/11 04:32:17 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:32:22 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wuratiy5rutu' -> proton drive root link ID 'rclone-test-lucicut9kece' 2025/08/11 04:32:26 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Using server-side directory move 2025/08/11 04:32:26 INFO : proton drive root link ID 'rclone-test-lucicut9kece': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/11 04:32:26 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/11 04:32:26 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/11 04:32:26 DEBUG : empty space: Unchanged skipping 2025/08/11 04:32:26 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/11 04:32:27 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Waiting for checks to finish 2025/08/11 04:32:27 INFO : potato3: Deleted 2025/08/11 04:32:27 INFO : empty space: Deleted 2025/08/11 04:32:27 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Waiting for transfers to finish 2025/08/11 04:32:27.386529 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_4JOOU3gY4BfuFo1nY0tyqYZIl3-cFCSiAZZr1pqEJdDs5fB3HoRJyNvgJQvetRX0G4UPTSc5EcQeW6NLVdwBQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:27.386592 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_4JOOU3gY4BfuFo1nY0tyqYZIl3-cFCSiAZZr1pqEJdDs5fB3HoRJyNvgJQvetRX0G4UPTSc5EcQeW6NLVdwBQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:27 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_4JOOU3gY4BfuFo1nY0tyqYZIl3-cFCSiAZZr1pqEJdDs5fB3HoRJyNvgJQvetRX0G4UPTSc5EcQeW6NLVdwBQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:27.496708 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Km9FOk1Vyy7KLaKn-zNjGKCJaHMtEMxfVmI_q0pi7jNWV32dM_b3mvsj6MKJJfoHt4PHykKnceadLAQbxKqNDg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:32:27.496752 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Km9FOk1Vyy7KLaKn-zNjGKCJaHMtEMxfVmI_q0pi7jNWV32dM_b3mvsj6MKJJfoHt4PHykKnceadLAQbxKqNDg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:27 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Km9FOk1Vyy7KLaKn-zNjGKCJaHMtEMxfVmI_q0pi7jNWV32dM_b3mvsj6MKJJfoHt4PHykKnceadLAQbxKqNDg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:32:27 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/11 04:32:27 DEBUG : proton drive root link ID 'rclone-test-lucicut9kece': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (12.42s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:32:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:32:34 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:32:35 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:34:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/backup" 2025/08/11 04:34:36 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Has cached credentials 2025/08/11 04:34:36 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:37:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:37:41 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:37:41 DEBUG : two: Unchanged skipping 2025/08/11 04:37:41 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for checks to finish 2025/08/11 04:37:42.649768 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6CZApbcor6_ryLP-yZlRqSY95ls38mvpVMJ6iWi_3VDDrB4wsr99bX_8eaI3Izjyt7hJb14y79VUBl63WtfA8Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:37:42.649810 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6CZApbcor6_ryLP-yZlRqSY95ls38mvpVMJ6iWi_3VDDrB4wsr99bX_8eaI3Izjyt7hJb14y79VUBl63WtfA8Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:37:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6CZApbcor6_ryLP-yZlRqSY95ls38mvpVMJ6iWi_3VDDrB4wsr99bX_8eaI3Izjyt7hJb14y79VUBl63WtfA8Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:37:42 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for transfers to finish 2025/08/11 04:37:42 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting files as there were IO errors 2025/08/11 04:37:42 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/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/6CZApbcor6_ryLP-yZlRqSY95ls38mvpVMJ6iWi_3VDDrB4wsr99bX_8eaI3Izjyt7hJb14y79VUBl63WtfA8Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (315.46s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:37:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:37:49 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:37:50 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:39:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/backup" 2025/08/11 04:39:23 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Has cached credentials 2025/08/11 04:39:23 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:42:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:42:29 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:42:29 DEBUG : two: Unchanged skipping 2025/08/11 04:42:29 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for checks to finish 2025/08/11 04:42:30.239967 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CiCSL1XJaKf4N2LJJzRETNfyIZ2L0nLRSD54pPAdigVpREF9Cet2nwmn2wFp12bvYNc3yH_9s95Z8OIuuZWnJQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:42:30.240011 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CiCSL1XJaKf4N2LJJzRETNfyIZ2L0nLRSD54pPAdigVpREF9Cet2nwmn2wFp12bvYNc3yH_9s95Z8OIuuZWnJQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:42:30 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CiCSL1XJaKf4N2LJJzRETNfyIZ2L0nLRSD54pPAdigVpREF9Cet2nwmn2wFp12bvYNc3yH_9s95Z8OIuuZWnJQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:42:30 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for transfers to finish 2025/08/11 04:42:30 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting files as there were IO errors 2025/08/11 04:42:30 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/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/CiCSL1XJaKf4N2LJJzRETNfyIZ2L0nLRSD54pPAdigVpREF9Cet2nwmn2wFp12bvYNc3yH_9s95Z8OIuuZWnJQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (287.61s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:42:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:42:37 DEBUG : Config file has changed externally - reloading 2025/08/11 04:42:37 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:42:38 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:44:09 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/backup" 2025/08/11 04:44:09 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Has cached credentials 2025/08/11 04:44:10 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:47:17 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for checks to finish 2025/08/11 04:47:17 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:47:17 DEBUG : two: Unchanged skipping 2025/08/11 04:47:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:47:17.972899 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBwqA-nZ4mt_VHCU-Z8z1ZEnZruawWvLjMh84zRpRhraE4aEw1aJO3Cu55VhRlHLIHqor9Ii5D6s2x2FMFeAcA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:47:17.972997 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBwqA-nZ4mt_VHCU-Z8z1ZEnZruawWvLjMh84zRpRhraE4aEw1aJO3Cu55VhRlHLIHqor9Ii5D6s2x2FMFeAcA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:47:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBwqA-nZ4mt_VHCU-Z8z1ZEnZruawWvLjMh84zRpRhraE4aEw1aJO3Cu55VhRlHLIHqor9Ii5D6s2x2FMFeAcA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:47:17 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for transfers to finish 2025/08/11 04:47:17 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting files as there were IO errors 2025/08/11 04:47:17 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBwqA-nZ4mt_VHCU-Z8z1ZEnZruawWvLjMh84zRpRhraE4aEw1aJO3Cu55VhRlHLIHqor9Ii5D6s2x2FMFeAcA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (287.73s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:47:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:47:25 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:47:25 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:48:59 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:48:59 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for checks to finish 2025/08/11 04:48:59 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/11 04:48:59 DEBUG : two: Unchanged skipping 2025/08/11 04:48:59.493786 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IpTiMGW962fTzWY31Q8hwLbu2AErtZ5XANG4nOroCUS14pnqGhJHWtJZD2oELO5wbGLmgq59w7mF2E1_hPaxfA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:48:59.493830 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IpTiMGW962fTzWY31Q8hwLbu2AErtZ5XANG4nOroCUS14pnqGhJHWtJZD2oELO5wbGLmgq59w7mF2E1_hPaxfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:48:59 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IpTiMGW962fTzWY31Q8hwLbu2AErtZ5XANG4nOroCUS14pnqGhJHWtJZD2oELO5wbGLmgq59w7mF2E1_hPaxfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:48:59 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Waiting for transfers to finish 2025/08/11 04:48:59 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting files as there were IO errors 2025/08/11 04:48:59 ERROR : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IpTiMGW962fTzWY31Q8hwLbu2AErtZ5XANG4nOroCUS14pnqGhJHWtJZD2oELO5wbGLmgq59w7mF2E1_hPaxfA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (101.21s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:49:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:49:06 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:49:07 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:50:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:50:40.672163 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O7tXxrhCGyV1Z-PEwoBKGredgZYG_VqP-ARVrW3EW0EjuMvW1tpOl7AqoEJjrfkITN72ITaL70BdPS146rE4uw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:50:40.672212 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O7tXxrhCGyV1Z-PEwoBKGredgZYG_VqP-ARVrW3EW0EjuMvW1tpOl7AqoEJjrfkITN72ITaL70BdPS146rE4uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:50:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O7tXxrhCGyV1Z-PEwoBKGredgZYG_VqP-ARVrW3EW0EjuMvW1tpOl7AqoEJjrfkITN72ITaL70BdPS146rE4uw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O7tXxrhCGyV1Z-PEwoBKGredgZYG_VqP-ARVrW3EW0EjuMvW1tpOl7AqoEJjrfkITN72ITaL70BdPS146rE4uw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (101.17s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-wuratiy5rutu'", Local "Local file system at /tmp/rclone1383014859", Modify Window "1s" 2025/08/11 04:50:47 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuratiy5rutu/dst" 2025/08/11 04:50:47 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Has cached credentials 2025/08/11 04:50:48 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/11 04:52:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/11 04:52:21.951782 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C_IAkVLyqKj9d9dN81pDvSJO63xv_smUje201RBw1-xKldSx3WYlBy5CyxkevelfPsNYx8n9Spf07TQrkWSz2w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/11 04:52:21.951824 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C_IAkVLyqKj9d9dN81pDvSJO63xv_smUje201RBw1-xKldSx3WYlBy5CyxkevelfPsNYx8n9Spf07TQrkWSz2w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/11 04:52:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C_IAkVLyqKj9d9dN81pDvSJO63xv_smUje201RBw1-xKldSx3WYlBy5CyxkevelfPsNYx8n9Spf07TQrkWSz2w==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C_IAkVLyqKj9d9dN81pDvSJO63xv_smUje201RBw1-xKldSx3WYlBy5CyxkevelfPsNYx8n9Spf07TQrkWSz2w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (101.24s) FAIL 2025/08/11 04:52:23 DEBUG : proton drive root link ID 'rclone-test-wuratiy5rutu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 21m6.812662975s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]