"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 4/5) 2025/09/23 17:01:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo" 2025/09/23 17:01:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/23 17:01:51 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Has cached credentials 2025/09/23 17:01:53 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:01:54 DEBUG : Creating backend with remote "/tmp/rclone3837720103" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:02:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lofaqod9rapu" 2025/09/23 17:02:01 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Has cached credentials 2025/09/23 17:02:03 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-wujupod7bixo' -> proton drive root link ID 'rclone-test-lofaqod9rapu' 2025/09/23 17:02:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/23 17:02:05 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Waiting for checks to finish 2025/09/23 17:02:05 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Waiting for transfers to finish 2025/09/23 17:02:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/23 17:02:11 INFO : sub dir/hello world: Copied (new) 2025/09/23 17:02:14.493515 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/23 17:02:14.493570 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/23 17:02:18 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Using server-side directory move 2025/09/23 17:02:18 INFO : proton drive root link ID 'rclone-test-lofaqod9rapu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/23 17:02:19 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/23 17:02:19 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Waiting for checks to finish 2025/09/23 17:02:19 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Waiting for transfers to finish 2025/09/23 17:02:20 INFO : sub dir/hello world: Deleted 2025/09/23 17:02:21.719254 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vC6S1J6iX0eeLYFUp7DNJ9a3sGQb8qLmzLTcUseRCZc2L-1VdKbFey7VxU1sLMx5rUVQTpvsHBvNE5BYvCpZXA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:02:21.719295 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vC6S1J6iX0eeLYFUp7DNJ9a3sGQb8qLmzLTcUseRCZc2L-1VdKbFey7VxU1sLMx5rUVQTpvsHBvNE5BYvCpZXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:21 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vC6S1J6iX0eeLYFUp7DNJ9a3sGQb8qLmzLTcUseRCZc2L-1VdKbFey7VxU1sLMx5rUVQTpvsHBvNE5BYvCpZXA==/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/vC6S1J6iX0eeLYFUp7DNJ9a3sGQb8qLmzLTcUseRCZc2L-1VdKbFey7VxU1sLMx5rUVQTpvsHBvNE5BYvCpZXA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/23 17:02:21 DEBUG : proton drive root link ID 'rclone-test-lofaqod9rapu': Purge remote --- FAIL: TestServerSideMoveOverSelf (30.93s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/23 17:02:25 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:25 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:25 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:25 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/23 17:02:25 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/23 17:02:25 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:25 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:27 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/23 17:02:27 INFO : potato: Copied (new) 2025/09/23 17:02:28 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:28 INFO : yam: Copied (new) 2025/09/23 17:02:28 DEBUG : Waiting for deletions to finish 2025/09/23 17:02:30 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:02:30 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:30 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:30 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:30 DEBUG : potato: Unchanged skipping 2025/09/23 17:02:30 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:31.341662 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fLlPM1JQQlidW7QlmTxuqE7yjG6j51ck5Rl5sJJKTUb8BNlzotFkGrBxsdQuODOsRe30dmDis2djcYNg263RKQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:02:31.341700 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fLlPM1JQQlidW7QlmTxuqE7yjG6j51ck5Rl5sJJKTUb8BNlzotFkGrBxsdQuODOsRe30dmDis2djcYNg263RKQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:31 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fLlPM1JQQlidW7QlmTxuqE7yjG6j51ck5Rl5sJJKTUb8BNlzotFkGrBxsdQuODOsRe30dmDis2djcYNg263RKQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:31 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fLlPM1JQQlidW7QlmTxuqE7yjG6j51ck5Rl5sJJKTUb8BNlzotFkGrBxsdQuODOsRe30dmDis2djcYNg263RKQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:31 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/23 17:02:31 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:33 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:33 INFO : yaml: Copied (new) 2025/09/23 17:02:33 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': not deleting files as there were IO errors 2025/09/23 17:02:33 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': 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 (11.19s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/23 17:02:36 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:36 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:36 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/23 17:02:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/23 17:02:36 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:36 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/23 17:02:38 INFO : potato: Copied (new) 2025/09/23 17:02:39 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:39 INFO : yam: Copied (new) 2025/09/23 17:02:39 DEBUG : Waiting for deletions to finish 2025/09/23 17:02:40 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:02:40 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:40 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:40 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:40 DEBUG : potato: Unchanged skipping 2025/09/23 17:02:40 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:42.199055 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8SlGnu-iRSIGDoonvlG3EETiHDTyoTfgEmD9jdiq937rEtwJgbVCrwtJXJD5FFzpqkGRlV2BjiT0P-nyJWF2dg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:02:42.199122 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8SlGnu-iRSIGDoonvlG3EETiHDTyoTfgEmD9jdiq937rEtwJgbVCrwtJXJD5FFzpqkGRlV2BjiT0P-nyJWF2dg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:42 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8SlGnu-iRSIGDoonvlG3EETiHDTyoTfgEmD9jdiq937rEtwJgbVCrwtJXJD5FFzpqkGRlV2BjiT0P-nyJWF2dg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:42 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8SlGnu-iRSIGDoonvlG3EETiHDTyoTfgEmD9jdiq937rEtwJgbVCrwtJXJD5FFzpqkGRlV2BjiT0P-nyJWF2dg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:42 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/23 17:02:42 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:44 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:44 INFO : yaml: Copied (new) 2025/09/23 17:02:44 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': not deleting files as there were IO errors 2025/09/23 17:02:44 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': 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 (11.59s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/23 17:02:48 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:48 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:48 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:48 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/23 17:02:48 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:48 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/23 17:02:48 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:51 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/23 17:02:51 INFO : potato: Copied (new) 2025/09/23 17:02:51 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:51 INFO : sub/yam: Copied (new) 2025/09/23 17:02:51 DEBUG : Waiting for deletions to finish 2025/09/23 17:02:53 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:02:53 DEBUG : potato: Unchanged skipping 2025/09/23 17:02:54 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Making map for --track-renames 2025/09/23 17:02:54 INFO : proton drive root link ID 'rclone-test-wujupod7bixo': Finished making map for --track-renames 2025/09/23 17:02:54 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:02:54 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for renames to finish 2025/09/23 17:02:55.624897 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Llbsg9GpothfnYQq1hsvJilohhnBwVGlWR4gqkSLQwlfDhqfmxoni5o-Xtq4MfRZTmy_Uy1-eEX2wunqVoSJBg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:02:55.624937 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Llbsg9GpothfnYQq1hsvJilohhnBwVGlWR4gqkSLQwlfDhqfmxoni5o-Xtq4MfRZTmy_Uy1-eEX2wunqVoSJBg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:55 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Llbsg9GpothfnYQq1hsvJilohhnBwVGlWR4gqkSLQwlfDhqfmxoni5o-Xtq4MfRZTmy_Uy1-eEX2wunqVoSJBg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:55 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Llbsg9GpothfnYQq1hsvJilohhnBwVGlWR4gqkSLQwlfDhqfmxoni5o-Xtq4MfRZTmy_Uy1-eEX2wunqVoSJBg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:02:55 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/23 17:02:55 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:02:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/23 17:02:57 INFO : yam: Copied (new) 2025/09/23 17:02:57 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': not deleting files as there were IO errors 2025/09/23 17:02:57 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': 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 (14.14s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:03:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/23 17:03:02 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/23 17:03:02 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for checks to finish 2025/09/23 17:03:02 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Waiting for transfers to finish 2025/09/23 17:03:07 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/23 17:03:07 INFO : nested/sub dir/file: Copied (new) 2025/09/23 17:03:07 INFO : nested/sub dir/file: Deleted 2025/09/23 17:03:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/23 17:03:08 INFO : sub dir/hello world: Copied (new) 2025/09/23 17:03:08 INFO : sub dir/hello world: Deleted 2025/09/23 17:03:08 ERROR : Local file system at /tmp/rclone3837720103: 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 (11.05s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:03:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xebebiv1suyu" 2025/09/23 17:03:13 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Has cached credentials 2025/09/23 17:03:15 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wujupod7bixo' -> proton drive root link ID 'rclone-test-xebebiv1suyu' 2025/09/23 17:03:30 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Using server-side directory move 2025/09/23 17:03:30 INFO : proton drive root link ID 'rclone-test-xebebiv1suyu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/23 17:03:31 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/23 17:03:31 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/23 17:03:31 DEBUG : empty space: Unchanged skipping 2025/09/23 17:03:31 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/23 17:03:31 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Waiting for checks to finish 2025/09/23 17:03:31 INFO : potato3: Deleted 2025/09/23 17:03:31 INFO : empty space: Deleted 2025/09/23 17:03:31 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Waiting for transfers to finish 2025/09/23 17:03:32.892972 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0azoihCwsMQk0oM2I6jYak6faTByHAGxbZpJd6CJejIQT9xLiwts8JV9LqDTLoqrVS8UC3XVerMemiF-efkwiQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:03:32.893032 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0azoihCwsMQk0oM2I6jYak6faTByHAGxbZpJd6CJejIQT9xLiwts8JV9LqDTLoqrVS8UC3XVerMemiF-efkwiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:32 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0azoihCwsMQk0oM2I6jYak6faTByHAGxbZpJd6CJejIQT9xLiwts8JV9LqDTLoqrVS8UC3XVerMemiF-efkwiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:33.075872 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7tOPLE64p0W-JuaPiQUWYAbpGHdbdJPc0hVTtyVcnU0MnvlSS6BGrGs8c8-9a7niLlHbZxiLhSIZhy81-hhCBQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:03:33.075914 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7tOPLE64p0W-JuaPiQUWYAbpGHdbdJPc0hVTtyVcnU0MnvlSS6BGrGs8c8-9a7niLlHbZxiLhSIZhy81-hhCBQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:33 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7tOPLE64p0W-JuaPiQUWYAbpGHdbdJPc0hVTtyVcnU0MnvlSS6BGrGs8c8-9a7niLlHbZxiLhSIZhy81-hhCBQ==/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/7tOPLE64p0W-JuaPiQUWYAbpGHdbdJPc0hVTtyVcnU0MnvlSS6BGrGs8c8-9a7niLlHbZxiLhSIZhy81-hhCBQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/23 17:03:33 DEBUG : proton drive root link ID 'rclone-test-xebebiv1suyu': Purge remote --- FAIL: TestServerSideMove (23.56s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:03:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kevozir4domu" 2025/09/23 17:03:36 DEBUG : proton drive root link ID 'rclone-test-kevozir4domu': Has cached credentials 2025/09/23 17:03:39 DEBUG : proton drive root link ID 'rclone-test-kevozir4domu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wujupod7bixo' -> proton drive root link ID 'rclone-test-kevozir4domu' 2025/09/23 17:03:55 DEBUG : empty space: Excluded (Size Filter) 2025/09/23 17:03:55 DEBUG : empty space: Excluded 2025/09/23 17:03:55 DEBUG : empty space: Excluded (Size Filter) 2025/09/23 17:03:55 DEBUG : empty space: Excluded 2025/09/23 17:03:55 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/23 17:03:55 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/23 17:03:55 DEBUG : proton drive root link ID 'rclone-test-kevozir4domu': Waiting for checks to finish 2025/09/23 17:03:55 DEBUG : proton drive root link ID 'rclone-test-kevozir4domu': Waiting for transfers to finish 2025/09/23 17:03:56 INFO : potato3: Deleted 2025/09/23 17:03:56.781049 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fV31xmbuZnRImDZx7jzzd8f0h91rgHun0S66uGisBXaCowYFF_82JnoLsKQSTMCS9ra96cm866gLxLID6sWTOg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:03:56.781087 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fV31xmbuZnRImDZx7jzzd8f0h91rgHun0S66uGisBXaCowYFF_82JnoLsKQSTMCS9ra96cm866gLxLID6sWTOg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:56 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fV31xmbuZnRImDZx7jzzd8f0h91rgHun0S66uGisBXaCowYFF_82JnoLsKQSTMCS9ra96cm866gLxLID6sWTOg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:57.207793 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6hEvagPofb1dTwbSl2jFZaVe4BkzHn6QBEAppiCD5iUGCXjfMDdZfqieKBp7m_DHnBLQ2-t8e7TzmNSF3pcQ5g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:03:57.207828 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6hEvagPofb1dTwbSl2jFZaVe4BkzHn6QBEAppiCD5iUGCXjfMDdZfqieKBp7m_DHnBLQ2-t8e7TzmNSF3pcQ5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:03:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6hEvagPofb1dTwbSl2jFZaVe4BkzHn6QBEAppiCD5iUGCXjfMDdZfqieKBp7m_DHnBLQ2-t8e7TzmNSF3pcQ5g==/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/6hEvagPofb1dTwbSl2jFZaVe4BkzHn6QBEAppiCD5iUGCXjfMDdZfqieKBp7m_DHnBLQ2-t8e7TzmNSF3pcQ5g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/23 17:03:57 DEBUG : proton drive root link ID 'rclone-test-kevozir4domu': Purge remote --- FAIL: TestServerSideMoveWithFilter (25.37s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:04:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-petubew3woji" 2025/09/23 17:04:02 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Has cached credentials 2025/09/23 17:04:04 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:04:11 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-wujupod7bixo' -> proton drive root link ID 'rclone-test-petubew3woji' 2025/09/23 17:04:20 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Using server-side directory move 2025/09/23 17:04:20 INFO : proton drive root link ID 'rclone-test-petubew3woji': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/23 17:04:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/23 17:04:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/23 17:04:21 DEBUG : empty space: Unchanged skipping 2025/09/23 17:04:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/23 17:04:21 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Waiting for checks to finish 2025/09/23 17:04:22 INFO : potato3: Deleted 2025/09/23 17:04:22 INFO : empty space: Deleted 2025/09/23 17:04:22 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Waiting for transfers to finish 2025/09/23 17:04:22.367958 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mCv5nh8yoz-Ir_5hhEAwAvxEOgfKda_UlffXDTx10VEHjzPSGf0J5zot2hQqhjKMJMO4OEo2tMPk9UVRKQkqvQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:04:22.368001 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mCv5nh8yoz-Ir_5hhEAwAvxEOgfKda_UlffXDTx10VEHjzPSGf0J5zot2hQqhjKMJMO4OEo2tMPk9UVRKQkqvQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:04:22 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/mCv5nh8yoz-Ir_5hhEAwAvxEOgfKda_UlffXDTx10VEHjzPSGf0J5zot2hQqhjKMJMO4OEo2tMPk9UVRKQkqvQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:04:22.984067 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vRSUWE5L9krmNPJdYXTZpRhVJNCazlsRTRAwsdREz35W2slkbB2SQL-GrFjJ3cD9ltevUhtKVHqZ8cSRVjyhQA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:04:22.984105 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vRSUWE5L9krmNPJdYXTZpRhVJNCazlsRTRAwsdREz35W2slkbB2SQL-GrFjJ3cD9ltevUhtKVHqZ8cSRVjyhQA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:04:22 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vRSUWE5L9krmNPJdYXTZpRhVJNCazlsRTRAwsdREz35W2slkbB2SQL-GrFjJ3cD9ltevUhtKVHqZ8cSRVjyhQA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:04:22 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo': 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/23 17:04:22 DEBUG : proton drive root link ID 'rclone-test-petubew3woji': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (25.13s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:04:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/dst" 2025/09/23 17:04:36 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Has cached credentials 2025/09/23 17:04:38 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:06:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/backup" 2025/09/23 17:06:21 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Has cached credentials 2025/09/23 17:06:23 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:09:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/23 17:09:49 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for checks to finish 2025/09/23 17:09:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:09:49 DEBUG : two: Unchanged skipping 2025/09/23 17:09:52.298890 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FhO9p8teK1UhQCyKYr90SLxoGMLnV-k5O1eIJ5yi28cUMZas9w_4vhNg0Ftlcw8lcRdkVgWudpExLubP5UGgJQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:09:52.298932 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FhO9p8teK1UhQCyKYr90SLxoGMLnV-k5O1eIJ5yi28cUMZas9w_4vhNg0Ftlcw8lcRdkVgWudpExLubP5UGgJQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:09:52 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FhO9p8teK1UhQCyKYr90SLxoGMLnV-k5O1eIJ5yi28cUMZas9w_4vhNg0Ftlcw8lcRdkVgWudpExLubP5UGgJQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:09:52 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for transfers to finish 2025/09/23 17:09:52 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/dst': not deleting files as there were IO errors 2025/09/23 17:09:52 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/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/FhO9p8teK1UhQCyKYr90SLxoGMLnV-k5O1eIJ5yi28cUMZas9w_4vhNg0Ftlcw8lcRdkVgWudpExLubP5UGgJQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (330.90s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:10:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/dst" 2025/09/23 17:10:06 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Has cached credentials 2025/09/23 17:10:08 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:11:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/backup" 2025/09/23 17:11:53 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Has cached credentials 2025/09/23 17:11:55 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:15:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/23 17:15:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:15:20 DEBUG : two: Unchanged skipping 2025/09/23 17:15:20 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for checks to finish 2025/09/23 17:15:23.181185 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5bsKBiJmxv5uXm1X3P8zcfpfcqeuzMqt4Ti-SnkV9YNiTXYBPYQt7wfKuAXkP6Q9YT_zzgP3bGAnBE7gbGjK1Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:15:23.181221 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5bsKBiJmxv5uXm1X3P8zcfpfcqeuzMqt4Ti-SnkV9YNiTXYBPYQt7wfKuAXkP6Q9YT_zzgP3bGAnBE7gbGjK1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:15:23 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5bsKBiJmxv5uXm1X3P8zcfpfcqeuzMqt4Ti-SnkV9YNiTXYBPYQt7wfKuAXkP6Q9YT_zzgP3bGAnBE7gbGjK1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:15:23 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for transfers to finish 2025/09/23 17:15:23 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/dst': not deleting files as there were IO errors 2025/09/23 17:15:23 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/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/5bsKBiJmxv5uXm1X3P8zcfpfcqeuzMqt4Ti-SnkV9YNiTXYBPYQt7wfKuAXkP6Q9YT_zzgP3bGAnBE7gbGjK1Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (330.55s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:15:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/dst" 2025/09/23 17:15:37 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Has cached credentials 2025/09/23 17:15:40 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:17:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/backup" 2025/09/23 17:17:23 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Has cached credentials 2025/09/23 17:17:25 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:20:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/23 17:20:51 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:20:51 DEBUG : two: Unchanged skipping 2025/09/23 17:20:51 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for checks to finish 2025/09/23 17:20:54.019867 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-Sqw1PXuaGtsZK63aWPA_VoRu7HVbY5ciFUST96xTPF8895L84RMogEjHChZhXAr3KacK6N5Ctfm1xdCsdVtMQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:20:54.019914 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-Sqw1PXuaGtsZK63aWPA_VoRu7HVbY5ciFUST96xTPF8895L84RMogEjHChZhXAr3KacK6N5Ctfm1xdCsdVtMQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:20:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-Sqw1PXuaGtsZK63aWPA_VoRu7HVbY5ciFUST96xTPF8895L84RMogEjHChZhXAr3KacK6N5Ctfm1xdCsdVtMQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:20:54 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for transfers to finish 2025/09/23 17:20:54 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/dst': not deleting files as there were IO errors 2025/09/23 17:20:54 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/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/-Sqw1PXuaGtsZK63aWPA_VoRu7HVbY5ciFUST96xTPF8895L84RMogEjHChZhXAr3KacK6N5Ctfm1xdCsdVtMQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (330.31s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-wujupod7bixo'", Local "Local file system at /tmp/rclone3837720103", Modify Window "1s" 2025/09/23 17:21:08 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wujupod7bixo/dst" 2025/09/23 17:21:08 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Has cached credentials 2025/09/23 17:21:10 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/23 17:22:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/23 17:22:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/23 17:22:53 DEBUG : two: Unchanged skipping 2025/09/23 17:22:53 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for checks to finish 2025/09/23 17:22:54.721133 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6dJoaJa2HzjeUxZZwFHch7sJzFSoChCkJnBfBCfCIKuavJm1oMKyCJ-d6o8FlVNJYirStB7dMp90Hv1765SrSQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/23 17:22:54.721175 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6dJoaJa2HzjeUxZZwFHch7sJzFSoChCkJnBfBCfCIKuavJm1oMKyCJ-d6o8FlVNJYirStB7dMp90Hv1765SrSQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:22:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6dJoaJa2HzjeUxZZwFHch7sJzFSoChCkJnBfBCfCIKuavJm1oMKyCJ-d6o8FlVNJYirStB7dMp90Hv1765SrSQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/23 17:22:54 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo/dst': Waiting for transfers to finish 2025/09/23 17:22:54 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/dst': not deleting files as there were IO errors 2025/09/23 17:22:54 ERROR : proton drive root link ID 'rclone-test-wujupod7bixo/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/6dJoaJa2HzjeUxZZwFHch7sJzFSoChCkJnBfBCfCIKuavJm1oMKyCJ-d6o8FlVNJYirStB7dMp90Hv1765SrSQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (120.66s) FAIL 2025/09/23 17:22:59 DEBUG : proton drive root link ID 'rclone-test-wujupod7bixo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 21m9.149661046s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]