"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 4/5) 2025/07/04 02:38:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lowurir7samu" 2025/07/04 02:38:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/04 02:38:11 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Has cached credentials 2025/07/04 02:38:14 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Used cached credential to initialize the ProtonDrive API 2025/07/04 02:38:14 DEBUG : Creating backend with remote "/tmp/rclone902928527" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" 2025/07/04 02:38:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yuwamum0tisu" 2025/07/04 02:38:20 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Has cached credentials 2025/07/04 02:38:22 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Used cached credential to initialize the ProtonDrive API sync_test.go:672: Server side copy (if possible) proton drive root link ID 'rclone-test-lowurir7samu' -> proton drive root link ID 'rclone-test-yuwamum0tisu' 2025/07/04 02:38:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/04 02:38:24 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Waiting for checks to finish 2025/07/04 02:38:24 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Waiting for transfers to finish 2025/07/04 02:38:29 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/04 02:38:29 INFO : sub dir/hello world: Copied (new) 2025/07/04 02:38:32.166886 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/07/04 02:38:32.166938 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/07/04 02:38:35 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Using server-side directory move 2025/07/04 02:38:35 INFO : proton drive root link ID 'rclone-test-yuwamum0tisu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/04 02:38:36 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/04 02:38:36 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Waiting for checks to finish 2025/07/04 02:38:36 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Waiting for transfers to finish 2025/07/04 02:38:37 INFO : sub dir/hello world: Deleted 2025/07/04 02:38:38.799689 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4TY9nQ-u-TKK7N31XgZr_HS8jRvK238e1hFUwwkMVKp4XBdOjtv5mohz89fMIRAnczrzTf1R3Y-o1cyEadYKVQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:38:38.799724 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4TY9nQ-u-TKK7N31XgZr_HS8jRvK238e1hFUwwkMVKp4XBdOjtv5mohz89fMIRAnczrzTf1R3Y-o1cyEadYKVQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:38 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4TY9nQ-u-TKK7N31XgZr_HS8jRvK238e1hFUwwkMVKp4XBdOjtv5mohz89fMIRAnczrzTf1R3Y-o1cyEadYKVQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:685 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4TY9nQ-u-TKK7N31XgZr_HS8jRvK238e1hFUwwkMVKp4XBdOjtv5mohz89fMIRAnczrzTf1R3Y-o1cyEadYKVQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/04 02:38:38 DEBUG : proton drive root link ID 'rclone-test-yuwamum0tisu': Purge remote --- FAIL: TestServerSideMoveOverSelf (28.27s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" sync_test.go:1539: Can track renames: true 2025/07/04 02:38:43 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:38:43 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:38:43 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:38:43 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/04 02:38:43 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:38:43 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/04 02:38:43 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:38:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:38:44 INFO : yam: Copied (new) 2025/07/04 02:38:44 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/04 02:38:44 INFO : potato: Copied (new) 2025/07/04 02:38:44 DEBUG : Waiting for deletions to finish 2025/07/04 02:38:46 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/04 02:38:46 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:38:46 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:38:46 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:38:46 DEBUG : potato: Unchanged skipping 2025/07/04 02:38:46 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:38:47.732762 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FYBJRZRzo-sdN86BEfXJPp2Zs53FtH0s9kr3czB99BazKNets-oyO2ONBZUg5mOu_sabYpEAb9-ALsJcUxhESQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:38:47.732820 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FYBJRZRzo-sdN86BEfXJPp2Zs53FtH0s9kr3czB99BazKNets-oyO2ONBZUg5mOu_sabYpEAb9-ALsJcUxhESQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:47 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FYBJRZRzo-sdN86BEfXJPp2Zs53FtH0s9kr3czB99BazKNets-oyO2ONBZUg5mOu_sabYpEAb9-ALsJcUxhESQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:47 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FYBJRZRzo-sdN86BEfXJPp2Zs53FtH0s9kr3czB99BazKNets-oyO2ONBZUg5mOu_sabYpEAb9-ALsJcUxhESQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:47 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/04 02:38:47 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:38:49 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:38:49 INFO : yaml: Copied (new) 2025/07/04 02:38:49 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting files as there were IO errors 2025/07/04 02:38:49 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting directories as there were IO errors sync_test.go:1557: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1557 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (9.99s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" sync_test.go:1611: Can track renames: true 2025/07/04 02:38:53 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:38:53 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:38:53 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:38:53 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:38:53 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/04 02:38:53 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/04 02:38:53 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:38:54 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:38:54 INFO : yam: Copied (new) 2025/07/04 02:38:54 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/04 02:38:54 INFO : potato: Copied (new) 2025/07/04 02:38:54 DEBUG : Waiting for deletions to finish 2025/07/04 02:38:56 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/04 02:38:56 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:38:56 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:38:56 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:38:56 DEBUG : potato: Unchanged skipping 2025/07/04 02:38:56 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:38:58.024589 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Q-dw6vXLnAagb9KyLNPsV62IHr5p1gHgyey_VygkFtPcT1JM061lntE8MjB3lm_lnzcPlsQP_IzSIqmBocTx-g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:38:58.024626 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Q-dw6vXLnAagb9KyLNPsV62IHr5p1gHgyey_VygkFtPcT1JM061lntE8MjB3lm_lnzcPlsQP_IzSIqmBocTx-g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:58 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Q-dw6vXLnAagb9KyLNPsV62IHr5p1gHgyey_VygkFtPcT1JM061lntE8MjB3lm_lnzcPlsQP_IzSIqmBocTx-g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:58 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Q-dw6vXLnAagb9KyLNPsV62IHr5p1gHgyey_VygkFtPcT1JM061lntE8MjB3lm_lnzcPlsQP_IzSIqmBocTx-g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:38:58 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/04 02:38:58 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:38:59 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:38:59 INFO : yaml: Copied (new) 2025/07/04 02:38:59 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting files as there were IO errors 2025/07/04 02:38:59 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting directories as there were IO errors sync_test.go:1629: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1629 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (10.32s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" sync_test.go:1650: Can track renames: true 2025/07/04 02:39:03 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:39:03 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:39:03 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:39:03 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/04 02:39:03 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:39:03 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/04 02:39:03 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:39:06 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/04 02:39:06 INFO : potato: Copied (new) 2025/07/04 02:39:06 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:39:06 INFO : sub/yam: Copied (new) 2025/07/04 02:39:06 DEBUG : Waiting for deletions to finish 2025/07/04 02:39:08 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/04 02:39:08 DEBUG : potato: Unchanged skipping 2025/07/04 02:39:09 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Making map for --track-renames 2025/07/04 02:39:09 INFO : proton drive root link ID 'rclone-test-lowurir7samu': Finished making map for --track-renames 2025/07/04 02:39:09 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:39:09 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for renames to finish 2025/07/04 02:39:10.581547 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DwS-O3JLFZbJXsLRAypl0FeVM6Ejr7reSWHwBcwt_qS2OZazbStJew81jL-wvYd3sgEhQ8ens-E3Jm6j9R22Yg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:39:10.581579 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DwS-O3JLFZbJXsLRAypl0FeVM6Ejr7reSWHwBcwt_qS2OZazbStJew81jL-wvYd3sgEhQ8ens-E3Jm6j9R22Yg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:10 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DwS-O3JLFZbJXsLRAypl0FeVM6Ejr7reSWHwBcwt_qS2OZazbStJew81jL-wvYd3sgEhQ8ens-E3Jm6j9R22Yg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:10 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DwS-O3JLFZbJXsLRAypl0FeVM6Ejr7reSWHwBcwt_qS2OZazbStJew81jL-wvYd3sgEhQ8ens-E3Jm6j9R22Yg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:10 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/04 02:39:10 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:39:12 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/04 02:39:12 INFO : yam: Copied (new) 2025/07/04 02:39:12 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting files as there were IO errors 2025/07/04 02:39:12 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting directories as there were IO errors sync_test.go:1668: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1668 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (13.96s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" 2025/07/04 02:39:17 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/04 02:39:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/04 02:39:17 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for checks to finish 2025/07/04 02:39:17 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Waiting for transfers to finish 2025/07/04 02:39:21 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/04 02:39:21 INFO : nested/sub dir/file: Copied (new) 2025/07/04 02:39:21 INFO : nested/sub dir/file: Deleted 2025/07/04 02:39:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/04 02:39:21 INFO : sub dir/hello world: Copied (new) 2025/07/04 02:39:21 INFO : sub dir/hello world: Deleted 2025/07/04 02:39:21 ERROR : Local file system at /tmp/rclone902928527: not deleting directories as there were IO errors sync_test.go:1789: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1789 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (9.96s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" 2025/07/04 02:39:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pudugiz8pido" 2025/07/04 02:39:27 DEBUG : Config file has changed externally - reloading 2025/07/04 02:39:27 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Has cached credentials 2025/07/04 02:39:29 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-lowurir7samu' -> proton drive root link ID 'rclone-test-pudugiz8pido' 2025/07/04 02:39:41 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Using server-side directory move 2025/07/04 02:39:41 INFO : proton drive root link ID 'rclone-test-pudugiz8pido': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/04 02:39:43 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/04 02:39:43 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/04 02:39:43 DEBUG : empty space: Unchanged skipping 2025/07/04 02:39:43 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/04 02:39:43 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Waiting for checks to finish 2025/07/04 02:39:43 INFO : potato3: Deleted 2025/07/04 02:39:43 INFO : empty space: Deleted 2025/07/04 02:39:43 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Waiting for transfers to finish 2025/07/04 02:39:44.256229 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wWFMBc1pTp5yiUR9N-amXEuSOakScenEh23TFS3yUpjMwt0HIi6_z5HCXU1ni0dhNbDikTO12fQFvsv8HlKWrA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:39:44.256264 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wWFMBc1pTp5yiUR9N-amXEuSOakScenEh23TFS3yUpjMwt0HIi6_z5HCXU1ni0dhNbDikTO12fQFvsv8HlKWrA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:44 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wWFMBc1pTp5yiUR9N-amXEuSOakScenEh23TFS3yUpjMwt0HIi6_z5HCXU1ni0dhNbDikTO12fQFvsv8HlKWrA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:44.509919 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iel4X7-tWfFVluJaUPyY6xJYHXzC7elumKHEixC6jJJJTANOEoypXj8qtuiOz9mqVb6CAcmZSBVubPUq8fbwJw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:39:44.509957 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iel4X7-tWfFVluJaUPyY6xJYHXzC7elumKHEixC6jJJJTANOEoypXj8qtuiOz9mqVb6CAcmZSBVubPUq8fbwJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:39:44 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iel4X7-tWfFVluJaUPyY6xJYHXzC7elumKHEixC6jJJJTANOEoypXj8qtuiOz9mqVb6CAcmZSBVubPUq8fbwJw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1882 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iel4X7-tWfFVluJaUPyY6xJYHXzC7elumKHEixC6jJJJTANOEoypXj8qtuiOz9mqVb6CAcmZSBVubPUq8fbwJw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/04 02:39:44 DEBUG : proton drive root link ID 'rclone-test-pudugiz8pido': Purge remote --- FAIL: TestServerSideMove (21.01s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" 2025/07/04 02:39:48 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-timaniv2zamo" 2025/07/04 02:39:48 DEBUG : proton drive root link ID 'rclone-test-timaniv2zamo': Has cached credentials 2025/07/04 02:39:50 DEBUG : proton drive root link ID 'rclone-test-timaniv2zamo': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-lowurir7samu' -> proton drive root link ID 'rclone-test-timaniv2zamo' 2025/07/04 02:40:03 DEBUG : empty space: Excluded (Size Filter) 2025/07/04 02:40:03 DEBUG : empty space: Excluded 2025/07/04 02:40:03 DEBUG : empty space: Excluded (Size Filter) 2025/07/04 02:40:03 DEBUG : empty space: Excluded 2025/07/04 02:40:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/04 02:40:03 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/04 02:40:03 DEBUG : proton drive root link ID 'rclone-test-timaniv2zamo': Waiting for checks to finish 2025/07/04 02:40:03 DEBUG : proton drive root link ID 'rclone-test-timaniv2zamo': Waiting for transfers to finish 2025/07/04 02:40:04 INFO : potato3: Deleted 2025/07/04 02:40:05.078771 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-J2n4y2raoaAnSNmL2bhrpYznH14OjXmuF_LPjeyBqFRLVs52oYe0k7_vhvBLaduWQgEvLTkovaC0sAVT2wgjw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:40:05.078814 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-J2n4y2raoaAnSNmL2bhrpYznH14OjXmuF_LPjeyBqFRLVs52oYe0k7_vhvBLaduWQgEvLTkovaC0sAVT2wgjw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:05 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-J2n4y2raoaAnSNmL2bhrpYznH14OjXmuF_LPjeyBqFRLVs52oYe0k7_vhvBLaduWQgEvLTkovaC0sAVT2wgjw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:05.285855 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BT8AtWWlZo1MRlepQUrmG-gYd20m4-mCDuCe1zDDCCRJVAwClvv82nCvcnIUKP176asvXLPDiRpT5f94c6KVkg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:40:05.285889 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BT8AtWWlZo1MRlepQUrmG-gYd20m4-mCDuCe1zDDCCRJVAwClvv82nCvcnIUKP176asvXLPDiRpT5f94c6KVkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:05 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BT8AtWWlZo1MRlepQUrmG-gYd20m4-mCDuCe1zDDCCRJVAwClvv82nCvcnIUKP176asvXLPDiRpT5f94c6KVkg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1895 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BT8AtWWlZo1MRlepQUrmG-gYd20m4-mCDuCe1zDDCCRJVAwClvv82nCvcnIUKP176asvXLPDiRpT5f94c6KVkg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/04 02:40:05 DEBUG : proton drive root link ID 'rclone-test-timaniv2zamo': Purge remote --- FAIL: TestServerSideMoveWithFilter (22.00s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-lowurir7samu'", Local "Local file system at /tmp/rclone902928527", Modify Window "1s" 2025/07/04 02:40:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zemoyey8cujo" 2025/07/04 02:40:10 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Has cached credentials 2025/07/04 02:40:12 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Used cached credential to initialize the ProtonDrive API 2025/07/04 02:40:18 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-lowurir7samu' -> proton drive root link ID 'rclone-test-zemoyey8cujo' 2025/07/04 02:40:25 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Using server-side directory move 2025/07/04 02:40:25 INFO : proton drive root link ID 'rclone-test-zemoyey8cujo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/04 02:40:27 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/04 02:40:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/04 02:40:27 DEBUG : empty space: Unchanged skipping 2025/07/04 02:40:27 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/04 02:40:27 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Waiting for checks to finish 2025/07/04 02:40:27 INFO : empty space: Deleted 2025/07/04 02:40:27 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Waiting for transfers to finish 2025/07/04 02:40:27 INFO : potato3: Deleted 2025/07/04 02:40:28.244913 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/36zJJMbvMcQH9UociNfHeM7_RchubZgZwAvaFtjfI4mADLPDnkooE2s2xW_4nNizNg8nPGxVx-RIvUP28t8LiA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:40:28.244943 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/36zJJMbvMcQH9UociNfHeM7_RchubZgZwAvaFtjfI4mADLPDnkooE2s2xW_4nNizNg8nPGxVx-RIvUP28t8LiA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:28 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/36zJJMbvMcQH9UociNfHeM7_RchubZgZwAvaFtjfI4mADLPDnkooE2s2xW_4nNizNg8nPGxVx-RIvUP28t8LiA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:28.437809 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AFyhQ7AN8r15t3BjXqK3H3rns4suuf_mnIW_oX-3-Fa1wZ4pdUY_pb4a_txptDHsFpJS2IithdIyIESqUvVqMQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/04 02:40:28.437846 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AFyhQ7AN8r15t3BjXqK3H3rns4suuf_mnIW_oX-3-Fa1wZ4pdUY_pb4a_txptDHsFpJS2IithdIyIESqUvVqMQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:28 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AFyhQ7AN8r15t3BjXqK3H3rns4suuf_mnIW_oX-3-Fa1wZ4pdUY_pb4a_txptDHsFpJS2IithdIyIESqUvVqMQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/04 02:40:28 ERROR : proton drive root link ID 'rclone-test-lowurir7samu': not deleting directories as there were IO errors sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1902 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/07/04 02:40:28 DEBUG : proton drive root link ID 'rclone-test-zemoyey8cujo': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (23.00s) FAIL 2025/07/04 02:40:33 DEBUG : proton drive root link ID 'rclone-test-lowurir7samu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 2m22.318026765s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs]