"./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 3/5) 2025/04/30 04:37:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo" 2025/04/30 04:37:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/30 04:37:07 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Has cached credentials 2025/04/30 04:37:09 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:37:09 DEBUG : Creating backend with remote "/tmp/rclone2982221836" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-jafuyeg0havu" 2025/04/30 04:37:14 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Has cached credentials 2025/04/30 04:37:15 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-hiqopox6qafo' -> proton drive root link ID 'rclone-test-jafuyeg0havu' 2025/04/30 04:37:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/30 04:37:16 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Waiting for checks to finish 2025/04/30 04:37:16 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Waiting for transfers to finish 2025/04/30 04:37:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/30 04:37:20 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:22.590376 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/04/30 04:37:22.590410 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/04/30 04:37:25 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Using server-side directory move 2025/04/30 04:37:25 INFO : proton drive root link ID 'rclone-test-jafuyeg0havu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/30 04:37:26 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/30 04:37:26 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Waiting for checks to finish 2025/04/30 04:37:26 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Waiting for transfers to finish 2025/04/30 04:37:26 INFO : sub dir/hello world: Deleted 2025/04/30 04:37:27.408089 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AYQWdNSz5ELWgeZIIBw1bdmNjKTpVMM62nFu3IGcidGZ4vrBYoxIe3MOntkEUjhC1OWNu84lVTVQ4fJk0z_DaQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:37:27.408127 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AYQWdNSz5ELWgeZIIBw1bdmNjKTpVMM62nFu3IGcidGZ4vrBYoxIe3MOntkEUjhC1OWNu84lVTVQ4fJk0z_DaQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:27 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AYQWdNSz5ELWgeZIIBw1bdmNjKTpVMM62nFu3IGcidGZ4vrBYoxIe3MOntkEUjhC1OWNu84lVTVQ4fJk0z_DaQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AYQWdNSz5ELWgeZIIBw1bdmNjKTpVMM62nFu3IGcidGZ4vrBYoxIe3MOntkEUjhC1OWNu84lVTVQ4fJk0z_DaQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/04/30 04:37:27 DEBUG : proton drive root link ID 'rclone-test-jafuyeg0havu': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.19s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/04/30 04:37:31 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:31 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:31 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:31 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/30 04:37:31 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/30 04:37:31 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:31 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:32 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/30 04:37:32 INFO : potato: Copied (new) 2025/04/30 04:37:32 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:32 INFO : yam: Copied (new) 2025/04/30 04:37:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:34 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:37:34 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:34 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:34 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:34 DEBUG : potato: Unchanged skipping 2025/04/30 04:37:34 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:34.762162 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VzCEeFeK-C868jhqxIvmH55GepdzOxul1LKSdQi-PpDM7tXDFiSFbJhSsfLcxrr-NqS3_2k62UoWTmHwPCVbTQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:37:34.762203 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VzCEeFeK-C868jhqxIvmH55GepdzOxul1LKSdQi-PpDM7tXDFiSFbJhSsfLcxrr-NqS3_2k62UoWTmHwPCVbTQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:34 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VzCEeFeK-C868jhqxIvmH55GepdzOxul1LKSdQi-PpDM7tXDFiSFbJhSsfLcxrr-NqS3_2k62UoWTmHwPCVbTQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:34 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VzCEeFeK-C868jhqxIvmH55GepdzOxul1LKSdQi-PpDM7tXDFiSFbJhSsfLcxrr-NqS3_2k62UoWTmHwPCVbTQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:34 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/04/30 04:37:34 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:36 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:36 INFO : yaml: Copied (new) 2025/04/30 04:37:36 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting files as there were IO errors 2025/04/30 04:37:36 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.43s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/04/30 04:37:39 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:39 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:39 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:39 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/30 04:37:39 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/30 04:37:39 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:39 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:41 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/30 04:37:41 INFO : potato: Copied (new) 2025/04/30 04:37:41 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:41 INFO : yam: Copied (new) 2025/04/30 04:37:41 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:42 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:37:42 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:42 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:42 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:42 DEBUG : potato: Unchanged skipping 2025/04/30 04:37:42 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:43.321023 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DbzUvCHMlXO3IF6_wL2HXesGHEnVdmqoYeCVBM-T_X2v_DyOcwHJuovOB3GXQeFPTDIIqZj8WP365XK2Ts3igg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:37:43.321042 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DbzUvCHMlXO3IF6_wL2HXesGHEnVdmqoYeCVBM-T_X2v_DyOcwHJuovOB3GXQeFPTDIIqZj8WP365XK2Ts3igg==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:43 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DbzUvCHMlXO3IF6_wL2HXesGHEnVdmqoYeCVBM-T_X2v_DyOcwHJuovOB3GXQeFPTDIIqZj8WP365XK2Ts3igg==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:43 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DbzUvCHMlXO3IF6_wL2HXesGHEnVdmqoYeCVBM-T_X2v_DyOcwHJuovOB3GXQeFPTDIIqZj8WP365XK2Ts3igg==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:43 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/04/30 04:37:43 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:44 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:44 INFO : yaml: Copied (new) 2025/04/30 04:37:44 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting files as there were IO errors 2025/04/30 04:37:44 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (8.41s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/04/30 04:37:48 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:48 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:48 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:48 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/30 04:37:48 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/04/30 04:37:48 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:48 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:50 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/30 04:37:50 INFO : potato: Copied (new) 2025/04/30 04:37:51 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:51 INFO : sub/yam: Copied (new) 2025/04/30 04:37:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:52 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:37:52 DEBUG : potato: Unchanged skipping 2025/04/30 04:37:52 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Making map for --track-renames 2025/04/30 04:37:52 INFO : proton drive root link ID 'rclone-test-hiqopox6qafo': Finished making map for --track-renames 2025/04/30 04:37:52 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:52 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for renames to finish 2025/04/30 04:37:53.673059 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vbVeMBYdD1MEeCXCbfoxPzR1XWkk2JCiQENVGhCQTJQKoXVC7vQeiTShyrrJOMSmq9QayyaSWW-MzzT48MgLIw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:37:53.673078 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vbVeMBYdD1MEeCXCbfoxPzR1XWkk2JCiQENVGhCQTJQKoXVC7vQeiTShyrrJOMSmq9QayyaSWW-MzzT48MgLIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:53 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vbVeMBYdD1MEeCXCbfoxPzR1XWkk2JCiQENVGhCQTJQKoXVC7vQeiTShyrrJOMSmq9QayyaSWW-MzzT48MgLIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:53 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vbVeMBYdD1MEeCXCbfoxPzR1XWkk2JCiQENVGhCQTJQKoXVC7vQeiTShyrrJOMSmq9QayyaSWW-MzzT48MgLIw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:37:53 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/30 04:37:53 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:37:55 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/30 04:37:55 INFO : yam: Copied (new) 2025/04/30 04:37:55 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting files as there were IO errors 2025/04/30 04:37:55 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (11.14s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:37:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/30 04:37:59 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/30 04:37:59 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for checks to finish 2025/04/30 04:37:59 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': Waiting for transfers to finish 2025/04/30 04:38:03 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/30 04:38:03 INFO : sub dir/hello world: Copied (new) 2025/04/30 04:38:03 INFO : sub dir/hello world: Deleted 2025/04/30 04:38:03 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/04/30 04:38:03 INFO : nested/sub dir/file: Copied (new) 2025/04/30 04:38:03 INFO : nested/sub dir/file: Deleted 2025/04/30 04:38:03 ERROR : Local file system at /tmp/rclone2982221836: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (8.05s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:38:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-roxabar1kuvo" 2025/04/30 04:38:06 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Has cached credentials 2025/04/30 04:38:08 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-hiqopox6qafo' -> proton drive root link ID 'rclone-test-roxabar1kuvo' 2025/04/30 04:38:19 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Using server-side directory move 2025/04/30 04:38:19 INFO : proton drive root link ID 'rclone-test-roxabar1kuvo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/30 04:38:20 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/30 04:38:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/30 04:38:20 DEBUG : empty space: Unchanged skipping 2025/04/30 04:38:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/30 04:38:20 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Waiting for checks to finish 2025/04/30 04:38:20 INFO : empty space: Deleted 2025/04/30 04:38:20 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Waiting for transfers to finish 2025/04/30 04:38:20 INFO : potato3: Deleted 2025/04/30 04:38:21.231871 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gv_ksYj314WZYkqZJ3ygpDwnQ3Dfp9el6av5DqeiyqvdJpZntS634t6rCW3PH9mkzDIZ68YMSSnGSHuFnh9uAQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:21.231891 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gv_ksYj314WZYkqZJ3ygpDwnQ3Dfp9el6av5DqeiyqvdJpZntS634t6rCW3PH9mkzDIZ68YMSSnGSHuFnh9uAQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:21 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gv_ksYj314WZYkqZJ3ygpDwnQ3Dfp9el6av5DqeiyqvdJpZntS634t6rCW3PH9mkzDIZ68YMSSnGSHuFnh9uAQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:21.538953 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TCaZLLLMUJWSIW4hGqCzc4Osj4xCGpF1JePjuUjWdz16wme0u8CC_DwjZS2bIgxXGUBL-1UcfJTGqf2vQDeg7g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:21.538977 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TCaZLLLMUJWSIW4hGqCzc4Osj4xCGpF1JePjuUjWdz16wme0u8CC_DwjZS2bIgxXGUBL-1UcfJTGqf2vQDeg7g==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:21 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TCaZLLLMUJWSIW4hGqCzc4Osj4xCGpF1JePjuUjWdz16wme0u8CC_DwjZS2bIgxXGUBL-1UcfJTGqf2vQDeg7g==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TCaZLLLMUJWSIW4hGqCzc4Osj4xCGpF1JePjuUjWdz16wme0u8CC_DwjZS2bIgxXGUBL-1UcfJTGqf2vQDeg7g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/04/30 04:38:21 DEBUG : proton drive root link ID 'rclone-test-roxabar1kuvo': Purge remote --- FAIL: TestServerSideMove (17.09s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:38:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-botoxij4qebi" 2025/04/30 04:38:24 DEBUG : proton drive root link ID 'rclone-test-botoxij4qebi': Has cached credentials 2025/04/30 04:38:25 DEBUG : proton drive root link ID 'rclone-test-botoxij4qebi': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-hiqopox6qafo' -> proton drive root link ID 'rclone-test-botoxij4qebi' 2025/04/30 04:38:36 DEBUG : empty space: Excluded (Size Filter) 2025/04/30 04:38:36 DEBUG : empty space: Excluded 2025/04/30 04:38:36 DEBUG : empty space: Excluded (Size Filter) 2025/04/30 04:38:36 DEBUG : empty space: Excluded 2025/04/30 04:38:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/30 04:38:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/30 04:38:36 DEBUG : proton drive root link ID 'rclone-test-botoxij4qebi': Waiting for checks to finish 2025/04/30 04:38:36 DEBUG : proton drive root link ID 'rclone-test-botoxij4qebi': Waiting for transfers to finish 2025/04/30 04:38:36 INFO : potato3: Deleted 2025/04/30 04:38:37.116043 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zkkZuMj4vy8ToUkQdSiwvx7pl9GEDTE_LkGc_zkdGHiDtrUDOa4BA4WGLQzhdzz4OtcZ1z0rAu9FcuKO68DGJw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:37.116078 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zkkZuMj4vy8ToUkQdSiwvx7pl9GEDTE_LkGc_zkdGHiDtrUDOa4BA4WGLQzhdzz4OtcZ1z0rAu9FcuKO68DGJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:37 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zkkZuMj4vy8ToUkQdSiwvx7pl9GEDTE_LkGc_zkdGHiDtrUDOa4BA4WGLQzhdzz4OtcZ1z0rAu9FcuKO68DGJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:37.440242 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l8hQM5-J6Hssb6yYQ5iQ7muTXTu8jk9TPbJTkfpn8kbD4vuZWWuMDsBhQVHbCrxU9FNW8jzkHY-utBP_hMBWOA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:37.440262 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l8hQM5-J6Hssb6yYQ5iQ7muTXTu8jk9TPbJTkfpn8kbD4vuZWWuMDsBhQVHbCrxU9FNW8jzkHY-utBP_hMBWOA==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:37 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l8hQM5-J6Hssb6yYQ5iQ7muTXTu8jk9TPbJTkfpn8kbD4vuZWWuMDsBhQVHbCrxU9FNW8jzkHY-utBP_hMBWOA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l8hQM5-J6Hssb6yYQ5iQ7muTXTu8jk9TPbJTkfpn8kbD4vuZWWuMDsBhQVHbCrxU9FNW8jzkHY-utBP_hMBWOA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/04/30 04:38:37 DEBUG : proton drive root link ID 'rclone-test-botoxij4qebi': Purge remote --- FAIL: TestServerSideMoveWithFilter (16.28s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:38:40 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qovivag1zuli" 2025/04/30 04:38:40 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Has cached credentials 2025/04/30 04:38:41 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:38:47 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-hiqopox6qafo' -> proton drive root link ID 'rclone-test-qovivag1zuli' 2025/04/30 04:38:53 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Using server-side directory move 2025/04/30 04:38:53 INFO : proton drive root link ID 'rclone-test-qovivag1zuli': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/30 04:38:54 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/30 04:38:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/30 04:38:54 DEBUG : empty space: Unchanged skipping 2025/04/30 04:38:54 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/30 04:38:54 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Waiting for checks to finish 2025/04/30 04:38:55 INFO : potato3: Deleted 2025/04/30 04:38:55 INFO : empty space: Deleted 2025/04/30 04:38:55 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Waiting for transfers to finish 2025/04/30 04:38:55.282301 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xw1OQcwMqh7sUjqS6x69BSKD7PDRgfY18CVhX49dRy-Lb0kXEenpMvphJUp2KHJJN0igQH7G8PDsP9ejyRq5sw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:55.282329 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xw1OQcwMqh7sUjqS6x69BSKD7PDRgfY18CVhX49dRy-Lb0kXEenpMvphJUp2KHJJN0igQH7G8PDsP9ejyRq5sw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:55 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xw1OQcwMqh7sUjqS6x69BSKD7PDRgfY18CVhX49dRy-Lb0kXEenpMvphJUp2KHJJN0igQH7G8PDsP9ejyRq5sw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:55.611091 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6nDcsVXGGtbp3JmB8wfQiO0PWFAgQAyyZv0KLeMIcPnrDMiZ-LwxesUi5XZn8vTCY1a6fNfFAaIxaR3zNxR26Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:38:55.611121 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6nDcsVXGGtbp3JmB8wfQiO0PWFAgQAyyZv0KLeMIcPnrDMiZ-LwxesUi5XZn8vTCY1a6fNfFAaIxaR3zNxR26Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:55 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6nDcsVXGGtbp3JmB8wfQiO0PWFAgQAyyZv0KLeMIcPnrDMiZ-LwxesUi5XZn8vTCY1a6fNfFAaIxaR3zNxR26Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:38:55 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/04/30 04:38:55 DEBUG : proton drive root link ID 'rclone-test-qovivag1zuli': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (18.32s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:39:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:39:04 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:39:06 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:40:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/backup" 2025/04/30 04:40:06 DEBUG : Config file has changed externally - reloading 2025/04/30 04:40:06 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Has cached credentials 2025/04/30 04:40:07 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:42:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:42:07 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:42:07 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for checks to finish 2025/04/30 04:42:07 DEBUG : two: Unchanged skipping 2025/04/30 04:42:09.154692 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PmtGF6Y2yo97mIxSOJCL98B4zH25uy84L2xGdCF59UPZzQNskq2qRaw57tXc-jI8wimpIfEls4Riw1NlUo3C_Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:42:09.154721 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PmtGF6Y2yo97mIxSOJCL98B4zH25uy84L2xGdCF59UPZzQNskq2qRaw57tXc-jI8wimpIfEls4Riw1NlUo3C_Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:42:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PmtGF6Y2yo97mIxSOJCL98B4zH25uy84L2xGdCF59UPZzQNskq2qRaw57tXc-jI8wimpIfEls4Riw1NlUo3C_Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:42:09 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for transfers to finish 2025/04/30 04:42:09 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting files as there were IO errors 2025/04/30 04:42:09 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PmtGF6Y2yo97mIxSOJCL98B4zH25uy84L2xGdCF59UPZzQNskq2qRaw57tXc-jI8wimpIfEls4Riw1NlUo3C_Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (194.04s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:42:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:42:19 DEBUG : Config file has changed externally - reloading 2025/04/30 04:42:19 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:42:20 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:43:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/backup" 2025/04/30 04:43:21 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Has cached credentials 2025/04/30 04:43:22 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:45:22 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:45:22 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:45:22 DEBUG : two: Unchanged skipping 2025/04/30 04:45:22 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for checks to finish 2025/04/30 04:45:23.753829 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RznwIdZSut4SpOJLwOBeEsXgY5_Szuim_7e_Rf0__xUiBay7PDGSGJhav7KdEFbz-7BNo0GhJqjaRB6pbFkR2A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:45:23.753856 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RznwIdZSut4SpOJLwOBeEsXgY5_Szuim_7e_Rf0__xUiBay7PDGSGJhav7KdEFbz-7BNo0GhJqjaRB6pbFkR2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:45:23 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RznwIdZSut4SpOJLwOBeEsXgY5_Szuim_7e_Rf0__xUiBay7PDGSGJhav7KdEFbz-7BNo0GhJqjaRB6pbFkR2A==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:45:23 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for transfers to finish 2025/04/30 04:45:23 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting files as there were IO errors 2025/04/30 04:45:23 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RznwIdZSut4SpOJLwOBeEsXgY5_Szuim_7e_Rf0__xUiBay7PDGSGJhav7KdEFbz-7BNo0GhJqjaRB6pbFkR2A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (194.80s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:45:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:45:34 DEBUG : Config file has changed externally - reloading 2025/04/30 04:45:34 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:45:35 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:46:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/backup" 2025/04/30 04:46:35 DEBUG : Config file has changed externally - reloading 2025/04/30 04:46:35 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Has cached credentials 2025/04/30 04:46:36 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/backup': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:48:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:48:37 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:48:37 DEBUG : two: Unchanged skipping 2025/04/30 04:48:37 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for checks to finish 2025/04/30 04:48:39.341279 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iIbtruO32Yw8w2lk9slC4GmZi2gHhNrG3Vm3hhzf9t_tkxgPjuqKTurFB14m7ChOsrQNh6IEZZi-pk5x8PS4Uw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:48:39.341310 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iIbtruO32Yw8w2lk9slC4GmZi2gHhNrG3Vm3hhzf9t_tkxgPjuqKTurFB14m7ChOsrQNh6IEZZi-pk5x8PS4Uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:48:39 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iIbtruO32Yw8w2lk9slC4GmZi2gHhNrG3Vm3hhzf9t_tkxgPjuqKTurFB14m7ChOsrQNh6IEZZi-pk5x8PS4Uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:48:39 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for transfers to finish 2025/04/30 04:48:39 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting files as there were IO errors 2025/04/30 04:48:39 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iIbtruO32Yw8w2lk9slC4GmZi2gHhNrG3Vm3hhzf9t_tkxgPjuqKTurFB14m7ChOsrQNh6IEZZi-pk5x8PS4Uw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (195.48s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:48:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:48:50 DEBUG : Config file has changed externally - reloading 2025/04/30 04:48:50 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:48:51 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:49:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:49:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/30 04:49:53 DEBUG : two: Unchanged skipping 2025/04/30 04:49:53 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for checks to finish 2025/04/30 04:49:54.393400 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_umJvHkgsyiJJpMcq2byoyzIPj2fQJ3Y9Jk2ePrPGNg2aAPvp1WJnolpUIRpO8uw8Sr9GpF8MUegzSbCFOLvmA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:49:54.393452 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_umJvHkgsyiJJpMcq2byoyzIPj2fQJ3Y9Jk2ePrPGNg2aAPvp1WJnolpUIRpO8uw8Sr9GpF8MUegzSbCFOLvmA==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:49:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_umJvHkgsyiJJpMcq2byoyzIPj2fQJ3Y9Jk2ePrPGNg2aAPvp1WJnolpUIRpO8uw8Sr9GpF8MUegzSbCFOLvmA==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:49:54 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Waiting for transfers to finish 2025/04/30 04:49:54 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting files as there were IO errors 2025/04/30 04:49:54 ERROR : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_umJvHkgsyiJJpMcq2byoyzIPj2fQJ3Y9Jk2ePrPGNg2aAPvp1WJnolpUIRpO8uw8Sr9GpF8MUegzSbCFOLvmA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (74.50s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:50:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:50:04 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:50:05 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:51:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:51:09.084034 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uQdAo6eSrnwCOM1aMhsp2caMam5cjpvw-UI7KEhAAwvmSq5rAwmQ_vxGwRhQd-u56APrLLrGE8f_WfSKVrFoRA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:51:09.084075 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uQdAo6eSrnwCOM1aMhsp2caMam5cjpvw-UI7KEhAAwvmSq5rAwmQ_vxGwRhQd-u56APrLLrGE8f_WfSKVrFoRA==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:51:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uQdAo6eSrnwCOM1aMhsp2caMam5cjpvw-UI7KEhAAwvmSq5rAwmQ_vxGwRhQd-u56APrLLrGE8f_WfSKVrFoRA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uQdAo6eSrnwCOM1aMhsp2caMam5cjpvw-UI7KEhAAwvmSq5rAwmQ_vxGwRhQd-u56APrLLrGE8f_WfSKVrFoRA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (74.86s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-hiqopox6qafo'", Local "Local file system at /tmp/rclone2982221836", Modify Window "1s" 2025/04/30 04:51:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hiqopox6qafo/dst" 2025/04/30 04:51:19 DEBUG : Config file has changed externally - reloading 2025/04/30 04:51:19 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Has cached credentials 2025/04/30 04:51:20 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo/dst': Used cached credential to initialize the ProtonDrive API 2025/04/30 04:52:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/30 04:52:21.281904 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LqJX4Di9q_lHxZXxZ2jkePJUWOoBLTFoObkAH6CCvzhjhnVQMXs19lagzH7ulghpCuSGjQElxgDyke7to2Bmzg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/04/30 04:52:21.281939 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LqJX4Di9q_lHxZXxZ2jkePJUWOoBLTFoObkAH6CCvzhjhnVQMXs19lagzH7ulghpCuSGjQElxgDyke7to2Bmzg==/move: This value should not be blank. (Code=2000, Status=400) 2025/04/30 04:52:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LqJX4Di9q_lHxZXxZ2jkePJUWOoBLTFoObkAH6CCvzhjhnVQMXs19lagzH7ulghpCuSGjQElxgDyke7to2Bmzg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LqJX4Di9q_lHxZXxZ2jkePJUWOoBLTFoObkAH6CCvzhjhnVQMXs19lagzH7ulghpCuSGjQElxgDyke7to2Bmzg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (72.10s) FAIL 2025/04/30 04:52:24 DEBUG : proton drive root link ID 'rclone-test-hiqopox6qafo': 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 15m17.007979691s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]