"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2025/08/05 05:00:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu" 2025/08/05 05:00:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/05 05:00:18 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Has cached credentials 2025/08/05 05:00:19 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:00:20 DEBUG : Creating backend with remote "/tmp/rclone3534221099" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:00:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pukepis3veye" 2025/08/05 05:00:24 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Has cached credentials 2025/08/05 05:00:26 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-cequjew2bacu' -> proton drive root link ID 'rclone-test-pukepis3veye' 2025/08/05 05:00:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/05 05:00:27 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Waiting for checks to finish 2025/08/05 05:00:27 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Waiting for transfers to finish 2025/08/05 05:00:32 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/05 05:00:32 INFO : sub dir/hello world: Copied (new) 2025/08/05 05:00:33.986836 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:00:33.986870 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:00:36 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Using server-side directory move 2025/08/05 05:00:36 INFO : proton drive root link ID 'rclone-test-pukepis3veye': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/05 05:00:37 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Waiting for checks to finish 2025/08/05 05:00:37 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/05 05:00:37 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Waiting for transfers to finish 2025/08/05 05:00:38 INFO : sub dir/hello world: Deleted 2025/08/05 05:00:39.072152 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hdNucSk_QRrJVOSRljaKHf4w7Q1r-7XGdu458ZnM-jUZaHp0xc8dyq3-o2v0_pZy0f4_7O9EsxnFZVBqxKli6g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:00:39.072205 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hdNucSk_QRrJVOSRljaKHf4w7Q1r-7XGdu458ZnM-jUZaHp0xc8dyq3-o2v0_pZy0f4_7O9EsxnFZVBqxKli6g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:39 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hdNucSk_QRrJVOSRljaKHf4w7Q1r-7XGdu458ZnM-jUZaHp0xc8dyq3-o2v0_pZy0f4_7O9EsxnFZVBqxKli6g==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hdNucSk_QRrJVOSRljaKHf4w7Q1r-7XGdu458ZnM-jUZaHp0xc8dyq3-o2v0_pZy0f4_7O9EsxnFZVBqxKli6g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/05 05:00:39 DEBUG : proton drive root link ID 'rclone-test-pukepis3veye': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.85s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/05 05:00:42 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:00:42 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:00:42 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:00:42 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/05 05:00:42 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/05 05:00:42 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:00:42 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:00:44 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/05 05:00:44 INFO : potato: Copied (new) 2025/08/05 05:00:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:00:44 INFO : yam: Copied (new) 2025/08/05 05:00:44 DEBUG : Waiting for deletions to finish 2025/08/05 05:00:45 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:00:45 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:00:45 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:00:45 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:00:45 DEBUG : potato: Unchanged skipping 2025/08/05 05:00:45 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:00:46.793467 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YQAC0ZB2MOK4ojqsYsC5zruORFGyTe0CIkUUWOH8Jf-RkSKUnkzv47Knk4R0Ttoq0e_B2BQxgG2xjCBHjWBWow==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:00:46.793548 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YQAC0ZB2MOK4ojqsYsC5zruORFGyTe0CIkUUWOH8Jf-RkSKUnkzv47Knk4R0Ttoq0e_B2BQxgG2xjCBHjWBWow==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:46 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YQAC0ZB2MOK4ojqsYsC5zruORFGyTe0CIkUUWOH8Jf-RkSKUnkzv47Knk4R0Ttoq0e_B2BQxgG2xjCBHjWBWow==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:46 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YQAC0ZB2MOK4ojqsYsC5zruORFGyTe0CIkUUWOH8Jf-RkSKUnkzv47Knk4R0Ttoq0e_B2BQxgG2xjCBHjWBWow==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:46 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/05 05:00:46 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:00:48 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:00:48 INFO : yaml: Copied (new) 2025/08/05 05:00:48 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting files as there were IO errors 2025/08/05 05:00:48 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.92s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/05 05:00:51 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:00:51 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:00:51 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:00:51 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/05 05:00:51 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/05 05:00:51 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:00:51 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:00:53 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:00:53 INFO : yam: Copied (new) 2025/08/05 05:00:53 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/05 05:00:53 INFO : potato: Copied (new) 2025/08/05 05:00:53 DEBUG : Waiting for deletions to finish 2025/08/05 05:00:54 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:00:54 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:00:54 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:00:54 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:00:54 DEBUG : potato: Unchanged skipping 2025/08/05 05:00:54 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:00:55.412841 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3Y_VeCRW-5BNa_qMOVkx5DLhxd-grYuUZ83tY7IaxbIJY97Q4NuAAM1aUqjCzxLX6yQ5oNQBaoNC_gQrsRWZhg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:00:55.412885 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3Y_VeCRW-5BNa_qMOVkx5DLhxd-grYuUZ83tY7IaxbIJY97Q4NuAAM1aUqjCzxLX6yQ5oNQBaoNC_gQrsRWZhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:55 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3Y_VeCRW-5BNa_qMOVkx5DLhxd-grYuUZ83tY7IaxbIJY97Q4NuAAM1aUqjCzxLX6yQ5oNQBaoNC_gQrsRWZhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:55 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3Y_VeCRW-5BNa_qMOVkx5DLhxd-grYuUZ83tY7IaxbIJY97Q4NuAAM1aUqjCzxLX6yQ5oNQBaoNC_gQrsRWZhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:00:55 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/05 05:00:55 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:00:57 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:00:57 INFO : yaml: Copied (new) 2025/08/05 05:00:57 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting files as there were IO errors 2025/08/05 05:00:57 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (8.62s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/05 05:01:00 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:01:00 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:01:00 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:01:00 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/05 05:01:00 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/05 05:01:00 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:01:00 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:01:02 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/05 05:01:02 INFO : potato: Copied (new) 2025/08/05 05:01:02 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:01:02 INFO : sub/yam: Copied (new) 2025/08/05 05:01:02 DEBUG : Waiting for deletions to finish 2025/08/05 05:01:04 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:01:04 DEBUG : potato: Unchanged skipping 2025/08/05 05:01:04 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Making map for --track-renames 2025/08/05 05:01:04 INFO : proton drive root link ID 'rclone-test-cequjew2bacu': Finished making map for --track-renames 2025/08/05 05:01:04 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:01:04 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for renames to finish 2025/08/05 05:01:05.687747 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I8dK1v0BtYg97b2v4oL-AEaZh7c0V09savEXftoS3RG6wqQTjdAg4_Pkbg5ryHWZE8XntdKc0eLuopea7LKd1Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:01:05.687775 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I8dK1v0BtYg97b2v4oL-AEaZh7c0V09savEXftoS3RG6wqQTjdAg4_Pkbg5ryHWZE8XntdKc0eLuopea7LKd1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:05 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I8dK1v0BtYg97b2v4oL-AEaZh7c0V09savEXftoS3RG6wqQTjdAg4_Pkbg5ryHWZE8XntdKc0eLuopea7LKd1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:05 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I8dK1v0BtYg97b2v4oL-AEaZh7c0V09savEXftoS3RG6wqQTjdAg4_Pkbg5ryHWZE8XntdKc0eLuopea7LKd1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:05 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/05 05:01:05 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:01:07 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/05 05:01:07 INFO : yam: Copied (new) 2025/08/05 05:01:07 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting files as there were IO errors 2025/08/05 05:01:07 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (11.21s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:01:11 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/05 05:01:11 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/05 05:01:11 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:01:11 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:01:15 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/05 05:01:15 INFO : sub dir/hello world: Copied (new) 2025/08/05 05:01:15 INFO : sub dir/hello world: Deleted 2025/08/05 05:01:15 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/05 05:01:15 INFO : nested/sub dir/file: Copied (new) 2025/08/05 05:01:15 INFO : nested/sub dir/file: Deleted 2025/08/05 05:01:15 ERROR : Local file system at /tmp/rclone3534221099: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (8.96s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:01:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kobegef1haca" 2025/08/05 05:01:19 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Has cached credentials 2025/08/05 05:01:21 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-cequjew2bacu' -> proton drive root link ID 'rclone-test-kobegef1haca' 2025/08/05 05:01:32 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Using server-side directory move 2025/08/05 05:01:32 INFO : proton drive root link ID 'rclone-test-kobegef1haca': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/05 05:01:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/05 05:01:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/05 05:01:33 DEBUG : empty space: Unchanged skipping 2025/08/05 05:01:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/05 05:01:33 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Waiting for checks to finish 2025/08/05 05:01:34 INFO : potato3: Deleted 2025/08/05 05:01:34 INFO : empty space: Deleted 2025/08/05 05:01:34 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Waiting for transfers to finish 2025/08/05 05:01:34.425299 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AU3almUljFrstgkh-xvga4zXTzNlupyTDtHhfBsaYMYjpSlTnlfZOKO6pxMtkfyf-WYx3lng6tgadAoi6xnxyg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:01:34.425339 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AU3almUljFrstgkh-xvga4zXTzNlupyTDtHhfBsaYMYjpSlTnlfZOKO6pxMtkfyf-WYx3lng6tgadAoi6xnxyg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:34 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AU3almUljFrstgkh-xvga4zXTzNlupyTDtHhfBsaYMYjpSlTnlfZOKO6pxMtkfyf-WYx3lng6tgadAoi6xnxyg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:34.725874 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wxWddf96yrLfnk5SR9HANlukBD5QFta-a8SE4nX6vF2UfatyKQr7JRMMHyvd1mdp_GbksscKVlXIbSdjwyE2sQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:01:34.725917 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wxWddf96yrLfnk5SR9HANlukBD5QFta-a8SE4nX6vF2UfatyKQr7JRMMHyvd1mdp_GbksscKVlXIbSdjwyE2sQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:34 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wxWddf96yrLfnk5SR9HANlukBD5QFta-a8SE4nX6vF2UfatyKQr7JRMMHyvd1mdp_GbksscKVlXIbSdjwyE2sQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1911 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wxWddf96yrLfnk5SR9HANlukBD5QFta-a8SE4nX6vF2UfatyKQr7JRMMHyvd1mdp_GbksscKVlXIbSdjwyE2sQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/05 05:01:34 DEBUG : proton drive root link ID 'rclone-test-kobegef1haca': Purge remote --- FAIL: TestServerSideMove (17.54s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:01:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tijojuq9jefe" 2025/08/05 05:01:37 DEBUG : proton drive root link ID 'rclone-test-tijojuq9jefe': Has cached credentials 2025/08/05 05:01:38 DEBUG : proton drive root link ID 'rclone-test-tijojuq9jefe': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-cequjew2bacu' -> proton drive root link ID 'rclone-test-tijojuq9jefe' 2025/08/05 05:01:50 DEBUG : empty space: Excluded (Size Filter) 2025/08/05 05:01:50 DEBUG : empty space: Excluded 2025/08/05 05:01:50 DEBUG : empty space: Excluded (Size Filter) 2025/08/05 05:01:50 DEBUG : empty space: Excluded 2025/08/05 05:01:50 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/05 05:01:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/05 05:01:50 DEBUG : proton drive root link ID 'rclone-test-tijojuq9jefe': Waiting for checks to finish 2025/08/05 05:01:50 DEBUG : proton drive root link ID 'rclone-test-tijojuq9jefe': Waiting for transfers to finish 2025/08/05 05:01:51 INFO : potato3: Deleted 2025/08/05 05:01:51.784870 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5hd55pkw2SKkwa7xAoh8kEVlZre5KmnxilTlT3tA36GNcsvDJH9AZqQYc_ScQpbJmrOmwYYBa-LedzVv6-ndjw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:01:51.784911 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5hd55pkw2SKkwa7xAoh8kEVlZre5KmnxilTlT3tA36GNcsvDJH9AZqQYc_ScQpbJmrOmwYYBa-LedzVv6-ndjw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:51 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5hd55pkw2SKkwa7xAoh8kEVlZre5KmnxilTlT3tA36GNcsvDJH9AZqQYc_ScQpbJmrOmwYYBa-LedzVv6-ndjw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:52.056199 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9vkTrxmnb_V5aJ8rRFoX-xXjo6PGGVIU1NdjGpKzyWhTS-DAxEiQ4q4uGBRTFYlldHnMCxXk28JPgkIYBZZ-cA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:01:52.056248 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9vkTrxmnb_V5aJ8rRFoX-xXjo6PGGVIU1NdjGpKzyWhTS-DAxEiQ4q4uGBRTFYlldHnMCxXk28JPgkIYBZZ-cA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:01:52 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9vkTrxmnb_V5aJ8rRFoX-xXjo6PGGVIU1NdjGpKzyWhTS-DAxEiQ4q4uGBRTFYlldHnMCxXk28JPgkIYBZZ-cA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1924 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9vkTrxmnb_V5aJ8rRFoX-xXjo6PGGVIU1NdjGpKzyWhTS-DAxEiQ4q4uGBRTFYlldHnMCxXk28JPgkIYBZZ-cA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/05 05:01:52 DEBUG : proton drive root link ID 'rclone-test-tijojuq9jefe': Purge remote --- FAIL: TestServerSideMoveWithFilter (18.15s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:01:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-vevafaq6mare" 2025/08/05 05:01:55 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Has cached credentials 2025/08/05 05:01:56 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:02:02 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-cequjew2bacu' -> proton drive root link ID 'rclone-test-vevafaq6mare' 2025/08/05 05:02:09 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Using server-side directory move 2025/08/05 05:02:09 INFO : proton drive root link ID 'rclone-test-vevafaq6mare': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/05 05:02:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/05 05:02:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/05 05:02:10 DEBUG : empty space: Unchanged skipping 2025/08/05 05:02:10 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/05 05:02:10 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Waiting for checks to finish 2025/08/05 05:02:10 INFO : potato3: Deleted 2025/08/05 05:02:10 INFO : empty space: Deleted 2025/08/05 05:02:10 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Waiting for transfers to finish 2025/08/05 05:02:10.896937 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L3drgKmTUcKFhbMVC6Unsh8LEe_fxn5cNtb-wS2lOeZx4JKhnT9tgKmRJ38ENx9PMNVMJqPAT-TOT0QFYwDAQw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:02:10.896972 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L3drgKmTUcKFhbMVC6Unsh8LEe_fxn5cNtb-wS2lOeZx4JKhnT9tgKmRJ38ENx9PMNVMJqPAT-TOT0QFYwDAQw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:02:10 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/L3drgKmTUcKFhbMVC6Unsh8LEe_fxn5cNtb-wS2lOeZx4JKhnT9tgKmRJ38ENx9PMNVMJqPAT-TOT0QFYwDAQw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:02:11.171171 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4tuLIoTGstOw76rszmSQZnRZBEWftb0M4va37ouy0lgWupNWbH4yOLgzA-cmr519E5iJ5BM-RPaHOQ4ePfGs1w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:02:11.171204 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4tuLIoTGstOw76rszmSQZnRZBEWftb0M4va37ouy0lgWupNWbH4yOLgzA-cmr519E5iJ5BM-RPaHOQ4ePfGs1w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:02:11 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4tuLIoTGstOw76rszmSQZnRZBEWftb0M4va37ouy0lgWupNWbH4yOLgzA-cmr519E5iJ5BM-RPaHOQ4ePfGs1w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:02:11 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/05 05:02:11 DEBUG : proton drive root link ID 'rclone-test-vevafaq6mare': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.01s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:02:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:02:21 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:02:23 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:04:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/backup" 2025/08/05 05:04:06 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Has cached credentials 2025/08/05 05:04:08 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:07:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:07:19 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:07:19 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for checks to finish 2025/08/05 05:07:19 DEBUG : two: Unchanged skipping 2025/08/05 05:07:21.503909 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/koTix0gVipBP1xmi6YadIPVY2EHZ8mMV0LUou9AREDYkk_lfBWCyZtz25Qo-HwTB7ZF6e-4BEdUeAk-2jux3VQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:07:21.503959 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/koTix0gVipBP1xmi6YadIPVY2EHZ8mMV0LUou9AREDYkk_lfBWCyZtz25Qo-HwTB7ZF6e-4BEdUeAk-2jux3VQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:07:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/koTix0gVipBP1xmi6YadIPVY2EHZ8mMV0LUou9AREDYkk_lfBWCyZtz25Qo-HwTB7ZF6e-4BEdUeAk-2jux3VQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:07:21 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for transfers to finish 2025/08/05 05:07:21 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting files as there were IO errors 2025/08/05 05:07:21 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/koTix0gVipBP1xmi6YadIPVY2EHZ8mMV0LUou9AREDYkk_lfBWCyZtz25Qo-HwTB7ZF6e-4BEdUeAk-2jux3VQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (310.89s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:07:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:07:32 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:07:33 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:09:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/backup" 2025/08/05 05:09:07 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Has cached credentials 2025/08/05 05:09:08 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:12:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:12:19 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for checks to finish 2025/08/05 05:12:19 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:12:19 DEBUG : two: Unchanged skipping 2025/08/05 05:12:21.465461 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LbAJDujwokwVmTma7cDTyOxdfNvL-k_SkhYH7cot8fsVK2ymHuWeINdCGNr2IBYdZVEOkO3mnYKhuM3NdC5J8g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:12:21.465524 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LbAJDujwokwVmTma7cDTyOxdfNvL-k_SkhYH7cot8fsVK2ymHuWeINdCGNr2IBYdZVEOkO3mnYKhuM3NdC5J8g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:12:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LbAJDujwokwVmTma7cDTyOxdfNvL-k_SkhYH7cot8fsVK2ymHuWeINdCGNr2IBYdZVEOkO3mnYKhuM3NdC5J8g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:12:21 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for transfers to finish 2025/08/05 05:12:21 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting files as there were IO errors 2025/08/05 05:12:21 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LbAJDujwokwVmTma7cDTyOxdfNvL-k_SkhYH7cot8fsVK2ymHuWeINdCGNr2IBYdZVEOkO3mnYKhuM3NdC5J8g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (300.10s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:12:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:12:32 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:12:34 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:14:12 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/backup" 2025/08/05 05:14:12 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Has cached credentials 2025/08/05 05:14:14 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/backup': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:17:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:17:24 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for checks to finish 2025/08/05 05:17:24 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:17:24 DEBUG : two: Unchanged skipping 2025/08/05 05:17:26.651957 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BXmvOXfHBLPpW4LaqOSVJpStr7ac2YLRNkDeRwXYWm-P-_C_TZI0GJhw9GYiNhTbRiL6inCN0Esy7LVq6sPYpA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:17:26.652002 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BXmvOXfHBLPpW4LaqOSVJpStr7ac2YLRNkDeRwXYWm-P-_C_TZI0GJhw9GYiNhTbRiL6inCN0Esy7LVq6sPYpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:17:26 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BXmvOXfHBLPpW4LaqOSVJpStr7ac2YLRNkDeRwXYWm-P-_C_TZI0GJhw9GYiNhTbRiL6inCN0Esy7LVq6sPYpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:17:26 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for transfers to finish 2025/08/05 05:17:26 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting files as there were IO errors 2025/08/05 05:17:26 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BXmvOXfHBLPpW4LaqOSVJpStr7ac2YLRNkDeRwXYWm-P-_C_TZI0GJhw9GYiNhTbRiL6inCN0Esy7LVq6sPYpA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (305.10s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:17:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:17:38 DEBUG : Config file has changed externally - reloading 2025/08/05 05:17:38 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:17:39 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:19:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:19:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:19:15 DEBUG : two: Unchanged skipping 2025/08/05 05:19:15 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for checks to finish 2025/08/05 05:19:16.013441 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_RVKyFnfezkLIO_CAoZEtMXLvisNV-ZVBELE_PWCd1QGltE6PpWd6ZahvnVOjH_WjPXz7yg1lDoMqaF3qJffrQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:19:16.013569 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_RVKyFnfezkLIO_CAoZEtMXLvisNV-ZVBELE_PWCd1QGltE6PpWd6ZahvnVOjH_WjPXz7yg1lDoMqaF3qJffrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:19:16 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_RVKyFnfezkLIO_CAoZEtMXLvisNV-ZVBELE_PWCd1QGltE6PpWd6ZahvnVOjH_WjPXz7yg1lDoMqaF3qJffrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:19:16 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Waiting for transfers to finish 2025/08/05 05:19:16 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting files as there were IO errors 2025/08/05 05:19:16 ERROR : proton drive root link ID 'rclone-test-cequjew2bacu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_RVKyFnfezkLIO_CAoZEtMXLvisNV-ZVBELE_PWCd1QGltE6PpWd6ZahvnVOjH_WjPXz7yg1lDoMqaF3qJffrQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (108.75s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:19:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:19:26 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:19:28 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:21:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:21:03.704905 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dyHVVeYK6GVv1-LskeM7oYuX0VYldz_2ZWibUZrTOscJtxeLlT8vnX_iIhkGT4F3awLmS7bIPJkiJ7pBl5PIkg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:21:03.704938 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dyHVVeYK6GVv1-LskeM7oYuX0VYldz_2ZWibUZrTOscJtxeLlT8vnX_iIhkGT4F3awLmS7bIPJkiJ7pBl5PIkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:21:03 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dyHVVeYK6GVv1-LskeM7oYuX0VYldz_2ZWibUZrTOscJtxeLlT8vnX_iIhkGT4F3awLmS7bIPJkiJ7pBl5PIkg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dyHVVeYK6GVv1-LskeM7oYuX0VYldz_2ZWibUZrTOscJtxeLlT8vnX_iIhkGT4F3awLmS7bIPJkiJ7pBl5PIkg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (107.66s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:21:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cequjew2bacu/dst" 2025/08/05 05:21:14 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Has cached credentials 2025/08/05 05:21:15 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu/dst': Used cached credential to initialize the ProtonDrive API 2025/08/05 05:22:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/05 05:22:52.132719 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/U7f52hWpjqVKs7pYDFmvLOlaziu1nmjkY6y6SNSMi-yEVMOlEneGMXp2tb7usZfA6_lfxUBAtbbGqyUzmYnnXQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/05 05:22:52.132758 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/U7f52hWpjqVKs7pYDFmvLOlaziu1nmjkY6y6SNSMi-yEVMOlEneGMXp2tb7usZfA6_lfxUBAtbbGqyUzmYnnXQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/05 05:22:52 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/U7f52hWpjqVKs7pYDFmvLOlaziu1nmjkY6y6SNSMi-yEVMOlEneGMXp2tb7usZfA6_lfxUBAtbbGqyUzmYnnXQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/U7f52hWpjqVKs7pYDFmvLOlaziu1nmjkY6y6SNSMi-yEVMOlEneGMXp2tb7usZfA6_lfxUBAtbbGqyUzmYnnXQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (108.66s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "proton drive root link ID 'rclone-test-cequjew2bacu'", Local "Local file system at /tmp/rclone3534221099", Modify Window "1s" 2025/08/05 05:24:15 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for checks to finish 2025/08/05 05:24:15 DEBUG : both11: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both0: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both12: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both15: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both10: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both17: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both13: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both14: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both16: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both18: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both3: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both4: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both5: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both19: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both7: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both1: Unchanged skipping 2025/08/05 05:24:15 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/05 05:24:15 DEBUG : both8: Unchanged skipping 2025/08/05 05:24:15 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : both9: Unchanged skipping 2025/08/05 05:24:15 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : both6: Unchanged skipping 2025/08/05 05:24:15 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : both2: Unchanged skipping 2025/08/05 05:24:15 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/08/05 05:24:15 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Waiting for transfers to finish 2025/08/05 05:24:15.817381 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:15.817409 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:15.870753 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:15.870789 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:15.951935 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:15.951974 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:16.010321 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:16.010373 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:17 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:17 INFO : only0: Copied (replaced existing) 2025/08/05 05:24:17 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:17 INFO : only14: Copied (replaced existing) 2025/08/05 05:24:17 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:17 INFO : only11: Copied (replaced existing) 2025/08/05 05:24:17 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:17 INFO : only13: Copied (replaced existing) 2025/08/05 05:24:17.651091 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:17.651137 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:17.713310 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:17.713347 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:17.784194 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:17.784238 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:17.886424 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:17.886458 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:19 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:19 INFO : only10: Copied (replaced existing) 2025/08/05 05:24:19 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:19 INFO : only12: Copied (replaced existing) 2025/08/05 05:24:19 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:19 INFO : only16: Copied (replaced existing) 2025/08/05 05:24:19 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:19 INFO : only19: Copied (replaced existing) 2025/08/05 05:24:19.463148 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:19.463192 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:19.529206 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:19.529256 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:19.618922 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:19.618969 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:19.688055 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:19.688089 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:20 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:20 INFO : only15: Copied (replaced existing) 2025/08/05 05:24:20 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:20 INFO : only3: Copied (replaced existing) 2025/08/05 05:24:20 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:20 INFO : only2: Copied (replaced existing) 2025/08/05 05:24:21 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:21 INFO : only4: Copied (replaced existing) 2025/08/05 05:24:21.299448 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:21.299546 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:21.396067 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:21.396103 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:21.453357 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:21.453404 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:21.520917 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:21.520967 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:22 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:22 INFO : only17: Copied (replaced existing) 2025/08/05 05:24:22 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:22 INFO : only7: Copied (replaced existing) 2025/08/05 05:24:22 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:22 INFO : only6: Copied (replaced existing) 2025/08/05 05:24:22 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:22 INFO : only8: Copied (replaced existing) 2025/08/05 05:24:23.032791 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:23.032843 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:23.281594 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:23.281632 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:23.333551 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:23.333587 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:23.407872 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/05 05:24:23.407916 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/05 05:24:24 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:24 INFO : only18: Copied (replaced existing) 2025/08/05 05:24:24 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:24 INFO : only9: Copied (replaced existing) 2025/08/05 05:24:24 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:24 INFO : only1: Copied (replaced existing) 2025/08/05 05:24:24 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/05 05:24:24 INFO : only5: Copied (replaced existing) 2025/08/05 05:24:24 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (124.18s) FAIL 2025/08/05 05:25:00 DEBUG : proton drive root link ID 'rclone-test-cequjew2bacu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 24m42.315115168s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]