"./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/09/22 04:58:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu" 2025/09/22 04:58:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/22 04:58:22 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Has cached credentials 2025/09/22 04:58:24 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Used cached credential to initialize the ProtonDrive API 2025/09/22 04:58:25 DEBUG : Creating backend with remote "/tmp/rclone3573883737" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 04:58:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tiwekuw6xosa" 2025/09/22 04:58:29 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Has cached credentials 2025/09/22 04:58:31 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-lohurux9vemu' -> proton drive root link ID 'rclone-test-tiwekuw6xosa' 2025/09/22 04:58:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/22 04:58:32 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Waiting for checks to finish 2025/09/22 04:58:32 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Waiting for transfers to finish 2025/09/22 04:58:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/22 04:58:37 INFO : sub dir/hello world: Copied (new) 2025/09/22 04:58:39.012891 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/22 04:58:39.012930 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/22 04:58:41 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Using server-side directory move 2025/09/22 04:58:41 INFO : proton drive root link ID 'rclone-test-tiwekuw6xosa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/22 04:58:42 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/22 04:58:42 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Waiting for checks to finish 2025/09/22 04:58:42 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Waiting for transfers to finish 2025/09/22 04:58:43 INFO : sub dir/hello world: Deleted 2025/09/22 04:58:44.413540 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AaZj6LdbdgiwWfzl1xSEgIHxFx909TsRr0hIgZN88db_YBjfSrclZ6e9oDWV7KJlWEpUncWX6fqtZy8uErPlBA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:58:44.413581 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AaZj6LdbdgiwWfzl1xSEgIHxFx909TsRr0hIgZN88db_YBjfSrclZ6e9oDWV7KJlWEpUncWX6fqtZy8uErPlBA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:58:44 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AaZj6LdbdgiwWfzl1xSEgIHxFx909TsRr0hIgZN88db_YBjfSrclZ6e9oDWV7KJlWEpUncWX6fqtZy8uErPlBA==/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/AaZj6LdbdgiwWfzl1xSEgIHxFx909TsRr0hIgZN88db_YBjfSrclZ6e9oDWV7KJlWEpUncWX6fqtZy8uErPlBA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/22 04:58:44 DEBUG : proton drive root link ID 'rclone-test-tiwekuw6xosa': Purge remote --- FAIL: TestServerSideMoveOverSelf (22.35s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/22 04:58:47 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:58:47 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:58:47 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:58:47 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/22 04:58:47 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/22 04:58:47 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:58:47 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:58:49 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/22 04:58:49 INFO : potato: Copied (new) 2025/09/22 04:58:49 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:58:49 INFO : yam: Copied (new) 2025/09/22 04:58:49 DEBUG : Waiting for deletions to finish 2025/09/22 04:58:50 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 04:58:50 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:58:50 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:58:50 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:58:50 DEBUG : potato: Unchanged skipping 2025/09/22 04:58:50 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:58:51.717249 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2v5mEVRRxaiHimHT9U_NBYjLyQaUY_BtDt8YYTg8A2N1f9PX9b_PdDVRWLi5-VQpIb0b6re9p6uNOQOoQ9h8Aw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:58:51.717285 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2v5mEVRRxaiHimHT9U_NBYjLyQaUY_BtDt8YYTg8A2N1f9PX9b_PdDVRWLi5-VQpIb0b6re9p6uNOQOoQ9h8Aw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:58:51 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2v5mEVRRxaiHimHT9U_NBYjLyQaUY_BtDt8YYTg8A2N1f9PX9b_PdDVRWLi5-VQpIb0b6re9p6uNOQOoQ9h8Aw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:58:51 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2v5mEVRRxaiHimHT9U_NBYjLyQaUY_BtDt8YYTg8A2N1f9PX9b_PdDVRWLi5-VQpIb0b6re9p6uNOQOoQ9h8Aw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:58:51 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/22 04:58:51 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:58:53 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:58:53 INFO : yaml: Copied (new) 2025/09/22 04:58:53 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': not deleting files as there were IO errors 2025/09/22 04:58:53 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': 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 (8.65s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/22 04:58:56 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:58:56 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:58:56 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:58:56 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/22 04:58:56 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:58:56 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/22 04:58:56 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:58:58 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/22 04:58:58 INFO : potato: Copied (new) 2025/09/22 04:58:58 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:58:58 INFO : yam: Copied (new) 2025/09/22 04:58:58 DEBUG : Waiting for deletions to finish 2025/09/22 04:58:59 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 04:58:59 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:58:59 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:58:59 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:58:59 DEBUG : potato: Unchanged skipping 2025/09/22 04:58:59 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:59:00.371192 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt6dSwdUa5zYx165_5AtotEDvV1ggvNprf7didlJ3_Ipirwpi8b96-ivvP2x4DbxFQ4rTHkDRdSVIOTJjOzv6A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:00.371230 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt6dSwdUa5zYx165_5AtotEDvV1ggvNprf7didlJ3_Ipirwpi8b96-ivvP2x4DbxFQ4rTHkDRdSVIOTJjOzv6A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:00 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt6dSwdUa5zYx165_5AtotEDvV1ggvNprf7didlJ3_Ipirwpi8b96-ivvP2x4DbxFQ4rTHkDRdSVIOTJjOzv6A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:00 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt6dSwdUa5zYx165_5AtotEDvV1ggvNprf7didlJ3_Ipirwpi8b96-ivvP2x4DbxFQ4rTHkDRdSVIOTJjOzv6A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:00 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/22 04:59:00 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:59:02 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:59:02 INFO : yaml: Copied (new) 2025/09/22 04:59:02 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': not deleting files as there were IO errors 2025/09/22 04:59:02 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': 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 (8.67s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/22 04:59:05 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:59:05 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:59:05 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:59:05 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/22 04:59:05 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:59:05 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/22 04:59:05 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:59:07 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/22 04:59:07 INFO : potato: Copied (new) 2025/09/22 04:59:07 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:59:07 INFO : sub/yam: Copied (new) 2025/09/22 04:59:07 DEBUG : Waiting for deletions to finish 2025/09/22 04:59:09 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 04:59:09 DEBUG : potato: Unchanged skipping 2025/09/22 04:59:09 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Making map for --track-renames 2025/09/22 04:59:09 INFO : proton drive root link ID 'rclone-test-lohurux9vemu': Finished making map for --track-renames 2025/09/22 04:59:09 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:59:09 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for renames to finish 2025/09/22 04:59:10.602071 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iWrkTNeCXo6eqqyoNZvL_LLZL_cquJXwd1qvRcDajCGhK5g5rmCMh6ZM52rz-k-8thb93f0IUyZ1rHNSSDgV2A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:10.602127 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iWrkTNeCXo6eqqyoNZvL_LLZL_cquJXwd1qvRcDajCGhK5g5rmCMh6ZM52rz-k-8thb93f0IUyZ1rHNSSDgV2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:10 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iWrkTNeCXo6eqqyoNZvL_LLZL_cquJXwd1qvRcDajCGhK5g5rmCMh6ZM52rz-k-8thb93f0IUyZ1rHNSSDgV2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:10 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iWrkTNeCXo6eqqyoNZvL_LLZL_cquJXwd1qvRcDajCGhK5g5rmCMh6ZM52rz-k-8thb93f0IUyZ1rHNSSDgV2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:10 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/22 04:59:10 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:59:12 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/22 04:59:12 INFO : yam: Copied (new) 2025/09/22 04:59:12 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': not deleting files as there were IO errors 2025/09/22 04:59:12 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': 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 (11.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 04:59:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/22 04:59:16 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/22 04:59:16 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for checks to finish 2025/09/22 04:59:16 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': Waiting for transfers to finish 2025/09/22 04:59:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/22 04:59:20 INFO : sub dir/hello world: Copied (new) 2025/09/22 04:59:20 INFO : sub dir/hello world: Deleted 2025/09/22 04:59:20 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/22 04:59:20 INFO : nested/sub dir/file: Copied (new) 2025/09/22 04:59:20 INFO : nested/sub dir/file: Deleted 2025/09/22 04:59:20 ERROR : Local file system at /tmp/rclone3573883737: 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 (9.01s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 04:59:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cilepuj9luru" 2025/09/22 04:59:24 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Has cached credentials 2025/09/22 04:59:26 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-lohurux9vemu' -> proton drive root link ID 'rclone-test-cilepuj9luru' 2025/09/22 04:59:37 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Using server-side directory move 2025/09/22 04:59:37 INFO : proton drive root link ID 'rclone-test-cilepuj9luru': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/22 04:59:38 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/22 04:59:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/22 04:59:38 DEBUG : empty space: Unchanged skipping 2025/09/22 04:59:38 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Waiting for checks to finish 2025/09/22 04:59:38 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/22 04:59:39 INFO : empty space: Deleted 2025/09/22 04:59:39 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Waiting for transfers to finish 2025/09/22 04:59:39 INFO : potato3: Deleted 2025/09/22 04:59:39.594381 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XYWua0IrLAr7i3rPpwc7rF5batJIgamrHl-WMt9yKn4sw8xLWq2kzSnf-B7oCJyKXjPs1x_rSD81GF-kXZGZVg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:39.594418 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XYWua0IrLAr7i3rPpwc7rF5batJIgamrHl-WMt9yKn4sw8xLWq2kzSnf-B7oCJyKXjPs1x_rSD81GF-kXZGZVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:39 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XYWua0IrLAr7i3rPpwc7rF5batJIgamrHl-WMt9yKn4sw8xLWq2kzSnf-B7oCJyKXjPs1x_rSD81GF-kXZGZVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:39.821066 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sIThEMInqXpOxVEEElh1uj7SarTc1zgkEDJMtQC1a3d2Ix3GImbEOkKQ-uDrlD4n7FGRRCOnUOVG0ZujQDdmKA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:39.821102 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sIThEMInqXpOxVEEElh1uj7SarTc1zgkEDJMtQC1a3d2Ix3GImbEOkKQ-uDrlD4n7FGRRCOnUOVG0ZujQDdmKA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:39 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sIThEMInqXpOxVEEElh1uj7SarTc1zgkEDJMtQC1a3d2Ix3GImbEOkKQ-uDrlD4n7FGRRCOnUOVG0ZujQDdmKA==/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/sIThEMInqXpOxVEEElh1uj7SarTc1zgkEDJMtQC1a3d2Ix3GImbEOkKQ-uDrlD4n7FGRRCOnUOVG0ZujQDdmKA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/22 04:59:39 DEBUG : proton drive root link ID 'rclone-test-cilepuj9luru': Purge remote --- FAIL: TestServerSideMove (17.92s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 04:59:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qazojar2hibu" 2025/09/22 04:59:42 DEBUG : proton drive root link ID 'rclone-test-qazojar2hibu': Has cached credentials 2025/09/22 04:59:44 DEBUG : proton drive root link ID 'rclone-test-qazojar2hibu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-lohurux9vemu' -> proton drive root link ID 'rclone-test-qazojar2hibu' 2025/09/22 04:59:56 DEBUG : empty space: Excluded (Size Filter) 2025/09/22 04:59:56 DEBUG : empty space: Excluded 2025/09/22 04:59:56 DEBUG : empty space: Excluded (Size Filter) 2025/09/22 04:59:56 DEBUG : empty space: Excluded 2025/09/22 04:59:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/22 04:59:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/22 04:59:56 DEBUG : proton drive root link ID 'rclone-test-qazojar2hibu': Waiting for checks to finish 2025/09/22 04:59:56 DEBUG : proton drive root link ID 'rclone-test-qazojar2hibu': Waiting for transfers to finish 2025/09/22 04:59:57 INFO : potato3: Deleted 2025/09/22 04:59:57.489617 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nDwP53ijMrWqYpRLD59tJKVBux0oVvJzbLwzVFz-7mk2J59NwV29ghI0DTDfM9wfxaXjdTJGfWbjJDzPyWr6FQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:57.489652 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nDwP53ijMrWqYpRLD59tJKVBux0oVvJzbLwzVFz-7mk2J59NwV29ghI0DTDfM9wfxaXjdTJGfWbjJDzPyWr6FQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nDwP53ijMrWqYpRLD59tJKVBux0oVvJzbLwzVFz-7mk2J59NwV29ghI0DTDfM9wfxaXjdTJGfWbjJDzPyWr6FQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:57.826764 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_v4efY4REETIlIL2CtU6qxzO8IiFQROIwHveGC_2NL4QBouxn-bGtkqDKaNZUq6S30GdMppo_MiPs5Xx6kIag==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 04:59:57.826818 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_v4efY4REETIlIL2CtU6qxzO8IiFQROIwHveGC_2NL4QBouxn-bGtkqDKaNZUq6S30GdMppo_MiPs5Xx6kIag==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 04:59:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_v4efY4REETIlIL2CtU6qxzO8IiFQROIwHveGC_2NL4QBouxn-bGtkqDKaNZUq6S30GdMppo_MiPs5Xx6kIag==/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/R_v4efY4REETIlIL2CtU6qxzO8IiFQROIwHveGC_2NL4QBouxn-bGtkqDKaNZUq6S30GdMppo_MiPs5Xx6kIag==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/22 04:59:57 DEBUG : proton drive root link ID 'rclone-test-qazojar2hibu': Purge remote --- FAIL: TestServerSideMoveWithFilter (18.55s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:00:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yugugid1duhe" 2025/09/22 05:00:01 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Has cached credentials 2025/09/22 05:00:02 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:00:08 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-lohurux9vemu' -> proton drive root link ID 'rclone-test-yugugid1duhe' 2025/09/22 05:00:15 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Using server-side directory move 2025/09/22 05:00:15 INFO : proton drive root link ID 'rclone-test-yugugid1duhe': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/22 05:00:16 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/22 05:00:16 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/22 05:00:16 DEBUG : empty space: Unchanged skipping 2025/09/22 05:00:16 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/22 05:00:16 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Waiting for checks to finish 2025/09/22 05:00:16 INFO : potato3: Deleted 2025/09/22 05:00:16 INFO : empty space: Deleted 2025/09/22 05:00:16 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Waiting for transfers to finish 2025/09/22 05:00:17.111571 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Df6Ip30WV9AY-mtppDN9AnEfSn6Pg_miS3E2alzGk3JVSHdt3Qoq12orisSgr6siDb95T74eJD6qUvWGSuEgg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:00:17.111591 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Df6Ip30WV9AY-mtppDN9AnEfSn6Pg_miS3E2alzGk3JVSHdt3Qoq12orisSgr6siDb95T74eJD6qUvWGSuEgg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:00:17 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Df6Ip30WV9AY-mtppDN9AnEfSn6Pg_miS3E2alzGk3JVSHdt3Qoq12orisSgr6siDb95T74eJD6qUvWGSuEgg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:00:17.481023 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/K_WPQxN3sHkLHlUl2anDVYZPTm92jEWOrpUJu_QErTUK0qfrRXiSj0sy7hTPW0oaLHvUYfGrRrBLS_sLBz2oIA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:00:17.481062 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/K_WPQxN3sHkLHlUl2anDVYZPTm92jEWOrpUJu_QErTUK0qfrRXiSj0sy7hTPW0oaLHvUYfGrRrBLS_sLBz2oIA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:00:17 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/K_WPQxN3sHkLHlUl2anDVYZPTm92jEWOrpUJu_QErTUK0qfrRXiSj0sy7hTPW0oaLHvUYfGrRrBLS_sLBz2oIA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:00:17 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu': 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/22 05:00:17 DEBUG : proton drive root link ID 'rclone-test-yugugid1duhe': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.78s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:00:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:00:27 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:00:29 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:02:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/backup" 2025/09/22 05:02:35 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Has cached credentials 2025/09/22 05:02:37 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:06:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:06:48 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 05:06:48 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for checks to finish 2025/09/22 05:06:48 DEBUG : two: Unchanged skipping 2025/09/22 05:06:50.416420 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/okcupYEkBInIp-H4b9bZbwaa0EpMP8Ad1E5cfO0yiXQ48DdBkt8LvP5rJgN56VhFMzEojhUtwsBaM8wGBUh1yQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:06:50.416458 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/okcupYEkBInIp-H4b9bZbwaa0EpMP8Ad1E5cfO0yiXQ48DdBkt8LvP5rJgN56VhFMzEojhUtwsBaM8wGBUh1yQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:06:50 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/okcupYEkBInIp-H4b9bZbwaa0EpMP8Ad1E5cfO0yiXQ48DdBkt8LvP5rJgN56VhFMzEojhUtwsBaM8wGBUh1yQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:06:50 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for transfers to finish 2025/09/22 05:06:50 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/dst': not deleting files as there were IO errors 2025/09/22 05:06:50 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/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/okcupYEkBInIp-H4b9bZbwaa0EpMP8Ad1E5cfO0yiXQ48DdBkt8LvP5rJgN56VhFMzEojhUtwsBaM8wGBUh1yQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (393.73s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:07:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:07:02 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:07:03 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:09:09 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/backup" 2025/09/22 05:09:09 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Has cached credentials 2025/09/22 05:09:10 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:13:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:13:21 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for checks to finish 2025/09/22 05:13:21 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 05:13:21 DEBUG : two: Unchanged skipping 2025/09/22 05:13:23.092061 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4gB0-dOq7ukususY1WbdoZkxZOv3XtAOvBMn84uGxlaze9TaIT_s2cIAwfCYMBp8TRmAEGkoXjwfp8mE-FUXeA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:13:23.092105 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4gB0-dOq7ukususY1WbdoZkxZOv3XtAOvBMn84uGxlaze9TaIT_s2cIAwfCYMBp8TRmAEGkoXjwfp8mE-FUXeA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:13:23 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4gB0-dOq7ukususY1WbdoZkxZOv3XtAOvBMn84uGxlaze9TaIT_s2cIAwfCYMBp8TRmAEGkoXjwfp8mE-FUXeA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:13:23 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for transfers to finish 2025/09/22 05:13:23 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/dst': not deleting files as there were IO errors 2025/09/22 05:13:23 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/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/4gB0-dOq7ukususY1WbdoZkxZOv3XtAOvBMn84uGxlaze9TaIT_s2cIAwfCYMBp8TRmAEGkoXjwfp8mE-FUXeA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (392.63s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:13:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:13:34 DEBUG : Config file has changed externally - reloading 2025/09/22 05:13:34 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:13:36 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:15:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/backup" 2025/09/22 05:15:41 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Has cached credentials 2025/09/22 05:15:42 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/backup': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:19:54 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for checks to finish 2025/09/22 05:19:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:19:54 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 05:19:54 DEBUG : two: Unchanged skipping 2025/09/22 05:19:56.882956 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1HlePVHfFinSuuM3r93xXiCYL8WEMJXEcKO-4T_P_FW5ZPC0NjaB1x5fsgLstH_hhCr8odTkWCsDDimyJhG8pw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:19:56.883001 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1HlePVHfFinSuuM3r93xXiCYL8WEMJXEcKO-4T_P_FW5ZPC0NjaB1x5fsgLstH_hhCr8odTkWCsDDimyJhG8pw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:19:56 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1HlePVHfFinSuuM3r93xXiCYL8WEMJXEcKO-4T_P_FW5ZPC0NjaB1x5fsgLstH_hhCr8odTkWCsDDimyJhG8pw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:19:56 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for transfers to finish 2025/09/22 05:19:56 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/dst': not deleting files as there were IO errors 2025/09/22 05:19:56 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/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/1HlePVHfFinSuuM3r93xXiCYL8WEMJXEcKO-4T_P_FW5ZPC0NjaB1x5fsgLstH_hhCr8odTkWCsDDimyJhG8pw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (393.69s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:20:08 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:20:08 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:20:10 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:22:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:22:21 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/22 05:22:21 DEBUG : two: Unchanged skipping 2025/09/22 05:22:21 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for checks to finish 2025/09/22 05:22:22.252275 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/luj6GRAt85bKatcBOktp0md90p8-c9Nl1RCn-YRRJOcRcfvguBPgHCmg-ocGB-c3RCfbCZlW32T7-BLEh75PQQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:22:22.252311 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/luj6GRAt85bKatcBOktp0md90p8-c9Nl1RCn-YRRJOcRcfvguBPgHCmg-ocGB-c3RCfbCZlW32T7-BLEh75PQQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:22:22 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/luj6GRAt85bKatcBOktp0md90p8-c9Nl1RCn-YRRJOcRcfvguBPgHCmg-ocGB-c3RCfbCZlW32T7-BLEh75PQQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:22:22 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Waiting for transfers to finish 2025/09/22 05:22:22 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/dst': not deleting files as there were IO errors 2025/09/22 05:22:22 ERROR : proton drive root link ID 'rclone-test-lohurux9vemu/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/luj6GRAt85bKatcBOktp0md90p8-c9Nl1RCn-YRRJOcRcfvguBPgHCmg-ocGB-c3RCfbCZlW32T7-BLEh75PQQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (144.83s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:22:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:22:33 DEBUG : Config file has changed externally - reloading 2025/09/22 05:22:33 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:22:34 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:24:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:24:51.299769 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TH3j5Mt9jCLUZcjmtn0HB9jUFlho58O9oeMb_9B50hBGROfI4eel3zuY5VTHX0i0DhoBRCol0ZwCg2KtQtn0-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:24:51.299799 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TH3j5Mt9jCLUZcjmtn0HB9jUFlho58O9oeMb_9B50hBGROfI4eel3zuY5VTHX0i0DhoBRCol0ZwCg2KtQtn0-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:24:51 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TH3j5Mt9jCLUZcjmtn0HB9jUFlho58O9oeMb_9B50hBGROfI4eel3zuY5VTHX0i0DhoBRCol0ZwCg2KtQtn0-w==/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/TH3j5Mt9jCLUZcjmtn0HB9jUFlho58O9oeMb_9B50hBGROfI4eel3zuY5VTHX0i0DhoBRCol0ZwCg2KtQtn0-w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (148.98s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-lohurux9vemu'", Local "Local file system at /tmp/rclone3573883737", Modify Window "1s" 2025/09/22 05:25:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lohurux9vemu/dst" 2025/09/22 05:25:02 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Has cached credentials 2025/09/22 05:25:03 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu/dst': Used cached credential to initialize the ProtonDrive API 2025/09/22 05:27:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/22 05:27:17.941643 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3ibZKjsPQQyD9eUXp1JB-B8CZjnXBqAwnLYz7Bi3vwWyC3ex3CbqCmHVz2UdDp2gPxgQe6oSHjsnZ3hXZGyh9w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/22 05:27:17.941754 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3ibZKjsPQQyD9eUXp1JB-B8CZjnXBqAwnLYz7Bi3vwWyC3ex3CbqCmHVz2UdDp2gPxgQe6oSHjsnZ3hXZGyh9w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/22 05:27:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3ibZKjsPQQyD9eUXp1JB-B8CZjnXBqAwnLYz7Bi3vwWyC3ex3CbqCmHVz2UdDp2gPxgQe6oSHjsnZ3hXZGyh9w==/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/3ibZKjsPQQyD9eUXp1JB-B8CZjnXBqAwnLYz7Bi3vwWyC3ex3CbqCmHVz2UdDp2gPxgQe6oSHjsnZ3hXZGyh9w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (146.61s) FAIL 2025/09/22 05:27:21 DEBUG : proton drive root link ID 'rclone-test-lohurux9vemu': 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 28m59.635154825s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]