"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 3/5) 2025/06/29 04:35:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno" 2025/06/29 04:35:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/29 04:35:07 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Has cached credentials 2025/06/29 04:35:08 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:35:08 DEBUG : Creating backend with remote "/tmp/rclone2169783689" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:35:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cixaguc2pozo" 2025/06/29 04:35:10 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Has cached credentials 2025/06/29 04:35:11 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Used cached credential to initialize the ProtonDrive API sync_test.go:672: Server side copy (if possible) proton drive root link ID 'rclone-test-mofokuy2juno' -> proton drive root link ID 'rclone-test-cixaguc2pozo' 2025/06/29 04:35:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/29 04:35:12 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Waiting for checks to finish 2025/06/29 04:35:12 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Waiting for transfers to finish 2025/06/29 04:35:15 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/29 04:35:15 INFO : sub dir/hello world: Copied (new) 2025/06/29 04:35:15.933459 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/29 04:35:15.933550 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/29 04:35:17 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Using server-side directory move 2025/06/29 04:35:17 INFO : proton drive root link ID 'rclone-test-cixaguc2pozo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/29 04:35:18 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/29 04:35:18 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Waiting for checks to finish 2025/06/29 04:35:18 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Waiting for transfers to finish 2025/06/29 04:35:18 INFO : sub dir/hello world: Deleted 2025/06/29 04:35:18.830023 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tTzCZ4mHJn8G7JagDR2hceuMLYvfGDpvjuyWWAYDVr2w5kYj3LBTmasCsiHb2AWAq-1sGyevswn7_NgTGlAdQQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:18.830062 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tTzCZ4mHJn8G7JagDR2hceuMLYvfGDpvjuyWWAYDVr2w5kYj3LBTmasCsiHb2AWAq-1sGyevswn7_NgTGlAdQQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:18 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tTzCZ4mHJn8G7JagDR2hceuMLYvfGDpvjuyWWAYDVr2w5kYj3LBTmasCsiHb2AWAq-1sGyevswn7_NgTGlAdQQ==/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/tTzCZ4mHJn8G7JagDR2hceuMLYvfGDpvjuyWWAYDVr2w5kYj3LBTmasCsiHb2AWAq-1sGyevswn7_NgTGlAdQQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/06/29 04:35:18 DEBUG : proton drive root link ID 'rclone-test-cixaguc2pozo': Purge remote --- FAIL: TestServerSideMoveOverSelf (11.87s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" sync_test.go:1539: Can track renames: true 2025/06/29 04:35:20 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:20 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:20 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:20 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/29 04:35:20 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/29 04:35:20 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:21 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/29 04:35:21 INFO : potato: Copied (new) 2025/06/29 04:35:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:21 INFO : yam: Copied (new) 2025/06/29 04:35:21 DEBUG : Waiting for deletions to finish 2025/06/29 04:35:22 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:35:22 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:22 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:22 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:22 DEBUG : potato: Unchanged skipping 2025/06/29 04:35:22 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:22.801667 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cnWu3eN2KNCggggnbqyFhtwuxV1q3qnXU5xuts5-owy-4yk8U1Y1_9KaiKVDr-GkL54KOtmmlV2MA70Hfnc8ww==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:22.801705 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cnWu3eN2KNCggggnbqyFhtwuxV1q3qnXU5xuts5-owy-4yk8U1Y1_9KaiKVDr-GkL54KOtmmlV2MA70Hfnc8ww==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:22 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cnWu3eN2KNCggggnbqyFhtwuxV1q3qnXU5xuts5-owy-4yk8U1Y1_9KaiKVDr-GkL54KOtmmlV2MA70Hfnc8ww==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:22 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cnWu3eN2KNCggggnbqyFhtwuxV1q3qnXU5xuts5-owy-4yk8U1Y1_9KaiKVDr-GkL54KOtmmlV2MA70Hfnc8ww==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:22 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/29 04:35:22 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:23 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:23 INFO : yaml: Copied (new) 2025/06/29 04:35:23 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': not deleting files as there were IO errors 2025/06/29 04:35:23 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': 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 (4.95s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" sync_test.go:1611: Can track renames: true 2025/06/29 04:35:25 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:25 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:25 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:25 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/29 04:35:25 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/29 04:35:25 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:25 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:26 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:26 INFO : yam: Copied (new) 2025/06/29 04:35:26 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/29 04:35:26 INFO : potato: Copied (new) 2025/06/29 04:35:26 DEBUG : Waiting for deletions to finish 2025/06/29 04:35:27 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:35:27 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:27 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:27 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:27 DEBUG : potato: Unchanged skipping 2025/06/29 04:35:27 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:27.721113 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MU6e3skNFzQ4I6eAR8wcK6WDr2CX1_yf-e3xL5JihFqUQUK2DwyuFsEcWoN2Vg6PnMYGF4Xr6iGBuFubwkibDA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:27.721153 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MU6e3skNFzQ4I6eAR8wcK6WDr2CX1_yf-e3xL5JihFqUQUK2DwyuFsEcWoN2Vg6PnMYGF4Xr6iGBuFubwkibDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:27 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MU6e3skNFzQ4I6eAR8wcK6WDr2CX1_yf-e3xL5JihFqUQUK2DwyuFsEcWoN2Vg6PnMYGF4Xr6iGBuFubwkibDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:27 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MU6e3skNFzQ4I6eAR8wcK6WDr2CX1_yf-e3xL5JihFqUQUK2DwyuFsEcWoN2Vg6PnMYGF4Xr6iGBuFubwkibDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:27 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/29 04:35:27 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:29 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:29 INFO : yaml: Copied (new) 2025/06/29 04:35:29 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': not deleting files as there were IO errors 2025/06/29 04:35:29 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': 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 (5.11s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" sync_test.go:1650: Can track renames: true 2025/06/29 04:35:30 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:30 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:30 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:30 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/29 04:35:30 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:30 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/29 04:35:30 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:32 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/29 04:35:32 INFO : potato: Copied (new) 2025/06/29 04:35:32 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:32 INFO : sub/yam: Copied (new) 2025/06/29 04:35:32 DEBUG : Waiting for deletions to finish 2025/06/29 04:35:32 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:35:32 DEBUG : potato: Unchanged skipping 2025/06/29 04:35:33 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Making map for --track-renames 2025/06/29 04:35:33 INFO : proton drive root link ID 'rclone-test-mofokuy2juno': Finished making map for --track-renames 2025/06/29 04:35:33 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:33 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for renames to finish 2025/06/29 04:35:33.427762 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/p5184UAiUAvPW0QK2UWfa1PPUTQ8LcKTMZvL71gaTlBcqTlGW7Pykj-oODFrd_ScHDrLviGbue0Z33cTFMGPzg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:33.427810 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/p5184UAiUAvPW0QK2UWfa1PPUTQ8LcKTMZvL71gaTlBcqTlGW7Pykj-oODFrd_ScHDrLviGbue0Z33cTFMGPzg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:33 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/p5184UAiUAvPW0QK2UWfa1PPUTQ8LcKTMZvL71gaTlBcqTlGW7Pykj-oODFrd_ScHDrLviGbue0Z33cTFMGPzg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:33 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/p5184UAiUAvPW0QK2UWfa1PPUTQ8LcKTMZvL71gaTlBcqTlGW7Pykj-oODFrd_ScHDrLviGbue0Z33cTFMGPzg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:33 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/29 04:35:33 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:34 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/29 04:35:34 INFO : yam: Copied (new) 2025/06/29 04:35:34 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': not deleting files as there were IO errors 2025/06/29 04:35:34 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': 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 (6.06s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:35:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/29 04:35:36 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/29 04:35:36 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:35:36 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:35:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/29 04:35:38 INFO : sub dir/hello world: Copied (new) 2025/06/29 04:35:38 INFO : sub dir/hello world: Deleted 2025/06/29 04:35:38 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/06/29 04:35:38 INFO : nested/sub dir/file: Copied (new) 2025/06/29 04:35:38 INFO : nested/sub dir/file: Deleted 2025/06/29 04:35:38 ERROR : Local file system at /tmp/rclone2169783689: 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 (4.35s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:35:40 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gekipov9juwu" 2025/06/29 04:35:40 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Has cached credentials 2025/06/29 04:35:41 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-mofokuy2juno' -> proton drive root link ID 'rclone-test-gekipov9juwu' 2025/06/29 04:35:49 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Using server-side directory move 2025/06/29 04:35:49 INFO : proton drive root link ID 'rclone-test-gekipov9juwu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/29 04:35:49 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/29 04:35:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/29 04:35:49 DEBUG : empty space: Unchanged skipping 2025/06/29 04:35:49 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/29 04:35:49 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Waiting for checks to finish 2025/06/29 04:35:49 INFO : empty space: Deleted 2025/06/29 04:35:49 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Waiting for transfers to finish 2025/06/29 04:35:49 INFO : potato3: Deleted 2025/06/29 04:35:49.939165 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bk_orPObVwZS2JYneJKjcGhvqtQ7_x2v1rkRjuHLVgzDvsPBOk3LV2zSQMNrCtGl9kTJZjclxlgBoNGhvrgFcg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:49.939249 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bk_orPObVwZS2JYneJKjcGhvqtQ7_x2v1rkRjuHLVgzDvsPBOk3LV2zSQMNrCtGl9kTJZjclxlgBoNGhvrgFcg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:49 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Bk_orPObVwZS2JYneJKjcGhvqtQ7_x2v1rkRjuHLVgzDvsPBOk3LV2zSQMNrCtGl9kTJZjclxlgBoNGhvrgFcg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:50.070181 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uzYBfhoiH-tLQ4i0jnua7ry7TvIUG496wdLSyMviJ3983V-81WFNlr0OsWlzBHGcUeVaXd3SXmTlsMqx7WUwGw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:35:50.070223 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uzYBfhoiH-tLQ4i0jnua7ry7TvIUG496wdLSyMviJ3983V-81WFNlr0OsWlzBHGcUeVaXd3SXmTlsMqx7WUwGw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:35:50 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uzYBfhoiH-tLQ4i0jnua7ry7TvIUG496wdLSyMviJ3983V-81WFNlr0OsWlzBHGcUeVaXd3SXmTlsMqx7WUwGw==/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/uzYBfhoiH-tLQ4i0jnua7ry7TvIUG496wdLSyMviJ3983V-81WFNlr0OsWlzBHGcUeVaXd3SXmTlsMqx7WUwGw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/06/29 04:35:50 DEBUG : proton drive root link ID 'rclone-test-gekipov9juwu': Purge remote --- FAIL: TestServerSideMove (10.58s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:35:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wufopap6ceju" 2025/06/29 04:35:51 DEBUG : proton drive root link ID 'rclone-test-wufopap6ceju': Has cached credentials 2025/06/29 04:35:52 DEBUG : proton drive root link ID 'rclone-test-wufopap6ceju': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-mofokuy2juno' -> proton drive root link ID 'rclone-test-wufopap6ceju' 2025/06/29 04:36:00 DEBUG : empty space: Excluded (Size Filter) 2025/06/29 04:36:00 DEBUG : empty space: Excluded 2025/06/29 04:36:00 DEBUG : empty space: Excluded (Size Filter) 2025/06/29 04:36:00 DEBUG : empty space: Excluded 2025/06/29 04:36:00 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/29 04:36:00 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/29 04:36:00 DEBUG : proton drive root link ID 'rclone-test-wufopap6ceju': Waiting for checks to finish 2025/06/29 04:36:00 DEBUG : proton drive root link ID 'rclone-test-wufopap6ceju': Waiting for transfers to finish 2025/06/29 04:36:00 INFO : potato3: Deleted 2025/06/29 04:36:00.575458 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_5TfbjRswoneRU0w7UO8kEe8LswkApLQwsWmN1avCCn5edmnKNixDsYtMnGlXf1UiJ3z1aO3Eh-N4P94U3Iu2Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:36:00.575564 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_5TfbjRswoneRU0w7UO8kEe8LswkApLQwsWmN1avCCn5edmnKNixDsYtMnGlXf1UiJ3z1aO3Eh-N4P94U3Iu2Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:00 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_5TfbjRswoneRU0w7UO8kEe8LswkApLQwsWmN1avCCn5edmnKNixDsYtMnGlXf1UiJ3z1aO3Eh-N4P94U3Iu2Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:00.683850 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ppcLAvDvc5-MrSrQv94oICPuBCwf9uspiFJASynTmUbv-2jAyudU2CmUHnp0ddG2mhoQ-b_ukU8Qfu4ZFb0Hpw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:36:00.683887 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ppcLAvDvc5-MrSrQv94oICPuBCwf9uspiFJASynTmUbv-2jAyudU2CmUHnp0ddG2mhoQ-b_ukU8Qfu4ZFb0Hpw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:00 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ppcLAvDvc5-MrSrQv94oICPuBCwf9uspiFJASynTmUbv-2jAyudU2CmUHnp0ddG2mhoQ-b_ukU8Qfu4ZFb0Hpw==/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/ppcLAvDvc5-MrSrQv94oICPuBCwf9uspiFJASynTmUbv-2jAyudU2CmUHnp0ddG2mhoQ-b_ukU8Qfu4ZFb0Hpw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/06/29 04:36:00 DEBUG : proton drive root link ID 'rclone-test-wufopap6ceju': Purge remote --- FAIL: TestServerSideMoveWithFilter (10.91s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:36:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-giwiwin9givo" 2025/06/29 04:36:02 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Has cached credentials 2025/06/29 04:36:02 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:36:06 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-mofokuy2juno' -> proton drive root link ID 'rclone-test-giwiwin9givo' 2025/06/29 04:36:11 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Using server-side directory move 2025/06/29 04:36:11 INFO : proton drive root link ID 'rclone-test-giwiwin9givo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/29 04:36:11 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/29 04:36:11 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/29 04:36:11 DEBUG : empty space: Unchanged skipping 2025/06/29 04:36:11 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/29 04:36:11 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Waiting for checks to finish 2025/06/29 04:36:11 INFO : potato3: Deleted 2025/06/29 04:36:11 INFO : empty space: Deleted 2025/06/29 04:36:11 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Waiting for transfers to finish 2025/06/29 04:36:11.993652 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qexRr7UUV0fOrrsAeqoJqOdPspS0szLBoLs9AgqVj2AYljmmCtby9_iJ4tKHoa0dHsm-AEH55rWX0HCiLPmYOQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:36:11.993696 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qexRr7UUV0fOrrsAeqoJqOdPspS0szLBoLs9AgqVj2AYljmmCtby9_iJ4tKHoa0dHsm-AEH55rWX0HCiLPmYOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:11 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qexRr7UUV0fOrrsAeqoJqOdPspS0szLBoLs9AgqVj2AYljmmCtby9_iJ4tKHoa0dHsm-AEH55rWX0HCiLPmYOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:12.015267 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bukIOgqGKqCj3Kn77BEkawDPYJM9CnFaieOHqDmEvhLSjQSEGaMoGkx9IUGVS5rbGsWQvmQMNFgAD4id3Ltaaw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:36:12.015336 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bukIOgqGKqCj3Kn77BEkawDPYJM9CnFaieOHqDmEvhLSjQSEGaMoGkx9IUGVS5rbGsWQvmQMNFgAD4id3Ltaaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:12 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bukIOgqGKqCj3Kn77BEkawDPYJM9CnFaieOHqDmEvhLSjQSEGaMoGkx9IUGVS5rbGsWQvmQMNFgAD4id3Ltaaw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:36:12 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno': 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/29 04:36:12 DEBUG : proton drive root link ID 'rclone-test-giwiwin9givo': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (11.46s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:36:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:36:18 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:36:19 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:37:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/backup" 2025/06/29 04:37:27 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Has cached credentials 2025/06/29 04:37:28 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:39:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:39:40 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:39:40 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for checks to finish 2025/06/29 04:39:40 DEBUG : two: Unchanged skipping 2025/06/29 04:39:40.935919 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/JL9id47rXXfRM4ttuoNuxb1JWu9jS8t2MavaUsmzUe_y2qabi5L2d2VD4zPVmun-MjX25iEjFNS910NKMlCrTA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:39:40.936037 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/JL9id47rXXfRM4ttuoNuxb1JWu9jS8t2MavaUsmzUe_y2qabi5L2d2VD4zPVmun-MjX25iEjFNS910NKMlCrTA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:39:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/JL9id47rXXfRM4ttuoNuxb1JWu9jS8t2MavaUsmzUe_y2qabi5L2d2VD4zPVmun-MjX25iEjFNS910NKMlCrTA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:39:40 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for transfers to finish 2025/06/29 04:39:40 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/dst': not deleting files as there were IO errors 2025/06/29 04:39:40 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/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/JL9id47rXXfRM4ttuoNuxb1JWu9jS8t2MavaUsmzUe_y2qabi5L2d2VD4zPVmun-MjX25iEjFNS910NKMlCrTA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (209.13s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:39:47 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:39:47 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:39:48 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:40:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/backup" 2025/06/29 04:40:53 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Has cached credentials 2025/06/29 04:40:54 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:43:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:43:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:43:08 DEBUG : two: Unchanged skipping 2025/06/29 04:43:08 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for checks to finish 2025/06/29 04:43:09.172464 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nRHrqnH7cSdlN9hjWUcesEdG_jpK212Z1PFJvUBTg1n3AwxX48gGIanLsFwBLjIA33SPC3dIRaNxi2zlC3J5og==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:43:09.172528 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nRHrqnH7cSdlN9hjWUcesEdG_jpK212Z1PFJvUBTg1n3AwxX48gGIanLsFwBLjIA33SPC3dIRaNxi2zlC3J5og==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:43:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/nRHrqnH7cSdlN9hjWUcesEdG_jpK212Z1PFJvUBTg1n3AwxX48gGIanLsFwBLjIA33SPC3dIRaNxi2zlC3J5og==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:43:09 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for transfers to finish 2025/06/29 04:43:09 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/dst': not deleting files as there were IO errors 2025/06/29 04:43:09 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/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/nRHrqnH7cSdlN9hjWUcesEdG_jpK212Z1PFJvUBTg1n3AwxX48gGIanLsFwBLjIA33SPC3dIRaNxi2zlC3J5og==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (208.23s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:43:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:43:16 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:43:16 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:44:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/backup" 2025/06/29 04:44:22 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Has cached credentials 2025/06/29 04:44:22 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/backup': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:46:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:46:34 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:46:34 DEBUG : two: Unchanged skipping 2025/06/29 04:46:34 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for checks to finish 2025/06/29 04:46:35.747414 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qJWpNYFc6KOJSIbJJWfC6tQrz766H7rkU2APcxN3oAjWdl86CIWuNeb3vcYGKCU6NQhV2J3_2xUWJ6F25jO22A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:46:35.747454 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qJWpNYFc6KOJSIbJJWfC6tQrz766H7rkU2APcxN3oAjWdl86CIWuNeb3vcYGKCU6NQhV2J3_2xUWJ6F25jO22A==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:46:35 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qJWpNYFc6KOJSIbJJWfC6tQrz766H7rkU2APcxN3oAjWdl86CIWuNeb3vcYGKCU6NQhV2J3_2xUWJ6F25jO22A==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:46:35 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for transfers to finish 2025/06/29 04:46:35 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/dst': not deleting files as there were IO errors 2025/06/29 04:46:35 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/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/qJWpNYFc6KOJSIbJJWfC6tQrz766H7rkU2APcxN3oAjWdl86CIWuNeb3vcYGKCU6NQhV2J3_2xUWJ6F25jO22A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (206.54s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:46:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:46:42 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:46:43 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:47:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:47:49 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for checks to finish 2025/06/29 04:47:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:47:49 DEBUG : two: Unchanged skipping 2025/06/29 04:47:49.702064 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1PkSC85CLkEJGuiN5vpSFPmzBhK7H64pikXY1wQGO1CL7-NO90wDPid54EOxKjD85NtDF2JWSXJfvQVmXvqT5g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:47:49.702131 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1PkSC85CLkEJGuiN5vpSFPmzBhK7H64pikXY1wQGO1CL7-NO90wDPid54EOxKjD85NtDF2JWSXJfvQVmXvqT5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:47:49 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1PkSC85CLkEJGuiN5vpSFPmzBhK7H64pikXY1wQGO1CL7-NO90wDPid54EOxKjD85NtDF2JWSXJfvQVmXvqT5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:47:49 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Waiting for transfers to finish 2025/06/29 04:47:49 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/dst': not deleting files as there were IO errors 2025/06/29 04:47:49 ERROR : proton drive root link ID 'rclone-test-mofokuy2juno/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/1PkSC85CLkEJGuiN5vpSFPmzBhK7H64pikXY1wQGO1CL7-NO90wDPid54EOxKjD85NtDF2JWSXJfvQVmXvqT5g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (73.70s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:47:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:47:56 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:47:57 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:49:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:49:04.597988 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z5TPKzMp-rmfO6OlpcRuYG7WjNsPLRfpbYIsaECD7VthdMhjJuOCgic6zPtDEbjc6QrfaR0Eqi1spYq6SpcGHw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:49:04.598039 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z5TPKzMp-rmfO6OlpcRuYG7WjNsPLRfpbYIsaECD7VthdMhjJuOCgic6zPtDEbjc6QrfaR0Eqi1spYq6SpcGHw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:49:04 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z5TPKzMp-rmfO6OlpcRuYG7WjNsPLRfpbYIsaECD7VthdMhjJuOCgic6zPtDEbjc6QrfaR0Eqi1spYq6SpcGHw==/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/z5TPKzMp-rmfO6OlpcRuYG7WjNsPLRfpbYIsaECD7VthdMhjJuOCgic6zPtDEbjc6QrfaR0Eqi1spYq6SpcGHw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (74.97s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:49:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofokuy2juno/dst" 2025/06/29 04:49:11 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Has cached credentials 2025/06/29 04:49:11 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno/dst': Used cached credential to initialize the ProtonDrive API 2025/06/29 04:50:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/29 04:50:20.126052 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ndHMGJGBl7ylHDgRxYDO6bo68TTyidqLvPzy4YUObjInJp4nNUk0K3ucpt2g7PUlCQhIsXl8wn2CP7t-EobFdg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/29 04:50:20.126092 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ndHMGJGBl7ylHDgRxYDO6bo68TTyidqLvPzy4YUObjInJp4nNUk0K3ucpt2g7PUlCQhIsXl8wn2CP7t-EobFdg==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/29 04:50:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ndHMGJGBl7ylHDgRxYDO6bo68TTyidqLvPzy4YUObjInJp4nNUk0K3ucpt2g7PUlCQhIsXl8wn2CP7t-EobFdg==/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/ndHMGJGBl7ylHDgRxYDO6bo68TTyidqLvPzy4YUObjInJp4nNUk0K3ucpt2g7PUlCQhIsXl8wn2CP7t-EobFdg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (75.46s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "proton drive root link ID 'rclone-test-mofokuy2juno'", Local "Local file system at /tmp/rclone2169783689", Modify Window "1s" 2025/06/29 04:51:19 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for checks to finish 2025/06/29 04:51:19 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both10: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both13: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both14: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both15: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both0: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both11: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both18: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both19: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both12: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both16: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both3: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both17: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both5: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both1: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both7: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both8: Unchanged skipping 2025/06/29 04:51:19 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/29 04:51:19 DEBUG : both9: Unchanged skipping 2025/06/29 04:51:19 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : both2: Unchanged skipping 2025/06/29 04:51:19 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : both4: Unchanged skipping 2025/06/29 04:51:19 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : both6: Unchanged skipping 2025/06/29 04:51:19 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/06/29 04:51:19 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Waiting for transfers to finish 2025/06/29 04:51:19.599977 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/29 04:51:19.600205 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/29 04:51:19.606932 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/29 04:51:19.606969 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/29 04:51:19.633339 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/29 04:51:19.633410 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/29 04:51:19.634710 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/29 04:51:19.634748 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/29 04:51:20 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:20 INFO : only12: Copied (replaced existing) 2025/06/29 04:51:20 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:20 INFO : only14: Copied (replaced existing) 2025/06/29 04:51:20 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:20 INFO : only0: Copied (replaced existing) 2025/06/29 04:51:20 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:20 INFO : only13: Copied (replaced existing) 2025/06/29 04:51:20.334769 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/29 04:51:20.334802 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/29 04:51:20.343652 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/29 04:51:20.343678 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/29 04:51:20.399644 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/29 04:51:20.399685 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/29 04:51:20.471734 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/29 04:51:20.471781 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/29 04:51:21 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only11: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only17: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only10: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only19: Copied (replaced existing) 2025/06/29 04:51:21.183607 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/29 04:51:21.183654 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/29 04:51:21.206839 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/29 04:51:21.206877 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/29 04:51:21.226804 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/29 04:51:21.226829 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/29 04:51:21.248987 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/29 04:51:21.249021 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/29 04:51:21 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only15: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only2: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only4: Copied (replaced existing) 2025/06/29 04:51:21 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:21 INFO : only3: Copied (replaced existing) 2025/06/29 04:51:21.950305 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/29 04:51:21.950325 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/29 04:51:21.982590 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/29 04:51:21.982620 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/29 04:51:22.009888 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/29 04:51:22.009924 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/29 04:51:22.030351 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/29 04:51:22.030413 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/29 04:51:22 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:22 INFO : only16: Copied (replaced existing) 2025/06/29 04:51:22 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:22 INFO : only6: Copied (replaced existing) 2025/06/29 04:51:22 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:22 INFO : only5: Copied (replaced existing) 2025/06/29 04:51:22 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:22 INFO : only7: Copied (replaced existing) 2025/06/29 04:51:22.733861 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/29 04:51:22.733904 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/29 04:51:22.762547 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/29 04:51:22.762568 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/29 04:51:22.777300 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/29 04:51:22.777317 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/29 04:51:22.831326 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/29 04:51:22.831356 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/29 04:51:23 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:23 INFO : only18: Copied (replaced existing) 2025/06/29 04:51:23 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:23 INFO : only9: Copied (replaced existing) 2025/06/29 04:51:23 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:23 INFO : only1: Copied (replaced existing) 2025/06/29 04:51:23 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/06/29 04:51:23 INFO : only8: Copied (replaced existing) 2025/06/29 04:51:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (75.41s) FAIL 2025/06/29 04:51:37 DEBUG : proton drive root link ID 'rclone-test-mofokuy2juno': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 16m30.149344835s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]