"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestFixCase|TestMoveWithDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Starting (try 2/5) 2024/12/13 04:42:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine" 2024/12/13 04:42:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/12/13 04:42:15 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Using username and password to log in 2024/12/13 04:42:17 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Used username and password to initialize the ProtonDrive API 2024/12/13 04:42:17 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2024/12/13 04:42:17 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2024/12/13 04:42:17 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2024/12/13 04:42:17 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2024/12/13 04:42:18 DEBUG : Creating backend with remote "/tmp/rclone2930683498" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-winewob6cimu" 2024/12/13 04:42:20 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Has cached credentials 2024/12/13 04:42:20 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-rocafoh0bine' -> proton drive root link ID 'rclone-test-winewob6cimu' 2024/12/13 04:42:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/12/13 04:42:21 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Waiting for checks to finish 2024/12/13 04:42:21 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Waiting for transfers to finish 2024/12/13 04:42:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/12/13 04:42:23 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:24.131779 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/12/13 04:42:24.131802 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/12/13 04:42:25 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Using server-side directory move 2024/12/13 04:42:25 INFO : proton drive root link ID 'rclone-test-winewob6cimu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:42:25 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Waiting for checks to finish 2024/12/13 04:42:25 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/12/13 04:42:25 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Waiting for transfers to finish 2024/12/13 04:42:25 INFO : sub dir/hello world: Deleted 2024/12/13 04:42:26.393966 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3xDSetozp5JnBfYwbgCjYvIB4sGd23dqWGZiU8uyuTshVFimxrxj4tOZa40BDZaTe6GcqtmlLivVFWqIbmDPDQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:26.393982 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3xDSetozp5JnBfYwbgCjYvIB4sGd23dqWGZiU8uyuTshVFimxrxj4tOZa40BDZaTe6GcqtmlLivVFWqIbmDPDQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:26 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3xDSetozp5JnBfYwbgCjYvIB4sGd23dqWGZiU8uyuTshVFimxrxj4tOZa40BDZaTe6GcqtmlLivVFWqIbmDPDQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3xDSetozp5JnBfYwbgCjYvIB4sGd23dqWGZiU8uyuTshVFimxrxj4tOZa40BDZaTe6GcqtmlLivVFWqIbmDPDQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2024/12/13 04:42:26 DEBUG : proton drive root link ID 'rclone-test-winewob6cimu': Purge remote --- FAIL: TestServerSideMoveOverSelf (9.86s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:1538: Can track renames: true 2024/12/13 04:42:28 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:28 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:28 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:42:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:42:28 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:28 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:28 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:42:28 INFO : potato: Copied (new) 2024/12/13 04:42:28 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:28 INFO : yam: Copied (new) 2024/12/13 04:42:28 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:29 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:29 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:42:29 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:29 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:29 DEBUG : potato: Unchanged skipping 2024/12/13 04:42:29 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:29.860201 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7m0K9Q1tkCDVWhMn1C8NADUF6RaHPtIKw30JLj61I3I3prIr8bCD6p_Umgd9SidLhpYkJslRAVD4oqKkOk7gMg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:29.860226 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7m0K9Q1tkCDVWhMn1C8NADUF6RaHPtIKw30JLj61I3I3prIr8bCD6p_Umgd9SidLhpYkJslRAVD4oqKkOk7gMg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:29 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7m0K9Q1tkCDVWhMn1C8NADUF6RaHPtIKw30JLj61I3I3prIr8bCD6p_Umgd9SidLhpYkJslRAVD4oqKkOk7gMg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:29 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7m0K9Q1tkCDVWhMn1C8NADUF6RaHPtIKw30JLj61I3I3prIr8bCD6p_Umgd9SidLhpYkJslRAVD4oqKkOk7gMg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:29 DEBUG : yaml: Need to transfer - No matching file found at Destination 2024/12/13 04:42:29 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:30 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:30 INFO : yaml: Copied (new) 2024/12/13 04:42:30 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting files as there were IO errors 2024/12/13 04:42:30 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (3.91s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:1610: Can track renames: true 2024/12/13 04:42:32 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:32 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:32 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:32 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:42:32 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:42:32 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:32 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:32 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:42:32 INFO : potato: Copied (new) 2024/12/13 04:42:32 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:32 INFO : yam: Copied (new) 2024/12/13 04:42:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:33 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:33 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:42:33 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:33 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:33 DEBUG : potato: Unchanged skipping 2024/12/13 04:42:33 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:33.856433 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TeK37Z5DmIakWiufT3-Nx-J934tPCREd0VAqk4LyGQO1cQ_DwZXsG25v9AQNHMmAE7DIJ-47hLigTJocR5wXeg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:33.856456 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TeK37Z5DmIakWiufT3-Nx-J934tPCREd0VAqk4LyGQO1cQ_DwZXsG25v9AQNHMmAE7DIJ-47hLigTJocR5wXeg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:33 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TeK37Z5DmIakWiufT3-Nx-J934tPCREd0VAqk4LyGQO1cQ_DwZXsG25v9AQNHMmAE7DIJ-47hLigTJocR5wXeg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:33 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/TeK37Z5DmIakWiufT3-Nx-J934tPCREd0VAqk4LyGQO1cQ_DwZXsG25v9AQNHMmAE7DIJ-47hLigTJocR5wXeg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:33 DEBUG : yaml: Need to transfer - No matching file found at Destination 2024/12/13 04:42:33 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:34 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:34 INFO : yaml: Copied (new) 2024/12/13 04:42:34 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting files as there were IO errors 2024/12/13 04:42:34 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (4.06s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:1649: Can track renames: true 2024/12/13 04:42:36 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:36 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:36 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:42:36 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/12/13 04:42:36 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:36 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:37 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:42:37 INFO : potato: Copied (new) 2024/12/13 04:42:37 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:37 INFO : sub/yam: Copied (new) 2024/12/13 04:42:37 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:38 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:42:38 DEBUG : potato: Unchanged skipping 2024/12/13 04:42:38 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Making map for --track-renames 2024/12/13 04:42:38 INFO : proton drive root link ID 'rclone-test-rocafoh0bine': Finished making map for --track-renames 2024/12/13 04:42:38 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:38 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for renames to finish 2024/12/13 04:42:38.687523 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt-WHba2c_vf8_QnrrxULGHQSZiyIk35vWpIcHUWRDbOGrB0e8J8AZpRF_YVSfvv30jy4enXCXCd3Rr7AhGl8A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:38.687545 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt-WHba2c_vf8_QnrrxULGHQSZiyIk35vWpIcHUWRDbOGrB0e8J8AZpRF_YVSfvv30jy4enXCXCd3Rr7AhGl8A==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:38 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt-WHba2c_vf8_QnrrxULGHQSZiyIk35vWpIcHUWRDbOGrB0e8J8AZpRF_YVSfvv30jy4enXCXCd3Rr7AhGl8A==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:38 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zt-WHba2c_vf8_QnrrxULGHQSZiyIk35vWpIcHUWRDbOGrB0e8J8AZpRF_YVSfvv30jy4enXCXCd3Rr7AhGl8A==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:38 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:42:38 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:39 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:42:39 INFO : yam: Copied (new) 2024/12/13 04:42:39 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting files as there were IO errors 2024/12/13 04:42:39 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (5.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/12/13 04:42:41 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/12/13 04:42:41 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:42:41 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:42:43 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/12/13 04:42:43 INFO : nested/sub dir/file: Copied (new) 2024/12/13 04:42:43 INFO : nested/sub dir/file: Deleted 2024/12/13 04:42:43 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/12/13 04:42:43 INFO : sub dir/hello world: Copied (new) 2024/12/13 04:42:43 INFO : sub dir/hello world: Deleted 2024/12/13 04:42:43 ERROR : Local file system at /tmp/rclone2930683498: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (3.81s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rixonoc2roco" 2024/12/13 04:42:44 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Has cached credentials 2024/12/13 04:42:45 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-rocafoh0bine' -> proton drive root link ID 'rclone-test-rixonoc2roco' 2024/12/13 04:42:50 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Using server-side directory move 2024/12/13 04:42:50 INFO : proton drive root link ID 'rclone-test-rixonoc2roco': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:42:50 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:42:50 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/12/13 04:42:50 DEBUG : empty space: Unchanged skipping 2024/12/13 04:42:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:42:50 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Waiting for checks to finish 2024/12/13 04:42:50 INFO : empty space: Deleted 2024/12/13 04:42:50 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Waiting for transfers to finish 2024/12/13 04:42:50 INFO : potato3: Deleted 2024/12/13 04:42:51.019840 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zuK2KvlzWDymohNQ9Wk9RS63RwrFPaHUf8skA5NMWgg-S4-NaUzgslbKVrtrtv90T-9pqa7bXZnt7PQwjGZGyQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:51.019863 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zuK2KvlzWDymohNQ9Wk9RS63RwrFPaHUf8skA5NMWgg-S4-NaUzgslbKVrtrtv90T-9pqa7bXZnt7PQwjGZGyQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:51 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zuK2KvlzWDymohNQ9Wk9RS63RwrFPaHUf8skA5NMWgg-S4-NaUzgslbKVrtrtv90T-9pqa7bXZnt7PQwjGZGyQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:51.113122 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jmzoalYvWbdmX7PSZLAhADyMvO72Mbus8X6PwLiSLlskR8fgH3fUggkiEaTmUW1j0xDDVecEihKUPsfKwQQkRQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:51.113162 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jmzoalYvWbdmX7PSZLAhADyMvO72Mbus8X6PwLiSLlskR8fgH3fUggkiEaTmUW1j0xDDVecEihKUPsfKwQQkRQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:51 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jmzoalYvWbdmX7PSZLAhADyMvO72Mbus8X6PwLiSLlskR8fgH3fUggkiEaTmUW1j0xDDVecEihKUPsfKwQQkRQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jmzoalYvWbdmX7PSZLAhADyMvO72Mbus8X6PwLiSLlskR8fgH3fUggkiEaTmUW1j0xDDVecEihKUPsfKwQQkRQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2024/12/13 04:42:51 DEBUG : proton drive root link ID 'rclone-test-rixonoc2roco': Purge remote --- FAIL: TestServerSideMove (7.33s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:42:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rufanim6mufi" 2024/12/13 04:42:52 DEBUG : proton drive root link ID 'rclone-test-rufanim6mufi': Has cached credentials 2024/12/13 04:42:52 DEBUG : proton drive root link ID 'rclone-test-rufanim6mufi': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-rocafoh0bine' -> proton drive root link ID 'rclone-test-rufanim6mufi' 2024/12/13 04:42:58 DEBUG : empty space: Excluded (Size Filter) 2024/12/13 04:42:58 DEBUG : empty space: Excluded 2024/12/13 04:42:58 DEBUG : empty space: Excluded (Size Filter) 2024/12/13 04:42:58 DEBUG : empty space: Excluded 2024/12/13 04:42:58 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:42:58 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:42:58 DEBUG : proton drive root link ID 'rclone-test-rufanim6mufi': Waiting for checks to finish 2024/12/13 04:42:58 DEBUG : proton drive root link ID 'rclone-test-rufanim6mufi': Waiting for transfers to finish 2024/12/13 04:42:58 INFO : potato3: Deleted 2024/12/13 04:42:58.580248 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3dwpxLnkNubeKfVhZyKS9B2kkgEvBT-yTIZsVvIJI5d2qSAx7VRJjdLJjbffzwIOAe-l6-9zfW5wnNMhA9Ytuw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:58.580269 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3dwpxLnkNubeKfVhZyKS9B2kkgEvBT-yTIZsVvIJI5d2qSAx7VRJjdLJjbffzwIOAe-l6-9zfW5wnNMhA9Ytuw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3dwpxLnkNubeKfVhZyKS9B2kkgEvBT-yTIZsVvIJI5d2qSAx7VRJjdLJjbffzwIOAe-l6-9zfW5wnNMhA9Ytuw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:58.659297 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wL7nFn9p-G2_wcBAGOzeQI0y8wImQlykJ0C481QVFzfIkqNFLm03kLWAczsVMUGT5QH0oqqVaBYmKYTQlXPdiQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:42:58.659318 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wL7nFn9p-G2_wcBAGOzeQI0y8wImQlykJ0C481QVFzfIkqNFLm03kLWAczsVMUGT5QH0oqqVaBYmKYTQlXPdiQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:42:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wL7nFn9p-G2_wcBAGOzeQI0y8wImQlykJ0C481QVFzfIkqNFLm03kLWAczsVMUGT5QH0oqqVaBYmKYTQlXPdiQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wL7nFn9p-G2_wcBAGOzeQI0y8wImQlykJ0C481QVFzfIkqNFLm03kLWAczsVMUGT5QH0oqqVaBYmKYTQlXPdiQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2024/12/13 04:42:58 DEBUG : proton drive root link ID 'rclone-test-rufanim6mufi': Purge remote --- FAIL: TestServerSideMoveWithFilter (7.89s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:43:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuhoniy1yusi" 2024/12/13 04:43:00 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Has cached credentials 2024/12/13 04:43:00 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:43:03 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-rocafoh0bine' -> proton drive root link ID 'rclone-test-wuhoniy1yusi' 2024/12/13 04:43:05 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Using server-side directory move 2024/12/13 04:43:05 INFO : proton drive root link ID 'rclone-test-wuhoniy1yusi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:43:06 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:43:06 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/12/13 04:43:06 DEBUG : empty space: Unchanged skipping 2024/12/13 04:43:06 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:43:06 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Waiting for checks to finish 2024/12/13 04:43:06 INFO : potato3: Deleted 2024/12/13 04:43:06 INFO : empty space: Deleted 2024/12/13 04:43:06 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Waiting for transfers to finish 2024/12/13 04:43:06.608344 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pmXMUAzK2diWS3HAzWHxfE0N2zjKyrJ7chAKdPwjYrjEusLghE5M7jWvfvNwnuBz9SsiZdUYgkfTbpvoDbwfwA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:43:06.608366 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pmXMUAzK2diWS3HAzWHxfE0N2zjKyrJ7chAKdPwjYrjEusLghE5M7jWvfvNwnuBz9SsiZdUYgkfTbpvoDbwfwA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:43:06 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pmXMUAzK2diWS3HAzWHxfE0N2zjKyrJ7chAKdPwjYrjEusLghE5M7jWvfvNwnuBz9SsiZdUYgkfTbpvoDbwfwA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:43:06.740393 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/86B2CEx7SVxzlgAjaBoYomhitPSLtaSOvEjMCS0WhdTU8l-a9fIsDWXtTiYMo_iVk2ekf9nLJoB9e1frpY7OqA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:43:06.740417 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/86B2CEx7SVxzlgAjaBoYomhitPSLtaSOvEjMCS0WhdTU8l-a9fIsDWXtTiYMo_iVk2ekf9nLJoB9e1frpY7OqA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:43:06 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/86B2CEx7SVxzlgAjaBoYomhitPSLtaSOvEjMCS0WhdTU8l-a9fIsDWXtTiYMo_iVk2ekf9nLJoB9e1frpY7OqA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:43:06 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2024/12/13 04:43:06 DEBUG : proton drive root link ID 'rclone-test-wuhoniy1yusi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (8.06s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:43:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dest" 2024/12/13 04:43:10 DEBUG : Config file has changed externally - reloading 2024/12/13 04:43:10 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dest': Has cached credentials 2024/12/13 04:43:11 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dest': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:44:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/pre-dest1" 2024/12/13 04:44:03 DEBUG : Config file has changed externally - reloading 2024/12/13 04:44:03 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/pre-dest1': Has cached credentials 2024/12/13 04:44:03 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/pre-dest1': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:44:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/pre-dest2" 2024/12/13 04:44:29 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/pre-dest2': Has cached credentials 2024/12/13 04:44:30 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/pre-dest2': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:44:57 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:44:57 DEBUG : 1: Destination found in --compare-dest, skipping 2024/12/13 04:44:57 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:44:57 DEBUG : 2: Destination found in --compare-dest, skipping 2024/12/13 04:44:57 DEBUG : 3: Need to transfer - File not found at Destination 2024/12/13 04:44:57 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dest': Waiting for checks to finish 2024/12/13 04:44:57 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dest': Waiting for transfers to finish 2024/12/13 04:44:59 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/12/13 04:44:59 INFO : 3: Copied (new) 2024/12/13 04:44:59 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (113.36s) === RUN TestSyncCopyDest run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:2235: Skipping test as remote does not support server-side copy --- SKIP: TestSyncCopyDest (0.34s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:45:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:45:05 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:45:05 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:45:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/backup" 2024/12/13 04:45:32 DEBUG : Config file has changed externally - reloading 2024/12/13 04:45:32 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Has cached credentials 2024/12/13 04:45:33 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:46:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:46:24 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:46:24 DEBUG : two: Unchanged skipping 2024/12/13 04:46:24 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for checks to finish 2024/12/13 04:46:25.482684 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/j94KZLzeHW1MA-hF2rbBOJsdioIZrTYR4csKG_zgpQ2o-sq2EREv-NNHEiEfTQTaazz-oqwEWVgenE8BJYpyoQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:46:25.482708 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/j94KZLzeHW1MA-hF2rbBOJsdioIZrTYR4csKG_zgpQ2o-sq2EREv-NNHEiEfTQTaazz-oqwEWVgenE8BJYpyoQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:46:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/j94KZLzeHW1MA-hF2rbBOJsdioIZrTYR4csKG_zgpQ2o-sq2EREv-NNHEiEfTQTaazz-oqwEWVgenE8BJYpyoQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:46:25 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for transfers to finish 2024/12/13 04:46:25 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting files as there were IO errors 2024/12/13 04:46:25 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/j94KZLzeHW1MA-hF2rbBOJsdioIZrTYR4csKG_zgpQ2o-sq2EREv-NNHEiEfTQTaazz-oqwEWVgenE8BJYpyoQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (85.29s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:46:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:46:30 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:46:31 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:46:57 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/backup" 2024/12/13 04:46:57 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Has cached credentials 2024/12/13 04:46:58 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:47:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:47:50 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:47:50 DEBUG : two: Unchanged skipping 2024/12/13 04:47:50 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for checks to finish 2024/12/13 04:47:51.514490 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Iz03YNJj8AGF0OvNyOCEly_7CDnQg9shCn2-Q2QFKG25djYmLnXf1pgIfNowDcnhedQikjF8kq9tCQHjg819xg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:47:51.514643 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Iz03YNJj8AGF0OvNyOCEly_7CDnQg9shCn2-Q2QFKG25djYmLnXf1pgIfNowDcnhedQikjF8kq9tCQHjg819xg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:47:51 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Iz03YNJj8AGF0OvNyOCEly_7CDnQg9shCn2-Q2QFKG25djYmLnXf1pgIfNowDcnhedQikjF8kq9tCQHjg819xg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:47:51 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for transfers to finish 2024/12/13 04:47:51 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting files as there were IO errors 2024/12/13 04:47:51 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Iz03YNJj8AGF0OvNyOCEly_7CDnQg9shCn2-Q2QFKG25djYmLnXf1pgIfNowDcnhedQikjF8kq9tCQHjg819xg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (85.92s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:47:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:47:56 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:47:57 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:48:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/backup" 2024/12/13 04:48:22 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Has cached credentials 2024/12/13 04:48:23 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:49:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:49:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:49:15 DEBUG : two: Unchanged skipping 2024/12/13 04:49:15 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for checks to finish 2024/12/13 04:49:16.395747 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5oiHebP6SAlgc9kLJtExbEH5SuEuAJq5UYP5R1MmlEDb32p63kF0voJe1UmumSqH2xGtTNfYugiNkzOeHa4GSw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:49:16.395791 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5oiHebP6SAlgc9kLJtExbEH5SuEuAJq5UYP5R1MmlEDb32p63kF0voJe1UmumSqH2xGtTNfYugiNkzOeHa4GSw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:49:16 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5oiHebP6SAlgc9kLJtExbEH5SuEuAJq5UYP5R1MmlEDb32p63kF0voJe1UmumSqH2xGtTNfYugiNkzOeHa4GSw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:49:16 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for transfers to finish 2024/12/13 04:49:16 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting files as there were IO errors 2024/12/13 04:49:16 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5oiHebP6SAlgc9kLJtExbEH5SuEuAJq5UYP5R1MmlEDb32p63kF0voJe1UmumSqH2xGtTNfYugiNkzOeHa4GSw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (84.94s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:49:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:49:21 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:49:22 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:49:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:49:48 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for checks to finish 2024/12/13 04:49:48 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:49:48 DEBUG : two: Unchanged skipping 2024/12/13 04:49:49.010721 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pd5qdsSnNDMHVtOS5VJu2enNwpGHaxTpXN6b727-dBC1axQtY5YoRolHKfOOTU53Z7CrVRFvmi97k2hevTyNEA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:49:49.010796 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pd5qdsSnNDMHVtOS5VJu2enNwpGHaxTpXN6b727-dBC1axQtY5YoRolHKfOOTU53Z7CrVRFvmi97k2hevTyNEA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:49:49 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pd5qdsSnNDMHVtOS5VJu2enNwpGHaxTpXN6b727-dBC1axQtY5YoRolHKfOOTU53Z7CrVRFvmi97k2hevTyNEA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:49:49 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Waiting for transfers to finish 2024/12/13 04:49:49 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting files as there were IO errors 2024/12/13 04:49:49 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pd5qdsSnNDMHVtOS5VJu2enNwpGHaxTpXN6b727-dBC1axQtY5YoRolHKfOOTU53Z7CrVRFvmi97k2hevTyNEA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (32.47s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:49:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:49:53 DEBUG : Config file has changed externally - reloading 2024/12/13 04:49:53 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:49:54 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:50:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:50:20.869236 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8LlIEsJmnKxIh5BX5lUM3oQF2rR_Gog9UPMxZy9hW7ai7FknKSFlXU5UTm5O9Bke9fJfl_u364rRjivxrT7x4Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:50:20.869259 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8LlIEsJmnKxIh5BX5lUM3oQF2rR_Gog9UPMxZy9hW7ai7FknKSFlXU5UTm5O9Bke9fJfl_u364rRjivxrT7x4Q==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:50:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8LlIEsJmnKxIh5BX5lUM3oQF2rR_Gog9UPMxZy9hW7ai7FknKSFlXU5UTm5O9Bke9fJfl_u364rRjivxrT7x4Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8LlIEsJmnKxIh5BX5lUM3oQF2rR_Gog9UPMxZy9hW7ai7FknKSFlXU5UTm5O9Bke9fJfl_u364rRjivxrT7x4Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (31.77s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:50:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rocafoh0bine/dst" 2024/12/13 04:50:25 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Has cached credentials 2024/12/13 04:50:26 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:50:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:50:53.200121 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CIkYD_GZVZSVxi2ELeSVRq-S6AlH5fKIAuJ6DdUbGK34Hgsenl564H96X2zGaxgkWHM7f0NeqysXAyYETQmpUg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:50:53.200161 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CIkYD_GZVZSVxi2ELeSVRq-S6AlH5fKIAuJ6DdUbGK34Hgsenl564H96X2zGaxgkWHM7f0NeqysXAyYETQmpUg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:50:53 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CIkYD_GZVZSVxi2ELeSVRq-S6AlH5fKIAuJ6DdUbGK34Hgsenl564H96X2zGaxgkWHM7f0NeqysXAyYETQmpUg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /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/CIkYD_GZVZSVxi2ELeSVRq-S6AlH5fKIAuJ6DdUbGK34Hgsenl564H96X2zGaxgkWHM7f0NeqysXAyYETQmpUg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (32.36s) === RUN TestSyncUTFNorm run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:50:56 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/12/13 04:50:56 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:50:56 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:50:56.278355 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/12/13 04:50:56.278378 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/12/13 04:50:57 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/12/13 04:50:57 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/12/13 04:50:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.22s) === RUN TestSyncImmutable run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:50:58 DEBUG : existing: Need to transfer - File not found at Destination 2024/12/13 04:50:58 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:50:58 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:50:59 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/12/13 04:50:59 INFO : existing: Copied (new) 2024/12/13 04:50:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:50:59 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:50:59 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/12/13 04:50:59 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/12/13 04:50:59 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:50:59 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting files as there were IO errors 2024/12/13 04:50:59 ERROR : proton drive root link ID 'rclone-test-rocafoh0bine': not deleting directories as there were IO errors run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" --- PASS: TestSyncImmutable (3.44s) === RUN TestSyncIgnoreCase run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:51:02 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:51:02 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:02 DEBUG : existing: Unchanged skipping 2024/12/13 04:51:02 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:51:02 DEBUG : Waiting for deletions to finish 2024/12/13 04:51:02 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.97s) === RUN TestFixCase run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.38s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (1.04s) --- SKIP: TestMaxTransfer/Hard (0.35s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.31s) === RUN TestSyncConcurrentDelete run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:51:38 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:51:38 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both0: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both12: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both1: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both11: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both15: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both16: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both17: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both18: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both19: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both2: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both3: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both4: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both5: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both6: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both7: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both8: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:51:38 DEBUG : both9: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both10: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both13: Unchanged skipping 2024/12/13 04:51:38 DEBUG : both14: Unchanged skipping 2024/12/13 04:51:38 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:51:38 DEBUG : Waiting for deletions to finish 2024/12/13 04:51:39 INFO : only1: Deleted 2024/12/13 04:51:39 INFO : only13: Deleted 2024/12/13 04:51:39 INFO : only12: Deleted 2024/12/13 04:51:39 INFO : only11: Deleted 2024/12/13 04:51:39 INFO : only0: Deleted 2024/12/13 04:51:39 INFO : only19: Deleted 2024/12/13 04:51:39 INFO : only15: Deleted 2024/12/13 04:51:39 INFO : only6: Deleted 2024/12/13 04:51:39 INFO : only14: Deleted 2024/12/13 04:51:39 INFO : only17: Deleted 2024/12/13 04:51:39 INFO : only18: Deleted 2024/12/13 04:51:39 INFO : only7: Deleted 2024/12/13 04:51:39 INFO : only10: Deleted 2024/12/13 04:51:39 INFO : only2: Deleted 2024/12/13 04:51:39 INFO : only4: Deleted 2024/12/13 04:51:39 INFO : only3: Deleted 2024/12/13 04:51:39 INFO : only5: Deleted 2024/12/13 04:51:39 INFO : only8: Deleted 2024/12/13 04:51:39 INFO : only16: Deleted 2024/12/13 04:51:39 INFO : only9: Deleted 2024/12/13 04:51:39 INFO : There was nothing to transfer run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" --- PASS: TestSyncConcurrentDelete (42.72s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:52:21 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both0: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both1: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both10: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both11: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both12: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both13: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for checks to finish 2024/12/13 04:52:21 DEBUG : both14: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both17: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both18: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both19: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both2: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both3: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both4: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both5: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both6: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both16: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:52:21 DEBUG : both9: Unchanged skipping 2024/12/13 04:52:21 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/12/13 04:52:21 DEBUG : both15: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both7: Unchanged skipping 2024/12/13 04:52:21 DEBUG : both8: Unchanged skipping 2024/12/13 04:52:21 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Waiting for transfers to finish 2024/12/13 04:52:21.578544 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/12/13 04:52:21.578573 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/12/13 04:52:21.593440 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/12/13 04:52:21.593468 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/12/13 04:52:21.604155 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/12/13 04:52:21.604174 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/12/13 04:52:21.640325 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/12/13 04:52:21.640346 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/12/13 04:52:22 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:22 INFO : only11: Copied (replaced existing) 2024/12/13 04:52:22 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:22 INFO : only1: Copied (replaced existing) 2024/12/13 04:52:22 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:22 INFO : only10: Copied (replaced existing) 2024/12/13 04:52:22 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:22 INFO : only0: Copied (replaced existing) 2024/12/13 04:52:22.474413 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/12/13 04:52:22.474436 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/12/13 04:52:22.480557 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/12/13 04:52:22.480576 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/12/13 04:52:22.497229 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/12/13 04:52:22.497252 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/12/13 04:52:22.504453 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/12/13 04:52:22.504473 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/12/13 04:52:23 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:23 INFO : only14: Copied (replaced existing) 2024/12/13 04:52:23 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:23 INFO : only13: Copied (replaced existing) 2024/12/13 04:52:23 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:23 INFO : only12: Copied (replaced existing) 2024/12/13 04:52:23 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:23 INFO : only15: Copied (replaced existing) 2024/12/13 04:52:23.327798 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/12/13 04:52:23.327817 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/12/13 04:52:23.358134 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/12/13 04:52:23.358149 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/12/13 04:52:23.402527 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/12/13 04:52:23.402542 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/12/13 04:52:23.416976 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/12/13 04:52:23.417003 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/12/13 04:52:23 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:23 INFO : only16: Copied (replaced existing) 2024/12/13 04:52:24 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:24 INFO : only18: Copied (replaced existing) 2024/12/13 04:52:24.102576 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/12/13 04:52:24.102593 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/12/13 04:52:24 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:24 INFO : only17: Copied (replaced existing) 2024/12/13 04:52:24 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:24 INFO : only19: Copied (replaced existing) 2024/12/13 04:52:24.209094 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/12/13 04:52:24.209115 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/12/13 04:52:24.296340 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/12/13 04:52:24.296420 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/12/13 04:52:24.342643 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/12/13 04:52:24.342662 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/12/13 04:52:24 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:24 INFO : only2: Copied (replaced existing) 2024/12/13 04:52:24 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:24 INFO : only3: Copied (replaced existing) 2024/12/13 04:52:24.961210 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/12/13 04:52:24.961235 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/12/13 04:52:25 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only5: Copied (replaced existing) 2024/12/13 04:52:25 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only4: Copied (replaced existing) 2024/12/13 04:52:25.103897 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/12/13 04:52:25.103975 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/12/13 04:52:25.211062 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/12/13 04:52:25.211095 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/12/13 04:52:25.255397 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/12/13 04:52:25.255426 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/12/13 04:52:25 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only6: Copied (replaced existing) 2024/12/13 04:52:25 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only7: Copied (replaced existing) 2024/12/13 04:52:25 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only9: Copied (replaced existing) 2024/12/13 04:52:25 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/12/13 04:52:25 INFO : only8: Copied (replaced existing) 2024/12/13 04:52:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" --- PASS: TestSyncConcurrentTruncate (52.54s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:52:40 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/12/13 04:52:40 DEBUG : sub dir: Making directory 2024/12/13 04:52:40 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" --- PASS: TestNothingToTransferWithEmptyDirs (14.27s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" 2024/12/13 04:52:54 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/12/13 04:52:54 DEBUG : sub dir: Making directory 2024/12/13 04:52:54 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" run.go:180: Remote "proton drive root link ID 'rclone-test-rocafoh0bine'", Local "Local file system at /tmp/rclone2930683498", Modify Window "1s" --- PASS: TestNothingToTransferWithoutEmptyDirs (19.96s) FAIL 2024/12/13 04:53:14 DEBUG : proton drive root link ID 'rclone-test-rocafoh0bine': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestFixCase|TestMoveWithDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Finished ERROR in 10m59.271867271s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]