"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2025/08/29 04:52:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu" 2025/08/29 04:52:29 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/29 04:52:29 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Has cached credentials 2025/08/29 04:52:30 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Used cached credential to initialize the ProtonDrive API 2025/08/29 04:52:30 DEBUG : Creating backend with remote "/tmp/rclone1401195264" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:52:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xevoyav0juhu" 2025/08/29 04:52:33 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Has cached credentials 2025/08/29 04:52:33 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-povuduc8zumu' -> proton drive root link ID 'rclone-test-xevoyav0juhu' 2025/08/29 04:52:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/29 04:52:34 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Waiting for checks to finish 2025/08/29 04:52:34 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Waiting for transfers to finish 2025/08/29 04:52:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/29 04:52:37 INFO : sub dir/hello world: Copied (new) 2025/08/29 04:52:38.203821 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/08/29 04:52:38.203864 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/08/29 04:52:40 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Using server-side directory move 2025/08/29 04:52:40 INFO : proton drive root link ID 'rclone-test-xevoyav0juhu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/29 04:52:40 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/29 04:52:40 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Waiting for checks to finish 2025/08/29 04:52:40 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Waiting for transfers to finish 2025/08/29 04:52:40 INFO : sub dir/hello world: Deleted 2025/08/29 04:52:41.490350 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/taeTrbWl8B0wlG2WTx6RP7nIMdvln6DFMtRo9g_a4i4v9dxy_OKSaPiYdqYNy5XxC-ksaX-YYhwrkYvZd4-r-Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:52:41.490374 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/taeTrbWl8B0wlG2WTx6RP7nIMdvln6DFMtRo9g_a4i4v9dxy_OKSaPiYdqYNy5XxC-ksaX-YYhwrkYvZd4-r-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:41 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/taeTrbWl8B0wlG2WTx6RP7nIMdvln6DFMtRo9g_a4i4v9dxy_OKSaPiYdqYNy5XxC-ksaX-YYhwrkYvZd4-r-Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/taeTrbWl8B0wlG2WTx6RP7nIMdvln6DFMtRo9g_a4i4v9dxy_OKSaPiYdqYNy5XxC-ksaX-YYhwrkYvZd4-r-Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/29 04:52:41 DEBUG : proton drive root link ID 'rclone-test-xevoyav0juhu': Purge remote --- FAIL: TestServerSideMoveOverSelf (12.39s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/29 04:52:43 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:43 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:43 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:43 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:43 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/29 04:52:43 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/29 04:52:43 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:44 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/29 04:52:44 INFO : potato: Copied (new) 2025/08/29 04:52:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:44 INFO : yam: Copied (new) 2025/08/29 04:52:44 DEBUG : Waiting for deletions to finish 2025/08/29 04:52:45 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 04:52:45 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:45 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:45 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:45 DEBUG : potato: Unchanged skipping 2025/08/29 04:52:45 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:45.763526 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WbxBT7I_ZUzZKjmq0IiLZ_5-0xm_tlwrlhKH82Uv1wm5ymaejb4P9ibzXbvrlBV6L8NvG8jwJkvmgUs5Te82gg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:52:45.763573 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WbxBT7I_ZUzZKjmq0IiLZ_5-0xm_tlwrlhKH82Uv1wm5ymaejb4P9ibzXbvrlBV6L8NvG8jwJkvmgUs5Te82gg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:45 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WbxBT7I_ZUzZKjmq0IiLZ_5-0xm_tlwrlhKH82Uv1wm5ymaejb4P9ibzXbvrlBV6L8NvG8jwJkvmgUs5Te82gg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:45 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WbxBT7I_ZUzZKjmq0IiLZ_5-0xm_tlwrlhKH82Uv1wm5ymaejb4P9ibzXbvrlBV6L8NvG8jwJkvmgUs5Te82gg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:45 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/29 04:52:45 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:47 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:47 INFO : yaml: Copied (new) 2025/08/29 04:52:47 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting files as there were IO errors 2025/08/29 04:52:47 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (5.29s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/29 04:52:48 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:48 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:48 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:48 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/29 04:52:48 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/29 04:52:48 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:48 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:49 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/29 04:52:49 INFO : potato: Copied (new) 2025/08/29 04:52:49 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:49 INFO : yam: Copied (new) 2025/08/29 04:52:49 DEBUG : Waiting for deletions to finish 2025/08/29 04:52:50 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 04:52:50 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:50 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:50 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:50 DEBUG : potato: Unchanged skipping 2025/08/29 04:52:50 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:50.791614 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/npE5yFJGRLV-YqJ75uHKb-uSI6cEUMbIVdrNy4BnYzCpvFSFjpj8De4-7iU41TcE8SkBa0C9pjXaxmu-YmHNoQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:52:50.791649 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/npE5yFJGRLV-YqJ75uHKb-uSI6cEUMbIVdrNy4BnYzCpvFSFjpj8De4-7iU41TcE8SkBa0C9pjXaxmu-YmHNoQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:50 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/npE5yFJGRLV-YqJ75uHKb-uSI6cEUMbIVdrNy4BnYzCpvFSFjpj8De4-7iU41TcE8SkBa0C9pjXaxmu-YmHNoQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:50 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/npE5yFJGRLV-YqJ75uHKb-uSI6cEUMbIVdrNy4BnYzCpvFSFjpj8De4-7iU41TcE8SkBa0C9pjXaxmu-YmHNoQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:50 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/29 04:52:50 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:52 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:52 INFO : yaml: Copied (new) 2025/08/29 04:52:52 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting files as there were IO errors 2025/08/29 04:52:52 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (5.15s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/29 04:52:53 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:53 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:53 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:53 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/29 04:52:53 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/29 04:52:53 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:53 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:55 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/29 04:52:55 INFO : potato: Copied (new) 2025/08/29 04:52:55 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:55 INFO : sub/yam: Copied (new) 2025/08/29 04:52:55 DEBUG : Waiting for deletions to finish 2025/08/29 04:52:56 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 04:52:56 DEBUG : potato: Unchanged skipping 2025/08/29 04:52:56 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Making map for --track-renames 2025/08/29 04:52:56 INFO : proton drive root link ID 'rclone-test-povuduc8zumu': Finished making map for --track-renames 2025/08/29 04:52:56 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:56 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for renames to finish 2025/08/29 04:52:56.737794 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EVhfSUEOQ_Bl_kICWlm3hvkOoJMNCs3GFkCvkRBkITZmuYDF2t2segbueUBHfWp9DcT_VKlhQTN8Ib7cNqEIag==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:52:56.737834 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EVhfSUEOQ_Bl_kICWlm3hvkOoJMNCs3GFkCvkRBkITZmuYDF2t2segbueUBHfWp9DcT_VKlhQTN8Ib7cNqEIag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:56 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EVhfSUEOQ_Bl_kICWlm3hvkOoJMNCs3GFkCvkRBkITZmuYDF2t2segbueUBHfWp9DcT_VKlhQTN8Ib7cNqEIag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:56 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EVhfSUEOQ_Bl_kICWlm3hvkOoJMNCs3GFkCvkRBkITZmuYDF2t2segbueUBHfWp9DcT_VKlhQTN8Ib7cNqEIag==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:52:56 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/29 04:52:56 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:52:58 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/29 04:52:58 INFO : yam: Copied (new) 2025/08/29 04:52:58 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting files as there were IO errors 2025/08/29 04:52:58 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (6.41s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:52:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/29 04:52:59 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/29 04:52:59 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for checks to finish 2025/08/29 04:52:59 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Waiting for transfers to finish 2025/08/29 04:53:02 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/29 04:53:02 INFO : nested/sub dir/file: Copied (new) 2025/08/29 04:53:02 INFO : nested/sub dir/file: Deleted 2025/08/29 04:53:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/29 04:53:02 INFO : sub dir/hello world: Copied (new) 2025/08/29 04:53:02 INFO : sub dir/hello world: Deleted 2025/08/29 04:53:02 ERROR : Local file system at /tmp/rclone1401195264: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (4.56s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:53:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zoxatef2piqa" 2025/08/29 04:53:04 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Has cached credentials 2025/08/29 04:53:05 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-povuduc8zumu' -> proton drive root link ID 'rclone-test-zoxatef2piqa' 2025/08/29 04:53:13 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Using server-side directory move 2025/08/29 04:53:13 INFO : proton drive root link ID 'rclone-test-zoxatef2piqa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/29 04:53:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/29 04:53:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/29 04:53:13 DEBUG : empty space: Unchanged skipping 2025/08/29 04:53:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/29 04:53:13 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Waiting for checks to finish 2025/08/29 04:53:13 INFO : empty space: Deleted 2025/08/29 04:53:13 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Waiting for transfers to finish 2025/08/29 04:53:13 INFO : potato3: Deleted 2025/08/29 04:53:14.014079 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NhJteNEajTgA64cASJEaybzdGN9ztp074NGnn4JLFPyDC6nXT62jetSPd5qTO3q9IQBCKnfSdcqqPKFTN-LJ1w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:14.014108 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NhJteNEajTgA64cASJEaybzdGN9ztp074NGnn4JLFPyDC6nXT62jetSPd5qTO3q9IQBCKnfSdcqqPKFTN-LJ1w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:14 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NhJteNEajTgA64cASJEaybzdGN9ztp074NGnn4JLFPyDC6nXT62jetSPd5qTO3q9IQBCKnfSdcqqPKFTN-LJ1w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:14.123502 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MKHU8SQFWxmiVvxV5DcJSRKzizFWhSCLPti6LeS0F-7z35DdS01re2in3LkUuT0j1ZyzOqJMbaMMPTff3c4gpA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:14.123540 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MKHU8SQFWxmiVvxV5DcJSRKzizFWhSCLPti6LeS0F-7z35DdS01re2in3LkUuT0j1ZyzOqJMbaMMPTff3c4gpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:14 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MKHU8SQFWxmiVvxV5DcJSRKzizFWhSCLPti6LeS0F-7z35DdS01re2in3LkUuT0j1ZyzOqJMbaMMPTff3c4gpA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1911 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MKHU8SQFWxmiVvxV5DcJSRKzizFWhSCLPti6LeS0F-7z35DdS01re2in3LkUuT0j1ZyzOqJMbaMMPTff3c4gpA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/29 04:53:14 DEBUG : proton drive root link ID 'rclone-test-zoxatef2piqa': Purge remote --- FAIL: TestServerSideMove (11.19s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:53:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pacurek5yipa" 2025/08/29 04:53:15 DEBUG : proton drive root link ID 'rclone-test-pacurek5yipa': Has cached credentials 2025/08/29 04:53:16 DEBUG : proton drive root link ID 'rclone-test-pacurek5yipa': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-povuduc8zumu' -> proton drive root link ID 'rclone-test-pacurek5yipa' 2025/08/29 04:53:24 DEBUG : empty space: Excluded (Size Filter) 2025/08/29 04:53:24 DEBUG : empty space: Excluded 2025/08/29 04:53:24 DEBUG : empty space: Excluded (Size Filter) 2025/08/29 04:53:24 DEBUG : empty space: Excluded 2025/08/29 04:53:24 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/29 04:53:24 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/29 04:53:24 DEBUG : proton drive root link ID 'rclone-test-pacurek5yipa': Waiting for checks to finish 2025/08/29 04:53:24 DEBUG : proton drive root link ID 'rclone-test-pacurek5yipa': Waiting for transfers to finish 2025/08/29 04:53:24 INFO : potato3: Deleted 2025/08/29 04:53:24.987362 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jF36XhCfTBQFj6fQCBUyVHrFsE5Mkvr-MgEZ1fnSk5XfSN0Xjvtl3FIBOConXPhnDPBUDfBDwy8ntZm3b1nwrg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:24.987402 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jF36XhCfTBQFj6fQCBUyVHrFsE5Mkvr-MgEZ1fnSk5XfSN0Xjvtl3FIBOConXPhnDPBUDfBDwy8ntZm3b1nwrg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:24 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jF36XhCfTBQFj6fQCBUyVHrFsE5Mkvr-MgEZ1fnSk5XfSN0Xjvtl3FIBOConXPhnDPBUDfBDwy8ntZm3b1nwrg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:25.071019 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yoVUU2BbxMxVfTDoUrxfm_4VeCj4gWj0ZG9tZT8hXiO_GpdcV55S7RPHZXnD1cMhBso9HJaLGQ3a2SJ-iPgQ7Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:25.071052 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yoVUU2BbxMxVfTDoUrxfm_4VeCj4gWj0ZG9tZT8hXiO_GpdcV55S7RPHZXnD1cMhBso9HJaLGQ3a2SJ-iPgQ7Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:25 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yoVUU2BbxMxVfTDoUrxfm_4VeCj4gWj0ZG9tZT8hXiO_GpdcV55S7RPHZXnD1cMhBso9HJaLGQ3a2SJ-iPgQ7Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1924 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yoVUU2BbxMxVfTDoUrxfm_4VeCj4gWj0ZG9tZT8hXiO_GpdcV55S7RPHZXnD1cMhBso9HJaLGQ3a2SJ-iPgQ7Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/29 04:53:25 DEBUG : proton drive root link ID 'rclone-test-pacurek5yipa': Purge remote --- FAIL: TestServerSideMoveWithFilter (11.12s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:53:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sicayat2voqo" 2025/08/29 04:53:26 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Has cached credentials 2025/08/29 04:53:27 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Used cached credential to initialize the ProtonDrive API 2025/08/29 04:53:31 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-povuduc8zumu' -> proton drive root link ID 'rclone-test-sicayat2voqo' 2025/08/29 04:53:35 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Using server-side directory move 2025/08/29 04:53:35 INFO : proton drive root link ID 'rclone-test-sicayat2voqo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/29 04:53:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/29 04:53:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/29 04:53:36 DEBUG : empty space: Unchanged skipping 2025/08/29 04:53:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/29 04:53:36 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Waiting for checks to finish 2025/08/29 04:53:36 INFO : empty space: Deleted 2025/08/29 04:53:36 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Waiting for transfers to finish 2025/08/29 04:53:36 INFO : potato3: Deleted 2025/08/29 04:53:36.651126 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hegwUf-T0yypWNgRfQXdvh_AD3LeaWz-NgE144XITy9GT84kGSnEtJqapotd_myeH2gS0rFUJINdyzDqST1CgA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:36.651156 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hegwUf-T0yypWNgRfQXdvh_AD3LeaWz-NgE144XITy9GT84kGSnEtJqapotd_myeH2gS0rFUJINdyzDqST1CgA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:36 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hegwUf-T0yypWNgRfQXdvh_AD3LeaWz-NgE144XITy9GT84kGSnEtJqapotd_myeH2gS0rFUJINdyzDqST1CgA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:36.759009 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/js1yIAPUBkPafxaO3kM0Qav4KgkZ26yD8wgYGAV3qNTgZcdECvPmV5kXIxHzU3gOp6zElGOGUeUO6HQPy8U4-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:53:36.759056 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/js1yIAPUBkPafxaO3kM0Qav4KgkZ26yD8wgYGAV3qNTgZcdECvPmV5kXIxHzU3gOp6zElGOGUeUO6HQPy8U4-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:36 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/js1yIAPUBkPafxaO3kM0Qav4KgkZ26yD8wgYGAV3qNTgZcdECvPmV5kXIxHzU3gOp6zElGOGUeUO6HQPy8U4-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:53:36 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/29 04:53:36 DEBUG : proton drive root link ID 'rclone-test-sicayat2voqo': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (11.82s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:53:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/dst" 2025/08/29 04:53:43 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Has cached credentials 2025/08/29 04:53:44 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/29 04:55:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/backup" 2025/08/29 04:55:20 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Has cached credentials 2025/08/29 04:55:20 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/29 04:58:36 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for checks to finish 2025/08/29 04:58:36 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/29 04:58:36 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 04:58:36 DEBUG : two: Unchanged skipping 2025/08/29 04:58:37.747608 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EwQe0Ql0kaAYgAgj2DI-UdWq8vJEAV-PiMo6oCiPbaAdIYSTJO6rwOqGjD8Qf-p03UUcwTgFrnOns1NeSKdptw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 04:58:37.747653 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EwQe0Ql0kaAYgAgj2DI-UdWq8vJEAV-PiMo6oCiPbaAdIYSTJO6rwOqGjD8Qf-p03UUcwTgFrnOns1NeSKdptw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:58:37 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EwQe0Ql0kaAYgAgj2DI-UdWq8vJEAV-PiMo6oCiPbaAdIYSTJO6rwOqGjD8Qf-p03UUcwTgFrnOns1NeSKdptw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 04:58:37 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for transfers to finish 2025/08/29 04:58:37 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting files as there were IO errors 2025/08/29 04:58:37 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EwQe0Ql0kaAYgAgj2DI-UdWq8vJEAV-PiMo6oCiPbaAdIYSTJO6rwOqGjD8Qf-p03UUcwTgFrnOns1NeSKdptw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (301.36s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 04:58:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/dst" 2025/08/29 04:58:44 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Has cached credentials 2025/08/29 04:58:45 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/29 05:00:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/backup" 2025/08/29 05:00:21 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Has cached credentials 2025/08/29 05:00:22 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/29 05:03:34 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 05:03:34 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for checks to finish 2025/08/29 05:03:34 DEBUG : two: Unchanged skipping 2025/08/29 05:03:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/29 05:03:35.230894 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jyotGZW6_G5Jj3OzgLoZuZ1JUwU8J95UWM52sVtL2bH0KCZr0H_sFk-scx_uREYjpK-tz6scY6y0QIaSRNrZww==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 05:03:35.230945 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jyotGZW6_G5Jj3OzgLoZuZ1JUwU8J95UWM52sVtL2bH0KCZr0H_sFk-scx_uREYjpK-tz6scY6y0QIaSRNrZww==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:03:35 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jyotGZW6_G5Jj3OzgLoZuZ1JUwU8J95UWM52sVtL2bH0KCZr0H_sFk-scx_uREYjpK-tz6scY6y0QIaSRNrZww==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:03:35 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for transfers to finish 2025/08/29 05:03:35 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting files as there were IO errors 2025/08/29 05:03:35 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jyotGZW6_G5Jj3OzgLoZuZ1JUwU8J95UWM52sVtL2bH0KCZr0H_sFk-scx_uREYjpK-tz6scY6y0QIaSRNrZww==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (297.39s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 05:03:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/dst" 2025/08/29 05:03:42 DEBUG : Config file has changed externally - reloading 2025/08/29 05:03:42 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Has cached credentials 2025/08/29 05:03:43 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/29 05:05:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/backup" 2025/08/29 05:05:21 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Has cached credentials 2025/08/29 05:05:21 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/29 05:08:38 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/29 05:08:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 05:08:38 DEBUG : two: Unchanged skipping 2025/08/29 05:08:38 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for checks to finish 2025/08/29 05:08:39.150611 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/n1mrU885qV0a_IXCqNKYPfafhHm_E-sSc5y484zn4gmDR8Iij93q3Ab0-qETtr37wEeiS4uXp1E4P3mh9yUU0Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 05:08:39.150651 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/n1mrU885qV0a_IXCqNKYPfafhHm_E-sSc5y484zn4gmDR8Iij93q3Ab0-qETtr37wEeiS4uXp1E4P3mh9yUU0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:08:39 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/n1mrU885qV0a_IXCqNKYPfafhHm_E-sSc5y484zn4gmDR8Iij93q3Ab0-qETtr37wEeiS4uXp1E4P3mh9yUU0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:08:39 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for transfers to finish 2025/08/29 05:08:39 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting files as there were IO errors 2025/08/29 05:08:39 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/n1mrU885qV0a_IXCqNKYPfafhHm_E-sSc5y484zn4gmDR8Iij93q3Ab0-qETtr37wEeiS4uXp1E4P3mh9yUU0Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (303.93s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-povuduc8zumu'", Local "Local file system at /tmp/rclone1401195264", Modify Window "1s" 2025/08/29 05:08:46 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-povuduc8zumu/dst" 2025/08/29 05:08:46 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Has cached credentials 2025/08/29 05:08:46 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/29 05:10:26 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/29 05:10:26 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for checks to finish 2025/08/29 05:10:26 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/29 05:10:26 DEBUG : two: Unchanged skipping 2025/08/29 05:10:26.498988 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z0cAV3Uvo043qDcRY4g8Pu9zOxJXZpXOSHkp2X5j3PldR5dejd7iRvA9aqhUgxCTKNIMDXMZr94zC0wEcbUPwQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/29 05:10:26.499051 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z0cAV3Uvo043qDcRY4g8Pu9zOxJXZpXOSHkp2X5j3PldR5dejd7iRvA9aqhUgxCTKNIMDXMZr94zC0wEcbUPwQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:10:26 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z0cAV3Uvo043qDcRY4g8Pu9zOxJXZpXOSHkp2X5j3PldR5dejd7iRvA9aqhUgxCTKNIMDXMZr94zC0wEcbUPwQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/29 05:10:26 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu/dst': Waiting for transfers to finish 2025/08/29 05:10:26 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting files as there were IO errors 2025/08/29 05:10:26 ERROR : proton drive root link ID 'rclone-test-povuduc8zumu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z0cAV3Uvo043qDcRY4g8Pu9zOxJXZpXOSHkp2X5j3PldR5dejd7iRvA9aqhUgxCTKNIMDXMZr94zC0wEcbUPwQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (107.01s) FAIL 2025/08/29 05:10:28 DEBUG : proton drive root link ID 'rclone-test-povuduc8zumu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 17m59.214141579s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]