"./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 5/5) 2025/03/22 07:24:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri" 2025/03/22 07:24:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/22 07:24:25 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Has cached credentials 2025/03/22 07:24:27 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:24:27 DEBUG : Creating backend with remote "/tmp/rclone4149800515" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:24:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wejewup2heru" 2025/03/22 07:24:32 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Has cached credentials 2025/03/22 07:24:33 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-degomub0reri' -> proton drive root link ID 'rclone-test-wejewup2heru' 2025/03/22 07:24:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/22 07:24:34 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Waiting for checks to finish 2025/03/22 07:24:34 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Waiting for transfers to finish 2025/03/22 07:24:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/03/22 07:24:38 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:24:40.489357 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/03/22 07:24:40.489391 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/03/22 07:24:43 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Using server-side directory move 2025/03/22 07:24:43 INFO : proton drive root link ID 'rclone-test-wejewup2heru': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/22 07:24:44 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/22 07:24:44 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Waiting for checks to finish 2025/03/22 07:24:44 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Waiting for transfers to finish 2025/03/22 07:24:44 INFO : sub dir/hello world: Deleted 2025/03/22 07:24:45.461168 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DrczpiGL-wVG_D6Co6a9eZtNz5A1YQMNbxYx63cdqZ7pAX7VvNp4BDQuQ8v1EjRHOSY3MyT4lmnaXIDagqfQnQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:24:45.461204 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DrczpiGL-wVG_D6Co6a9eZtNz5A1YQMNbxYx63cdqZ7pAX7VvNp4BDQuQ8v1EjRHOSY3MyT4lmnaXIDagqfQnQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:24:45 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DrczpiGL-wVG_D6Co6a9eZtNz5A1YQMNbxYx63cdqZ7pAX7VvNp4BDQuQ8v1EjRHOSY3MyT4lmnaXIDagqfQnQ==/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/DrczpiGL-wVG_D6Co6a9eZtNz5A1YQMNbxYx63cdqZ7pAX7VvNp4BDQuQ8v1EjRHOSY3MyT4lmnaXIDagqfQnQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/03/22 07:24:45 DEBUG : proton drive root link ID 'rclone-test-wejewup2heru': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.14s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/03/22 07:24:49 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:24:49 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:24:49 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:24:49 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:24:49 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/22 07:24:49 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/22 07:24:49 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:24:50 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:24:50 INFO : yam: Copied (new) 2025/03/22 07:24:51 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/22 07:24:51 INFO : potato: Copied (new) 2025/03/22 07:24:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:24:52 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:24:52 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:24:52 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:24:52 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:24:52 DEBUG : potato: Unchanged skipping 2025/03/22 07:24:52 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:24:52.862839 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BFTE821Gn1udo2PDcNMwG9XsBx6-_wgZ3cMemwjuXfHLOkzpmQJb_sIHzXepto9DfsXhXnwPwNpIjsNDueAJbw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:24:52.862877 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BFTE821Gn1udo2PDcNMwG9XsBx6-_wgZ3cMemwjuXfHLOkzpmQJb_sIHzXepto9DfsXhXnwPwNpIjsNDueAJbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:24:52 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BFTE821Gn1udo2PDcNMwG9XsBx6-_wgZ3cMemwjuXfHLOkzpmQJb_sIHzXepto9DfsXhXnwPwNpIjsNDueAJbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:24:52 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BFTE821Gn1udo2PDcNMwG9XsBx6-_wgZ3cMemwjuXfHLOkzpmQJb_sIHzXepto9DfsXhXnwPwNpIjsNDueAJbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:24:52 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/03/22 07:24:52 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:24:54 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:24:54 INFO : yaml: Copied (new) 2025/03/22 07:24:54 ERROR : proton drive root link ID 'rclone-test-degomub0reri': not deleting files as there were IO errors 2025/03/22 07:24:54 ERROR : proton drive root link ID 'rclone-test-degomub0reri': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.73s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/03/22 07:24:57 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:24:57 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:24:57 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:24:57 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/22 07:24:57 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/22 07:24:57 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:24:57 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:24:59 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/22 07:24:59 INFO : potato: Copied (new) 2025/03/22 07:24:59 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:24:59 INFO : yam: Copied (new) 2025/03/22 07:24:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:25:00 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:25:00 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:25:00 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:25:00 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:25:00 DEBUG : potato: Unchanged skipping 2025/03/22 07:25:00 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:25:01.669675 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cdzjhmbiE5-kbOPrRuOmekfaD5FcLZvbz_360Gpj75RWeTrSJUEHAz7oUhk8an55fWtJ3svDO1LDAwwiPOUEg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:01.669708 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cdzjhmbiE5-kbOPrRuOmekfaD5FcLZvbz_360Gpj75RWeTrSJUEHAz7oUhk8an55fWtJ3svDO1LDAwwiPOUEg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:01 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cdzjhmbiE5-kbOPrRuOmekfaD5FcLZvbz_360Gpj75RWeTrSJUEHAz7oUhk8an55fWtJ3svDO1LDAwwiPOUEg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:01 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4cdzjhmbiE5-kbOPrRuOmekfaD5FcLZvbz_360Gpj75RWeTrSJUEHAz7oUhk8an55fWtJ3svDO1LDAwwiPOUEg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:01 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/03/22 07:25:01 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:25:03 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:25:03 INFO : yaml: Copied (new) 2025/03/22 07:25:03 ERROR : proton drive root link ID 'rclone-test-degomub0reri': not deleting files as there were IO errors 2025/03/22 07:25:03 ERROR : proton drive root link ID 'rclone-test-degomub0reri': 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 (8.81s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/03/22 07:25:06 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:25:06 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:25:06 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:25:06 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/22 07:25:06 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/03/22 07:25:06 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:25:06 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:25:09 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/22 07:25:09 INFO : potato: Copied (new) 2025/03/22 07:25:09 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:25:09 INFO : sub/yam: Copied (new) 2025/03/22 07:25:09 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:25:10 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:25:10 DEBUG : potato: Unchanged skipping 2025/03/22 07:25:11 INFO : proton drive root link ID 'rclone-test-degomub0reri': Making map for --track-renames 2025/03/22 07:25:11 INFO : proton drive root link ID 'rclone-test-degomub0reri': Finished making map for --track-renames 2025/03/22 07:25:11 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:25:11 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for renames to finish 2025/03/22 07:25:11.751165 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LflP6d9P92uIlEjYhz0Nbjm953c1kCK8wmfl8EdkFSVoLN44I_6bJmUv02LaEBkBXq9PhYUeUK5snNJWOKgLxQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:11.751204 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LflP6d9P92uIlEjYhz0Nbjm953c1kCK8wmfl8EdkFSVoLN44I_6bJmUv02LaEBkBXq9PhYUeUK5snNJWOKgLxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:11 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LflP6d9P92uIlEjYhz0Nbjm953c1kCK8wmfl8EdkFSVoLN44I_6bJmUv02LaEBkBXq9PhYUeUK5snNJWOKgLxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:11 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LflP6d9P92uIlEjYhz0Nbjm953c1kCK8wmfl8EdkFSVoLN44I_6bJmUv02LaEBkBXq9PhYUeUK5snNJWOKgLxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/22 07:25:11 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:25:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/22 07:25:13 INFO : yam: Copied (new) 2025/03/22 07:25:13 ERROR : proton drive root link ID 'rclone-test-degomub0reri': not deleting files as there were IO errors 2025/03/22 07:25:13 ERROR : proton drive root link ID 'rclone-test-degomub0reri': 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 (10.97s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:25:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/22 07:25:17 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/22 07:25:17 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for checks to finish 2025/03/22 07:25:17 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': Waiting for transfers to finish 2025/03/22 07:25:22 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/03/22 07:25:22 INFO : nested/sub dir/file: Copied (new) 2025/03/22 07:25:22 INFO : nested/sub dir/file: Deleted 2025/03/22 07:25:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/03/22 07:25:22 INFO : sub dir/hello world: Copied (new) 2025/03/22 07:25:22 INFO : sub dir/hello world: Deleted 2025/03/22 07:25:22 ERROR : Local file system at /tmp/rclone4149800515: 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 (8.37s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:25:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-buluseg3balo" 2025/03/22 07:25:25 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Has cached credentials 2025/03/22 07:25:26 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-degomub0reri' -> proton drive root link ID 'rclone-test-buluseg3balo' 2025/03/22 07:25:38 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Using server-side directory move 2025/03/22 07:25:38 INFO : proton drive root link ID 'rclone-test-buluseg3balo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/22 07:25:39 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/22 07:25:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/03/22 07:25:39 DEBUG : empty space: Unchanged skipping 2025/03/22 07:25:39 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Waiting for checks to finish 2025/03/22 07:25:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/22 07:25:39 INFO : empty space: Deleted 2025/03/22 07:25:39 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Waiting for transfers to finish 2025/03/22 07:25:39 INFO : potato3: Deleted 2025/03/22 07:25:39.782763 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z_QxeTo1WRvErhapV0YAfr30mcZeUmYixNH9RPItMrlNip--mO8FrLZw0v6hn270h5EZxrvi-FKpkX7JH0YX7A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:39.782793 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z_QxeTo1WRvErhapV0YAfr30mcZeUmYixNH9RPItMrlNip--mO8FrLZw0v6hn270h5EZxrvi-FKpkX7JH0YX7A==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:39 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z_QxeTo1WRvErhapV0YAfr30mcZeUmYixNH9RPItMrlNip--mO8FrLZw0v6hn270h5EZxrvi-FKpkX7JH0YX7A==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:40.093140 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8bs-cQf3SLnEKxTOhxRkEejIzfyAveLiw771E2HBBdW6G-pdGzI1iT29QJQhG9m5QYB0AGD5qZXFd36bDh864w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:40.093174 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8bs-cQf3SLnEKxTOhxRkEejIzfyAveLiw771E2HBBdW6G-pdGzI1iT29QJQhG9m5QYB0AGD5qZXFd36bDh864w==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:40 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8bs-cQf3SLnEKxTOhxRkEejIzfyAveLiw771E2HBBdW6G-pdGzI1iT29QJQhG9m5QYB0AGD5qZXFd36bDh864w==/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/8bs-cQf3SLnEKxTOhxRkEejIzfyAveLiw771E2HBBdW6G-pdGzI1iT29QJQhG9m5QYB0AGD5qZXFd36bDh864w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/03/22 07:25:40 DEBUG : proton drive root link ID 'rclone-test-buluseg3balo': Purge remote --- FAIL: TestServerSideMove (17.07s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:25:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mupipuq9heho" 2025/03/22 07:25:42 DEBUG : proton drive root link ID 'rclone-test-mupipuq9heho': Has cached credentials 2025/03/22 07:25:43 DEBUG : proton drive root link ID 'rclone-test-mupipuq9heho': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-degomub0reri' -> proton drive root link ID 'rclone-test-mupipuq9heho' 2025/03/22 07:25:55 DEBUG : empty space: Excluded (Size Filter) 2025/03/22 07:25:55 DEBUG : empty space: Excluded 2025/03/22 07:25:56 DEBUG : empty space: Excluded (Size Filter) 2025/03/22 07:25:56 DEBUG : empty space: Excluded 2025/03/22 07:25:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/22 07:25:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/22 07:25:56 DEBUG : proton drive root link ID 'rclone-test-mupipuq9heho': Waiting for checks to finish 2025/03/22 07:25:56 DEBUG : proton drive root link ID 'rclone-test-mupipuq9heho': Waiting for transfers to finish 2025/03/22 07:25:56 INFO : potato3: Deleted 2025/03/22 07:25:56.883081 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uT1qycWLgpoQLW3Ucqaqi6GBqQYsn4kj9_NQno-R8kI2Uo86Dx5j0e9K8vg9a_xSYbSCar_CWM5ZuK9wWm8Pqg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:56.883111 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uT1qycWLgpoQLW3Ucqaqi6GBqQYsn4kj9_NQno-R8kI2Uo86Dx5j0e9K8vg9a_xSYbSCar_CWM5ZuK9wWm8Pqg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:56 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uT1qycWLgpoQLW3Ucqaqi6GBqQYsn4kj9_NQno-R8kI2Uo86Dx5j0e9K8vg9a_xSYbSCar_CWM5ZuK9wWm8Pqg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:57.113010 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pcNS4B6_G1eIBKH-UL7KOLgMhLJJe__ZqyRSYkYhEl7wgaVhwdHAO70RhXuJSUcerF3mrc9G-ES6L8KJDgvWYQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:25:57.113044 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pcNS4B6_G1eIBKH-UL7KOLgMhLJJe__ZqyRSYkYhEl7wgaVhwdHAO70RhXuJSUcerF3mrc9G-ES6L8KJDgvWYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:25:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pcNS4B6_G1eIBKH-UL7KOLgMhLJJe__ZqyRSYkYhEl7wgaVhwdHAO70RhXuJSUcerF3mrc9G-ES6L8KJDgvWYQ==/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/pcNS4B6_G1eIBKH-UL7KOLgMhLJJe__ZqyRSYkYhEl7wgaVhwdHAO70RhXuJSUcerF3mrc9G-ES6L8KJDgvWYQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/03/22 07:25:57 DEBUG : proton drive root link ID 'rclone-test-mupipuq9heho': Purge remote --- FAIL: TestServerSideMoveWithFilter (17.34s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:26:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zupebit7gicu" 2025/03/22 07:26:00 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Has cached credentials 2025/03/22 07:26:01 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:26:07 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-degomub0reri' -> proton drive root link ID 'rclone-test-zupebit7gicu' 2025/03/22 07:26:14 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Using server-side directory move 2025/03/22 07:26:14 INFO : proton drive root link ID 'rclone-test-zupebit7gicu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/22 07:26:14 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/22 07:26:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/03/22 07:26:14 DEBUG : empty space: Unchanged skipping 2025/03/22 07:26:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/22 07:26:15 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Waiting for checks to finish 2025/03/22 07:26:15 INFO : potato3: Deleted 2025/03/22 07:26:15 INFO : empty space: Deleted 2025/03/22 07:26:15 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Waiting for transfers to finish 2025/03/22 07:26:15.711626 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VE7aa7WZG4d5lHhBgIFWAMDMiSWXN8en0w1L9O2CBP1lCryaA2P8I20kyvRqUqV5rBW3tEhk90wIXRSBYZ64aA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:26:15.711667 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VE7aa7WZG4d5lHhBgIFWAMDMiSWXN8en0w1L9O2CBP1lCryaA2P8I20kyvRqUqV5rBW3tEhk90wIXRSBYZ64aA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:26:15 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VE7aa7WZG4d5lHhBgIFWAMDMiSWXN8en0w1L9O2CBP1lCryaA2P8I20kyvRqUqV5rBW3tEhk90wIXRSBYZ64aA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:26:15.952528 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9psCogUeymkfnhMEoLR2f41aEom19lM9MT8gwWb0QB9lPnAa0GLuD2FY1owD8_eVouE4e5NzOnADHzJFEuD8wg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:26:15.952562 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9psCogUeymkfnhMEoLR2f41aEom19lM9MT8gwWb0QB9lPnAa0GLuD2FY1owD8_eVouE4e5NzOnADHzJFEuD8wg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:26:15 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9psCogUeymkfnhMEoLR2f41aEom19lM9MT8gwWb0QB9lPnAa0GLuD2FY1owD8_eVouE4e5NzOnADHzJFEuD8wg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:26:15 ERROR : proton drive root link ID 'rclone-test-degomub0reri': 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/03/22 07:26:15 DEBUG : proton drive root link ID 'rclone-test-zupebit7gicu': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.24s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:26:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:26:26 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:26:27 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:27:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/backup" 2025/03/22 07:27:21 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Has cached credentials 2025/03/22 07:27:22 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:29:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:29:10 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:29:10 DEBUG : two: Unchanged skipping 2025/03/22 07:29:10 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for checks to finish 2025/03/22 07:29:12.581339 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFqybPumHeHWHtulRJP_098uK7QgEkBeL0enrhpv8OWSABogQ-4bjkn03mWQ7IxffCa_OGktXXlz_tS-R-uuCw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:29:12.581374 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFqybPumHeHWHtulRJP_098uK7QgEkBeL0enrhpv8OWSABogQ-4bjkn03mWQ7IxffCa_OGktXXlz_tS-R-uuCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:29:12 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFqybPumHeHWHtulRJP_098uK7QgEkBeL0enrhpv8OWSABogQ-4bjkn03mWQ7IxffCa_OGktXXlz_tS-R-uuCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:29:12 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for transfers to finish 2025/03/22 07:29:12 ERROR : proton drive root link ID 'rclone-test-degomub0reri/dst': not deleting files as there were IO errors 2025/03/22 07:29:12 ERROR : proton drive root link ID 'rclone-test-degomub0reri/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/RFqybPumHeHWHtulRJP_098uK7QgEkBeL0enrhpv8OWSABogQ-4bjkn03mWQ7IxffCa_OGktXXlz_tS-R-uuCw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (177.17s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:29:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:29:23 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:29:25 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:30:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/backup" 2025/03/22 07:30:18 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Has cached credentials 2025/03/22 07:30:19 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:32:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:32:07 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:32:07 DEBUG : two: Unchanged skipping 2025/03/22 07:32:07 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for checks to finish 2025/03/22 07:32:09.049150 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WKiwnrEcYL37W_hnkC5NYdCph1uW9V0KoDSJ483_w2eQk0KTeHwTVixiM6f3AYujeZgLRnnLi_ZulWhR87luOQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:32:09.049176 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WKiwnrEcYL37W_hnkC5NYdCph1uW9V0KoDSJ483_w2eQk0KTeHwTVixiM6f3AYujeZgLRnnLi_ZulWhR87luOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:32:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WKiwnrEcYL37W_hnkC5NYdCph1uW9V0KoDSJ483_w2eQk0KTeHwTVixiM6f3AYujeZgLRnnLi_ZulWhR87luOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:32:09 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for transfers to finish 2025/03/22 07:32:09 ERROR : proton drive root link ID 'rclone-test-degomub0reri/dst': not deleting files as there were IO errors 2025/03/22 07:32:09 ERROR : proton drive root link ID 'rclone-test-degomub0reri/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/WKiwnrEcYL37W_hnkC5NYdCph1uW9V0KoDSJ483_w2eQk0KTeHwTVixiM6f3AYujeZgLRnnLi_ZulWhR87luOQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (176.40s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:32:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:32:20 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:32:21 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:33:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/backup" 2025/03/22 07:33:15 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Has cached credentials 2025/03/22 07:33:16 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/backup': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:35:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:35:04 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:35:04 DEBUG : two: Unchanged skipping 2025/03/22 07:35:04 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for checks to finish 2025/03/22 07:35:06.501241 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5Us79HwyxqRvy4kHf_6KtcZEKp2mLxH9MnR4eOaQGuMTGK062PrfPaQInuRqWwdhyp5_N3nN9b51lR1wz-wD7w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:35:06.501276 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5Us79HwyxqRvy4kHf_6KtcZEKp2mLxH9MnR4eOaQGuMTGK062PrfPaQInuRqWwdhyp5_N3nN9b51lR1wz-wD7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:35:06 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5Us79HwyxqRvy4kHf_6KtcZEKp2mLxH9MnR4eOaQGuMTGK062PrfPaQInuRqWwdhyp5_N3nN9b51lR1wz-wD7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:35:06 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for transfers to finish 2025/03/22 07:35:06 ERROR : proton drive root link ID 'rclone-test-degomub0reri/dst': not deleting files as there were IO errors 2025/03/22 07:35:06 ERROR : proton drive root link ID 'rclone-test-degomub0reri/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/5Us79HwyxqRvy4kHf_6KtcZEKp2mLxH9MnR4eOaQGuMTGK062PrfPaQInuRqWwdhyp5_N3nN9b51lR1wz-wD7w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (177.62s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:35:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:35:17 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:35:19 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:36:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:36:13 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/22 07:36:13 DEBUG : two: Unchanged skipping 2025/03/22 07:36:13 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for checks to finish 2025/03/22 07:36:14.647206 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wzs8zc4FqqbBQVFsuXQIgBJGvu4wlivggqLtnWgFo7WOUCD1ny7jRUyOmNajf5KRyjf3HmFrBdg49ewWbeS5Bw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:36:14.647244 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wzs8zc4FqqbBQVFsuXQIgBJGvu4wlivggqLtnWgFo7WOUCD1ny7jRUyOmNajf5KRyjf3HmFrBdg49ewWbeS5Bw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:36:14 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wzs8zc4FqqbBQVFsuXQIgBJGvu4wlivggqLtnWgFo7WOUCD1ny7jRUyOmNajf5KRyjf3HmFrBdg49ewWbeS5Bw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:36:14 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Waiting for transfers to finish 2025/03/22 07:36:14 ERROR : proton drive root link ID 'rclone-test-degomub0reri/dst': not deleting files as there were IO errors 2025/03/22 07:36:14 ERROR : proton drive root link ID 'rclone-test-degomub0reri/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/Wzs8zc4FqqbBQVFsuXQIgBJGvu4wlivggqLtnWgFo7WOUCD1ny7jRUyOmNajf5KRyjf3HmFrBdg49ewWbeS5Bw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (67.31s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:36:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:36:25 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:36:26 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:37:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:37:22.489153 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jTk4Mk-DXsy3LaB14hTyz_ouZM5oorKPqdIEs_Q2bd-PYFkjPI2Zimne8VXZtxjSw4WQy_PHjY15AycUunXUJw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:37:22.489191 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jTk4Mk-DXsy3LaB14hTyz_ouZM5oorKPqdIEs_Q2bd-PYFkjPI2Zimne8VXZtxjSw4WQy_PHjY15AycUunXUJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:37:22 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jTk4Mk-DXsy3LaB14hTyz_ouZM5oorKPqdIEs_Q2bd-PYFkjPI2Zimne8VXZtxjSw4WQy_PHjY15AycUunXUJw==/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/jTk4Mk-DXsy3LaB14hTyz_ouZM5oorKPqdIEs_Q2bd-PYFkjPI2Zimne8VXZtxjSw4WQy_PHjY15AycUunXUJw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (67.60s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-degomub0reri'", Local "Local file system at /tmp/rclone4149800515", Modify Window "1s" 2025/03/22 07:37:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-degomub0reri/dst" 2025/03/22 07:37:32 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Has cached credentials 2025/03/22 07:37:34 DEBUG : proton drive root link ID 'rclone-test-degomub0reri/dst': Used cached credential to initialize the ProtonDrive API 2025/03/22 07:38:28 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 07:38:29.184658 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jfv1Ia_Ydu1lP4RnnYYoAQdbyliZcFZM8EQ5MfgUINPCdZPBpP3UgBwLlZt6-w7ATMKS0kL_oQwtjokiuLBnow==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/22 07:38:29.184692 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jfv1Ia_Ydu1lP4RnnYYoAQdbyliZcFZM8EQ5MfgUINPCdZPBpP3UgBwLlZt6-w7ATMKS0kL_oQwtjokiuLBnow==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/22 07:38:29 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jfv1Ia_Ydu1lP4RnnYYoAQdbyliZcFZM8EQ5MfgUINPCdZPBpP3UgBwLlZt6-w7ATMKS0kL_oQwtjokiuLBnow==/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/jfv1Ia_Ydu1lP4RnnYYoAQdbyliZcFZM8EQ5MfgUINPCdZPBpP3UgBwLlZt6-w7ATMKS0kL_oQwtjokiuLBnow==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (66.96s) FAIL 2025/03/22 07:38:32 DEBUG : proton drive root link ID 'rclone-test-degomub0reri': 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 14m7.144011479s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]