"./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 4/5) 2025/09/19 06:14:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo" 2025/09/19 06:14:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/19 06:14:13 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Has cached credentials 2025/09/19 06:14:14 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:14:14 DEBUG : Creating backend with remote "/tmp/rclone3366031472" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:14:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dejifik5papo" 2025/09/19 06:14:17 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Has cached credentials 2025/09/19 06:14:18 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-kelowiy5sizo' -> proton drive root link ID 'rclone-test-dejifik5papo' 2025/09/19 06:14:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/19 06:14:19 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Waiting for checks to finish 2025/09/19 06:14:19 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Waiting for transfers to finish 2025/09/19 06:14:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/19 06:14:22 INFO : sub dir/hello world: Copied (new) 2025/09/19 06:14:23.141763 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/09/19 06:14:23.141806 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/09/19 06:14:25 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Using server-side directory move 2025/09/19 06:14:25 INFO : proton drive root link ID 'rclone-test-dejifik5papo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/19 06:14:25 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/19 06:14:25 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Waiting for checks to finish 2025/09/19 06:14:25 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Waiting for transfers to finish 2025/09/19 06:14:25 INFO : sub dir/hello world: Deleted 2025/09/19 06:14:26.510501 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Kp66OMk8SZU8-79qX_WOkRgXDT7BmYzn7adFW2uBbYf3Ez7viGtA6nh5bwioh9YMSgm5TV5l_-KVfJKWKgSJGA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:14:26.510546 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Kp66OMk8SZU8-79qX_WOkRgXDT7BmYzn7adFW2uBbYf3Ez7viGtA6nh5bwioh9YMSgm5TV5l_-KVfJKWKgSJGA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:26 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Kp66OMk8SZU8-79qX_WOkRgXDT7BmYzn7adFW2uBbYf3Ez7viGtA6nh5bwioh9YMSgm5TV5l_-KVfJKWKgSJGA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Kp66OMk8SZU8-79qX_WOkRgXDT7BmYzn7adFW2uBbYf3Ez7viGtA6nh5bwioh9YMSgm5TV5l_-KVfJKWKgSJGA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/19 06:14:26 DEBUG : proton drive root link ID 'rclone-test-dejifik5papo': Purge remote --- FAIL: TestServerSideMoveOverSelf (13.50s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/19 06:14:28 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:28 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:28 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:28 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/19 06:14:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/19 06:14:28 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/19 06:14:29 INFO : potato: Copied (new) 2025/09/19 06:14:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:29 INFO : yam: Copied (new) 2025/09/19 06:14:29 DEBUG : Waiting for deletions to finish 2025/09/19 06:14:30 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:14:30 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:30 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:30 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:30 DEBUG : potato: Unchanged skipping 2025/09/19 06:14:30 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:30.908778 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r6q-Ma8gOHpF0vAUsGzy5uPE8NO_eikRyoEr9iWQmdy5ErMtqtHbFlcDGq_zPGK9GbRwWWbTDKLQ56kskCS6YA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:14:30.908816 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r6q-Ma8gOHpF0vAUsGzy5uPE8NO_eikRyoEr9iWQmdy5ErMtqtHbFlcDGq_zPGK9GbRwWWbTDKLQ56kskCS6YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:30 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r6q-Ma8gOHpF0vAUsGzy5uPE8NO_eikRyoEr9iWQmdy5ErMtqtHbFlcDGq_zPGK9GbRwWWbTDKLQ56kskCS6YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:30 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r6q-Ma8gOHpF0vAUsGzy5uPE8NO_eikRyoEr9iWQmdy5ErMtqtHbFlcDGq_zPGK9GbRwWWbTDKLQ56kskCS6YA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:30 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/19 06:14:30 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:32 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:32 INFO : yaml: Copied (new) 2025/09/19 06:14:32 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting files as there were IO errors 2025/09/19 06:14:32 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (5.47s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/19 06:14:33 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:33 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:33 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:33 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:33 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/19 06:14:33 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/19 06:14:33 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:35 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:35 INFO : yam: Copied (new) 2025/09/19 06:14:35 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/19 06:14:35 INFO : potato: Copied (new) 2025/09/19 06:14:35 DEBUG : Waiting for deletions to finish 2025/09/19 06:14:35 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:14:35 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:35 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:35 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:35 DEBUG : potato: Unchanged skipping 2025/09/19 06:14:35 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:36.427387 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/id_25wdLEwnkWtUZiRyT7_TBUHq0QP7wGtyeRbSa8Cy12nkOx4sDwuVWbh8ZyC2Cy576Kfsu-_mg48U6ivbjXA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:14:36.427436 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/id_25wdLEwnkWtUZiRyT7_TBUHq0QP7wGtyeRbSa8Cy12nkOx4sDwuVWbh8ZyC2Cy576Kfsu-_mg48U6ivbjXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:36 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/id_25wdLEwnkWtUZiRyT7_TBUHq0QP7wGtyeRbSa8Cy12nkOx4sDwuVWbh8ZyC2Cy576Kfsu-_mg48U6ivbjXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:36 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/id_25wdLEwnkWtUZiRyT7_TBUHq0QP7wGtyeRbSa8Cy12nkOx4sDwuVWbh8ZyC2Cy576Kfsu-_mg48U6ivbjXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:36 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/19 06:14:36 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:37 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:37 INFO : yaml: Copied (new) 2025/09/19 06:14:37 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting files as there were IO errors 2025/09/19 06:14:37 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (5.58s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/19 06:14:39 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:39 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:39 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:39 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/19 06:14:39 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:39 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/19 06:14:39 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:40 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/19 06:14:40 INFO : potato: Copied (new) 2025/09/19 06:14:41 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:41 INFO : sub/yam: Copied (new) 2025/09/19 06:14:41 DEBUG : Waiting for deletions to finish 2025/09/19 06:14:42 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:14:42 DEBUG : potato: Unchanged skipping 2025/09/19 06:14:42 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Making map for --track-renames 2025/09/19 06:14:42 INFO : proton drive root link ID 'rclone-test-kelowiy5sizo': Finished making map for --track-renames 2025/09/19 06:14:42 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:42 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for renames to finish 2025/09/19 06:14:42.829177 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5JUw4PwJFh0q5W2m3o7_w2r_JcmQ9y4LQstgOkjnOBC-mHpP4U1RvZlnTtOq1VqsugcrsdCoO8edDuJ1e6iI-A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:14:42.829215 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5JUw4PwJFh0q5W2m3o7_w2r_JcmQ9y4LQstgOkjnOBC-mHpP4U1RvZlnTtOq1VqsugcrsdCoO8edDuJ1e6iI-A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:42 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5JUw4PwJFh0q5W2m3o7_w2r_JcmQ9y4LQstgOkjnOBC-mHpP4U1RvZlnTtOq1VqsugcrsdCoO8edDuJ1e6iI-A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:42 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5JUw4PwJFh0q5W2m3o7_w2r_JcmQ9y4LQstgOkjnOBC-mHpP4U1RvZlnTtOq1VqsugcrsdCoO8edDuJ1e6iI-A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:14:42 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/19 06:14:42 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/19 06:14:44 INFO : yam: Copied (new) 2025/09/19 06:14:44 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting files as there were IO errors 2025/09/19 06:14:44 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (7.01s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:14:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/19 06:14:46 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/19 06:14:46 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for checks to finish 2025/09/19 06:14:46 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': Waiting for transfers to finish 2025/09/19 06:14:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/19 06:14:48 INFO : sub dir/hello world: Copied (new) 2025/09/19 06:14:48 INFO : sub dir/hello world: Deleted 2025/09/19 06:14:48 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/19 06:14:48 INFO : nested/sub dir/file: Copied (new) 2025/09/19 06:14:48 INFO : nested/sub dir/file: Deleted 2025/09/19 06:14:48 ERROR : Local file system at /tmp/rclone3366031472: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (4.86s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:14:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-fuwitay2qayo" 2025/09/19 06:14:50 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Has cached credentials 2025/09/19 06:14:51 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kelowiy5sizo' -> proton drive root link ID 'rclone-test-fuwitay2qayo' 2025/09/19 06:15:00 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Using server-side directory move 2025/09/19 06:15:00 INFO : proton drive root link ID 'rclone-test-fuwitay2qayo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/19 06:15:01 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/19 06:15:01 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/19 06:15:01 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Waiting for checks to finish 2025/09/19 06:15:01 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/19 06:15:01 DEBUG : empty space: Unchanged skipping 2025/09/19 06:15:01 INFO : empty space: Deleted 2025/09/19 06:15:01 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Waiting for transfers to finish 2025/09/19 06:15:01 INFO : potato3: Deleted 2025/09/19 06:15:01.470105 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lBEcLd4OGdbcVZstOlGx2Fgr2n2pKsiDKWX3Z8jdFwKQ_Rx8XcWl6Y1640QpT0Q1HWhPLNyT7bsc12IOCZZKVw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:01.470160 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lBEcLd4OGdbcVZstOlGx2Fgr2n2pKsiDKWX3Z8jdFwKQ_Rx8XcWl6Y1640QpT0Q1HWhPLNyT7bsc12IOCZZKVw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:01 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lBEcLd4OGdbcVZstOlGx2Fgr2n2pKsiDKWX3Z8jdFwKQ_Rx8XcWl6Y1640QpT0Q1HWhPLNyT7bsc12IOCZZKVw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:01.638898 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UGDovgJyzDlcbkRH-aW12IrGJqtGObKH5pJPKVD0cAHRzrz8p-Ts-Z0UZz9FAISP77zDEKe6FQsVVbeg_6Ht_Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:01.638942 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UGDovgJyzDlcbkRH-aW12IrGJqtGObKH5pJPKVD0cAHRzrz8p-Ts-Z0UZz9FAISP77zDEKe6FQsVVbeg_6Ht_Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:01 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UGDovgJyzDlcbkRH-aW12IrGJqtGObKH5pJPKVD0cAHRzrz8p-Ts-Z0UZz9FAISP77zDEKe6FQsVVbeg_6Ht_Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1911 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UGDovgJyzDlcbkRH-aW12IrGJqtGObKH5pJPKVD0cAHRzrz8p-Ts-Z0UZz9FAISP77zDEKe6FQsVVbeg_6Ht_Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/19 06:15:01 DEBUG : proton drive root link ID 'rclone-test-fuwitay2qayo': Purge remote --- FAIL: TestServerSideMove (12.31s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:15:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-fesayaw5biti" 2025/09/19 06:15:03 DEBUG : proton drive root link ID 'rclone-test-fesayaw5biti': Has cached credentials 2025/09/19 06:15:04 DEBUG : proton drive root link ID 'rclone-test-fesayaw5biti': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kelowiy5sizo' -> proton drive root link ID 'rclone-test-fesayaw5biti' 2025/09/19 06:15:13 DEBUG : empty space: Excluded (Size Filter) 2025/09/19 06:15:13 DEBUG : empty space: Excluded 2025/09/19 06:15:13 DEBUG : empty space: Excluded (Size Filter) 2025/09/19 06:15:13 DEBUG : empty space: Excluded 2025/09/19 06:15:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/19 06:15:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/19 06:15:13 DEBUG : proton drive root link ID 'rclone-test-fesayaw5biti': Waiting for checks to finish 2025/09/19 06:15:13 DEBUG : proton drive root link ID 'rclone-test-fesayaw5biti': Waiting for transfers to finish 2025/09/19 06:15:13 INFO : potato3: Deleted 2025/09/19 06:15:13.790446 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PR9ZKnBy9wUZkjU8BESKgTIXIHfZ1tLaKU8_MOw4pkyjFwyxWKZAhJDSUe0nw2GOWafAQnoM05ISw5TUZMVpPw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:13.790495 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PR9ZKnBy9wUZkjU8BESKgTIXIHfZ1tLaKU8_MOw4pkyjFwyxWKZAhJDSUe0nw2GOWafAQnoM05ISw5TUZMVpPw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:13 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PR9ZKnBy9wUZkjU8BESKgTIXIHfZ1tLaKU8_MOw4pkyjFwyxWKZAhJDSUe0nw2GOWafAQnoM05ISw5TUZMVpPw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:13.903365 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8pRechuLU3wwDIhBxgRwHe8MmPUOROB5YCqxrbph_K306D8n9gh53qnCizWEoTkGDlNx3GbkMvuAfusnCPSdLA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:13.903465 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8pRechuLU3wwDIhBxgRwHe8MmPUOROB5YCqxrbph_K306D8n9gh53qnCizWEoTkGDlNx3GbkMvuAfusnCPSdLA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:13 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8pRechuLU3wwDIhBxgRwHe8MmPUOROB5YCqxrbph_K306D8n9gh53qnCizWEoTkGDlNx3GbkMvuAfusnCPSdLA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1924 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8pRechuLU3wwDIhBxgRwHe8MmPUOROB5YCqxrbph_K306D8n9gh53qnCizWEoTkGDlNx3GbkMvuAfusnCPSdLA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/19 06:15:13 DEBUG : proton drive root link ID 'rclone-test-fesayaw5biti': Purge remote --- FAIL: TestServerSideMoveWithFilter (12.35s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:15:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hapevoq2xuza" 2025/09/19 06:15:15 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Has cached credentials 2025/09/19 06:15:16 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:15:20 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-kelowiy5sizo' -> proton drive root link ID 'rclone-test-hapevoq2xuza' 2025/09/19 06:15:25 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Using server-side directory move 2025/09/19 06:15:25 INFO : proton drive root link ID 'rclone-test-hapevoq2xuza': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/19 06:15:25 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/19 06:15:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/19 06:15:25 DEBUG : empty space: Unchanged skipping 2025/09/19 06:15:25 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/19 06:15:25 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Waiting for checks to finish 2025/09/19 06:15:25 INFO : empty space: Deleted 2025/09/19 06:15:25 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Waiting for transfers to finish 2025/09/19 06:15:25 INFO : potato3: Deleted 2025/09/19 06:15:26.161087 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ueHCAzsvz1-pqPduCjuOrqUco0vrLDs_P9QLf5y8R_A_aszKKRu2AMXjtbyoUDdgA502Sv-tsxFZGShSy_2k9A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:26.161128 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ueHCAzsvz1-pqPduCjuOrqUco0vrLDs_P9QLf5y8R_A_aszKKRu2AMXjtbyoUDdgA502Sv-tsxFZGShSy_2k9A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:26 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ueHCAzsvz1-pqPduCjuOrqUco0vrLDs_P9QLf5y8R_A_aszKKRu2AMXjtbyoUDdgA502Sv-tsxFZGShSy_2k9A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:26.311455 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gm08kvyc7NYW2u-o56OWxdR1fNWsJIrslyFiyDn9mwOpl3eCO5Gv-9o8EsvU4jX6c7IqY8Ef-5rIisPBlSKT7w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:15:26.311487 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gm08kvyc7NYW2u-o56OWxdR1fNWsJIrslyFiyDn9mwOpl3eCO5Gv-9o8EsvU4jX6c7IqY8Ef-5rIisPBlSKT7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:26 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gm08kvyc7NYW2u-o56OWxdR1fNWsJIrslyFiyDn9mwOpl3eCO5Gv-9o8EsvU4jX6c7IqY8Ef-5rIisPBlSKT7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:15:26 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/09/19 06:15:26 DEBUG : proton drive root link ID 'rclone-test-hapevoq2xuza': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (12.47s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:15:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:15:33 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:15:34 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:18:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/backup" 2025/09/19 06:18:04 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Has cached credentials 2025/09/19 06:18:05 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:18:39.714550 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=93&PageSize=150&ShowAll=1": read tcp 65.108.87.141:45434->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 06:18:47.918694 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=109&PageSize=150&ShowAll=1": read tcp 65.108.87.141:56058->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 06:19:51.450186 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=3&PageSize=150&ShowAll=1": read tcp 65.108.87.141:55434->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 06:21:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:21:30 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for checks to finish 2025/09/19 06:21:30 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:21:30 DEBUG : two: Unchanged skipping 2025/09/19 06:21:32.606512 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2gjNTdv-7l5hlA608zxXoevKkvFOJygJF5jw834gc12BDz4IKYRBadKC9D3BxL0rc0Er8WuMoErkdhTfF-pTBA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:21:32.606553 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2gjNTdv-7l5hlA608zxXoevKkvFOJygJF5jw834gc12BDz4IKYRBadKC9D3BxL0rc0Er8WuMoErkdhTfF-pTBA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:21:32 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2gjNTdv-7l5hlA608zxXoevKkvFOJygJF5jw834gc12BDz4IKYRBadKC9D3BxL0rc0Er8WuMoErkdhTfF-pTBA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:21:32 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for transfers to finish 2025/09/19 06:21:32 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting files as there were IO errors 2025/09/19 06:21:32 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2gjNTdv-7l5hlA608zxXoevKkvFOJygJF5jw834gc12BDz4IKYRBadKC9D3BxL0rc0Er8WuMoErkdhTfF-pTBA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (369.70s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:21:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:21:45 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:21:48 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:23:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/backup" 2025/09/19 06:23:25 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Has cached credentials 2025/09/19 06:23:27 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:26:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:26:44 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for checks to finish 2025/09/19 06:26:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:26:44 DEBUG : two: Unchanged skipping 2025/09/19 06:26:46.898619 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2OoHfH-VmVH--W492Fb8GObbC-ld1fEABsid1PeXRuJa2JJNNyJZTN_0edL0-Ec2UMcRY650VNMpEoxLKZ9R7A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:26:46.898669 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2OoHfH-VmVH--W492Fb8GObbC-ld1fEABsid1PeXRuJa2JJNNyJZTN_0edL0-Ec2UMcRY650VNMpEoxLKZ9R7A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:26:46 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2OoHfH-VmVH--W492Fb8GObbC-ld1fEABsid1PeXRuJa2JJNNyJZTN_0edL0-Ec2UMcRY650VNMpEoxLKZ9R7A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:26:46 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for transfers to finish 2025/09/19 06:26:46 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting files as there were IO errors 2025/09/19 06:26:46 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2OoHfH-VmVH--W492Fb8GObbC-ld1fEABsid1PeXRuJa2JJNNyJZTN_0edL0-Ec2UMcRY650VNMpEoxLKZ9R7A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (315.03s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:27:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:27:01 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:27:03 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:28:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/backup" 2025/09/19 06:28:42 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Has cached credentials 2025/09/19 06:28:44 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:32:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:32:00 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for checks to finish 2025/09/19 06:32:00 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:32:00 DEBUG : two: Unchanged skipping 2025/09/19 06:32:02.729675 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fVN4SkYJlEbpEtvQ1GjeAFCQr0pSi5pruZALow-IXdgDCq6Rp3wefZWKaS8YfgVp3WdrKDWZMMQSa11S9QCCuw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:32:02.729765 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fVN4SkYJlEbpEtvQ1GjeAFCQr0pSi5pruZALow-IXdgDCq6Rp3wefZWKaS8YfgVp3WdrKDWZMMQSa11S9QCCuw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:32:02 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fVN4SkYJlEbpEtvQ1GjeAFCQr0pSi5pruZALow-IXdgDCq6Rp3wefZWKaS8YfgVp3WdrKDWZMMQSa11S9QCCuw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:32:02 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for transfers to finish 2025/09/19 06:32:02 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting files as there were IO errors 2025/09/19 06:32:02 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fVN4SkYJlEbpEtvQ1GjeAFCQr0pSi5pruZALow-IXdgDCq6Rp3wefZWKaS8YfgVp3WdrKDWZMMQSa11S9QCCuw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (315.66s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:32:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:32:17 DEBUG : Config file has changed externally - reloading 2025/09/19 06:32:17 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:32:19 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:33:59 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:33:59 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for checks to finish 2025/09/19 06:33:59 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/19 06:33:59 DEBUG : two: Unchanged skipping 2025/09/19 06:34:00.157322 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ICa4SZ_yla6z8l_XG6QD_IZaq2YP9048TCFM0OsqIfAA-QyOeGMCHjhaBM6fn246AMAUfEZxBBxzwHULkTr2Ww==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:34:00.157372 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ICa4SZ_yla6z8l_XG6QD_IZaq2YP9048TCFM0OsqIfAA-QyOeGMCHjhaBM6fn246AMAUfEZxBBxzwHULkTr2Ww==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:34:00 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ICa4SZ_yla6z8l_XG6QD_IZaq2YP9048TCFM0OsqIfAA-QyOeGMCHjhaBM6fn246AMAUfEZxBBxzwHULkTr2Ww==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:34:00 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Waiting for transfers to finish 2025/09/19 06:34:00 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting files as there were IO errors 2025/09/19 06:34:00 ERROR : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ICa4SZ_yla6z8l_XG6QD_IZaq2YP9048TCFM0OsqIfAA-QyOeGMCHjhaBM6fn246AMAUfEZxBBxzwHULkTr2Ww==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (116.43s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:34:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:34:14 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:34:16 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:34:21.855834 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=16&PageSize=150&ShowAll=1": read tcp 65.108.87.141:49982->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 06:36:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:36:20.105031 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-SrUcsm71CJpfQEtAxYYI7rVfME70gbkEoBs806cn1IkAId0Dcmp90cORrucp-fQ2NhRglJ4NUROq-zKZnGbxA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:36:20.105094 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-SrUcsm71CJpfQEtAxYYI7rVfME70gbkEoBs806cn1IkAId0Dcmp90cORrucp-fQ2NhRglJ4NUROq-zKZnGbxA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:36:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-SrUcsm71CJpfQEtAxYYI7rVfME70gbkEoBs806cn1IkAId0Dcmp90cORrucp-fQ2NhRglJ4NUROq-zKZnGbxA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-SrUcsm71CJpfQEtAxYYI7rVfME70gbkEoBs806cn1IkAId0Dcmp90cORrucp-fQ2NhRglJ4NUROq-zKZnGbxA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (139.19s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-kelowiy5sizo'", Local "Local file system at /tmp/rclone3366031472", Modify Window "1s" 2025/09/19 06:36:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kelowiy5sizo/dst" 2025/09/19 06:36:32 DEBUG : Config file has changed externally - reloading 2025/09/19 06:36:32 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Has cached credentials 2025/09/19 06:36:34 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo/dst': Used cached credential to initialize the ProtonDrive API 2025/09/19 06:38:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/19 06:38:38.190650 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SqGynVBfqbmLHfWEStI-zBbd2ux2AuPCPRTJjX_QnyJtJ9Hl1cj-u13uqxlRERvVg6e8wC_Jq4-bd_rtVEmvBA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 06:38:38.190675 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SqGynVBfqbmLHfWEStI-zBbd2ux2AuPCPRTJjX_QnyJtJ9Hl1cj-u13uqxlRERvVg6e8wC_Jq4-bd_rtVEmvBA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 06:38:38 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SqGynVBfqbmLHfWEStI-zBbd2ux2AuPCPRTJjX_QnyJtJ9Hl1cj-u13uqxlRERvVg6e8wC_Jq4-bd_rtVEmvBA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SqGynVBfqbmLHfWEStI-zBbd2ux2AuPCPRTJjX_QnyJtJ9Hl1cj-u13uqxlRERvVg6e8wC_Jq4-bd_rtVEmvBA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (138.16s) FAIL 2025/09/19 06:38:42 DEBUG : proton drive root link ID 'rclone-test-kelowiy5sizo': 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 24m29.816379805s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]