"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestCopyOverSelf|TestMoveOverSelf|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingModtimeOnly|TestSyncCompareDest|TestSyncDoesntUpdateModtime|TestSyncIgnoreTimes|TestSyncUTFNorm|TestSyncWithUpdateOlder)$'" - Starting (try 2/5) 2024/10/30 03:05:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-ripayuq2sezo" 2024/10/30 03:05:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 03:05:49 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Has cached credentials 2024/10/30 03:05:50 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Used cached credential to initialize the ProtonDrive API 2024/10/30 03:05:51 DEBUG : Creating backend with remote "/tmp/rclone222887415" === RUN TestCopyOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:05:54 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:05:54 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 03:05:54 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:05:54.774411 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 2024/10/30 03:05:54.774437 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) 2024/10/30 03:06:06.865077 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:06:06Z" level=warning msg="Too many requests, retrying after delay" after=11 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==" 2024/10/30 03:06:28.127891 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:06:28Z" level=warning msg="Too many requests, retrying after delay" after=13 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==" 2024/10/30 03:06:51.494437 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:06:51Z" level=warning msg="Too many requests, retrying after delay" after=13 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==" 2024/10/30 03:07:15.226671 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:07:15.226690 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:07:15 ERROR : sub dir/hello world: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429) sync_test.go:611: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:611 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/cIykCqYd3iSXGaO4b6SJ9OaHCy85bYhAGK2qNv_oCuPvjJaRafLusWbvsLR2xR01fN0B0z4xHAx6FfGZl4X4Qg==/revisions/maynggIubxO43S8mOW53QY9BuQ0ovTrD1U7VEnicZ5PfTIzuS8lvk9ci-mMTa3BKraotTLHC9JY8Acgvy9q-xQ==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestCopyOverSelf --- FAIL: TestCopyOverSelf (85.62s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:07:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bexusaf8dusa" 2024/10/30 03:07:18 DEBUG : proton drive root link ID 'rclone-test-bexusaf8dusa': Has cached credentials 2024/10/30 03:07:19 DEBUG : proton drive root link ID 'rclone-test-bexusaf8dusa': Used cached credential to initialize the ProtonDrive API sync_test.go:626: Server side copy (if possible) proton drive root link ID 'rclone-test-ripayuq2sezo' -> proton drive root link ID 'rclone-test-bexusaf8dusa' 2024/10/30 03:07:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 03:07:20 DEBUG : proton drive root link ID 'rclone-test-bexusaf8dusa': Waiting for checks to finish 2024/10/30 03:07:20 DEBUG : proton drive root link ID 'rclone-test-bexusaf8dusa': Waiting for transfers to finish 2024/10/30 03:07:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/10/30 03:07:22 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:07:24.120599 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 2024/10/30 03:07:24.120619 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) 2024/10/30 03:07:35.361144 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:07:35Z" level=warning msg="Too many requests, retrying after delay" after=5 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==" 2024/10/30 03:07:50.659511 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:07:50Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==" 2024/10/30 03:08:10.890625 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:08:10Z" level=warning msg="Too many requests, retrying after delay" after=8 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==" 2024/10/30 03:08:29.333047 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:08:29.333071 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429) run.go:285: Failed to put "sub dir/hello world" to "proton drive root link ID 'rclone-test-ripayuq2sezo'": 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/kIp6M-vLg_g_zRdvDWFkePHLinEgLez2ckyuFxItlsCsvTy_NB1cqASHJay7uH_2jJ-M2oJgv6DKTgEZVjxaRg==/revisions/LlRDvUqr7zBq3NTt3cyyumpAStXJpYwcw6XFKUYlxA3xNlIy5th1tYh7oiYVTGfDo2r60opWeu1MKeZOeEhTrw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:08:29 DEBUG : proton drive root link ID 'rclone-test-bexusaf8dusa': Purge remote --- FAIL: TestServerSideCopyOverSelf (75.01s) === RUN TestMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:08:34 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:08:34 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 03:08:34 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:08:34.605806 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 2024/10/30 03:08:34.605829 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) 2024/10/30 03:08:46.019437 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:08:46Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==" 2024/10/30 03:09:10.691661 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:09:10Z" level=warning msg="Too many requests, retrying after delay" after=5 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==" 2024/10/30 03:09:26.662784 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:09:26Z" level=warning msg="Too many requests, retrying after delay" after=13 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==" 2024/10/30 03:09:50.106877 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:09:50.106892 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:09:50 ERROR : sub dir/hello world: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:09:50 ERROR : sub dir/hello world: Not deleting source as copy failed: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429) sync_test.go:655: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:655 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/4sygIklVirf_P92w7CffrhmWspb43HjDhnnRfO3AmAtJ62jlGZi7W2jnmTcxqN92sePzxqWBR798hes6d4O-UQ==/revisions/dFBzBpXl99jkRr0_sY5Cbz-Zt9goTAtSJKrIGEp1xDj03epk_CBMW9qArcu1L5ZEeNsgATVCu3vUuYipk4KDww==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestMoveOverSelf --- FAIL: TestMoveOverSelf (79.77s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:09:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xahafah1lifu" 2024/10/30 03:09:53 DEBUG : proton drive root link ID 'rclone-test-xahafah1lifu': Has cached credentials 2024/10/30 03:09:54 DEBUG : proton drive root link ID 'rclone-test-xahafah1lifu': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-ripayuq2sezo' -> proton drive root link ID 'rclone-test-xahafah1lifu' 2024/10/30 03:09:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 03:09:55 DEBUG : proton drive root link ID 'rclone-test-xahafah1lifu': Waiting for checks to finish 2024/10/30 03:09:55 DEBUG : proton drive root link ID 'rclone-test-xahafah1lifu': Waiting for transfers to finish 2024/10/30 03:09:57 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/10/30 03:09:57 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:09:58.850539 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 2024/10/30 03:09:58.850565 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) 2024/10/30 03:10:10.212233 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:10:10Z" level=warning msg="Too many requests, retrying after delay" after=13 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==" 2024/10/30 03:10:33.675783 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:10:33Z" level=warning msg="Too many requests, retrying after delay" after=7 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==" 2024/10/30 03:10:50.992848 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:10:50Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==" 2024/10/30 03:12:05.217638 WARN RESTY 500 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Internal server error (Code=500, Status=500), Attempt 4 2024/10/30 03:12:05.217669 ERROR RESTY 500 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Internal server error (Code=500, Status=500) run.go:285: Failed to put "sub dir/hello world" to "proton drive root link ID 'rclone-test-ripayuq2sezo'": 500 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/xVEa0vW2Qij0WxI5Lrek5mdk1HFaast-R9Rk3wcRD2fg738cnBwFUkte9Vf59fZHzz1gOJzft9QBymF6gMlPtA==/revisions/OodY2k0pv82Oomk91oScgxXlQYMLwAQphPgm5mNtqyb-XqmxefipTDpIcn4D_bpRWJQZ10Ra-lrusylUcQnSnQ==: Internal server error (Code=500, Status=500) 2024/10/30 03:12:05 DEBUG : proton drive root link ID 'rclone-test-xahafah1lifu': Purge remote 2024/10/30 03:12:16.758404 WARN RESTY 429 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/dfWOxoOENhdIfXPrYKzeZvL14VooL2MIfEo4-LTPfd_AawtKDISsZM3L7mbaaYTeZvz41_Iksm0tDRDGjbFoFw==/trash_multiple: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:12:16Z" level=warning msg="Too many requests, retrying after delay" after=6 method=POST pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/dfWOxoOENhdIfXPrYKzeZvL14VooL2MIfEo4-LTPfd_AawtKDISsZM3L7mbaaYTeZvz41_Iksm0tDRDGjbFoFw==/trash_multiple" 2024/10/30 03:12:33.075739 WARN RESTY 429 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/dfWOxoOENhdIfXPrYKzeZvL14VooL2MIfEo4-LTPfd_AawtKDISsZM3L7mbaaYTeZvz41_Iksm0tDRDGjbFoFw==/trash_multiple: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:12:33Z" level=warning msg="Too many requests, retrying after delay" after=9 method=POST pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/dfWOxoOENhdIfXPrYKzeZvL14VooL2MIfEo4-LTPfd_AawtKDISsZM3L7mbaaYTeZvz41_Iksm0tDRDGjbFoFw==/trash_multiple" --- FAIL: TestServerSideMoveOverSelf (171.72s) === RUN TestSyncIgnoreTimes run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:12:44 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/10/30 03:12:44 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:12:44 DEBUG : existing: Unchanged skipping 2024/10/30 03:12:44 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:12:44 DEBUG : Waiting for deletions to finish 2024/10/30 03:12:44 INFO : There was nothing to transfer run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:12:45 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/10/30 03:12:45 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:12:45 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:12:45.487166 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 2024/10/30 03:12:45.487185 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) 2024/10/30 03:12:57.255321 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:12:57Z" level=warning msg="Too many requests, retrying after delay" after=7 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==" 2024/10/30 03:13:14.650085 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:13:14Z" level=warning msg="Too many requests, retrying after delay" after=8 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==" 2024/10/30 03:13:33.055774 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:13:33Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==" 2024/10/30 03:13:58.079956 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:13:58.079976 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:13:58 ERROR : existing: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:13:58 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:13:58 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:875: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:875 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/0-x7YSzIA0S6uOL68FU_GiNxrjTDydugheCxH529h-fOSoAcvNb4AyVji51RosMZSckEQIH-q720EMYrzMIPlg==/revisions/e3f7Ttdb02NUdNvFkHVR909VAsceWq9VNPuuxcFJgY0u8f4oMGfOEZj2U-kd7B19VTiW5fpNw8SrnTBDwVD3sw==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncIgnoreTimes --- FAIL: TestSyncIgnoreTimes (76.12s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:14:01 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 +0000 2024/10/30 03:14:01 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:14:01 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/10/30 03:14:01 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/10/30 03:14:01 DEBUG : empty space: Unchanged skipping 2024/10/30 03:14:01 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:14:01 DEBUG : Waiting for deletions to finish 2024/10/30 03:14:01 INFO : There was nothing to transfer run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:14:01 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 +0000 2024/10/30 03:14:01 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:14:01 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/10/30 03:14:01 NOTICE: proton drive root link ID 'rclone-test-ripayuq2sezo': Forced to upload files to set modification times on this backend. 2024/10/30 03:14:01 INFO : empty space: src and dst identical but can't set mod time without re-uploading 2024/10/30 03:14:01 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:14:02.044649 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 2024/10/30 03:14:02.044669 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) 2024/10/30 03:14:13.793811 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:14:13Z" level=warning msg="Too many requests, retrying after delay" after=5 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==" 2024/10/30 03:14:28.989488 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:14:28Z" level=warning msg="Too many requests, retrying after delay" after=8 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==" 2024/10/30 03:14:47.803435 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:14:47Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==" 2024/10/30 03:15:08.111263 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:15:08.111276 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:15:08 ERROR : empty space: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:15:08 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:15:08 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:1003: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1003 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/leEmaE--o7YJP1exHzboxeV9xBjC9uQ9ukaQyT-hiD_HNWcILX7vzWh6aBq-18EVdeztT_c0PYLkbZ1C3I1oHw==/revisions/4_Eel2aSVgLs6kHqh7xeNifM9IDMFl5JNXV-lnMHkskB5KUvcXyVXnI9Fh5T5jgazDfC36kX93OMA_1_9yh-bw==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncAfterChangingModtimeOnly --- FAIL: TestSyncAfterChangingModtimeOnly (70.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:15:11 DEBUG : foo: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 +0000 2024/10/30 03:15:11 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:15:11 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone222887415) 2024/10/30 03:15:11 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (proton drive root link ID 'rclone-test-ripayuq2sezo') 2024/10/30 03:15:11 DEBUG : foo: sha1 differ 2024/10/30 03:15:11 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:15:11.398782 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 2024/10/30 03:15:11.398807 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) 2024/10/30 03:15:22.830571 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:15:22Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==" 2024/10/30 03:15:47.611801 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:15:47Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==" 2024/10/30 03:16:12.236552 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:16:12Z" level=warning msg="Too many requests, retrying after delay" after=6 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==" 2024/10/30 03:16:28.989676 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:16:28.989694 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:16:28 ERROR : foo: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:16:28 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:16:28 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:1054: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1054 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/87oe_6-JCqvG44Bj6nlHFOdmxlyDHh0c70kfGKV_-nmfFUA7LVYXFeSYnpasYcRehyJ-7ahIrp-lXI4a4k1wMg==/revisions/VcJFGqx6H1gy1dDk7oGTMBfzsbcm31Dt1ibdNyEOm8MBvhuvUUGIzjFlyzkNh_jKzLPrgRNbGYu4NHMUimGCmA==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncDoesntUpdateModtime --- FAIL: TestSyncDoesntUpdateModtime (80.40s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:16:31 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/10/30 03:16:31 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:16:31 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:16:31.632913 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 2024/10/30 03:16:31.632937 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) 2024/10/30 03:16:42.928062 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:16:42Z" level=warning msg="Too many requests, retrying after delay" after=5 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==" 2024/10/30 03:16:58.497938 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:16:58Z" level=warning msg="Too many requests, retrying after delay" after=9 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==" 2024/10/30 03:17:18.153700 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:17:18Z" level=warning msg="Too many requests, retrying after delay" after=11 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==" 2024/10/30 03:17:39.496530 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:17:39.496554 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:17:39 ERROR : potato: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:17:39 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:17:39 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:1093: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1093 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/26VXzBbb0g6PNx9LDEqHRQN-dB3JxvMAvHraIZ2AT_JrpAuCPrDUmGJqaaPzArnhf3fTIe5d3T7kdWxulJTliQ==/revisions/9Ayeif1zpRv-bJeJdh_D0ZMXWsIbyTzxp8txmtHiDjnmZl1Nj9RqUDEbycMlCwXuKyhUvbw2t9MDPfJmmvya7g==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncAfterChangingFilesSizeOnly --- FAIL: TestSyncAfterChangingFilesSizeOnly (70.57s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:17:41 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 +0000 2024/10/30 03:17:41 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:17:41 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone222887415) 2024/10/30 03:17:41 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (proton drive root link ID 'rclone-test-ripayuq2sezo') 2024/10/30 03:17:41 DEBUG : potato: sha1 differ 2024/10/30 03:17:41 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:17:42.080694 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 2024/10/30 03:17:42.080715 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) 2024/10/30 03:17:53.625601 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:17:53Z" level=warning msg="Too many requests, retrying after delay" after=12 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==" 2024/10/30 03:18:16.538044 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:18:16Z" level=warning msg="Too many requests, retrying after delay" after=11 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==" 2024/10/30 03:18:37.939174 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:18:37Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==" 2024/10/30 03:19:02.245894 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:19:02.245916 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:19:02 ERROR : potato: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:19:02 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:19:02 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:1118: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1118 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/2xnWeBo1WnVFQvzCvck4YT4-zU6OPBeOG1AYYyF_AQDIfpJXuRTST04eWpPODwGaqZ617DznFZ3V_6AfBTP8yQ==/revisions/IQa3otN-G4ynLeQU2HyCpNsoEVBJuhIuoRJ6pB6327_60Us7xQkA6OrB9abu0HUDNGOjWTFtZymzUn-nYdL7Ag==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncAfterChangingContentsOnly --- FAIL: TestSyncAfterChangingContentsOnly (82.80s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:19:08 DEBUG : five: Need to transfer - File not found at Destination 2024/10/30 03:19:08 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/10/30 03:19:08 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:19:08 DEBUG : one: Destination is newer than source, skipping 2024/10/30 03:19:08 DEBUG : three: Sizes identical 2024/10/30 03:19:08 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/10/30 03:19:08 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/10/30 03:19:08 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone222887415) 2024/10/30 03:19:08 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (proton drive root link ID 'rclone-test-ripayuq2sezo') 2024/10/30 03:19:08 DEBUG : two: sha1 differ 2024/10/30 03:19:08 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:19:08.316659 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 2024/10/30 03:19:08.316686 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) 2024/10/30 03:19:08.334668 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 2024/10/30 03:19:08.334693 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) 2024/10/30 03:19:08 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/10/30 03:19:08 INFO : five: Copied (new) 2024/10/30 03:19:19.648289 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:19:19Z" level=warning msg="Too many requests, retrying after delay" after=6 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==" 2024/10/30 03:19:19.650676 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:19:19Z" level=warning msg="Too many requests, retrying after delay" after=11 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==" 2024/10/30 03:19:37.169806 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:19:37Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==" 2024/10/30 03:19:41.400802 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:19:41Z" level=warning msg="Too many requests, retrying after delay" after=8 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==" 2024/10/30 03:19:58.303778 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:19:58Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==" 2024/10/30 03:20:00.327022 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:20:00Z" level=warning msg="Too many requests, retrying after delay" after=14 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==" 2024/10/30 03:20:23.485659 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:20:23.485677 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:20:23 ERROR : four: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/-nxObWSB_tKjnuQ4b3tzpGVa-6VllVUkK_fK5SCwYLXJ0TrIDZtqWUlDp9PlJGTKX8pdK9h79Hp6LWyGKsSWlA==/revisions/sDLgHmBKkVdBoOp1IjIcYyqvoTrw_kcvUHi1S6nWcKw_PP7x4JaqskkKfyxhvt49uweHNVga4bX2VN-VsoYAZQ==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:20:24.554495 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:20:24.554530 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:20:24 ERROR : two: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:20:24 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:20:24 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:1444: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1444 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/ETs7FVeLZSd5UNth8CZlHkYw3JBveYfgpxziUnRLwT88vkmS1GtzlNUX1_hcfVYJEJeurw5iDaMpz0fLvrT1ng==/revisions/eYeSxDCHqeuq0aJQju2tf7rKcKXjZ-McwlJTome3mUPcD8d_C3jIsASos2FB_FNLar1j5kUtla3kXnkk5_sIbw==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncWithUpdateOlder --- FAIL: TestSyncWithUpdateOlder (83.56s) === RUN TestSyncCompareDest run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:20:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-ripayuq2sezo/dst" 2024/10/30 03:20:26 DEBUG : Config file has changed externally - reloading 2024/10/30 03:20:26 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Has cached credentials 2024/10/30 03:20:27 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Used cached credential to initialize the ProtonDrive API 2024/10/30 03:21:57 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-ripayuq2sezo/CompareDest" 2024/10/30 03:21:57 DEBUG : Config file has changed externally - reloading 2024/10/30 03:21:57 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/CompareDest': Has cached credentials 2024/10/30 03:21:58 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/CompareDest': Used cached credential to initialize the ProtonDrive API 2024/10/30 03:23:27 DEBUG : one: Need to transfer - File not found at Destination 2024/10/30 03:23:27 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Waiting for checks to finish 2024/10/30 03:23:27 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Waiting for transfers to finish 2024/10/30 03:23:29 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/10/30 03:23:29 INFO : one: Copied (new) 2024/10/30 03:23:29 DEBUG : Waiting for deletions to finish 2024/10/30 03:23:30 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 03:23:30 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Waiting for checks to finish 2024/10/30 03:23:30 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': Waiting for transfers to finish 2024/10/30 03:23:30.959869 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 2024/10/30 03:23:30.959891 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) 2024/10/30 03:23:42.213062 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:23:42Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==" 2024/10/30 03:24:03.217687 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:24:03Z" level=warning msg="Too many requests, retrying after delay" after=12 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==" 2024/10/30 03:24:25.980040 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:24:25Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==" 2024/10/30 03:24:47.048888 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:24:47.048902 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:24:47 ERROR : one: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:24:47 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': not deleting files as there were IO errors 2024/10/30 03:24:47 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo/dst': not deleting directories as there were IO errors sync_test.go:2101: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2101 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/WCZ8oFKxu3Yr7MCWEyTVuy2SR4WN3LzrBdRjVb94nZUPV_DlonlkyS5zovulj_UKLMyWomsWCbsxSp3TWXSMvQ==/revisions/igcJ2pQCEzLNn1yxX5puGqzX1CWObom7FltEyDv4VU_iiTprwmRj2tI7ilXG6RbAqjOYxMnrFYoCN0UZw-mOjg==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncCompareDest run.go:125: removing dir "dst" failed - try 1/3: folder can't be deleted because it is not empty run.go:125: removing dir "dst" failed - try 2/3: folder can't be deleted because it is not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestSyncCompareDest (316.83s) === RUN TestSyncUTFNorm run.go:180: Remote "proton drive root link ID 'rclone-test-ripayuq2sezo'", Local "Local file system at /tmp/rclone222887415", Modify Window "1s" 2024/10/30 03:25:45 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/10/30 03:25:45 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for checks to finish 2024/10/30 03:25:45 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Waiting for transfers to finish 2024/10/30 03:25:45.566734 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 2024/10/30 03:25:45.566764 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) 2024/10/30 03:25:56.667396 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 1 time="2024-10-30T03:25:56Z" level=warning msg="Too many requests, retrying after delay" after=6 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==" 2024/10/30 03:26:13.701781 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 2 time="2024-10-30T03:26:13Z" level=warning msg="Too many requests, retrying after delay" after=10 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==" 2024/10/30 03:26:33.843741 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 3 time="2024-10-30T03:26:33Z" level=warning msg="Too many requests, retrying after delay" after=7 method=PUT pkg=go-proton-api status=429 url="https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==" 2024/10/30 03:26:51.181268 WARN RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429), Attempt 4 2024/10/30 03:26:51.181292 ERROR RESTY 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:26:51 ERROR : Testêé: Failed to copy: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429) 2024/10/30 03:26:51 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting files as there were IO errors 2024/10/30 03:26:51 ERROR : proton drive root link ID 'rclone-test-ripayuq2sezo': not deleting directories as there were IO errors sync_test.go:2551: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2551 Error: Received unexpected error: 429 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/TVlDhbBsmI3QYSU4G-_Y6rzb3-Te0ZoL_fcCa32LT2uMOgpP4kRxA0TSBgYyfnMZfEZP5BTAuUr6J9M0MWqM-w==/revisions/_xtW9tvm_tPmt2VrGj2H9C-vQ6rCDTZ-tylDwpw9x1EV05l1W2rcjtTy1BrwyMha20wamjkoeCFmi_f8OZAsDQ==: Resource is busy. Please try again (Code=2502, Status=429) Test: TestSyncUTFNorm --- FAIL: TestSyncUTFNorm (68.50s) FAIL 2024/10/30 03:26:52 DEBUG : proton drive root link ID 'rclone-test-ripayuq2sezo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestCopyOverSelf|TestMoveOverSelf|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingModtimeOnly|TestSyncCompareDest|TestSyncDoesntUpdateModtime|TestSyncIgnoreTimes|TestSyncUTFNorm|TestSyncWithUpdateOlder)$'" - Finished ERROR in 21m2.492223508s (try 2/5): exit status 1: Failed [TestCopyOverSelf TestServerSideCopyOverSelf TestMoveOverSelf TestServerSideMoveOverSelf TestSyncIgnoreTimes TestSyncAfterChangingModtimeOnly TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncCompareDest TestSyncUTFNorm]