"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2025/05/05 03:50:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze" 2025/05/05 03:50:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/05 03:50:14 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Has cached credentials 2025/05/05 03:50:16 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:50:16 DEBUG : Creating backend with remote "/tmp/rclone2689571342" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cerexah4cohe" 2025/05/05 03:50:21 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Has cached credentials 2025/05/05 03:50:22 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-facidow9buze' -> proton drive root link ID 'rclone-test-cerexah4cohe' 2025/05/05 03:50:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/05 03:50:23 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Waiting for checks to finish 2025/05/05 03:50:23 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Waiting for transfers to finish 2025/05/05 03:50:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/05 03:50:27 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:28.700960 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/05/05 03:50:28.700999 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/05/05 03:50:30 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Using server-side directory move 2025/05/05 03:50:30 INFO : proton drive root link ID 'rclone-test-cerexah4cohe': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/05 03:50:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/05 03:50:32 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Waiting for checks to finish 2025/05/05 03:50:32 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Waiting for transfers to finish 2025/05/05 03:50:32 INFO : sub dir/hello world: Deleted 2025/05/05 03:50:33.461139 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UWWglldjbysPEvm5-o92IqbdolTxezHMAlXTkT6HTCM44JUPgXeOQbPph-OS4xhiKefIWc3-0iOgZFUTq2yyqg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:50:33.461175 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UWWglldjbysPEvm5-o92IqbdolTxezHMAlXTkT6HTCM44JUPgXeOQbPph-OS4xhiKefIWc3-0iOgZFUTq2yyqg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:33 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UWWglldjbysPEvm5-o92IqbdolTxezHMAlXTkT6HTCM44JUPgXeOQbPph-OS4xhiKefIWc3-0iOgZFUTq2yyqg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UWWglldjbysPEvm5-o92IqbdolTxezHMAlXTkT6HTCM44JUPgXeOQbPph-OS4xhiKefIWc3-0iOgZFUTq2yyqg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/05/05 03:50:33 DEBUG : proton drive root link ID 'rclone-test-cerexah4cohe': Purge remote --- FAIL: TestServerSideMoveOverSelf (20.33s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/05/05 03:50:36 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:36 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:36 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:36 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/05 03:50:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/05 03:50:36 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:37 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:37 INFO : yam: Copied (new) 2025/05/05 03:50:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/05 03:50:38 INFO : potato: Copied (new) 2025/05/05 03:50:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:39 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 03:50:39 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:39 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:39 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:39 DEBUG : potato: Unchanged skipping 2025/05/05 03:50:39 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:40.165132 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DCXyxlPD3mzzJv9hijqFZicbN9e0qem2zDzYW-QMqPpuUaWpzsvBMaNmPfvZHNXtRnXtpTMmayX7W9acXfzY9w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:50:40.165177 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DCXyxlPD3mzzJv9hijqFZicbN9e0qem2zDzYW-QMqPpuUaWpzsvBMaNmPfvZHNXtRnXtpTMmayX7W9acXfzY9w==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:40 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DCXyxlPD3mzzJv9hijqFZicbN9e0qem2zDzYW-QMqPpuUaWpzsvBMaNmPfvZHNXtRnXtpTMmayX7W9acXfzY9w==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:40 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DCXyxlPD3mzzJv9hijqFZicbN9e0qem2zDzYW-QMqPpuUaWpzsvBMaNmPfvZHNXtRnXtpTMmayX7W9acXfzY9w==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:40 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/05 03:50:40 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:41 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:41 INFO : yaml: Copied (new) 2025/05/05 03:50:41 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting files as there were IO errors 2025/05/05 03:50:41 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (7.36s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/05/05 03:50:44 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:44 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:44 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:44 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/05 03:50:44 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/05 03:50:44 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:44 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:45 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/05 03:50:45 INFO : potato: Copied (new) 2025/05/05 03:50:45 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:45 INFO : yam: Copied (new) 2025/05/05 03:50:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:46 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 03:50:46 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:46 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:46 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:46 DEBUG : potato: Unchanged skipping 2025/05/05 03:50:46 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:47.207987 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lzoWNqEusyLbQrgLSnN0aMnhKRnIKgSzBbOKFEB2A4kOVQOgGkURHa03fY_vp2edMFezpfSS1jRjoLtaYjU3wA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:50:47.208023 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lzoWNqEusyLbQrgLSnN0aMnhKRnIKgSzBbOKFEB2A4kOVQOgGkURHa03fY_vp2edMFezpfSS1jRjoLtaYjU3wA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:47 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lzoWNqEusyLbQrgLSnN0aMnhKRnIKgSzBbOKFEB2A4kOVQOgGkURHa03fY_vp2edMFezpfSS1jRjoLtaYjU3wA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:47 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lzoWNqEusyLbQrgLSnN0aMnhKRnIKgSzBbOKFEB2A4kOVQOgGkURHa03fY_vp2edMFezpfSS1jRjoLtaYjU3wA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:47 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/05 03:50:47 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:48 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:48 INFO : yaml: Copied (new) 2025/05/05 03:50:48 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting files as there were IO errors 2025/05/05 03:50:48 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (7.16s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/05/05 03:50:51 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:51 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:51 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:51 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/05 03:50:51 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:51 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/05/05 03:50:51 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:52 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/05 03:50:52 INFO : potato: Copied (new) 2025/05/05 03:50:53 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:53 INFO : sub/yam: Copied (new) 2025/05/05 03:50:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:54 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 03:50:54 DEBUG : potato: Unchanged skipping 2025/05/05 03:50:54 INFO : proton drive root link ID 'rclone-test-facidow9buze': Making map for --track-renames 2025/05/05 03:50:54 INFO : proton drive root link ID 'rclone-test-facidow9buze': Finished making map for --track-renames 2025/05/05 03:50:54 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:54 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for renames to finish 2025/05/05 03:50:55.477314 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rq-JtkLXu7fkUluCzoJf-hlC74guc0rKvx-IqcFHeT-cFCHqTB5sMvMh6-qrR0CRhiSlGclUXC0mMzsBHHa1NA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:50:55.477350 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rq-JtkLXu7fkUluCzoJf-hlC74guc0rKvx-IqcFHeT-cFCHqTB5sMvMh6-qrR0CRhiSlGclUXC0mMzsBHHa1NA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:55 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rq-JtkLXu7fkUluCzoJf-hlC74guc0rKvx-IqcFHeT-cFCHqTB5sMvMh6-qrR0CRhiSlGclUXC0mMzsBHHa1NA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:55 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rq-JtkLXu7fkUluCzoJf-hlC74guc0rKvx-IqcFHeT-cFCHqTB5sMvMh6-qrR0CRhiSlGclUXC0mMzsBHHa1NA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:50:55 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/05 03:50:55 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:50:56 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/05 03:50:56 INFO : yam: Copied (new) 2025/05/05 03:50:56 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting files as there were IO errors 2025/05/05 03:50:56 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (8.56s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:50:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/05 03:50:59 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/05/05 03:50:59 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for checks to finish 2025/05/05 03:50:59 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': Waiting for transfers to finish 2025/05/05 03:51:03 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/05 03:51:03 INFO : sub dir/hello world: Copied (new) 2025/05/05 03:51:03 INFO : sub dir/hello world: Deleted 2025/05/05 03:51:03 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/05/05 03:51:03 INFO : nested/sub dir/file: Copied (new) 2025/05/05 03:51:03 INFO : nested/sub dir/file: Deleted 2025/05/05 03:51:03 ERROR : Local file system at /tmp/rclone2689571342: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (7.46s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:51:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-joruhep2bive" 2025/05/05 03:51:07 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Has cached credentials 2025/05/05 03:51:08 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-facidow9buze' -> proton drive root link ID 'rclone-test-joruhep2bive' 2025/05/05 03:51:16 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Using server-side directory move 2025/05/05 03:51:16 INFO : proton drive root link ID 'rclone-test-joruhep2bive': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/05 03:51:16 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/05 03:51:16 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/05 03:51:16 DEBUG : empty space: Unchanged skipping 2025/05/05 03:51:16 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/05 03:51:16 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Waiting for checks to finish 2025/05/05 03:51:17 INFO : potato3: Deleted 2025/05/05 03:51:17 INFO : empty space: Deleted 2025/05/05 03:51:17 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Waiting for transfers to finish 2025/05/05 03:51:17.546348 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nux2z9Sz1MfjdpUSSF4REP2bBa6PoDJjSGHD9cmk3-zuIGlm8Hht1pVEYPhtwMNL_ilTp6JEDPX5QPKit6PV2A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:17.546410 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nux2z9Sz1MfjdpUSSF4REP2bBa6PoDJjSGHD9cmk3-zuIGlm8Hht1pVEYPhtwMNL_ilTp6JEDPX5QPKit6PV2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:17 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nux2z9Sz1MfjdpUSSF4REP2bBa6PoDJjSGHD9cmk3-zuIGlm8Hht1pVEYPhtwMNL_ilTp6JEDPX5QPKit6PV2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:17.688338 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aEmL9GyFI-_aaJGFS6GB4jI6oUycjEPnKqFAIa7rY81FQGQs24WKOH6z3j1qtvU-q3jD47y57nZJNCYX4bFbTA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:17.688367 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aEmL9GyFI-_aaJGFS6GB4jI6oUycjEPnKqFAIa7rY81FQGQs24WKOH6z3j1qtvU-q3jD47y57nZJNCYX4bFbTA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:17 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aEmL9GyFI-_aaJGFS6GB4jI6oUycjEPnKqFAIa7rY81FQGQs24WKOH6z3j1qtvU-q3jD47y57nZJNCYX4bFbTA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aEmL9GyFI-_aaJGFS6GB4jI6oUycjEPnKqFAIa7rY81FQGQs24WKOH6z3j1qtvU-q3jD47y57nZJNCYX4bFbTA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/05/05 03:51:17 DEBUG : proton drive root link ID 'rclone-test-joruhep2bive': Purge remote --- FAIL: TestServerSideMove (12.75s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:51:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pajanid3sawe" 2025/05/05 03:51:19 DEBUG : proton drive root link ID 'rclone-test-pajanid3sawe': Has cached credentials 2025/05/05 03:51:21 DEBUG : proton drive root link ID 'rclone-test-pajanid3sawe': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-facidow9buze' -> proton drive root link ID 'rclone-test-pajanid3sawe' 2025/05/05 03:51:29 DEBUG : empty space: Excluded (Size Filter) 2025/05/05 03:51:29 DEBUG : empty space: Excluded 2025/05/05 03:51:29 DEBUG : empty space: Excluded (Size Filter) 2025/05/05 03:51:29 DEBUG : empty space: Excluded 2025/05/05 03:51:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/05 03:51:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/05 03:51:29 DEBUG : proton drive root link ID 'rclone-test-pajanid3sawe': Waiting for checks to finish 2025/05/05 03:51:29 DEBUG : proton drive root link ID 'rclone-test-pajanid3sawe': Waiting for transfers to finish 2025/05/05 03:51:30 INFO : potato3: Deleted 2025/05/05 03:51:30.330014 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dhafagNxh03hU_UAM27KU-SOc4DOF9WKK7sNwBssYOgO_zn9s13vLJek86W0RDAZciqGhI8SxHqghb0BRX8geg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:30.330038 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dhafagNxh03hU_UAM27KU-SOc4DOF9WKK7sNwBssYOgO_zn9s13vLJek86W0RDAZciqGhI8SxHqghb0BRX8geg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:30 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dhafagNxh03hU_UAM27KU-SOc4DOF9WKK7sNwBssYOgO_zn9s13vLJek86W0RDAZciqGhI8SxHqghb0BRX8geg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:30.669919 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2wP7_L-jUx-kDrFHoZj13vA0eDrLlODgFmjL-LitrYl_nLvXW9CTkhJ7SfKu42jbhiNQqJelZYafZcw20i6mFg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:30.669945 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2wP7_L-jUx-kDrFHoZj13vA0eDrLlODgFmjL-LitrYl_nLvXW9CTkhJ7SfKu42jbhiNQqJelZYafZcw20i6mFg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2wP7_L-jUx-kDrFHoZj13vA0eDrLlODgFmjL-LitrYl_nLvXW9CTkhJ7SfKu42jbhiNQqJelZYafZcw20i6mFg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2wP7_L-jUx-kDrFHoZj13vA0eDrLlODgFmjL-LitrYl_nLvXW9CTkhJ7SfKu42jbhiNQqJelZYafZcw20i6mFg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/05/05 03:51:30 DEBUG : proton drive root link ID 'rclone-test-pajanid3sawe': Purge remote --- FAIL: TestServerSideMoveWithFilter (13.70s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:51:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tolejok8nice" 2025/05/05 03:51:33 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Has cached credentials 2025/05/05 03:51:34 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:51:38 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-facidow9buze' -> proton drive root link ID 'rclone-test-tolejok8nice' 2025/05/05 03:51:43 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Using server-side directory move 2025/05/05 03:51:43 INFO : proton drive root link ID 'rclone-test-tolejok8nice': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/05 03:51:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/05 03:51:44 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/05 03:51:44 DEBUG : empty space: Unchanged skipping 2025/05/05 03:51:44 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/05 03:51:44 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Waiting for checks to finish 2025/05/05 03:51:44 INFO : empty space: Deleted 2025/05/05 03:51:44 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Waiting for transfers to finish 2025/05/05 03:51:44 INFO : potato3: Deleted 2025/05/05 03:51:45.095431 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XP1MLS4Zd3PRgoD1GtYFvpmrB5zYP0Zjt_lyWfodfHjTj-Tsptwd1yyPCnz3lReWlBRZNyV9dvIJEPYlFSNNng==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:45.095472 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XP1MLS4Zd3PRgoD1GtYFvpmrB5zYP0Zjt_lyWfodfHjTj-Tsptwd1yyPCnz3lReWlBRZNyV9dvIJEPYlFSNNng==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:45 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XP1MLS4Zd3PRgoD1GtYFvpmrB5zYP0Zjt_lyWfodfHjTj-Tsptwd1yyPCnz3lReWlBRZNyV9dvIJEPYlFSNNng==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:45.206976 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eemZYfylso_moWtKBTjLIJ33jYA9tE6X54vj-_OD0Fr7M-HmpDaB9jSgOS7mt_i7t1p7xmb3qscMokTu1gEVmw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:51:45.207011 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eemZYfylso_moWtKBTjLIJ33jYA9tE6X54vj-_OD0Fr7M-HmpDaB9jSgOS7mt_i7t1p7xmb3qscMokTu1gEVmw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:45 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eemZYfylso_moWtKBTjLIJ33jYA9tE6X54vj-_OD0Fr7M-HmpDaB9jSgOS7mt_i7t1p7xmb3qscMokTu1gEVmw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:51:45 ERROR : proton drive root link ID 'rclone-test-facidow9buze': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/05/05 03:51:45 DEBUG : proton drive root link ID 'rclone-test-tolejok8nice': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (14.37s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:51:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 03:51:53 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 03:51:55 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:52:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/backup" 2025/05/05 03:52:53 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Has cached credentials 2025/05/05 03:52:55 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:54:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 03:54:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 03:54:53 DEBUG : two: Unchanged skipping 2025/05/05 03:54:53 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for checks to finish 2025/05/05 03:54:55.452209 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8ebFUqek8q8XU4LQ55jS7Xm4ks5juHDQVEgRTBhZnunRJr7SLOMqJFrgeAtVEvIzG_5B7SjI2lQXJJRKkQAwsg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:54:55.452246 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8ebFUqek8q8XU4LQ55jS7Xm4ks5juHDQVEgRTBhZnunRJr7SLOMqJFrgeAtVEvIzG_5B7SjI2lQXJJRKkQAwsg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:54:55 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8ebFUqek8q8XU4LQ55jS7Xm4ks5juHDQVEgRTBhZnunRJr7SLOMqJFrgeAtVEvIzG_5B7SjI2lQXJJRKkQAwsg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:54:55 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for transfers to finish 2025/05/05 03:54:55 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting files as there were IO errors 2025/05/05 03:54:55 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8ebFUqek8q8XU4LQ55jS7Xm4ks5juHDQVEgRTBhZnunRJr7SLOMqJFrgeAtVEvIzG_5B7SjI2lQXJJRKkQAwsg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (190.68s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:55:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 03:55:04 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 03:55:05 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:56:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/backup" 2025/05/05 03:56:04 DEBUG : Config file has changed externally - reloading 2025/05/05 03:56:04 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Has cached credentials 2025/05/05 03:56:05 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:58:08 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for checks to finish 2025/05/05 03:58:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 03:58:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 03:58:08 DEBUG : two: Unchanged skipping 2025/05/05 03:58:09.915917 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N1VUX83p6XoP19AnUZ1RGTde_UTEa404FhRAtM4JlLH_WKSHD6In-r0_LSVXfVnesxx5Ncfud1akbVj1dsXPyA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 03:58:09.915955 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N1VUX83p6XoP19AnUZ1RGTde_UTEa404FhRAtM4JlLH_WKSHD6In-r0_LSVXfVnesxx5Ncfud1akbVj1dsXPyA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:58:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N1VUX83p6XoP19AnUZ1RGTde_UTEa404FhRAtM4JlLH_WKSHD6In-r0_LSVXfVnesxx5Ncfud1akbVj1dsXPyA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 03:58:09 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for transfers to finish 2025/05/05 03:58:09 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting files as there were IO errors 2025/05/05 03:58:09 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N1VUX83p6XoP19AnUZ1RGTde_UTEa404FhRAtM4JlLH_WKSHD6In-r0_LSVXfVnesxx5Ncfud1akbVj1dsXPyA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (194.31s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 03:58:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 03:58:18 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 03:58:19 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 03:59:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/backup" 2025/05/05 03:59:19 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Has cached credentials 2025/05/05 03:59:20 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/backup': Used cached credential to initialize the ProtonDrive API 2025/05/05 04:01:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 04:01:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 04:01:20 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for checks to finish 2025/05/05 04:01:20 DEBUG : two: Unchanged skipping 2025/05/05 04:01:22.518375 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VBZs2s2XKTIqDEUQryYXAEwDAGdkKYIbhjLpuv2VKrnp26HsyV_TaVMSp134P3c8uljYQY692y24MtM2piGR8A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 04:01:22.518409 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VBZs2s2XKTIqDEUQryYXAEwDAGdkKYIbhjLpuv2VKrnp26HsyV_TaVMSp134P3c8uljYQY692y24MtM2piGR8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:01:22 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VBZs2s2XKTIqDEUQryYXAEwDAGdkKYIbhjLpuv2VKrnp26HsyV_TaVMSp134P3c8uljYQY692y24MtM2piGR8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:01:22 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for transfers to finish 2025/05/05 04:01:22 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting files as there were IO errors 2025/05/05 04:01:22 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VBZs2s2XKTIqDEUQryYXAEwDAGdkKYIbhjLpuv2VKrnp26HsyV_TaVMSp134P3c8uljYQY692y24MtM2piGR8A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (192.57s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 04:01:31 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 04:01:31 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 04:01:32 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 04:02:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 04:02:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/05 04:02:32 DEBUG : two: Unchanged skipping 2025/05/05 04:02:32 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for checks to finish 2025/05/05 04:02:33.204699 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UT7oOjm_xV9sNU-bu4q4Fv10vPEtvV2o7zOC12ZiTRbJFfbDSLgil1TYBwPAGkUlodIjDh6bohGzLMpPOTTTvA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 04:02:33.204741 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UT7oOjm_xV9sNU-bu4q4Fv10vPEtvV2o7zOC12ZiTRbJFfbDSLgil1TYBwPAGkUlodIjDh6bohGzLMpPOTTTvA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:02:33 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UT7oOjm_xV9sNU-bu4q4Fv10vPEtvV2o7zOC12ZiTRbJFfbDSLgil1TYBwPAGkUlodIjDh6bohGzLMpPOTTTvA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:02:33 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Waiting for transfers to finish 2025/05/05 04:02:33 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting files as there were IO errors 2025/05/05 04:02:33 ERROR : proton drive root link ID 'rclone-test-facidow9buze/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UT7oOjm_xV9sNU-bu4q4Fv10vPEtvV2o7zOC12ZiTRbJFfbDSLgil1TYBwPAGkUlodIjDh6bohGzLMpPOTTTvA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (70.57s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 04:02:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 04:02:41 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 04:02:43 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 04:03:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 04:03:46.987931 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zMw8nkQeYIIXATrHnV9X00I7ry7d0iJi61SRHwUN32whrGqMgiLSf9OebuaSTZYztsC13BgUB6gkBXmI4p4pwQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 04:03:46.987963 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zMw8nkQeYIIXATrHnV9X00I7ry7d0iJi61SRHwUN32whrGqMgiLSf9OebuaSTZYztsC13BgUB6gkBXmI4p4pwQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:03:46 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zMw8nkQeYIIXATrHnV9X00I7ry7d0iJi61SRHwUN32whrGqMgiLSf9OebuaSTZYztsC13BgUB6gkBXmI4p4pwQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zMw8nkQeYIIXATrHnV9X00I7ry7d0iJi61SRHwUN32whrGqMgiLSf9OebuaSTZYztsC13BgUB6gkBXmI4p4pwQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (73.26s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-facidow9buze'", Local "Local file system at /tmp/rclone2689571342", Modify Window "1s" 2025/05/05 04:03:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-facidow9buze/dst" 2025/05/05 04:03:54 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Has cached credentials 2025/05/05 04:03:55 DEBUG : proton drive root link ID 'rclone-test-facidow9buze/dst': Used cached credential to initialize the ProtonDrive API 2025/05/05 04:04:57 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/05 04:04:58.335261 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUdLe5er_dpeAntZAAcXcSaHfJz1846Eac-CjUpaE9It7cHuA0OHiLfvfqpA_GNR48LjUnQko9GZwMT9atjeNg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/05 04:04:58.335288 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUdLe5er_dpeAntZAAcXcSaHfJz1846Eac-CjUpaE9It7cHuA0OHiLfvfqpA_GNR48LjUnQko9GZwMT9atjeNg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/05 04:04:58 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUdLe5er_dpeAntZAAcXcSaHfJz1846Eac-CjUpaE9It7cHuA0OHiLfvfqpA_GNR48LjUnQko9GZwMT9atjeNg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUdLe5er_dpeAntZAAcXcSaHfJz1846Eac-CjUpaE9It7cHuA0OHiLfvfqpA_GNR48LjUnQko9GZwMT9atjeNg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (71.86s) FAIL 2025/05/05 04:05:01 DEBUG : proton drive root link ID 'rclone-test-facidow9buze': 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 14m47.223404975s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]