"./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/07/31 06:01:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo" 2025/07/31 06:01:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/31 06:01:15 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Has cached credentials 2025/07/31 06:01:17 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:01:17 DEBUG : Creating backend with remote "/tmp/rclone4018717099" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:01:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wisapur3fode" 2025/07/31 06:01:23 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Has cached credentials 2025/07/31 06:01:25 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-tesoliy2feyo' -> proton drive root link ID 'rclone-test-wisapur3fode' 2025/07/31 06:01:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/31 06:01:26 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Waiting for checks to finish 2025/07/31 06:01:26 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Waiting for transfers to finish 2025/07/31 06:01:31 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/31 06:01:31 INFO : sub dir/hello world: Copied (new) 2025/07/31 06:01:33.938597 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/07/31 06:01:33.938746 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/07/31 06:01:36 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Using server-side directory move 2025/07/31 06:01:36 INFO : proton drive root link ID 'rclone-test-wisapur3fode': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/31 06:01:38 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/31 06:01:38 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Waiting for checks to finish 2025/07/31 06:01:38 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Waiting for transfers to finish 2025/07/31 06:01:38 INFO : sub dir/hello world: Deleted 2025/07/31 06:01:40.133367 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xh7l8JIgqKM2BhBS1oM77aMe4GbVyQ4R73o1vutZWjOdwsAKqqHTxOoSMna8Qy6R0vnEBvBSlCiJKqiaXTDJhw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:01:40.133734 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xh7l8JIgqKM2BhBS1oM77aMe4GbVyQ4R73o1vutZWjOdwsAKqqHTxOoSMna8Qy6R0vnEBvBSlCiJKqiaXTDJhw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:40 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xh7l8JIgqKM2BhBS1oM77aMe4GbVyQ4R73o1vutZWjOdwsAKqqHTxOoSMna8Qy6R0vnEBvBSlCiJKqiaXTDJhw==/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/xh7l8JIgqKM2BhBS1oM77aMe4GbVyQ4R73o1vutZWjOdwsAKqqHTxOoSMna8Qy6R0vnEBvBSlCiJKqiaXTDJhw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/31 06:01:40 DEBUG : proton drive root link ID 'rclone-test-wisapur3fode': Purge remote --- FAIL: TestServerSideMoveOverSelf (26.27s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/07/31 06:01:44 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:01:44 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:01:44 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:01:44 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:01:44 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/31 06:01:44 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/31 06:01:44 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:01:46 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:01:46 INFO : yam: Copied (new) 2025/07/31 06:01:46 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/31 06:01:46 INFO : potato: Copied (new) 2025/07/31 06:01:46 DEBUG : Waiting for deletions to finish 2025/07/31 06:01:48 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:01:48 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:01:48 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:01:48 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:01:48 DEBUG : potato: Unchanged skipping 2025/07/31 06:01:48 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:01:49.424470 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lPrYyaQLTw9ZyLdsvOuaHwP447IW7kTCA4NrYvp6hxPvRky81SCP7sQxoty2JUFTfD3M92zqQGvLbMAquCp1QQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:01:49.424591 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lPrYyaQLTw9ZyLdsvOuaHwP447IW7kTCA4NrYvp6hxPvRky81SCP7sQxoty2JUFTfD3M92zqQGvLbMAquCp1QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:49 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lPrYyaQLTw9ZyLdsvOuaHwP447IW7kTCA4NrYvp6hxPvRky81SCP7sQxoty2JUFTfD3M92zqQGvLbMAquCp1QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:49 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/lPrYyaQLTw9ZyLdsvOuaHwP447IW7kTCA4NrYvp6hxPvRky81SCP7sQxoty2JUFTfD3M92zqQGvLbMAquCp1QQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:49 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/31 06:01:49 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:01:51 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:01:51 INFO : yaml: Copied (new) 2025/07/31 06:01:51 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': not deleting files as there were IO errors 2025/07/31 06:01:51 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': 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 (10.68s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/07/31 06:01:55 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:01:55 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:01:55 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:01:55 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/31 06:01:55 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/31 06:01:55 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:01:55 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:01:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:01:57 INFO : yam: Copied (new) 2025/07/31 06:01:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/31 06:01:57 INFO : potato: Copied (new) 2025/07/31 06:01:57 DEBUG : Waiting for deletions to finish 2025/07/31 06:01:59 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:01:59 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:01:59 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:01:59 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:01:59 DEBUG : potato: Unchanged skipping 2025/07/31 06:01:59 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:01:59.977364 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l66criHxWTSbJDpjlXb8485DIFTEClWdF9NtKcfcyOkPwDSwOXk0c09bYF3ssR3SylXYwyg8vox66X8pt5xcFA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:01:59.977415 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l66criHxWTSbJDpjlXb8485DIFTEClWdF9NtKcfcyOkPwDSwOXk0c09bYF3ssR3SylXYwyg8vox66X8pt5xcFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:59 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l66criHxWTSbJDpjlXb8485DIFTEClWdF9NtKcfcyOkPwDSwOXk0c09bYF3ssR3SylXYwyg8vox66X8pt5xcFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:59 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/l66criHxWTSbJDpjlXb8485DIFTEClWdF9NtKcfcyOkPwDSwOXk0c09bYF3ssR3SylXYwyg8vox66X8pt5xcFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:01:59 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/31 06:01:59 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:02:01 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:02:01 INFO : yaml: Copied (new) 2025/07/31 06:02:01 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': not deleting files as there were IO errors 2025/07/31 06:02:01 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': 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 (10.41s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/07/31 06:02:05 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:02:05 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:02:05 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:02:05 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/31 06:02:05 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/31 06:02:05 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:02:05 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:02:08 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/31 06:02:08 INFO : potato: Copied (new) 2025/07/31 06:02:08 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:02:08 INFO : sub/yam: Copied (new) 2025/07/31 06:02:08 DEBUG : Waiting for deletions to finish 2025/07/31 06:02:10 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:02:10 DEBUG : potato: Unchanged skipping 2025/07/31 06:02:11 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Making map for --track-renames 2025/07/31 06:02:11 INFO : proton drive root link ID 'rclone-test-tesoliy2feyo': Finished making map for --track-renames 2025/07/31 06:02:11 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:02:11 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for renames to finish 2025/07/31 06:02:12.422237 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PchxEyd3PtAgexn5LHdHmqSjZqECqsZGQgD7bmAG7-2ML8rigp_fyZay7LuLUcyiWutq3LFAUn4N8RFNBnMBGg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:02:12.422282 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PchxEyd3PtAgexn5LHdHmqSjZqECqsZGQgD7bmAG7-2ML8rigp_fyZay7LuLUcyiWutq3LFAUn4N8RFNBnMBGg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:12 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PchxEyd3PtAgexn5LHdHmqSjZqECqsZGQgD7bmAG7-2ML8rigp_fyZay7LuLUcyiWutq3LFAUn4N8RFNBnMBGg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:12 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PchxEyd3PtAgexn5LHdHmqSjZqECqsZGQgD7bmAG7-2ML8rigp_fyZay7LuLUcyiWutq3LFAUn4N8RFNBnMBGg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:12 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/31 06:02:12 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:02:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/31 06:02:13 INFO : yam: Copied (new) 2025/07/31 06:02:13 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': not deleting files as there were IO errors 2025/07/31 06:02:13 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': 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 (13.43s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:02:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/31 06:02:19 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/31 06:02:19 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for checks to finish 2025/07/31 06:02:19 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': Waiting for transfers to finish 2025/07/31 06:02:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/31 06:02:23 INFO : sub dir/hello world: Copied (new) 2025/07/31 06:02:23 INFO : sub dir/hello world: Deleted 2025/07/31 06:02:23 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/31 06:02:23 INFO : nested/sub dir/file: Copied (new) 2025/07/31 06:02:23 INFO : nested/sub dir/file: Deleted 2025/07/31 06:02:23 ERROR : Local file system at /tmp/rclone4018717099: 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 (10.24s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:02:28 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cevoyic4diba" 2025/07/31 06:02:28 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Has cached credentials 2025/07/31 06:02:31 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-tesoliy2feyo' -> proton drive root link ID 'rclone-test-cevoyic4diba' 2025/07/31 06:02:44 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Using server-side directory move 2025/07/31 06:02:44 INFO : proton drive root link ID 'rclone-test-cevoyic4diba': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/31 06:02:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/31 06:02:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/31 06:02:45 DEBUG : empty space: Unchanged skipping 2025/07/31 06:02:45 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Waiting for checks to finish 2025/07/31 06:02:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/31 06:02:46 INFO : potato3: Deleted 2025/07/31 06:02:46 INFO : empty space: Deleted 2025/07/31 06:02:46 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Waiting for transfers to finish 2025/07/31 06:02:46.473260 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9pPGnr7LqnIdxxayxPzj_9XVTJSUJfF3za3faf2Nz5R1MzmxNG_pvnrDNjtutvHGWQrH-GmNrXrAvcfvG5pWjQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:02:46.473306 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9pPGnr7LqnIdxxayxPzj_9XVTJSUJfF3za3faf2Nz5R1MzmxNG_pvnrDNjtutvHGWQrH-GmNrXrAvcfvG5pWjQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:46 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9pPGnr7LqnIdxxayxPzj_9XVTJSUJfF3za3faf2Nz5R1MzmxNG_pvnrDNjtutvHGWQrH-GmNrXrAvcfvG5pWjQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:46.668227 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/57TBnvAFxYC-IuK3Q6k6e6nbMB2x5fp6DrsINX7Z7iMXxAbx4TQRVtcBS5KdS_Lsgtg9dAf0hwrv3FNSzALD9A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:02:46.668264 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/57TBnvAFxYC-IuK3Q6k6e6nbMB2x5fp6DrsINX7Z7iMXxAbx4TQRVtcBS5KdS_Lsgtg9dAf0hwrv3FNSzALD9A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:02:46 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/57TBnvAFxYC-IuK3Q6k6e6nbMB2x5fp6DrsINX7Z7iMXxAbx4TQRVtcBS5KdS_Lsgtg9dAf0hwrv3FNSzALD9A==/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/57TBnvAFxYC-IuK3Q6k6e6nbMB2x5fp6DrsINX7Z7iMXxAbx4TQRVtcBS5KdS_Lsgtg9dAf0hwrv3FNSzALD9A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/31 06:02:46 DEBUG : proton drive root link ID 'rclone-test-cevoyic4diba': Purge remote --- FAIL: TestServerSideMove (21.65s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:02:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cunocoy1bomi" 2025/07/31 06:02:50 DEBUG : proton drive root link ID 'rclone-test-cunocoy1bomi': Has cached credentials 2025/07/31 06:02:52 DEBUG : proton drive root link ID 'rclone-test-cunocoy1bomi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-tesoliy2feyo' -> proton drive root link ID 'rclone-test-cunocoy1bomi' 2025/07/31 06:03:06 DEBUG : empty space: Excluded (Size Filter) 2025/07/31 06:03:06 DEBUG : empty space: Excluded 2025/07/31 06:03:06 DEBUG : empty space: Excluded (Size Filter) 2025/07/31 06:03:06 DEBUG : empty space: Excluded 2025/07/31 06:03:06 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/31 06:03:06 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/31 06:03:06 DEBUG : proton drive root link ID 'rclone-test-cunocoy1bomi': Waiting for checks to finish 2025/07/31 06:03:06 DEBUG : proton drive root link ID 'rclone-test-cunocoy1bomi': Waiting for transfers to finish 2025/07/31 06:03:06 INFO : potato3: Deleted 2025/07/31 06:03:07.311677 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-4-456HiTr_aiD7djyiGZYsGDzEhpkZVxesUWA6iOFg592WKf3Dt_2hYQ7TC4Xk0Wxpy1Y49npPqS_6gunGV6Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:03:07.311718 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-4-456HiTr_aiD7djyiGZYsGDzEhpkZVxesUWA6iOFg592WKf3Dt_2hYQ7TC4Xk0Wxpy1Y49npPqS_6gunGV6Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:07 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-4-456HiTr_aiD7djyiGZYsGDzEhpkZVxesUWA6iOFg592WKf3Dt_2hYQ7TC4Xk0Wxpy1Y49npPqS_6gunGV6Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:07.500698 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MnnRUPIvZeBjC9fig7rTGfgv26g5OwhknaSvRjfLpWvh8tg08PPRa0-dF1ZqjxkJYFx5F4vEU7keb5D12Mu3FA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:03:07.500750 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MnnRUPIvZeBjC9fig7rTGfgv26g5OwhknaSvRjfLpWvh8tg08PPRa0-dF1ZqjxkJYFx5F4vEU7keb5D12Mu3FA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:07 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MnnRUPIvZeBjC9fig7rTGfgv26g5OwhknaSvRjfLpWvh8tg08PPRa0-dF1ZqjxkJYFx5F4vEU7keb5D12Mu3FA==/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/MnnRUPIvZeBjC9fig7rTGfgv26g5OwhknaSvRjfLpWvh8tg08PPRa0-dF1ZqjxkJYFx5F4vEU7keb5D12Mu3FA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/31 06:03:07 DEBUG : proton drive root link ID 'rclone-test-cunocoy1bomi': Purge remote --- FAIL: TestServerSideMoveWithFilter (21.30s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:03:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kanafut2yeze" 2025/07/31 06:03:11 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Has cached credentials 2025/07/31 06:03:14 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:03:19 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-tesoliy2feyo' -> proton drive root link ID 'rclone-test-kanafut2yeze' 2025/07/31 06:03:27 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Using server-side directory move 2025/07/31 06:03:27 INFO : proton drive root link ID 'rclone-test-kanafut2yeze': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/31 06:03:28 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/31 06:03:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/31 06:03:28 DEBUG : empty space: Unchanged skipping 2025/07/31 06:03:28 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/31 06:03:29 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Waiting for checks to finish 2025/07/31 06:03:29 INFO : empty space: Deleted 2025/07/31 06:03:29 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Waiting for transfers to finish 2025/07/31 06:03:29 INFO : potato3: Deleted 2025/07/31 06:03:29.872687 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Mvn7Sk1zGqsZb6a-pNtAC3vSQiG75UXiVMMTL_wOnZy6aDSqFdK7y8MMdE0leACzVpxWaqmbZr8tOnkl_3Fpxw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:03:29.872725 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Mvn7Sk1zGqsZb6a-pNtAC3vSQiG75UXiVMMTL_wOnZy6aDSqFdK7y8MMdE0leACzVpxWaqmbZr8tOnkl_3Fpxw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:29 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Mvn7Sk1zGqsZb6a-pNtAC3vSQiG75UXiVMMTL_wOnZy6aDSqFdK7y8MMdE0leACzVpxWaqmbZr8tOnkl_3Fpxw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:30.325474 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Z_VoPrm5igfONUlP4hd6UX6Uh52ORDtYTmZ31oQk_NDRONu0QTYCq-Y047ebKJsnCi97_9wBbr8-IBe3f0aFw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:03:30.325582 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Z_VoPrm5igfONUlP4hd6UX6Uh52ORDtYTmZ31oQk_NDRONu0QTYCq-Y047ebKJsnCi97_9wBbr8-IBe3f0aFw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4Z_VoPrm5igfONUlP4hd6UX6Uh52ORDtYTmZ31oQk_NDRONu0QTYCq-Y047ebKJsnCi97_9wBbr8-IBe3f0aFw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:03:30 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo': 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/07/31 06:03:30 DEBUG : proton drive root link ID 'rclone-test-kanafut2yeze': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.77s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:03:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:03:41 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:03:44 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:05:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/backup" 2025/07/31 06:05:21 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Has cached credentials 2025/07/31 06:05:24 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:08:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:08:17 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:08:17 DEBUG : two: Unchanged skipping 2025/07/31 06:08:17 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for checks to finish 2025/07/31 06:08:20.002857 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b3IXBKB79Xxt0ol_XHZ4BeXPHzDPz5smz147b7QGbbqaDrQwMwRJVqMBBbQbhMafPdIOSzO56GtjUfqgtcDKLA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:08:20.002898 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b3IXBKB79Xxt0ol_XHZ4BeXPHzDPz5smz147b7QGbbqaDrQwMwRJVqMBBbQbhMafPdIOSzO56GtjUfqgtcDKLA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:08:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b3IXBKB79Xxt0ol_XHZ4BeXPHzDPz5smz147b7QGbbqaDrQwMwRJVqMBBbQbhMafPdIOSzO56GtjUfqgtcDKLA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:08:20 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for transfers to finish 2025/07/31 06:08:20 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': not deleting files as there were IO errors 2025/07/31 06:08:20 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/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/b3IXBKB79Xxt0ol_XHZ4BeXPHzDPz5smz147b7QGbbqaDrQwMwRJVqMBBbQbhMafPdIOSzO56GtjUfqgtcDKLA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (290.98s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:08:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:08:33 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:08:35 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:10:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/backup" 2025/07/31 06:10:00 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Has cached credentials 2025/07/31 06:10:03 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:13:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:13:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:13:02 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for checks to finish 2025/07/31 06:13:02 DEBUG : two: Unchanged skipping 2025/07/31 06:13:04.988102 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CF_QDUdtxSwYpJMxdHBv-bE-B0AnwDSZvzR0jo2rjdxMbBcbxlIIbf0YPJtnxvb1AOxJLR8aNMG0XXqpur6vaw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:13:04.988158 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CF_QDUdtxSwYpJMxdHBv-bE-B0AnwDSZvzR0jo2rjdxMbBcbxlIIbf0YPJtnxvb1AOxJLR8aNMG0XXqpur6vaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:13:04 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CF_QDUdtxSwYpJMxdHBv-bE-B0AnwDSZvzR0jo2rjdxMbBcbxlIIbf0YPJtnxvb1AOxJLR8aNMG0XXqpur6vaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:13:04 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for transfers to finish 2025/07/31 06:13:04 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': not deleting files as there were IO errors 2025/07/31 06:13:04 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/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/CF_QDUdtxSwYpJMxdHBv-bE-B0AnwDSZvzR0jo2rjdxMbBcbxlIIbf0YPJtnxvb1AOxJLR8aNMG0XXqpur6vaw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (284.57s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:13:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:13:18 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:13:20 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:14:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/backup" 2025/07/31 06:14:50 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Has cached credentials 2025/07/31 06:14:52 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:17:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:17:51 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for checks to finish 2025/07/31 06:17:51 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:17:51 DEBUG : two: Unchanged skipping 2025/07/31 06:17:54.028924 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O0vI1hmHOyrFuTjBY6kRqYyAXB-7azY0N9iBsxCypjGkwlFIq3LSA_Km1ZJ6kMKOXbyO6eCy9HPsFrJA6E-7gQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:17:54.028967 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O0vI1hmHOyrFuTjBY6kRqYyAXB-7azY0N9iBsxCypjGkwlFIq3LSA_Km1ZJ6kMKOXbyO6eCy9HPsFrJA6E-7gQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:17:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O0vI1hmHOyrFuTjBY6kRqYyAXB-7azY0N9iBsxCypjGkwlFIq3LSA_Km1ZJ6kMKOXbyO6eCy9HPsFrJA6E-7gQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:17:54 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for transfers to finish 2025/07/31 06:17:54 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': not deleting files as there were IO errors 2025/07/31 06:17:54 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/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/O0vI1hmHOyrFuTjBY6kRqYyAXB-7azY0N9iBsxCypjGkwlFIq3LSA_Km1ZJ6kMKOXbyO6eCy9HPsFrJA6E-7gQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (288.65s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:18:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:18:07 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:18:09 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:19:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:19:39 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/31 06:19:39 DEBUG : two: Unchanged skipping 2025/07/31 06:19:39 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for checks to finish 2025/07/31 06:19:40.389321 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/REA_w4FKK3uufyyt4RHhCzR2GUk91JlxtRvXJ_QSAVjSLZWjquKsllG1bc3_F_JAJxXGzCdyx3qt9YRdQTpo3Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:19:40.389372 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/REA_w4FKK3uufyyt4RHhCzR2GUk91JlxtRvXJ_QSAVjSLZWjquKsllG1bc3_F_JAJxXGzCdyx3qt9YRdQTpo3Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:19:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/REA_w4FKK3uufyyt4RHhCzR2GUk91JlxtRvXJ_QSAVjSLZWjquKsllG1bc3_F_JAJxXGzCdyx3qt9YRdQTpo3Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:19:40 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Waiting for transfers to finish 2025/07/31 06:19:40 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': not deleting files as there were IO errors 2025/07/31 06:19:40 ERROR : proton drive root link ID 'rclone-test-tesoliy2feyo/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/REA_w4FKK3uufyyt4RHhCzR2GUk91JlxtRvXJ_QSAVjSLZWjquKsllG1bc3_F_JAJxXGzCdyx3qt9YRdQTpo3Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (106.32s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:19:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:19:52 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:19:55 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:21:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:21:26.037694 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dsOpdPwp5yS8edOboY9tdY5WX5jePVawhDQKlxNVkIVfQorFEchJe6mTx7ohEmob8LuKp_tEzausQEza_-cLsg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:21:26.037762 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dsOpdPwp5yS8edOboY9tdY5WX5jePVawhDQKlxNVkIVfQorFEchJe6mTx7ohEmob8LuKp_tEzausQEza_-cLsg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:21:26 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dsOpdPwp5yS8edOboY9tdY5WX5jePVawhDQKlxNVkIVfQorFEchJe6mTx7ohEmob8LuKp_tEzausQEza_-cLsg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dsOpdPwp5yS8edOboY9tdY5WX5jePVawhDQKlxNVkIVfQorFEchJe6mTx7ohEmob8LuKp_tEzausQEza_-cLsg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (105.64s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-tesoliy2feyo'", Local "Local file system at /tmp/rclone4018717099", Modify Window "1s" 2025/07/31 06:21:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tesoliy2feyo/dst" 2025/07/31 06:21:38 DEBUG : Config file has changed externally - reloading 2025/07/31 06:21:38 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Has cached credentials 2025/07/31 06:21:41 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/31 06:23:11 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/31 06:23:12.366570 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZhR5ut50XI-ZVqjo8NQruOp0Iqa2IpZZbRZyUogskdRh1Sz_1Qc9KlwEWaLCX4QychU4pQuW27lPgzsC1G1CA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/31 06:23:12.366608 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZhR5ut50XI-ZVqjo8NQruOp0Iqa2IpZZbRZyUogskdRh1Sz_1Qc9KlwEWaLCX4QychU4pQuW27lPgzsC1G1CA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/31 06:23:12 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZhR5ut50XI-ZVqjo8NQruOp0Iqa2IpZZbRZyUogskdRh1Sz_1Qc9KlwEWaLCX4QychU4pQuW27lPgzsC1G1CA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZhR5ut50XI-ZVqjo8NQruOp0Iqa2IpZZbRZyUogskdRh1Sz_1Qc9KlwEWaLCX4QychU4pQuW27lPgzsC1G1CA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (105.72s) FAIL 2025/07/31 06:23:16 DEBUG : proton drive root link ID 'rclone-test-tesoliy2feyo': 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 22m2.114127767s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]