"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 5/5) 2025/06/28 06:48:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude" 2025/06/28 06:48:24 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/28 06:48:24 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Has cached credentials 2025/06/28 06:48:25 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:48:26 DEBUG : Creating backend with remote "/tmp/rclone1272417915" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:48:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-muliken9lije" 2025/06/28 06:48:30 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Has cached credentials 2025/06/28 06:48:32 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Used cached credential to initialize the ProtonDrive API sync_test.go:672: Server side copy (if possible) proton drive root link ID 'rclone-test-gofeyes0gude' -> proton drive root link ID 'rclone-test-muliken9lije' 2025/06/28 06:48:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/28 06:48:33 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Waiting for checks to finish 2025/06/28 06:48:33 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Waiting for transfers to finish 2025/06/28 06:48:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/28 06:48:38 INFO : sub dir/hello world: Copied (new) 2025/06/28 06:48:40.073050 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/06/28 06:48:40.073087 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/06/28 06:48:42 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Using server-side directory move 2025/06/28 06:48:42 INFO : proton drive root link ID 'rclone-test-muliken9lije': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 06:48:43 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/28 06:48:43 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Waiting for checks to finish 2025/06/28 06:48:43 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Waiting for transfers to finish 2025/06/28 06:48:43 INFO : sub dir/hello world: Deleted 2025/06/28 06:48:44.980634 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_fNberH0M64sU26r7x-d7IXwFbHRcj-AjP-UC1pq6HcQD3VEiVfIrH78iR6cTqBQ36Q56YUqOBWFhQNn8s4j2g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:48:44.980671 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_fNberH0M64sU26r7x-d7IXwFbHRcj-AjP-UC1pq6HcQD3VEiVfIrH78iR6cTqBQ36Q56YUqOBWFhQNn8s4j2g==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:48:44 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_fNberH0M64sU26r7x-d7IXwFbHRcj-AjP-UC1pq6HcQD3VEiVfIrH78iR6cTqBQ36Q56YUqOBWFhQNn8s4j2g==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:685 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_fNberH0M64sU26r7x-d7IXwFbHRcj-AjP-UC1pq6HcQD3VEiVfIrH78iR6cTqBQ36Q56YUqOBWFhQNn8s4j2g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/06/28 06:48:44 DEBUG : proton drive root link ID 'rclone-test-muliken9lije': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.47s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" sync_test.go:1539: Can track renames: true 2025/06/28 06:48:48 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:48:48 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:48:48 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:48:48 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:48:48 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 06:48:48 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 06:48:48 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:48:49 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:48:49 INFO : yam: Copied (new) 2025/06/28 06:48:50 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 06:48:50 INFO : potato: Copied (new) 2025/06/28 06:48:50 DEBUG : Waiting for deletions to finish 2025/06/28 06:48:51 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:48:51 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:48:51 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:48:51 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:48:51 DEBUG : potato: Unchanged skipping 2025/06/28 06:48:51 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:48:52.344619 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RughDItStB0cDxPve64cGm00gDEKfjZ9gNiLstjuYtAXuYIFtmJCF4TuxwSADyKoYVmFGNiafxcNrAirKxKzcw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:48:52.344683 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RughDItStB0cDxPve64cGm00gDEKfjZ9gNiLstjuYtAXuYIFtmJCF4TuxwSADyKoYVmFGNiafxcNrAirKxKzcw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:48:52 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RughDItStB0cDxPve64cGm00gDEKfjZ9gNiLstjuYtAXuYIFtmJCF4TuxwSADyKoYVmFGNiafxcNrAirKxKzcw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:48:52 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RughDItStB0cDxPve64cGm00gDEKfjZ9gNiLstjuYtAXuYIFtmJCF4TuxwSADyKoYVmFGNiafxcNrAirKxKzcw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:48:52 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/28 06:48:52 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:48:54 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:48:54 INFO : yaml: Copied (new) 2025/06/28 06:48:54 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting files as there were IO errors 2025/06/28 06:48:54 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting directories as there were IO errors sync_test.go:1557: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1557 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.84s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" sync_test.go:1611: Can track renames: true 2025/06/28 06:48:57 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:48:57 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:48:57 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:48:57 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:48:57 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 06:48:57 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 06:48:57 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:48:58 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 06:48:58 INFO : potato: Copied (new) 2025/06/28 06:48:58 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:48:58 INFO : yam: Copied (new) 2025/06/28 06:48:58 DEBUG : Waiting for deletions to finish 2025/06/28 06:49:00 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:49:00 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:49:00 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:49:00 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:49:00 DEBUG : potato: Unchanged skipping 2025/06/28 06:49:00 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:49:01.057149 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mxz5yjCYuMhgEbcou_-7wZzE1rEL64E0UqXPXdLENmdqFvmOr1qZEBF1aBNfqd9pKDHdNZ1bQd3zCIMAjwmyw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:01.057198 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mxz5yjCYuMhgEbcou_-7wZzE1rEL64E0UqXPXdLENmdqFvmOr1qZEBF1aBNfqd9pKDHdNZ1bQd3zCIMAjwmyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:01 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mxz5yjCYuMhgEbcou_-7wZzE1rEL64E0UqXPXdLENmdqFvmOr1qZEBF1aBNfqd9pKDHdNZ1bQd3zCIMAjwmyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:01 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mxz5yjCYuMhgEbcou_-7wZzE1rEL64E0UqXPXdLENmdqFvmOr1qZEBF1aBNfqd9pKDHdNZ1bQd3zCIMAjwmyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:01 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/28 06:49:01 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:49:02 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:49:02 INFO : yaml: Copied (new) 2025/06/28 06:49:02 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting files as there were IO errors 2025/06/28 06:49:02 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting directories as there were IO errors sync_test.go:1629: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1629 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (8.99s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" sync_test.go:1650: Can track renames: true 2025/06/28 06:49:06 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:49:06 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:49:06 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:49:06 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 06:49:06 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/28 06:49:06 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:49:06 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:49:08 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 06:49:08 INFO : potato: Copied (new) 2025/06/28 06:49:08 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:49:08 INFO : sub/yam: Copied (new) 2025/06/28 06:49:08 DEBUG : Waiting for deletions to finish 2025/06/28 06:49:10 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:49:10 DEBUG : potato: Unchanged skipping 2025/06/28 06:49:10 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Making map for --track-renames 2025/06/28 06:49:10 INFO : proton drive root link ID 'rclone-test-gofeyes0gude': Finished making map for --track-renames 2025/06/28 06:49:10 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:49:10 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for renames to finish 2025/06/28 06:49:11.555684 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aCfEZod4vz7ejHqOhH2lGoW5Mhekp6VDcDtwv1RAHLoScPRC5p2VgwIl_QPbISTk2g3LaeyyVr8ozVv4pa0rAg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:11.555722 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aCfEZod4vz7ejHqOhH2lGoW5Mhekp6VDcDtwv1RAHLoScPRC5p2VgwIl_QPbISTk2g3LaeyyVr8ozVv4pa0rAg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:11 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aCfEZod4vz7ejHqOhH2lGoW5Mhekp6VDcDtwv1RAHLoScPRC5p2VgwIl_QPbISTk2g3LaeyyVr8ozVv4pa0rAg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:11 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aCfEZod4vz7ejHqOhH2lGoW5Mhekp6VDcDtwv1RAHLoScPRC5p2VgwIl_QPbISTk2g3LaeyyVr8ozVv4pa0rAg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:11 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 06:49:11 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:49:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 06:49:13 INFO : yam: Copied (new) 2025/06/28 06:49:13 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting files as there were IO errors 2025/06/28 06:49:13 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting directories as there were IO errors sync_test.go:1668: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1668 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (11.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:49:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/28 06:49:17 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/28 06:49:17 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for checks to finish 2025/06/28 06:49:17 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': Waiting for transfers to finish 2025/06/28 06:49:21 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/06/28 06:49:21 INFO : nested/sub dir/file: Copied (new) 2025/06/28 06:49:21 INFO : nested/sub dir/file: Deleted 2025/06/28 06:49:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/28 06:49:21 INFO : sub dir/hello world: Copied (new) 2025/06/28 06:49:21 INFO : sub dir/hello world: Deleted 2025/06/28 06:49:21 ERROR : Local file system at /tmp/rclone1272417915: not deleting directories as there were IO errors sync_test.go:1789: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1789 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (8.85s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:49:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tanapov9xadi" 2025/06/28 06:49:25 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Has cached credentials 2025/06/28 06:49:27 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-gofeyes0gude' -> proton drive root link ID 'rclone-test-tanapov9xadi' 2025/06/28 06:49:39 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Using server-side directory move 2025/06/28 06:49:39 INFO : proton drive root link ID 'rclone-test-tanapov9xadi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 06:49:39 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:49:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/28 06:49:39 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Waiting for checks to finish 2025/06/28 06:49:39 DEBUG : empty space: Unchanged skipping 2025/06/28 06:49:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:49:40 INFO : empty space: Deleted 2025/06/28 06:49:40 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Waiting for transfers to finish 2025/06/28 06:49:40 INFO : potato3: Deleted 2025/06/28 06:49:40.762140 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Sbh8hi7lJ2iXNfOmChqlA0VxPP7oGiWvlYvUVBwQ-P70uDN9v_QdYtEUSs_E5HZhb2vrvaOWqnk9J8ZFKAvNJw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:40.762207 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Sbh8hi7lJ2iXNfOmChqlA0VxPP7oGiWvlYvUVBwQ-P70uDN9v_QdYtEUSs_E5HZhb2vrvaOWqnk9J8ZFKAvNJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:40 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Sbh8hi7lJ2iXNfOmChqlA0VxPP7oGiWvlYvUVBwQ-P70uDN9v_QdYtEUSs_E5HZhb2vrvaOWqnk9J8ZFKAvNJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:41.165329 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EXPA8H4VhJKDU3U5dDTjWi-kdX_R3a_EPpMCUssMyDgVclaDqbW4gyr9T94Zu2N_S8Ir6U0-PLrdlbvuFX2qWQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:41.165430 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EXPA8H4VhJKDU3U5dDTjWi-kdX_R3a_EPpMCUssMyDgVclaDqbW4gyr9T94Zu2N_S8Ir6U0-PLrdlbvuFX2qWQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:41 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EXPA8H4VhJKDU3U5dDTjWi-kdX_R3a_EPpMCUssMyDgVclaDqbW4gyr9T94Zu2N_S8Ir6U0-PLrdlbvuFX2qWQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1882 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/EXPA8H4VhJKDU3U5dDTjWi-kdX_R3a_EPpMCUssMyDgVclaDqbW4gyr9T94Zu2N_S8Ir6U0-PLrdlbvuFX2qWQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/06/28 06:49:41 DEBUG : proton drive root link ID 'rclone-test-tanapov9xadi': Purge remote --- FAIL: TestServerSideMove (18.07s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:49:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-duqidiz3kavu" 2025/06/28 06:49:43 DEBUG : proton drive root link ID 'rclone-test-duqidiz3kavu': Has cached credentials 2025/06/28 06:49:45 DEBUG : proton drive root link ID 'rclone-test-duqidiz3kavu': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-gofeyes0gude' -> proton drive root link ID 'rclone-test-duqidiz3kavu' 2025/06/28 06:49:57 DEBUG : empty space: Excluded (Size Filter) 2025/06/28 06:49:57 DEBUG : empty space: Excluded 2025/06/28 06:49:57 DEBUG : empty space: Excluded (Size Filter) 2025/06/28 06:49:57 DEBUG : empty space: Excluded 2025/06/28 06:49:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:49:57 DEBUG : proton drive root link ID 'rclone-test-duqidiz3kavu': Waiting for checks to finish 2025/06/28 06:49:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:49:57 DEBUG : proton drive root link ID 'rclone-test-duqidiz3kavu': Waiting for transfers to finish 2025/06/28 06:49:58 INFO : potato3: Deleted 2025/06/28 06:49:58.646900 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gx4tPpKbtwWwVtgWQEdKvKBV93FuBG17Ryjg223w-2F9_zyqFa_yXoFIxrCyF2_hQ4EHP51Dtcu_2XA0TWODwg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:58.646940 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gx4tPpKbtwWwVtgWQEdKvKBV93FuBG17Ryjg223w-2F9_zyqFa_yXoFIxrCyF2_hQ4EHP51Dtcu_2XA0TWODwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gx4tPpKbtwWwVtgWQEdKvKBV93FuBG17Ryjg223w-2F9_zyqFa_yXoFIxrCyF2_hQ4EHP51Dtcu_2XA0TWODwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:58.976350 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IvfBAJAbFs6IjBsuR6AiYuPh5hGhlTo61Vn90Bs79psUEfmItv1gw4D7Hcl7GUHrm901t0KM41nREOtTcA9GJg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:49:58.976469 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IvfBAJAbFs6IjBsuR6AiYuPh5hGhlTo61Vn90Bs79psUEfmItv1gw4D7Hcl7GUHrm901t0KM41nREOtTcA9GJg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:49:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IvfBAJAbFs6IjBsuR6AiYuPh5hGhlTo61Vn90Bs79psUEfmItv1gw4D7Hcl7GUHrm901t0KM41nREOtTcA9GJg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1895 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IvfBAJAbFs6IjBsuR6AiYuPh5hGhlTo61Vn90Bs79psUEfmItv1gw4D7Hcl7GUHrm901t0KM41nREOtTcA9GJg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/06/28 06:49:58 DEBUG : proton drive root link ID 'rclone-test-duqidiz3kavu': Purge remote --- FAIL: TestServerSideMoveWithFilter (18.54s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:50:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-diwucew9diti" 2025/06/28 06:50:02 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Has cached credentials 2025/06/28 06:50:03 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:50:09 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-gofeyes0gude' -> proton drive root link ID 'rclone-test-diwucew9diti' 2025/06/28 06:50:16 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Using server-side directory move 2025/06/28 06:50:16 INFO : proton drive root link ID 'rclone-test-diwucew9diti': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 06:50:17 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:50:17 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/28 06:50:17 DEBUG : empty space: Unchanged skipping 2025/06/28 06:50:17 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:50:17 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Waiting for checks to finish 2025/06/28 06:50:17 INFO : empty space: Deleted 2025/06/28 06:50:17 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Waiting for transfers to finish 2025/06/28 06:50:17 INFO : potato3: Deleted 2025/06/28 06:50:18.086316 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ewMgoJ1kpqTCfjvIIkoZp0jwijLQKSPosaPzh7uc49Jga2ydDgl6Nk-6ohfvdzcPn4ay99u0C7Z1_kA2YCIYIQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:50:18.086351 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ewMgoJ1kpqTCfjvIIkoZp0jwijLQKSPosaPzh7uc49Jga2ydDgl6Nk-6ohfvdzcPn4ay99u0C7Z1_kA2YCIYIQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:50:18 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ewMgoJ1kpqTCfjvIIkoZp0jwijLQKSPosaPzh7uc49Jga2ydDgl6Nk-6ohfvdzcPn4ay99u0C7Z1_kA2YCIYIQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:50:18.478742 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AnbBNqng-Q_Olb8i4ld41u6QuEkHPCh-Q5nT6cPoQAbNSdczsKB8FyzlBQt6F1A9HeN2FXIo7zcgzsB0bvPrXg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:50:18.478789 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AnbBNqng-Q_Olb8i4ld41u6QuEkHPCh-Q5nT6cPoQAbNSdczsKB8FyzlBQt6F1A9HeN2FXIo7zcgzsB0bvPrXg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:50:18 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AnbBNqng-Q_Olb8i4ld41u6QuEkHPCh-Q5nT6cPoQAbNSdczsKB8FyzlBQt6F1A9HeN2FXIo7zcgzsB0bvPrXg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:50:18 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude': not deleting directories as there were IO errors sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1902 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/06/28 06:50:18 DEBUG : proton drive root link ID 'rclone-test-diwucew9diti': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.60s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:50:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 06:50:29 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 06:50:30 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:51:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/backup" 2025/06/28 06:51:50 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Has cached credentials 2025/06/28 06:51:52 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:54:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:54:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:54:32 DEBUG : two: Unchanged skipping 2025/06/28 06:54:32 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for checks to finish 2025/06/28 06:54:34.121970 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wVXd6y_Xtdmn-WiufxYoTo_-TAOad8U44inJ0RayyO719AbuvYwEAIREr6nvfA4Y7e2CDKi0KSCSfgMNpSHTsg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:54:34.122012 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wVXd6y_Xtdmn-WiufxYoTo_-TAOad8U44inJ0RayyO719AbuvYwEAIREr6nvfA4Y7e2CDKi0KSCSfgMNpSHTsg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:54:34 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wVXd6y_Xtdmn-WiufxYoTo_-TAOad8U44inJ0RayyO719AbuvYwEAIREr6nvfA4Y7e2CDKi0KSCSfgMNpSHTsg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:54:34 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for transfers to finish 2025/06/28 06:54:34 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting files as there were IO errors 2025/06/28 06:54:34 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wVXd6y_Xtdmn-WiufxYoTo_-TAOad8U44inJ0RayyO719AbuvYwEAIREr6nvfA4Y7e2CDKi0KSCSfgMNpSHTsg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (256.39s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:54:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 06:54:45 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 06:54:47 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:56:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/backup" 2025/06/28 06:56:06 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Has cached credentials 2025/06/28 06:56:07 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:58:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:58:45 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:58:45 DEBUG : two: Unchanged skipping 2025/06/28 06:58:45 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for checks to finish 2025/06/28 06:58:47.347249 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5dxUAi8oRdQ8Ykp7oO5skauRhiVJo85ElyJeqZKc1HrgcZOinQ0boUI-wE9VZUmULOWhyUFdemSJZGq0VS27jQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:58:47.347292 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5dxUAi8oRdQ8Ykp7oO5skauRhiVJo85ElyJeqZKc1HrgcZOinQ0boUI-wE9VZUmULOWhyUFdemSJZGq0VS27jQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:58:47 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5dxUAi8oRdQ8Ykp7oO5skauRhiVJo85ElyJeqZKc1HrgcZOinQ0boUI-wE9VZUmULOWhyUFdemSJZGq0VS27jQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:58:47 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for transfers to finish 2025/06/28 06:58:47 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting files as there were IO errors 2025/06/28 06:58:47 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2432 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5dxUAi8oRdQ8Ykp7oO5skauRhiVJo85ElyJeqZKc1HrgcZOinQ0boUI-wE9VZUmULOWhyUFdemSJZGq0VS27jQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (253.11s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 06:58:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 06:58:59 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 06:59:00 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 07:00:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/backup" 2025/06/28 07:00:19 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Has cached credentials 2025/06/28 07:00:20 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 07:02:58 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 07:02:58 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 07:02:58 DEBUG : two: Unchanged skipping 2025/06/28 07:02:58 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for checks to finish 2025/06/28 07:03:00.054702 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1UPWTIpAwXWmbCPUYAEFxk8o7P06WJklCOahjDj2SdBTPqs1Kaq3pvj0jEZICZWuHuPzUD3FkyRz6JPfAgRAOg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 07:03:00.054734 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1UPWTIpAwXWmbCPUYAEFxk8o7P06WJklCOahjDj2SdBTPqs1Kaq3pvj0jEZICZWuHuPzUD3FkyRz6JPfAgRAOg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:03:00 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1UPWTIpAwXWmbCPUYAEFxk8o7P06WJklCOahjDj2SdBTPqs1Kaq3pvj0jEZICZWuHuPzUD3FkyRz6JPfAgRAOg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:03:00 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for transfers to finish 2025/06/28 07:03:00 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting files as there were IO errors 2025/06/28 07:03:00 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2436 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1UPWTIpAwXWmbCPUYAEFxk8o7P06WJklCOahjDj2SdBTPqs1Kaq3pvj0jEZICZWuHuPzUD3FkyRz6JPfAgRAOg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (252.76s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 07:03:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 07:03:11 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 07:03:13 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 07:04:33 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 07:04:33 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 07:04:33 DEBUG : two: Unchanged skipping 2025/06/28 07:04:33 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for checks to finish 2025/06/28 07:04:34.117057 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2KC7yg8meRLmCUyEAkOeCtZjz-lAFgWrJhMgL3_feeywgUqnSCxnTAWtCiB666Q6n488rMleF2E-XXEzrHLSrQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 07:04:34.117110 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2KC7yg8meRLmCUyEAkOeCtZjz-lAFgWrJhMgL3_feeywgUqnSCxnTAWtCiB666Q6n488rMleF2E-XXEzrHLSrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:04:34 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2KC7yg8meRLmCUyEAkOeCtZjz-lAFgWrJhMgL3_feeywgUqnSCxnTAWtCiB666Q6n488rMleF2E-XXEzrHLSrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:04:34 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Waiting for transfers to finish 2025/06/28 07:04:34 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting files as there were IO errors 2025/06/28 07:04:34 ERROR : proton drive root link ID 'rclone-test-gofeyes0gude/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2440 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2KC7yg8meRLmCUyEAkOeCtZjz-lAFgWrJhMgL3_feeywgUqnSCxnTAWtCiB666Q6n488rMleF2E-XXEzrHLSrQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (93.46s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 07:04:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 07:04:45 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 07:04:46 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 07:06:05 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 07:06:05.974952 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x59IclY8gb1ugKWltnVQOHxqO_t7l6Ff-M1hkREgJ72gQJ2b228AbwpHGkfsHKHvK9Z8T9c5ALKVqLolA9Am5Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 07:06:05.974993 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x59IclY8gb1ugKWltnVQOHxqO_t7l6Ff-M1hkREgJ72gQJ2b228AbwpHGkfsHKHvK9Z8T9c5ALKVqLolA9Am5Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:06:05 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x59IclY8gb1ugKWltnVQOHxqO_t7l6Ff-M1hkREgJ72gQJ2b228AbwpHGkfsHKHvK9Z8T9c5ALKVqLolA9Am5Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x59IclY8gb1ugKWltnVQOHxqO_t7l6Ff-M1hkREgJ72gQJ2b228AbwpHGkfsHKHvK9Z8T9c5ALKVqLolA9Am5Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (91.84s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-gofeyes0gude'", Local "Local file system at /tmp/rclone1272417915", Modify Window "1s" 2025/06/28 07:06:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gofeyes0gude/dst" 2025/06/28 07:06:17 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Has cached credentials 2025/06/28 07:06:18 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 07:07:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 07:07:37.925010 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M7S2kW8iikfasiM8WqhP_DsY2qrGTe4GG3gTiZscoRS85A7TTZ2dbCaOwyLFyV1lTQogYU9ZSTktHdQt7OK9fg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 07:07:37.925052 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M7S2kW8iikfasiM8WqhP_DsY2qrGTe4GG3gTiZscoRS85A7TTZ2dbCaOwyLFyV1lTQogYU9ZSTktHdQt7OK9fg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 07:07:37 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M7S2kW8iikfasiM8WqhP_DsY2qrGTe4GG3gTiZscoRS85A7TTZ2dbCaOwyLFyV1lTQogYU9ZSTktHdQt7OK9fg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2525 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M7S2kW8iikfasiM8WqhP_DsY2qrGTe4GG3gTiZscoRS85A7TTZ2dbCaOwyLFyV1lTQogYU9ZSTktHdQt7OK9fg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (91.91s) FAIL 2025/06/28 07:07:41 DEBUG : proton drive root link ID 'rclone-test-gofeyes0gude': 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 19m17.774777156s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]