"./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 4/5) 2025/09/01 05:52:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju" 2025/09/01 05:52:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/01 05:52:42 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Has cached credentials 2025/09/01 05:52:44 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Used cached credential to initialize the ProtonDrive API 2025/09/01 05:52:45 DEBUG : Creating backend with remote "/tmp/rclone875141195" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:52:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dolexum5yuqu" 2025/09/01 05:52:50 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Has cached credentials 2025/09/01 05:52:52 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-niqijag9weju' -> proton drive root link ID 'rclone-test-dolexum5yuqu' 2025/09/01 05:52:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/01 05:52:54 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Waiting for checks to finish 2025/09/01 05:52:54 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Waiting for transfers to finish 2025/09/01 05:52:59 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/01 05:52:59 INFO : sub dir/hello world: Copied (new) 2025/09/01 05:53:01.259126 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/09/01 05:53:01.259168 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/09/01 05:53:04 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Using server-side directory move 2025/09/01 05:53:04 INFO : proton drive root link ID 'rclone-test-dolexum5yuqu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/01 05:53:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/01 05:53:05 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Waiting for checks to finish 2025/09/01 05:53:05 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Waiting for transfers to finish 2025/09/01 05:53:06 INFO : sub dir/hello world: Deleted 2025/09/01 05:53:07.613459 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c3ligC3PFaSJpKsNaafoOfUNSLG3SEaLN7u9pfLSjZJKneRsztnSBdG8Z_aP1yCtsrN70BNzyOYEE7BclzaxrA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:53:07.613499 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c3ligC3PFaSJpKsNaafoOfUNSLG3SEaLN7u9pfLSjZJKneRsztnSBdG8Z_aP1yCtsrN70BNzyOYEE7BclzaxrA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:07 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c3ligC3PFaSJpKsNaafoOfUNSLG3SEaLN7u9pfLSjZJKneRsztnSBdG8Z_aP1yCtsrN70BNzyOYEE7BclzaxrA==/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/c3ligC3PFaSJpKsNaafoOfUNSLG3SEaLN7u9pfLSjZJKneRsztnSBdG8Z_aP1yCtsrN70BNzyOYEE7BclzaxrA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/01 05:53:07 DEBUG : proton drive root link ID 'rclone-test-dolexum5yuqu': Purge remote --- FAIL: TestServerSideMoveOverSelf (25.96s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/01 05:53:11 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:11 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:11 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:11 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/01 05:53:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/01 05:53:11 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:11 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:13 INFO : yam: Copied (new) 2025/09/01 05:53:13 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/01 05:53:13 INFO : potato: Copied (new) 2025/09/01 05:53:13 DEBUG : Waiting for deletions to finish 2025/09/01 05:53:15 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 05:53:15 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:15 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:15 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:15 DEBUG : potato: Unchanged skipping 2025/09/01 05:53:15 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:16.547530 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oOU4PjAX-7Vse6vGuu9Jhztv51aOFHVi8UuxdFLEBWgqGnQEczhSjfFH58Wd2Af1slTz-Bs1EmkFvnanvChygA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:53:16.547561 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oOU4PjAX-7Vse6vGuu9Jhztv51aOFHVi8UuxdFLEBWgqGnQEczhSjfFH58Wd2Af1slTz-Bs1EmkFvnanvChygA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:16 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oOU4PjAX-7Vse6vGuu9Jhztv51aOFHVi8UuxdFLEBWgqGnQEczhSjfFH58Wd2Af1slTz-Bs1EmkFvnanvChygA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:16 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oOU4PjAX-7Vse6vGuu9Jhztv51aOFHVi8UuxdFLEBWgqGnQEczhSjfFH58Wd2Af1slTz-Bs1EmkFvnanvChygA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:16 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/01 05:53:16 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:18 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:18 INFO : yaml: Copied (new) 2025/09/01 05:53:18 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': not deleting files as there were IO errors 2025/09/01 05:53:18 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': 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.21s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/01 05:53:22 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:22 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:22 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:22 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/01 05:53:22 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:22 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/01 05:53:22 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:23 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/01 05:53:23 INFO : potato: Copied (new) 2025/09/01 05:53:23 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:23 INFO : yam: Copied (new) 2025/09/01 05:53:23 DEBUG : Waiting for deletions to finish 2025/09/01 05:53:25 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 05:53:25 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:25 DEBUG : potato: Unchanged skipping 2025/09/01 05:53:25 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:25 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:25 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:26.724182 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8CgaYhC7CWloKFs51Dcyzxolq1KkwYTlMgsozBSlqG6t_hVmiHzlaoPPyJJWwUL-CPSVfYcw8px1LTLIXMgeDA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:53:26.724223 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8CgaYhC7CWloKFs51Dcyzxolq1KkwYTlMgsozBSlqG6t_hVmiHzlaoPPyJJWwUL-CPSVfYcw8px1LTLIXMgeDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:26 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8CgaYhC7CWloKFs51Dcyzxolq1KkwYTlMgsozBSlqG6t_hVmiHzlaoPPyJJWwUL-CPSVfYcw8px1LTLIXMgeDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:26 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8CgaYhC7CWloKFs51Dcyzxolq1KkwYTlMgsozBSlqG6t_hVmiHzlaoPPyJJWwUL-CPSVfYcw8px1LTLIXMgeDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:26 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/01 05:53:26 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:28 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:28 INFO : yaml: Copied (new) 2025/09/01 05:53:28 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': not deleting files as there were IO errors 2025/09/01 05:53:28 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': 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.19s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/01 05:53:32 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:32 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:32 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:32 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:32 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/01 05:53:32 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/01 05:53:32 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:35 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/01 05:53:35 INFO : potato: Copied (new) 2025/09/01 05:53:35 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:35 INFO : sub/yam: Copied (new) 2025/09/01 05:53:35 DEBUG : Waiting for deletions to finish 2025/09/01 05:53:37 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 05:53:37 DEBUG : potato: Unchanged skipping 2025/09/01 05:53:37 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Making map for --track-renames 2025/09/01 05:53:37 INFO : proton drive root link ID 'rclone-test-niqijag9weju': Finished making map for --track-renames 2025/09/01 05:53:37 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:37 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for renames to finish 2025/09/01 05:53:39.046190 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_hw4ZLsG8-sUk-7LswPO2CYFqT_nx9z_vPfBV5le-H1SkNE9UmZr5xKzXeqCXdeoEMZ-GjT9tBm155fSMUZ-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:53:39.046224 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_hw4ZLsG8-sUk-7LswPO2CYFqT_nx9z_vPfBV5le-H1SkNE9UmZr5xKzXeqCXdeoEMZ-GjT9tBm155fSMUZ-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:39 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_hw4ZLsG8-sUk-7LswPO2CYFqT_nx9z_vPfBV5le-H1SkNE9UmZr5xKzXeqCXdeoEMZ-GjT9tBm155fSMUZ-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:39 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B_hw4ZLsG8-sUk-7LswPO2CYFqT_nx9z_vPfBV5le-H1SkNE9UmZr5xKzXeqCXdeoEMZ-GjT9tBm155fSMUZ-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:53:39 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/01 05:53:39 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:40 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/01 05:53:40 INFO : yam: Copied (new) 2025/09/01 05:53:40 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': not deleting files as there were IO errors 2025/09/01 05:53:40 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': 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 (12.85s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:53:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/01 05:53:45 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/01 05:53:45 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for checks to finish 2025/09/01 05:53:45 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': Waiting for transfers to finish 2025/09/01 05:53:49 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/01 05:53:49 INFO : nested/sub dir/file: Copied (new) 2025/09/01 05:53:49 INFO : nested/sub dir/file: Deleted 2025/09/01 05:53:49 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/01 05:53:49 INFO : sub dir/hello world: Copied (new) 2025/09/01 05:53:49 INFO : sub dir/hello world: Deleted 2025/09/01 05:53:49 ERROR : Local file system at /tmp/rclone875141195: 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 (9.49s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:53:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qezojel1jihi" 2025/09/01 05:53:54 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Has cached credentials 2025/09/01 05:53:56 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-niqijag9weju' -> proton drive root link ID 'rclone-test-qezojel1jihi' 2025/09/01 05:54:07 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Using server-side directory move 2025/09/01 05:54:07 INFO : proton drive root link ID 'rclone-test-qezojel1jihi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/01 05:54:08 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/01 05:54:08 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/01 05:54:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/01 05:54:08 DEBUG : empty space: Unchanged skipping 2025/09/01 05:54:08 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Waiting for checks to finish 2025/09/01 05:54:09 INFO : empty space: Deleted 2025/09/01 05:54:09 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Waiting for transfers to finish 2025/09/01 05:54:09 INFO : potato3: Deleted 2025/09/01 05:54:09.815924 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PNOgxWpt_aP3ZgTa5yTTfhOdXFOV9UZHa-gvhdnuLCE3bJTB05LZHIvou6qv9JS5Axw9_Xee03aX0vfi9RqudQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:09.815967 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PNOgxWpt_aP3ZgTa5yTTfhOdXFOV9UZHa-gvhdnuLCE3bJTB05LZHIvou6qv9JS5Axw9_Xee03aX0vfi9RqudQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:09 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PNOgxWpt_aP3ZgTa5yTTfhOdXFOV9UZHa-gvhdnuLCE3bJTB05LZHIvou6qv9JS5Axw9_Xee03aX0vfi9RqudQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:10.130066 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YCJuT80gubHgGE-0V2YDqrvUJz8_5Yjr1Nc_kGVeFS08C9gTCwJ01UDQwmp8l0_hIaV-Ukj8PCHlPyF8d7RDgA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:10.130102 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YCJuT80gubHgGE-0V2YDqrvUJz8_5Yjr1Nc_kGVeFS08C9gTCwJ01UDQwmp8l0_hIaV-Ukj8PCHlPyF8d7RDgA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:10 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YCJuT80gubHgGE-0V2YDqrvUJz8_5Yjr1Nc_kGVeFS08C9gTCwJ01UDQwmp8l0_hIaV-Ukj8PCHlPyF8d7RDgA==/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/YCJuT80gubHgGE-0V2YDqrvUJz8_5Yjr1Nc_kGVeFS08C9gTCwJ01UDQwmp8l0_hIaV-Ukj8PCHlPyF8d7RDgA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/01 05:54:10 DEBUG : proton drive root link ID 'rclone-test-qezojel1jihi': Purge remote --- FAIL: TestServerSideMove (19.57s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:54:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xojeyow6sibi" 2025/09/01 05:54:13 DEBUG : proton drive root link ID 'rclone-test-xojeyow6sibi': Has cached credentials 2025/09/01 05:54:15 DEBUG : proton drive root link ID 'rclone-test-xojeyow6sibi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-niqijag9weju' -> proton drive root link ID 'rclone-test-xojeyow6sibi' 2025/09/01 05:54:29 DEBUG : empty space: Excluded (Size Filter) 2025/09/01 05:54:29 DEBUG : empty space: Excluded 2025/09/01 05:54:29 DEBUG : empty space: Excluded (Size Filter) 2025/09/01 05:54:29 DEBUG : empty space: Excluded 2025/09/01 05:54:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/01 05:54:29 DEBUG : proton drive root link ID 'rclone-test-xojeyow6sibi': Waiting for checks to finish 2025/09/01 05:54:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/01 05:54:29 DEBUG : proton drive root link ID 'rclone-test-xojeyow6sibi': Waiting for transfers to finish 2025/09/01 05:54:29 INFO : potato3: Deleted 2025/09/01 05:54:30.227869 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqGF21wkXbolZz1iTZ2hp_HcOu4WHZtcdtSvT1NGHGNbPKscCINneM3veeU2O0PMBr3dADDyqEb7SVRjO_tgVg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:30.227897 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqGF21wkXbolZz1iTZ2hp_HcOu4WHZtcdtSvT1NGHGNbPKscCINneM3veeU2O0PMBr3dADDyqEb7SVRjO_tgVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:30 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqGF21wkXbolZz1iTZ2hp_HcOu4WHZtcdtSvT1NGHGNbPKscCINneM3veeU2O0PMBr3dADDyqEb7SVRjO_tgVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:30.349417 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GYUaoT7z8BO2iGuiYS9nLVcCL--6xvlq46WiupuLhuOv2OXOmwCMSrCI1oZDdokpdlfjJ44s28_zWovcSEyoHw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:30.349490 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GYUaoT7z8BO2iGuiYS9nLVcCL--6xvlq46WiupuLhuOv2OXOmwCMSrCI1oZDdokpdlfjJ44s28_zWovcSEyoHw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GYUaoT7z8BO2iGuiYS9nLVcCL--6xvlq46WiupuLhuOv2OXOmwCMSrCI1oZDdokpdlfjJ44s28_zWovcSEyoHw==/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/GYUaoT7z8BO2iGuiYS9nLVcCL--6xvlq46WiupuLhuOv2OXOmwCMSrCI1oZDdokpdlfjJ44s28_zWovcSEyoHw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/01 05:54:30 DEBUG : proton drive root link ID 'rclone-test-xojeyow6sibi': Purge remote --- FAIL: TestServerSideMoveWithFilter (20.78s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:54:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-popegul1sona" 2025/09/01 05:54:34 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Has cached credentials 2025/09/01 05:54:36 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Used cached credential to initialize the ProtonDrive API 2025/09/01 05:54:42 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-niqijag9weju' -> proton drive root link ID 'rclone-test-popegul1sona' 2025/09/01 05:54:49 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Using server-side directory move 2025/09/01 05:54:49 INFO : proton drive root link ID 'rclone-test-popegul1sona': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/01 05:54:51 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/01 05:54:51 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/01 05:54:51 DEBUG : empty space: Unchanged skipping 2025/09/01 05:54:51 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/01 05:54:51 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Waiting for checks to finish 2025/09/01 05:54:51 INFO : empty space: Deleted 2025/09/01 05:54:51 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Waiting for transfers to finish 2025/09/01 05:54:51 INFO : potato3: Deleted 2025/09/01 05:54:51.976005 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rp7L6F5TlGboJlGArd2vh0NP3UNy9dHdsTwZdP8a89aPTDqxkN2lXURfImRiqYVb2iRmf2uc6IQ_ziTXzvToSw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:51.976052 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rp7L6F5TlGboJlGArd2vh0NP3UNy9dHdsTwZdP8a89aPTDqxkN2lXURfImRiqYVb2iRmf2uc6IQ_ziTXzvToSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:51 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rp7L6F5TlGboJlGArd2vh0NP3UNy9dHdsTwZdP8a89aPTDqxkN2lXURfImRiqYVb2iRmf2uc6IQ_ziTXzvToSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:52.425600 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f9ohBX8sIoEAX2Qm7LQ3w6x3Pna8aUBUzsHg7YtaDiothR_xYzS4ILNh-ByE5Cmbnw067rmn-ramIcE2qQ_uYQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:54:52.425634 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f9ohBX8sIoEAX2Qm7LQ3w6x3Pna8aUBUzsHg7YtaDiothR_xYzS4ILNh-ByE5Cmbnw067rmn-ramIcE2qQ_uYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:52 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f9ohBX8sIoEAX2Qm7LQ3w6x3Pna8aUBUzsHg7YtaDiothR_xYzS4ILNh-ByE5Cmbnw067rmn-ramIcE2qQ_uYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:54:52 ERROR : proton drive root link ID 'rclone-test-niqijag9weju': 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/09/01 05:54:52 DEBUG : proton drive root link ID 'rclone-test-popegul1sona': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.28s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:55:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/dst" 2025/09/01 05:55:04 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Has cached credentials 2025/09/01 05:55:06 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Used cached credential to initialize the ProtonDrive API 2025/09/01 05:56:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/backup" 2025/09/01 05:56:35 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Has cached credentials 2025/09/01 05:56:37 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Used cached credential to initialize the ProtonDrive API 2025/09/01 05:59:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/01 05:59:37 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for checks to finish 2025/09/01 05:59:37 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 05:59:37 DEBUG : two: Unchanged skipping 2025/09/01 05:59:39.091743 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-RHndth5D0hmtmJ5EeHn_m6GxuLFAtdO2gsa8GqX2sM-W1OzC847bt49qxSCe8Z7IIMt1NuJZNpXvX_fhoJ0Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 05:59:39.091775 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-RHndth5D0hmtmJ5EeHn_m6GxuLFAtdO2gsa8GqX2sM-W1OzC847bt49qxSCe8Z7IIMt1NuJZNpXvX_fhoJ0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:59:39 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-RHndth5D0hmtmJ5EeHn_m6GxuLFAtdO2gsa8GqX2sM-W1OzC847bt49qxSCe8Z7IIMt1NuJZNpXvX_fhoJ0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 05:59:39 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for transfers to finish 2025/09/01 05:59:39 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/dst': not deleting files as there were IO errors 2025/09/01 05:59:39 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/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/z-RHndth5D0hmtmJ5EeHn_m6GxuLFAtdO2gsa8GqX2sM-W1OzC847bt49qxSCe8Z7IIMt1NuJZNpXvX_fhoJ0Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (287.55s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 05:59:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/dst" 2025/09/01 05:59:52 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Has cached credentials 2025/09/01 05:59:54 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Used cached credential to initialize the ProtonDrive API 2025/09/01 06:01:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/backup" 2025/09/01 06:01:24 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Has cached credentials 2025/09/01 06:01:26 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Used cached credential to initialize the ProtonDrive API 2025/09/01 06:04:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/01 06:04:23 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 06:04:23 DEBUG : two: Unchanged skipping 2025/09/01 06:04:23 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for checks to finish 2025/09/01 06:04:25.834548 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OnJy615XEIIM69zic6cvQd9IhwDpUAWqVDj8ylralG1fq9WNWSEbRfWU0s6RqTjftmE5yk29pkKohnNKmXQkRw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 06:04:25.834587 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OnJy615XEIIM69zic6cvQd9IhwDpUAWqVDj8ylralG1fq9WNWSEbRfWU0s6RqTjftmE5yk29pkKohnNKmXQkRw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:04:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OnJy615XEIIM69zic6cvQd9IhwDpUAWqVDj8ylralG1fq9WNWSEbRfWU0s6RqTjftmE5yk29pkKohnNKmXQkRw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:04:25 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for transfers to finish 2025/09/01 06:04:25 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/dst': not deleting files as there were IO errors 2025/09/01 06:04:25 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/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/OnJy615XEIIM69zic6cvQd9IhwDpUAWqVDj8ylralG1fq9WNWSEbRfWU0s6RqTjftmE5yk29pkKohnNKmXQkRw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (286.75s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 06:04:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/dst" 2025/09/01 06:04:39 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Has cached credentials 2025/09/01 06:04:41 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Used cached credential to initialize the ProtonDrive API 2025/09/01 06:06:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/backup" 2025/09/01 06:06:10 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Has cached credentials 2025/09/01 06:06:12 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/backup': Used cached credential to initialize the ProtonDrive API 2025/09/01 06:08:33.001737 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=132&PageSize=150&ShowAll=1": read tcp 65.108.87.141:52444->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/01 06:09:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/01 06:09:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 06:09:12 DEBUG : two: Unchanged skipping 2025/09/01 06:09:12 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for checks to finish 2025/09/01 06:09:14.572401 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i9LT1Ed57gwcDeO3re2gZdfmP2VsM62szIiVQj1qyKE3GJ283yjGAnVITHXsZQ2QkVYNylUKPxNu2djPCZvhIA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 06:09:14.572441 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i9LT1Ed57gwcDeO3re2gZdfmP2VsM62szIiVQj1qyKE3GJ283yjGAnVITHXsZQ2QkVYNylUKPxNu2djPCZvhIA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:09:14 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i9LT1Ed57gwcDeO3re2gZdfmP2VsM62szIiVQj1qyKE3GJ283yjGAnVITHXsZQ2QkVYNylUKPxNu2djPCZvhIA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:09:14 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for transfers to finish 2025/09/01 06:09:14 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/dst': not deleting files as there were IO errors 2025/09/01 06:09:14 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/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/i9LT1Ed57gwcDeO3re2gZdfmP2VsM62szIiVQj1qyKE3GJ283yjGAnVITHXsZQ2QkVYNylUKPxNu2djPCZvhIA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (288.95s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-niqijag9weju'", Local "Local file system at /tmp/rclone875141195", Modify Window "1s" 2025/09/01 06:09:28 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-niqijag9weju/dst" 2025/09/01 06:09:28 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Has cached credentials 2025/09/01 06:09:30 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Used cached credential to initialize the ProtonDrive API 2025/09/01 06:11:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/01 06:11:02 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for checks to finish 2025/09/01 06:11:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/01 06:11:02 DEBUG : two: Unchanged skipping 2025/09/01 06:11:02.907471 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9re8p3HnXlCgz8xUo0UJGEiVPtJdyVzsRjNhs0opbVvqdLBtcg7cPDGL8noz30cRNOx1iGmhT99sGQ_K9YdnEA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/01 06:11:02.907516 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9re8p3HnXlCgz8xUo0UJGEiVPtJdyVzsRjNhs0opbVvqdLBtcg7cPDGL8noz30cRNOx1iGmhT99sGQ_K9YdnEA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:11:02 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9re8p3HnXlCgz8xUo0UJGEiVPtJdyVzsRjNhs0opbVvqdLBtcg7cPDGL8noz30cRNOx1iGmhT99sGQ_K9YdnEA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/01 06:11:02 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju/dst': Waiting for transfers to finish 2025/09/01 06:11:02 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/dst': not deleting files as there were IO errors 2025/09/01 06:11:02 ERROR : proton drive root link ID 'rclone-test-niqijag9weju/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/9re8p3HnXlCgz8xUo0UJGEiVPtJdyVzsRjNhs0opbVvqdLBtcg7cPDGL8noz30cRNOx1iGmhT99sGQ_K9YdnEA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (107.80s) FAIL 2025/09/01 06:11:07 DEBUG : proton drive root link ID 'rclone-test-niqijag9weju': 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 18m26.129773684s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]