"./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/05/16 07:16:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu" 2025/05/16 07:16:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/16 07:16:56 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Has cached credentials 2025/05/16 07:16:57 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:16:57 DEBUG : Creating backend with remote "/tmp/rclone1240278141" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:16:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-metisab7yife" 2025/05/16 07:16:59 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Has cached credentials 2025/05/16 07:17:00 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-matubag0nilu' -> proton drive root link ID 'rclone-test-metisab7yife' 2025/05/16 07:17:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 07:17:00 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Waiting for checks to finish 2025/05/16 07:17:00 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Waiting for transfers to finish 2025/05/16 07:17:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/16 07:17:02 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:03.421094 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/05/16 07:17:03.421138 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/05/16 07:17:04 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Using server-side directory move 2025/05/16 07:17:04 INFO : proton drive root link ID 'rclone-test-metisab7yife': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/16 07:17:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/16 07:17:05 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Waiting for checks to finish 2025/05/16 07:17:05 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Waiting for transfers to finish 2025/05/16 07:17:05 INFO : sub dir/hello world: Deleted 2025/05/16 07:17:05.686481 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BW7_DmGTcSQ3Aftm5vbspPA4WiW2e1uA5S3O6pHAN03T_Q1kIkorvBYc4ocTYPxVySOCz4sAZx2puSdt-FT0mQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:05.686555 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BW7_DmGTcSQ3Aftm5vbspPA4WiW2e1uA5S3O6pHAN03T_Q1kIkorvBYc4ocTYPxVySOCz4sAZx2puSdt-FT0mQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:05 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BW7_DmGTcSQ3Aftm5vbspPA4WiW2e1uA5S3O6pHAN03T_Q1kIkorvBYc4ocTYPxVySOCz4sAZx2puSdt-FT0mQ==/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/BW7_DmGTcSQ3Aftm5vbspPA4WiW2e1uA5S3O6pHAN03T_Q1kIkorvBYc4ocTYPxVySOCz4sAZx2puSdt-FT0mQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/05/16 07:17:05 DEBUG : proton drive root link ID 'rclone-test-metisab7yife': Purge remote --- FAIL: TestServerSideMoveOverSelf (9.79s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/05/16 07:17:07 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:07 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:07 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:07 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:07 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/16 07:17:07 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/16 07:17:07 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:08 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:08 INFO : yam: Copied (new) 2025/05/16 07:17:08 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/16 07:17:08 INFO : potato: Copied (new) 2025/05/16 07:17:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:09 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:17:09 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:09 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:09 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:09 DEBUG : potato: Unchanged skipping 2025/05/16 07:17:09 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:09.562499 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gZlnpFViC_zOGncyNpizaJ2dr9jQx9KySD_5i3Wk39mZhR7INVxK9rhbq7uWn-G00W2hGWpnKLdvPLcoVDQuQg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:09.562550 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gZlnpFViC_zOGncyNpizaJ2dr9jQx9KySD_5i3Wk39mZhR7INVxK9rhbq7uWn-G00W2hGWpnKLdvPLcoVDQuQg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:09 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gZlnpFViC_zOGncyNpizaJ2dr9jQx9KySD_5i3Wk39mZhR7INVxK9rhbq7uWn-G00W2hGWpnKLdvPLcoVDQuQg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:09 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gZlnpFViC_zOGncyNpizaJ2dr9jQx9KySD_5i3Wk39mZhR7INVxK9rhbq7uWn-G00W2hGWpnKLdvPLcoVDQuQg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:09 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/16 07:17:09 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:10 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:10 INFO : yaml: Copied (new) 2025/05/16 07:17:10 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': not deleting files as there were IO errors 2025/05/16 07:17:10 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': 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 (4.25s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/05/16 07:17:11 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:11 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:11 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:11 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/16 07:17:11 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/16 07:17:11 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:12 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:12 INFO : yam: Copied (new) 2025/05/16 07:17:12 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/16 07:17:12 INFO : potato: Copied (new) 2025/05/16 07:17:12 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:13 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:17:13 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:13 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:13 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:13 DEBUG : potato: Unchanged skipping 2025/05/16 07:17:13 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:13.439704 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5lNTjlBNq4Smi-1TZXuaG9WCTgZyyKNFlO2gkFClR0SyapupkdUJCYPrfDPDjvVXlte4trp6JnTockE5UuvaPg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:13.439740 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5lNTjlBNq4Smi-1TZXuaG9WCTgZyyKNFlO2gkFClR0SyapupkdUJCYPrfDPDjvVXlte4trp6JnTockE5UuvaPg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:13 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5lNTjlBNq4Smi-1TZXuaG9WCTgZyyKNFlO2gkFClR0SyapupkdUJCYPrfDPDjvVXlte4trp6JnTockE5UuvaPg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:13 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5lNTjlBNq4Smi-1TZXuaG9WCTgZyyKNFlO2gkFClR0SyapupkdUJCYPrfDPDjvVXlte4trp6JnTockE5UuvaPg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:13 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/05/16 07:17:13 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:14 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:14 INFO : yaml: Copied (new) 2025/05/16 07:17:14 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': not deleting files as there were IO errors 2025/05/16 07:17:14 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': 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 (3.87s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/05/16 07:17:15 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:15 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:15 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:15 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/16 07:17:15 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/05/16 07:17:15 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:15 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:16 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/05/16 07:17:16 INFO : potato: Copied (new) 2025/05/16 07:17:16 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:16 INFO : sub/yam: Copied (new) 2025/05/16 07:17:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:17 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:17:17 DEBUG : potato: Unchanged skipping 2025/05/16 07:17:17 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Making map for --track-renames 2025/05/16 07:17:17 INFO : proton drive root link ID 'rclone-test-matubag0nilu': Finished making map for --track-renames 2025/05/16 07:17:17 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:17 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for renames to finish 2025/05/16 07:17:17.948112 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RU-hHqBpuf6uqC89nxkTPIP9zRLPwPb3qcBLsWgO7l_8M9ifZ64lUtPMi3OsaSnhgEbRq2hFlY7CqkZioQIKnA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:17.948146 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RU-hHqBpuf6uqC89nxkTPIP9zRLPwPb3qcBLsWgO7l_8M9ifZ64lUtPMi3OsaSnhgEbRq2hFlY7CqkZioQIKnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:17 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RU-hHqBpuf6uqC89nxkTPIP9zRLPwPb3qcBLsWgO7l_8M9ifZ64lUtPMi3OsaSnhgEbRq2hFlY7CqkZioQIKnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:17 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RU-hHqBpuf6uqC89nxkTPIP9zRLPwPb3qcBLsWgO7l_8M9ifZ64lUtPMi3OsaSnhgEbRq2hFlY7CqkZioQIKnA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:17 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/16 07:17:17 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:18 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/05/16 07:17:18 INFO : yam: Copied (new) 2025/05/16 07:17:18 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': not deleting files as there were IO errors 2025/05/16 07:17:18 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': 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 (5.07s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 07:17:20 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/05/16 07:17:20 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for checks to finish 2025/05/16 07:17:20 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': Waiting for transfers to finish 2025/05/16 07:17:22 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/05/16 07:17:22 INFO : nested/sub dir/file: Copied (new) 2025/05/16 07:17:22 INFO : nested/sub dir/file: Deleted 2025/05/16 07:17:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/05/16 07:17:22 INFO : sub dir/hello world: Copied (new) 2025/05/16 07:17:22 INFO : sub dir/hello world: Deleted 2025/05/16 07:17:22 ERROR : Local file system at /tmp/rclone1240278141: 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 (3.75s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qodexok9dudi" 2025/05/16 07:17:24 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Has cached credentials 2025/05/16 07:17:24 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-matubag0nilu' -> proton drive root link ID 'rclone-test-qodexok9dudi' 2025/05/16 07:17:29 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Using server-side directory move 2025/05/16 07:17:29 INFO : proton drive root link ID 'rclone-test-qodexok9dudi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/16 07:17:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 07:17:29 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/16 07:17:29 DEBUG : empty space: Unchanged skipping 2025/05/16 07:17:29 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Waiting for checks to finish 2025/05/16 07:17:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 07:17:29 INFO : empty space: Deleted 2025/05/16 07:17:29 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Waiting for transfers to finish 2025/05/16 07:17:29 INFO : potato3: Deleted 2025/05/16 07:17:30.131893 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GgTi8PlNCgQ983LUHMl4CQXYCMKHZbSBUMjv7doqMboSWlCVEniF3CgqtmI4GSICI36VtwXyzSNAXWrUaQ22hg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:30.131912 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GgTi8PlNCgQ983LUHMl4CQXYCMKHZbSBUMjv7doqMboSWlCVEniF3CgqtmI4GSICI36VtwXyzSNAXWrUaQ22hg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:30 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GgTi8PlNCgQ983LUHMl4CQXYCMKHZbSBUMjv7doqMboSWlCVEniF3CgqtmI4GSICI36VtwXyzSNAXWrUaQ22hg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:30.250796 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cyq7fpWpGIevkJ-bBAPk5cN980WOejrye-ywniX_AmImvOaEg0SNJAKZRK09rNJnfgQz9-3W3X_ebKfDjayQXw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:30.250821 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cyq7fpWpGIevkJ-bBAPk5cN980WOejrye-ywniX_AmImvOaEg0SNJAKZRK09rNJnfgQz9-3W3X_ebKfDjayQXw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cyq7fpWpGIevkJ-bBAPk5cN980WOejrye-ywniX_AmImvOaEg0SNJAKZRK09rNJnfgQz9-3W3X_ebKfDjayQXw==/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/Cyq7fpWpGIevkJ-bBAPk5cN980WOejrye-ywniX_AmImvOaEg0SNJAKZRK09rNJnfgQz9-3W3X_ebKfDjayQXw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/05/16 07:17:30 DEBUG : proton drive root link ID 'rclone-test-qodexok9dudi': Purge remote --- FAIL: TestServerSideMove (7.17s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:31 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dahobuk3keca" 2025/05/16 07:17:31 DEBUG : proton drive root link ID 'rclone-test-dahobuk3keca': Has cached credentials 2025/05/16 07:17:32 DEBUG : proton drive root link ID 'rclone-test-dahobuk3keca': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-matubag0nilu' -> proton drive root link ID 'rclone-test-dahobuk3keca' 2025/05/16 07:17:37 DEBUG : empty space: Excluded (Size Filter) 2025/05/16 07:17:37 DEBUG : empty space: Excluded 2025/05/16 07:17:37 DEBUG : empty space: Excluded (Size Filter) 2025/05/16 07:17:37 DEBUG : empty space: Excluded 2025/05/16 07:17:37 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 07:17:37 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 07:17:37 DEBUG : proton drive root link ID 'rclone-test-dahobuk3keca': Waiting for checks to finish 2025/05/16 07:17:37 DEBUG : proton drive root link ID 'rclone-test-dahobuk3keca': Waiting for transfers to finish 2025/05/16 07:17:37 INFO : potato3: Deleted 2025/05/16 07:17:37.622070 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZaF8I3nuR7j2zE7EQd3V6OkkUnh2dpTxOMJHgtGwNzLDB0E8tz6nFSE4UsgQR7werQbtVi8bivIjntZYgDv7UQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:37.622107 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZaF8I3nuR7j2zE7EQd3V6OkkUnh2dpTxOMJHgtGwNzLDB0E8tz6nFSE4UsgQR7werQbtVi8bivIjntZYgDv7UQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:37 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZaF8I3nuR7j2zE7EQd3V6OkkUnh2dpTxOMJHgtGwNzLDB0E8tz6nFSE4UsgQR7werQbtVi8bivIjntZYgDv7UQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:37.678633 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XFIKSwlDWxroWJrdghyCrjJEmNAaKwDK-R7FVom-XGzAFIrOIxrHeikD3dfCv7zsy3o3Ix09-7vusNbsMfRcEw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:37.678671 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XFIKSwlDWxroWJrdghyCrjJEmNAaKwDK-R7FVom-XGzAFIrOIxrHeikD3dfCv7zsy3o3Ix09-7vusNbsMfRcEw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:37 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XFIKSwlDWxroWJrdghyCrjJEmNAaKwDK-R7FVom-XGzAFIrOIxrHeikD3dfCv7zsy3o3Ix09-7vusNbsMfRcEw==/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/XFIKSwlDWxroWJrdghyCrjJEmNAaKwDK-R7FVom-XGzAFIrOIxrHeikD3dfCv7zsy3o3Ix09-7vusNbsMfRcEw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/05/16 07:17:37 DEBUG : proton drive root link ID 'rclone-test-dahobuk3keca': Purge remote --- FAIL: TestServerSideMoveWithFilter (7.74s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-colukob1rine" 2025/05/16 07:17:39 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Has cached credentials 2025/05/16 07:17:39 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:17:42 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-matubag0nilu' -> proton drive root link ID 'rclone-test-colukob1rine' 2025/05/16 07:17:44 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Using server-side directory move 2025/05/16 07:17:44 INFO : proton drive root link ID 'rclone-test-colukob1rine': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/16 07:17:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 07:17:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/05/16 07:17:45 DEBUG : empty space: Unchanged skipping 2025/05/16 07:17:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 07:17:45 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Waiting for checks to finish 2025/05/16 07:17:45 INFO : empty space: Deleted 2025/05/16 07:17:45 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Waiting for transfers to finish 2025/05/16 07:17:45 INFO : potato3: Deleted 2025/05/16 07:17:45.692995 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YfVpldfhOnOBfMnjWz1GqZAAZb1sMnPd2b3uoLAjjrBxRKuQokrQz3da43bAW-0xJnTfj62ozio_Hp-YbbIpEw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:45.693034 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YfVpldfhOnOBfMnjWz1GqZAAZb1sMnPd2b3uoLAjjrBxRKuQokrQz3da43bAW-0xJnTfj62ozio_Hp-YbbIpEw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:45 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YfVpldfhOnOBfMnjWz1GqZAAZb1sMnPd2b3uoLAjjrBxRKuQokrQz3da43bAW-0xJnTfj62ozio_Hp-YbbIpEw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:45.784539 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fjVP5eGvGZUgwnMa8v0tJK04LDp24AwJS98eqOVQuouZJChIX_o7YQYilEYBUNwbg3ybXkBA37VGasxjDL48Iw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:17:45.784594 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fjVP5eGvGZUgwnMa8v0tJK04LDp24AwJS98eqOVQuouZJChIX_o7YQYilEYBUNwbg3ybXkBA37VGasxjDL48Iw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:45 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/fjVP5eGvGZUgwnMa8v0tJK04LDp24AwJS98eqOVQuouZJChIX_o7YQYilEYBUNwbg3ybXkBA37VGasxjDL48Iw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:17:45 ERROR : proton drive root link ID 'rclone-test-matubag0nilu': 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/05/16 07:17:45 DEBUG : proton drive root link ID 'rclone-test-colukob1rine': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (8.24s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:17:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:17:50 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:17:51 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:18:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/backup" 2025/05/16 07:18:44 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Has cached credentials 2025/05/16 07:18:45 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:20:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:20:34 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:20:34 DEBUG : two: Unchanged skipping 2025/05/16 07:20:34 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for checks to finish 2025/05/16 07:20:34.758994 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UZNApOKiwQnqYcaotvdX8jYFflOBfawFkHVQM6UAkQL3sAnwwt3HvP8PDlwHIt7qkdhIbot0JFl5X6n9LRCIbw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:20:34.759031 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UZNApOKiwQnqYcaotvdX8jYFflOBfawFkHVQM6UAkQL3sAnwwt3HvP8PDlwHIt7qkdhIbot0JFl5X6n9LRCIbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:20:34 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UZNApOKiwQnqYcaotvdX8jYFflOBfawFkHVQM6UAkQL3sAnwwt3HvP8PDlwHIt7qkdhIbot0JFl5X6n9LRCIbw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:20:34 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for transfers to finish 2025/05/16 07:20:34 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/dst': not deleting files as there were IO errors 2025/05/16 07:20:34 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/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/UZNApOKiwQnqYcaotvdX8jYFflOBfawFkHVQM6UAkQL3sAnwwt3HvP8PDlwHIt7qkdhIbot0JFl5X6n9LRCIbw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (169.14s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:20:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:20:39 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:20:40 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:21:31 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/backup" 2025/05/16 07:21:31 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Has cached credentials 2025/05/16 07:21:32 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:22:47.167511 WARN RESTY 503 GET https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=60&PageSize=150&ShowAll=1: 503 Service Unavailable (Code=0, Status=503), Attempt 1 time="2025-05-16T07:22:47Z" level=warning msg="Too many requests, retrying after delay" after=13 method=GET pkg=go-proton-api status=503 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=60&PageSize=150&ShowAll=1" 2025/05/16 07:24:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:24:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:24:32 DEBUG : two: Unchanged skipping 2025/05/16 07:24:32 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for checks to finish 2025/05/16 07:24:33.314244 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DYPapPC-BFFFL82Pf-Xcgln7bJclKbuKoTLA9elHr_7nn7ejwwGuBuptyfXywtAV_RnB5V2iLigIJbLNGLPqpQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:24:33.314280 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DYPapPC-BFFFL82Pf-Xcgln7bJclKbuKoTLA9elHr_7nn7ejwwGuBuptyfXywtAV_RnB5V2iLigIJbLNGLPqpQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:24:33 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DYPapPC-BFFFL82Pf-Xcgln7bJclKbuKoTLA9elHr_7nn7ejwwGuBuptyfXywtAV_RnB5V2iLigIJbLNGLPqpQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:24:33 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for transfers to finish 2025/05/16 07:24:33 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/dst': not deleting files as there were IO errors 2025/05/16 07:24:33 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/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/DYPapPC-BFFFL82Pf-Xcgln7bJclKbuKoTLA9elHr_7nn7ejwwGuBuptyfXywtAV_RnB5V2iLigIJbLNGLPqpQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (238.53s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:24:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:24:38 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:24:39 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:25:31 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/backup" 2025/05/16 07:25:31 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Has cached credentials 2025/05/16 07:25:32 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/backup': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:27:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:27:19 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:27:19 DEBUG : two: Unchanged skipping 2025/05/16 07:27:19 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for checks to finish 2025/05/16 07:27:19.804584 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HlkXebiTlQTCgwSXDwRSB0b-Ed-yHK4taWFtyQipENbUPRFHJwdAG43EwVLsyDRonMU1-YZxyP85Cjhc8xjDsw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:27:19.804626 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HlkXebiTlQTCgwSXDwRSB0b-Ed-yHK4taWFtyQipENbUPRFHJwdAG43EwVLsyDRonMU1-YZxyP85Cjhc8xjDsw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:27:19 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/HlkXebiTlQTCgwSXDwRSB0b-Ed-yHK4taWFtyQipENbUPRFHJwdAG43EwVLsyDRonMU1-YZxyP85Cjhc8xjDsw==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:27:19 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for transfers to finish 2025/05/16 07:27:19 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/dst': not deleting files as there were IO errors 2025/05/16 07:27:19 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/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/HlkXebiTlQTCgwSXDwRSB0b-Ed-yHK4taWFtyQipENbUPRFHJwdAG43EwVLsyDRonMU1-YZxyP85Cjhc8xjDsw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (166.57s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:27:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:27:24 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:27:25 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:28:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:28:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/16 07:28:20 DEBUG : two: Unchanged skipping 2025/05/16 07:28:20 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for checks to finish 2025/05/16 07:28:20.334214 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wEf-jciUWHsZ-ZuYJwgVvEJ6p-QdtcuXoudUE8FDKf_En72LumWjfSxGT5sVfmjrrEeNmKY_Xbf8Em7b6vd-8w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:28:20.334246 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wEf-jciUWHsZ-ZuYJwgVvEJ6p-QdtcuXoudUE8FDKf_En72LumWjfSxGT5sVfmjrrEeNmKY_Xbf8Em7b6vd-8w==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:28:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wEf-jciUWHsZ-ZuYJwgVvEJ6p-QdtcuXoudUE8FDKf_En72LumWjfSxGT5sVfmjrrEeNmKY_Xbf8Em7b6vd-8w==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:28:20 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Waiting for transfers to finish 2025/05/16 07:28:20 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/dst': not deleting files as there were IO errors 2025/05/16 07:28:20 ERROR : proton drive root link ID 'rclone-test-matubag0nilu/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/wEf-jciUWHsZ-ZuYJwgVvEJ6p-QdtcuXoudUE8FDKf_En72LumWjfSxGT5sVfmjrrEeNmKY_Xbf8Em7b6vd-8w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (60.20s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:28:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:28:24 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:28:25 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:29:18 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:29:18.372893 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8MQMdgzVcb7qAjgwRMC68-VyEdZss0hwQH35X9gWnpTjICiat4v1ycAFFgE2HNeowVQYNwLHWrjNpkxBCa2dxg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:29:18.372931 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8MQMdgzVcb7qAjgwRMC68-VyEdZss0hwQH35X9gWnpTjICiat4v1ycAFFgE2HNeowVQYNwLHWrjNpkxBCa2dxg==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:29:18 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8MQMdgzVcb7qAjgwRMC68-VyEdZss0hwQH35X9gWnpTjICiat4v1ycAFFgE2HNeowVQYNwLHWrjNpkxBCa2dxg==/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/8MQMdgzVcb7qAjgwRMC68-VyEdZss0hwQH35X9gWnpTjICiat4v1ycAFFgE2HNeowVQYNwLHWrjNpkxBCa2dxg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (58.20s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-matubag0nilu'", Local "Local file system at /tmp/rclone1240278141", Modify Window "1s" 2025/05/16 07:29:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-matubag0nilu/dst" 2025/05/16 07:29:23 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Has cached credentials 2025/05/16 07:29:23 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu/dst': Used cached credential to initialize the ProtonDrive API 2025/05/16 07:30:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 07:30:17.880555 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UaRSmDWGS41CYWRMvN2vmFAO2r08X27xxGExVg8wXYzRZB65irT1DdvQFqXW33X83ySYPhypsm5R1JG7azi8bA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/05/16 07:30:17.880590 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UaRSmDWGS41CYWRMvN2vmFAO2r08X27xxGExVg8wXYzRZB65irT1DdvQFqXW33X83ySYPhypsm5R1JG7azi8bA==/move: This value should not be blank. (Code=2000, Status=400) 2025/05/16 07:30:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UaRSmDWGS41CYWRMvN2vmFAO2r08X27xxGExVg8wXYzRZB65irT1DdvQFqXW33X83ySYPhypsm5R1JG7azi8bA==/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/UaRSmDWGS41CYWRMvN2vmFAO2r08X27xxGExVg8wXYzRZB65irT1DdvQFqXW33X83ySYPhypsm5R1JG7azi8bA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (59.40s) FAIL 2025/05/16 07:30:19 DEBUG : proton drive root link ID 'rclone-test-matubag0nilu': 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 13m23.227776286s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]