"./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 3/5) 2025/07/23 04:51:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi" 2025/07/23 04:51:30 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/23 04:51:30 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Has cached credentials 2025/07/23 04:51:32 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Used cached credential to initialize the ProtonDrive API 2025/07/23 04:51:33 DEBUG : Creating backend with remote "/tmp/rclone410832907" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:51:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-giziyug2hiri" 2025/07/23 04:51:38 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Has cached credentials 2025/07/23 04:51:40 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-zecujes4fimi' -> proton drive root link ID 'rclone-test-giziyug2hiri' 2025/07/23 04:51:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/23 04:51:42 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Waiting for checks to finish 2025/07/23 04:51:42 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Waiting for transfers to finish 2025/07/23 04:51:47 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/23 04:51:47 INFO : sub dir/hello world: Copied (new) 2025/07/23 04:51:50.190160 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/23 04:51:50.190208 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/23 04:51:53 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Using server-side directory move 2025/07/23 04:51:53 INFO : proton drive root link ID 'rclone-test-giziyug2hiri': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/23 04:51:54 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/23 04:51:54 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Waiting for checks to finish 2025/07/23 04:51:54 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Waiting for transfers to finish 2025/07/23 04:51:55 INFO : sub dir/hello world: Deleted 2025/07/23 04:51:57.012366 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-_V9UvVDqScJF0-hiA4aMV1BoVXTsd4AQAEJDdZA36L5n0BxRvXdAr7Zjvto48AJyWKUlW2UhR6oB-xKzlPyVA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:51:57.012416 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-_V9UvVDqScJF0-hiA4aMV1BoVXTsd4AQAEJDdZA36L5n0BxRvXdAr7Zjvto48AJyWKUlW2UhR6oB-xKzlPyVA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:51:57 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-_V9UvVDqScJF0-hiA4aMV1BoVXTsd4AQAEJDdZA36L5n0BxRvXdAr7Zjvto48AJyWKUlW2UhR6oB-xKzlPyVA==/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/-_V9UvVDqScJF0-hiA4aMV1BoVXTsd4AQAEJDdZA36L5n0BxRvXdAr7Zjvto48AJyWKUlW2UhR6oB-xKzlPyVA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/23 04:51:57 DEBUG : proton drive root link ID 'rclone-test-giziyug2hiri': Purge remote --- FAIL: TestServerSideMoveOverSelf (27.81s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/07/23 04:52:01 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:01 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:01 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:01 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/23 04:52:01 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:01 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/23 04:52:01 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:02 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:02 INFO : yam: Copied (new) 2025/07/23 04:52:02 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/23 04:52:02 INFO : potato: Copied (new) 2025/07/23 04:52:02 DEBUG : Waiting for deletions to finish 2025/07/23 04:52:04 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 04:52:04 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:04 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:04 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:04 DEBUG : potato: Unchanged skipping 2025/07/23 04:52:04 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:05.655372 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dtC8t-sJYl4hYrwo-e-zocm62g9srZ03C7ja-vdMaB8ZO7kwr9tfXPnVr80eCQOClMycS8Oho-rQB3AJSUR_Rg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:52:05.655409 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dtC8t-sJYl4hYrwo-e-zocm62g9srZ03C7ja-vdMaB8ZO7kwr9tfXPnVr80eCQOClMycS8Oho-rQB3AJSUR_Rg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:05 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dtC8t-sJYl4hYrwo-e-zocm62g9srZ03C7ja-vdMaB8ZO7kwr9tfXPnVr80eCQOClMycS8Oho-rQB3AJSUR_Rg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:05 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dtC8t-sJYl4hYrwo-e-zocm62g9srZ03C7ja-vdMaB8ZO7kwr9tfXPnVr80eCQOClMycS8Oho-rQB3AJSUR_Rg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:05 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/23 04:52:05 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:07 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:07 INFO : yaml: Copied (new) 2025/07/23 04:52:07 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': not deleting files as there were IO errors 2025/07/23 04:52:07 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': 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.04s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/07/23 04:52:11 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:11 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:11 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:11 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:11 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/23 04:52:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/23 04:52:11 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:12 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:12 INFO : yam: Copied (new) 2025/07/23 04:52:12 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/23 04:52:12 INFO : potato: Copied (new) 2025/07/23 04:52:12 DEBUG : Waiting for deletions to finish 2025/07/23 04:52:14 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 04:52:14 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:14 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:14 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:14 DEBUG : potato: Unchanged skipping 2025/07/23 04:52:14 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:15.563760 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bmTvcYZ4-0GaOJSiL_z21DLzWrOBaJG6DV6Hk2iv2NsbSErk5tcid-Dd99i-nh4TcXsdPUV_lCorj74FnpWNXg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:52:15.563817 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bmTvcYZ4-0GaOJSiL_z21DLzWrOBaJG6DV6Hk2iv2NsbSErk5tcid-Dd99i-nh4TcXsdPUV_lCorj74FnpWNXg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:15 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bmTvcYZ4-0GaOJSiL_z21DLzWrOBaJG6DV6Hk2iv2NsbSErk5tcid-Dd99i-nh4TcXsdPUV_lCorj74FnpWNXg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:15 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bmTvcYZ4-0GaOJSiL_z21DLzWrOBaJG6DV6Hk2iv2NsbSErk5tcid-Dd99i-nh4TcXsdPUV_lCorj74FnpWNXg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:15 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/23 04:52:15 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:17 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:17 INFO : yaml: Copied (new) 2025/07/23 04:52:17 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': not deleting files as there were IO errors 2025/07/23 04:52:17 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': 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 (9.25s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/07/23 04:52:20 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:20 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:20 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/23 04:52:20 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/23 04:52:20 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:20 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:23 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:23 INFO : sub/yam: Copied (new) 2025/07/23 04:52:23 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/23 04:52:23 INFO : potato: Copied (new) 2025/07/23 04:52:23 DEBUG : Waiting for deletions to finish 2025/07/23 04:52:25 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 04:52:25 DEBUG : potato: Unchanged skipping 2025/07/23 04:52:26 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Making map for --track-renames 2025/07/23 04:52:26 INFO : proton drive root link ID 'rclone-test-zecujes4fimi': Finished making map for --track-renames 2025/07/23 04:52:26 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:26 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for renames to finish 2025/07/23 04:52:27.113917 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wP_v6F1I2DQNoCs2JsJn4y0EmAJyqMqWu_ThiteLr1qVpC-Iv-eJ9jCv18AzDlQ6FQ_AJQfMqwfexO8hXX3R-Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:52:27.113963 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wP_v6F1I2DQNoCs2JsJn4y0EmAJyqMqWu_ThiteLr1qVpC-Iv-eJ9jCv18AzDlQ6FQ_AJQfMqwfexO8hXX3R-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:27 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wP_v6F1I2DQNoCs2JsJn4y0EmAJyqMqWu_ThiteLr1qVpC-Iv-eJ9jCv18AzDlQ6FQ_AJQfMqwfexO8hXX3R-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:27 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wP_v6F1I2DQNoCs2JsJn4y0EmAJyqMqWu_ThiteLr1qVpC-Iv-eJ9jCv18AzDlQ6FQ_AJQfMqwfexO8hXX3R-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:27 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/23 04:52:27 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:28 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/23 04:52:28 INFO : yam: Copied (new) 2025/07/23 04:52:28 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': not deleting files as there were IO errors 2025/07/23 04:52:28 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': 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.24s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:52:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/23 04:52:33 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/23 04:52:33 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for checks to finish 2025/07/23 04:52:33 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': Waiting for transfers to finish 2025/07/23 04:52:37 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/23 04:52:37 INFO : nested/sub dir/file: Copied (new) 2025/07/23 04:52:37 INFO : nested/sub dir/file: Deleted 2025/07/23 04:52:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/23 04:52:37 INFO : sub dir/hello world: Copied (new) 2025/07/23 04:52:37 INFO : sub dir/hello world: Deleted 2025/07/23 04:52:37 ERROR : Local file system at /tmp/rclone410832907: 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.38s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:52:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lamuqoh9tuna" 2025/07/23 04:52:42 DEBUG : Config file has changed externally - reloading 2025/07/23 04:52:42 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Has cached credentials 2025/07/23 04:52:44 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zecujes4fimi' -> proton drive root link ID 'rclone-test-lamuqoh9tuna' 2025/07/23 04:52:57 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Using server-side directory move 2025/07/23 04:52:57 INFO : proton drive root link ID 'rclone-test-lamuqoh9tuna': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/23 04:52:58 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/23 04:52:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/23 04:52:58 DEBUG : empty space: Unchanged skipping 2025/07/23 04:52:58 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Waiting for checks to finish 2025/07/23 04:52:58 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/23 04:52:59 INFO : potato3: Deleted 2025/07/23 04:52:59 INFO : empty space: Deleted 2025/07/23 04:52:59 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Waiting for transfers to finish 2025/07/23 04:52:59.793103 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IR4W1DTJFa_6AjWREZewQBF1U-j05MT-r8ki01hR-ettO1HEuhtnES3DumbIfOcfmDgNk0vUsFFjJD-ynF0BsA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:52:59.793164 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IR4W1DTJFa_6AjWREZewQBF1U-j05MT-r8ki01hR-ettO1HEuhtnES3DumbIfOcfmDgNk0vUsFFjJD-ynF0BsA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:59 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IR4W1DTJFa_6AjWREZewQBF1U-j05MT-r8ki01hR-ettO1HEuhtnES3DumbIfOcfmDgNk0vUsFFjJD-ynF0BsA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:59.991924 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EEPNm45chqhHzEK0vnA6WyQ7_6likXT2UDOXdi6vngxzwhe0ZFUvyS7Ivc3K23uGMuky_ehsrOs_YewhcN12CQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:52:59.991961 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EEPNm45chqhHzEK0vnA6WyQ7_6likXT2UDOXdi6vngxzwhe0ZFUvyS7Ivc3K23uGMuky_ehsrOs_YewhcN12CQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:52:59 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EEPNm45chqhHzEK0vnA6WyQ7_6likXT2UDOXdi6vngxzwhe0ZFUvyS7Ivc3K23uGMuky_ehsrOs_YewhcN12CQ==/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/EEPNm45chqhHzEK0vnA6WyQ7_6likXT2UDOXdi6vngxzwhe0ZFUvyS7Ivc3K23uGMuky_ehsrOs_YewhcN12CQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/23 04:52:59 DEBUG : proton drive root link ID 'rclone-test-lamuqoh9tuna': Purge remote --- FAIL: TestServerSideMove (20.97s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:53:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-maqinoc1pixo" 2025/07/23 04:53:03 DEBUG : proton drive root link ID 'rclone-test-maqinoc1pixo': Has cached credentials 2025/07/23 04:53:05 DEBUG : proton drive root link ID 'rclone-test-maqinoc1pixo': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zecujes4fimi' -> proton drive root link ID 'rclone-test-maqinoc1pixo' 2025/07/23 04:53:19 DEBUG : empty space: Excluded (Size Filter) 2025/07/23 04:53:19 DEBUG : empty space: Excluded 2025/07/23 04:53:19 DEBUG : empty space: Excluded (Size Filter) 2025/07/23 04:53:19 DEBUG : empty space: Excluded 2025/07/23 04:53:19 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/23 04:53:19 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/23 04:53:19 DEBUG : proton drive root link ID 'rclone-test-maqinoc1pixo': Waiting for checks to finish 2025/07/23 04:53:19 DEBUG : proton drive root link ID 'rclone-test-maqinoc1pixo': Waiting for transfers to finish 2025/07/23 04:53:20 INFO : potato3: Deleted 2025/07/23 04:53:20.361575 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7NMVx2EjKPHrTYyCdMyI7dNtMG6tMw5geHcyJe48isok4ecmvAjl2huoHRr3tPt532pheNkTEc9YQqiIpcz7PA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:53:20.361624 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7NMVx2EjKPHrTYyCdMyI7dNtMG6tMw5geHcyJe48isok4ecmvAjl2huoHRr3tPt532pheNkTEc9YQqiIpcz7PA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:20 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7NMVx2EjKPHrTYyCdMyI7dNtMG6tMw5geHcyJe48isok4ecmvAjl2huoHRr3tPt532pheNkTEc9YQqiIpcz7PA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:20.826094 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NVB_gzBZACJBGH1amEPtuMyifwIcTT5sTzPBOtiLE-kR5WneRusFOh0WrtMx7XKTB0fsTdGE5ewj7HIoWPcspQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:53:20.826140 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NVB_gzBZACJBGH1amEPtuMyifwIcTT5sTzPBOtiLE-kR5WneRusFOh0WrtMx7XKTB0fsTdGE5ewj7HIoWPcspQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:20 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/NVB_gzBZACJBGH1amEPtuMyifwIcTT5sTzPBOtiLE-kR5WneRusFOh0WrtMx7XKTB0fsTdGE5ewj7HIoWPcspQ==/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/NVB_gzBZACJBGH1amEPtuMyifwIcTT5sTzPBOtiLE-kR5WneRusFOh0WrtMx7XKTB0fsTdGE5ewj7HIoWPcspQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/23 04:53:20 DEBUG : proton drive root link ID 'rclone-test-maqinoc1pixo': Purge remote --- FAIL: TestServerSideMoveWithFilter (21.61s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:53:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tuxonic4hexi" 2025/07/23 04:53:25 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Has cached credentials 2025/07/23 04:53:27 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Used cached credential to initialize the ProtonDrive API 2025/07/23 04:53:32 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-zecujes4fimi' -> proton drive root link ID 'rclone-test-tuxonic4hexi' 2025/07/23 04:53:40 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Using server-side directory move 2025/07/23 04:53:40 INFO : proton drive root link ID 'rclone-test-tuxonic4hexi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/23 04:53:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/23 04:53:42 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/23 04:53:42 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/23 04:53:42 DEBUG : empty space: Unchanged skipping 2025/07/23 04:53:42 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Waiting for checks to finish 2025/07/23 04:53:42 INFO : empty space: Deleted 2025/07/23 04:53:42 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Waiting for transfers to finish 2025/07/23 04:53:42 INFO : potato3: Deleted 2025/07/23 04:53:43.112723 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dVdR0HxZFN_-E3tgHFHrsciQv9HCnCLPvA4aAxo194fG0-J-2KDbq3Pw0hwt0HhpvqcymZ-UqN67IChIvI53gw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:53:43.112763 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dVdR0HxZFN_-E3tgHFHrsciQv9HCnCLPvA4aAxo194fG0-J-2KDbq3Pw0hwt0HhpvqcymZ-UqN67IChIvI53gw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:43 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dVdR0HxZFN_-E3tgHFHrsciQv9HCnCLPvA4aAxo194fG0-J-2KDbq3Pw0hwt0HhpvqcymZ-UqN67IChIvI53gw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:43.513800 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tBJPZnUHzpXI9M3A3-yJ7jXnX-ADwZms3FJfvuObKDh7lUuAc6hdqJ0vCTrh2LE-BWAUFqNWKZskvaDbiLM7tw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:53:43.513844 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tBJPZnUHzpXI9M3A3-yJ7jXnX-ADwZms3FJfvuObKDh7lUuAc6hdqJ0vCTrh2LE-BWAUFqNWKZskvaDbiLM7tw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:43 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tBJPZnUHzpXI9M3A3-yJ7jXnX-ADwZms3FJfvuObKDh7lUuAc6hdqJ0vCTrh2LE-BWAUFqNWKZskvaDbiLM7tw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:53:43 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi': 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/23 04:53:43 DEBUG : proton drive root link ID 'rclone-test-tuxonic4hexi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.87s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:53:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 04:53:55 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 04:53:57 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 04:55:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/backup" 2025/07/23 04:55:30 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Has cached credentials 2025/07/23 04:55:32 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Used cached credential to initialize the ProtonDrive API 2025/07/23 04:58:03 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 04:58:03 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for checks to finish 2025/07/23 04:58:03 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 04:58:03 DEBUG : two: Unchanged skipping 2025/07/23 04:58:05.878774 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gRF9MMwUqqvy0VMsPq4LbmgLVM3FgpePjj6a9c4fOd7vHiNQsjeIlf3hjWTPlrRNFv-ZCDLV8S-dgA4-5Et9kg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 04:58:05.878816 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gRF9MMwUqqvy0VMsPq4LbmgLVM3FgpePjj6a9c4fOd7vHiNQsjeIlf3hjWTPlrRNFv-ZCDLV8S-dgA4-5Et9kg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:58:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/gRF9MMwUqqvy0VMsPq4LbmgLVM3FgpePjj6a9c4fOd7vHiNQsjeIlf3hjWTPlrRNFv-ZCDLV8S-dgA4-5Et9kg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 04:58:05 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for transfers to finish 2025/07/23 04:58:05 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/dst': not deleting files as there were IO errors 2025/07/23 04:58:05 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/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/gRF9MMwUqqvy0VMsPq4LbmgLVM3FgpePjj6a9c4fOd7vHiNQsjeIlf3hjWTPlrRNFv-ZCDLV8S-dgA4-5Et9kg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (263.08s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 04:58:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 04:58:19 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 04:58:21 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 04:59:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/backup" 2025/07/23 04:59:36 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Has cached credentials 2025/07/23 04:59:38 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:02:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 05:02:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 05:02:08 DEBUG : two: Unchanged skipping 2025/07/23 05:02:08 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for checks to finish 2025/07/23 05:02:10.771478 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CnEh-Wtz_lsOsXz-lHfF4rxs6plmuXb1vjdER06so2ItrW_H5ROBLGMm9D2oUrg-A5W6FJadoEcqklmdDmnl0Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 05:02:10.771570 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CnEh-Wtz_lsOsXz-lHfF4rxs6plmuXb1vjdER06so2ItrW_H5ROBLGMm9D2oUrg-A5W6FJadoEcqklmdDmnl0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:02:10 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CnEh-Wtz_lsOsXz-lHfF4rxs6plmuXb1vjdER06so2ItrW_H5ROBLGMm9D2oUrg-A5W6FJadoEcqklmdDmnl0Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:02:10 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for transfers to finish 2025/07/23 05:02:10 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/dst': not deleting files as there were IO errors 2025/07/23 05:02:10 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/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/CnEh-Wtz_lsOsXz-lHfF4rxs6plmuXb1vjdER06so2ItrW_H5ROBLGMm9D2oUrg-A5W6FJadoEcqklmdDmnl0Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (245.21s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 05:02:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 05:02:23 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 05:02:26 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:03:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/backup" 2025/07/23 05:03:41 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Has cached credentials 2025/07/23 05:03:43 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/backup': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:06:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 05:06:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 05:06:14 DEBUG : two: Unchanged skipping 2025/07/23 05:06:14 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for checks to finish 2025/07/23 05:06:17.057285 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-rWFf-qZPTXpN0zrILpkiJa6GQvSyHGE9X_O-ogi4G8u8Usb1ynTnuG4-Dm0kdCHCeR_tMa5LwkLEsd7Rv22Vg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 05:06:17.057351 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-rWFf-qZPTXpN0zrILpkiJa6GQvSyHGE9X_O-ogi4G8u8Usb1ynTnuG4-Dm0kdCHCeR_tMa5LwkLEsd7Rv22Vg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:06:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-rWFf-qZPTXpN0zrILpkiJa6GQvSyHGE9X_O-ogi4G8u8Usb1ynTnuG4-Dm0kdCHCeR_tMa5LwkLEsd7Rv22Vg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:06:17 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for transfers to finish 2025/07/23 05:06:17 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/dst': not deleting files as there were IO errors 2025/07/23 05:06:17 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/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/-rWFf-qZPTXpN0zrILpkiJa6GQvSyHGE9X_O-ogi4G8u8Usb1ynTnuG4-Dm0kdCHCeR_tMa5LwkLEsd7Rv22Vg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (245.47s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 05:06:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 05:06:29 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 05:06:32 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:07:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 05:07:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/23 05:07:49 DEBUG : two: Unchanged skipping 2025/07/23 05:07:49 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for checks to finish 2025/07/23 05:07:50.169711 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wT0oEeAUFVvspsYsDwcX1yJu2e1hFoJjX7Z4CARu1blNWMtppnN6Re0PraxpHsRBAKD1E0521I6ZvjiYXw6qDw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 05:07:50.169759 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wT0oEeAUFVvspsYsDwcX1yJu2e1hFoJjX7Z4CARu1blNWMtppnN6Re0PraxpHsRBAKD1E0521I6ZvjiYXw6qDw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:07:50 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wT0oEeAUFVvspsYsDwcX1yJu2e1hFoJjX7Z4CARu1blNWMtppnN6Re0PraxpHsRBAKD1E0521I6ZvjiYXw6qDw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:07:50 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Waiting for transfers to finish 2025/07/23 05:07:50 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/dst': not deleting files as there were IO errors 2025/07/23 05:07:50 ERROR : proton drive root link ID 'rclone-test-zecujes4fimi/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/wT0oEeAUFVvspsYsDwcX1yJu2e1hFoJjX7Z4CARu1blNWMtppnN6Re0PraxpHsRBAKD1E0521I6ZvjiYXw6qDw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (93.15s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 05:08:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 05:08:03 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 05:08:05 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:09:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 05:09:22.377023 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_TVI8EycbxoRKIU3T_TgC7VSfL3g2fPZs8O8odpIw1ElwTeVx52oxdLc5KtkyZZz4KeoePQ1H2aTbiJJvSYCgw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 05:09:22.377063 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_TVI8EycbxoRKIU3T_TgC7VSfL3g2fPZs8O8odpIw1ElwTeVx52oxdLc5KtkyZZz4KeoePQ1H2aTbiJJvSYCgw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:09:22 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_TVI8EycbxoRKIU3T_TgC7VSfL3g2fPZs8O8odpIw1ElwTeVx52oxdLc5KtkyZZz4KeoePQ1H2aTbiJJvSYCgw==/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/_TVI8EycbxoRKIU3T_TgC7VSfL3g2fPZs8O8odpIw1ElwTeVx52oxdLc5KtkyZZz4KeoePQ1H2aTbiJJvSYCgw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (92.25s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-zecujes4fimi'", Local "Local file system at /tmp/rclone410832907", Modify Window "1s" 2025/07/23 05:09:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zecujes4fimi/dst" 2025/07/23 05:09:35 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Has cached credentials 2025/07/23 05:09:37 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi/dst': Used cached credential to initialize the ProtonDrive API 2025/07/23 05:10:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/23 05:10:54.661657 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BxN4AZBHUZNKv2kI4GjPpEoKowHTaszdVA78lyXBX_4yKk1NKAIwDSgoInXKYuHbXY2-ShIQVQs7rA5MqfhL3Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/23 05:10:54.661698 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BxN4AZBHUZNKv2kI4GjPpEoKowHTaszdVA78lyXBX_4yKk1NKAIwDSgoInXKYuHbXY2-ShIQVQs7rA5MqfhL3Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/23 05:10:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BxN4AZBHUZNKv2kI4GjPpEoKowHTaszdVA78lyXBX_4yKk1NKAIwDSgoInXKYuHbXY2-ShIQVQs7rA5MqfhL3Q==/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/BxN4AZBHUZNKv2kI4GjPpEoKowHTaszdVA78lyXBX_4yKk1NKAIwDSgoInXKYuHbXY2-ShIQVQs7rA5MqfhL3Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (91.63s) FAIL 2025/07/23 05:10:58 DEBUG : proton drive root link ID 'rclone-test-zecujes4fimi': 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 19m29.569913977s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]