"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 5/5) 2025/10/23 04:53:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo" 2025/10/23 04:53:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/23 04:53:03 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Has cached credentials 2025/10/23 04:53:05 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:53:06 DEBUG : Creating backend with remote "/tmp/rclone3275052364" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:53:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hurinip9semu" 2025/10/23 04:53:10 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Has cached credentials 2025/10/23 04:53:12 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-pavetiv7dixo' -> proton drive root link ID 'rclone-test-hurinip9semu' 2025/10/23 04:53:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/23 04:53:13 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Waiting for checks to finish 2025/10/23 04:53:13 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Waiting for transfers to finish 2025/10/23 04:53:17 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/23 04:53:17 INFO : sub dir/hello world: Copied (new) 2025/10/23 04:53:19.621924 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/10/23 04:53:19.621966 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/10/23 04:53:22 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Using server-side directory move 2025/10/23 04:53:22 INFO : proton drive root link ID 'rclone-test-hurinip9semu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:53:23 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/23 04:53:23 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Waiting for checks to finish 2025/10/23 04:53:23 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Waiting for transfers to finish 2025/10/23 04:53:23 INFO : sub dir/hello world: Deleted 2025/10/23 04:53:24.981098 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bMoptMhxaFKvvf7LcuMFNdEIrzTZReUyftmxUnIWhY0sbHVijw24dMzTo84Rv1MWMwubW3WlfRvj4ilCVACM1g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:53:24.981128 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bMoptMhxaFKvvf7LcuMFNdEIrzTZReUyftmxUnIWhY0sbHVijw24dMzTo84Rv1MWMwubW3WlfRvj4ilCVACM1g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:24 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bMoptMhxaFKvvf7LcuMFNdEIrzTZReUyftmxUnIWhY0sbHVijw24dMzTo84Rv1MWMwubW3WlfRvj4ilCVACM1g==/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/bMoptMhxaFKvvf7LcuMFNdEIrzTZReUyftmxUnIWhY0sbHVijw24dMzTo84Rv1MWMwubW3WlfRvj4ilCVACM1g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/10/23 04:53:24 DEBUG : proton drive root link ID 'rclone-test-hurinip9semu': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.82s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/10/23 04:53:28 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:28 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:28 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:53:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:53:28 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:28 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:30 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:30 INFO : yam: Copied (new) 2025/10/23 04:53:30 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:53:30 INFO : potato: Copied (new) 2025/10/23 04:53:30 DEBUG : Waiting for deletions to finish 2025/10/23 04:53:31 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:53:31 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:31 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:31 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:31 DEBUG : potato: Unchanged skipping 2025/10/23 04:53:31 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:32.192982 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r3dgWD7yF7gSKZwySv1IrpRI72zacvlUe7f9gNjjiQPLV58JX5RMU4dmC97dFFHuBzgiZ10pRA-AsfAgIV9lYQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:53:32.193020 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r3dgWD7yF7gSKZwySv1IrpRI72zacvlUe7f9gNjjiQPLV58JX5RMU4dmC97dFFHuBzgiZ10pRA-AsfAgIV9lYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:32 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r3dgWD7yF7gSKZwySv1IrpRI72zacvlUe7f9gNjjiQPLV58JX5RMU4dmC97dFFHuBzgiZ10pRA-AsfAgIV9lYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:32 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/r3dgWD7yF7gSKZwySv1IrpRI72zacvlUe7f9gNjjiQPLV58JX5RMU4dmC97dFFHuBzgiZ10pRA-AsfAgIV9lYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:32 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/23 04:53:32 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:34 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:34 INFO : yaml: Copied (new) 2025/10/23 04:53:34 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': not deleting files as there were IO errors 2025/10/23 04:53:34 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': 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.77s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/10/23 04:53:36 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:36 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:36 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:53:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:53:36 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:36 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:38 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:38 INFO : yam: Copied (new) 2025/10/23 04:53:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:53:38 INFO : potato: Copied (new) 2025/10/23 04:53:38 DEBUG : Waiting for deletions to finish 2025/10/23 04:53:40 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:53:40 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:40 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:40 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:40 DEBUG : potato: Unchanged skipping 2025/10/23 04:53:40 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:40.925356 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J2VYJe-hfdeCaA4veLnOn-Jj-b3BG5QAuUcCYx3otO8hpvE_C8OnpAhVd8bRcHoh1-Da-XKq2NRMK7x8OsMlmw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:53:40.925391 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J2VYJe-hfdeCaA4veLnOn-Jj-b3BG5QAuUcCYx3otO8hpvE_C8OnpAhVd8bRcHoh1-Da-XKq2NRMK7x8OsMlmw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:40 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J2VYJe-hfdeCaA4veLnOn-Jj-b3BG5QAuUcCYx3otO8hpvE_C8OnpAhVd8bRcHoh1-Da-XKq2NRMK7x8OsMlmw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:40 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J2VYJe-hfdeCaA4veLnOn-Jj-b3BG5QAuUcCYx3otO8hpvE_C8OnpAhVd8bRcHoh1-Da-XKq2NRMK7x8OsMlmw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:40 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/23 04:53:40 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:42 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:42 INFO : yaml: Copied (new) 2025/10/23 04:53:42 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': not deleting files as there were IO errors 2025/10/23 04:53:42 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': 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.83s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/10/23 04:53:45 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:45 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:45 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:45 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:45 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/23 04:53:45 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/10/23 04:53:45 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:48 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/23 04:53:48 INFO : potato: Copied (new) 2025/10/23 04:53:48 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:48 INFO : sub/yam: Copied (new) 2025/10/23 04:53:48 DEBUG : Waiting for deletions to finish 2025/10/23 04:53:50 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 04:53:50 DEBUG : potato: Unchanged skipping 2025/10/23 04:53:50 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Making map for --track-renames 2025/10/23 04:53:50 INFO : proton drive root link ID 'rclone-test-pavetiv7dixo': Finished making map for --track-renames 2025/10/23 04:53:50 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:50 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for renames to finish 2025/10/23 04:53:51.258792 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1EwZ9-TMOYNHqTUu8aMS65hzC6H0HTVw_yBAeFKodL2xd5zjZ-x3P_ACr-uiiDrvZce3-XYR9a3M7rVDg3QizA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:53:51.258827 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1EwZ9-TMOYNHqTUu8aMS65hzC6H0HTVw_yBAeFKodL2xd5zjZ-x3P_ACr-uiiDrvZce3-XYR9a3M7rVDg3QizA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:51 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1EwZ9-TMOYNHqTUu8aMS65hzC6H0HTVw_yBAeFKodL2xd5zjZ-x3P_ACr-uiiDrvZce3-XYR9a3M7rVDg3QizA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:51 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1EwZ9-TMOYNHqTUu8aMS65hzC6H0HTVw_yBAeFKodL2xd5zjZ-x3P_ACr-uiiDrvZce3-XYR9a3M7rVDg3QizA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:53:51 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/23 04:53:51 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:53:53 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/23 04:53:53 INFO : yam: Copied (new) 2025/10/23 04:53:53 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': not deleting files as there were IO errors 2025/10/23 04:53:53 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': 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 (10.89s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:53:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/23 04:53:56 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/10/23 04:53:56 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for checks to finish 2025/10/23 04:53:56 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Waiting for transfers to finish 2025/10/23 04:54:01 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/23 04:54:01 INFO : sub dir/hello world: Copied (new) 2025/10/23 04:54:01 INFO : sub dir/hello world: Deleted 2025/10/23 04:54:01 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/10/23 04:54:01 INFO : nested/sub dir/file: Copied (new) 2025/10/23 04:54:01 INFO : nested/sub dir/file: Deleted 2025/10/23 04:54:01 ERROR : Local file system at /tmp/rclone3275052364: 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.75s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:54:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gupurur9feko" 2025/10/23 04:54:05 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Has cached credentials 2025/10/23 04:54:06 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pavetiv7dixo' -> proton drive root link ID 'rclone-test-gupurur9feko' 2025/10/23 04:54:18 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Using server-side directory move 2025/10/23 04:54:18 INFO : proton drive root link ID 'rclone-test-gupurur9feko': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:54:19 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:54:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/23 04:54:19 DEBUG : empty space: Unchanged skipping 2025/10/23 04:54:19 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:54:19 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Waiting for checks to finish 2025/10/23 04:54:19 INFO : empty space: Deleted 2025/10/23 04:54:19 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Waiting for transfers to finish 2025/10/23 04:54:19 INFO : potato3: Deleted 2025/10/23 04:54:20.156210 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IFmtRWANgVLL8BuwVS7QdKmv1Mm19mzvcPk9eVPVJuiu7IUEZdSY8dS5ME_f33GHQ7tJOxw7EJ3yBqwcImnhtw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:20.156244 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IFmtRWANgVLL8BuwVS7QdKmv1Mm19mzvcPk9eVPVJuiu7IUEZdSY8dS5ME_f33GHQ7tJOxw7EJ3yBqwcImnhtw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:20 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IFmtRWANgVLL8BuwVS7QdKmv1Mm19mzvcPk9eVPVJuiu7IUEZdSY8dS5ME_f33GHQ7tJOxw7EJ3yBqwcImnhtw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:20.373086 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4M3VtaxcZNVlrkC5bSWoJzBkLFv_EZ9qjOd9TZKoHNbjO5wwwPamB0qbhQH1IEvkL59UICzJJgFXWZZONjIRrQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:20.373126 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4M3VtaxcZNVlrkC5bSWoJzBkLFv_EZ9qjOd9TZKoHNbjO5wwwPamB0qbhQH1IEvkL59UICzJJgFXWZZONjIRrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:20 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4M3VtaxcZNVlrkC5bSWoJzBkLFv_EZ9qjOd9TZKoHNbjO5wwwPamB0qbhQH1IEvkL59UICzJJgFXWZZONjIRrQ==/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/4M3VtaxcZNVlrkC5bSWoJzBkLFv_EZ9qjOd9TZKoHNbjO5wwwPamB0qbhQH1IEvkL59UICzJJgFXWZZONjIRrQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/10/23 04:54:20 DEBUG : proton drive root link ID 'rclone-test-gupurur9feko': Purge remote --- FAIL: TestServerSideMove (17.86s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:54:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-holuheg5gacu" 2025/10/23 04:54:22 DEBUG : proton drive root link ID 'rclone-test-holuheg5gacu': Has cached credentials 2025/10/23 04:54:24 DEBUG : proton drive root link ID 'rclone-test-holuheg5gacu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pavetiv7dixo' -> proton drive root link ID 'rclone-test-holuheg5gacu' 2025/10/23 04:54:36 DEBUG : empty space: Excluded (Size Filter) 2025/10/23 04:54:36 DEBUG : empty space: Excluded 2025/10/23 04:54:36 DEBUG : empty space: Excluded (Size Filter) 2025/10/23 04:54:36 DEBUG : empty space: Excluded 2025/10/23 04:54:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:54:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:54:36 DEBUG : proton drive root link ID 'rclone-test-holuheg5gacu': Waiting for checks to finish 2025/10/23 04:54:36 DEBUG : proton drive root link ID 'rclone-test-holuheg5gacu': Waiting for transfers to finish 2025/10/23 04:54:37 INFO : potato3: Deleted 2025/10/23 04:54:37.674653 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/353dO-rZj-rIPmcPTxwyjzcGt8SUg_kK_XDJuZaNBCLxqXWmJ13LCnIomz2-DiRVox_-IrgQAJItpmW4Ljyg9g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:37.674695 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/353dO-rZj-rIPmcPTxwyjzcGt8SUg_kK_XDJuZaNBCLxqXWmJ13LCnIomz2-DiRVox_-IrgQAJItpmW4Ljyg9g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:37 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/353dO-rZj-rIPmcPTxwyjzcGt8SUg_kK_XDJuZaNBCLxqXWmJ13LCnIomz2-DiRVox_-IrgQAJItpmW4Ljyg9g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:37.957014 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BBPnZwsu_9hropwwhvo-jg7oXH1ueFHEAW8srMAzhO0nqqCyGISWXGlFHQAonvfXe7myXLjXtnm1yRTTusT_WA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:37.957037 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BBPnZwsu_9hropwwhvo-jg7oXH1ueFHEAW8srMAzhO0nqqCyGISWXGlFHQAonvfXe7myXLjXtnm1yRTTusT_WA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:37 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BBPnZwsu_9hropwwhvo-jg7oXH1ueFHEAW8srMAzhO0nqqCyGISWXGlFHQAonvfXe7myXLjXtnm1yRTTusT_WA==/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/BBPnZwsu_9hropwwhvo-jg7oXH1ueFHEAW8srMAzhO0nqqCyGISWXGlFHQAonvfXe7myXLjXtnm1yRTTusT_WA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/10/23 04:54:37 DEBUG : proton drive root link ID 'rclone-test-holuheg5gacu': Purge remote --- FAIL: TestServerSideMoveWithFilter (18.33s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:54:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-nupupar7tiwi" 2025/10/23 04:54:41 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Has cached credentials 2025/10/23 04:54:42 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:54:48 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-pavetiv7dixo' -> proton drive root link ID 'rclone-test-nupupar7tiwi' 2025/10/23 04:54:55 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Using server-side directory move 2025/10/23 04:54:55 INFO : proton drive root link ID 'rclone-test-nupupar7tiwi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/23 04:54:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/23 04:54:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/23 04:54:56 DEBUG : empty space: Unchanged skipping 2025/10/23 04:54:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/23 04:54:56 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Waiting for checks to finish 2025/10/23 04:54:56 INFO : potato3: Deleted 2025/10/23 04:54:57 INFO : empty space: Deleted 2025/10/23 04:54:57 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Waiting for transfers to finish 2025/10/23 04:54:57.291872 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BkW9TIs9B_aSR6kkT83zEQxUbHK5hulEdx0cmbPC5jlEAv7pjI0siXDA9vN-ViV7fMwTzUzsS1neiYV6qTEUwg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:57.291892 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BkW9TIs9B_aSR6kkT83zEQxUbHK5hulEdx0cmbPC5jlEAv7pjI0siXDA9vN-ViV7fMwTzUzsS1neiYV6qTEUwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BkW9TIs9B_aSR6kkT83zEQxUbHK5hulEdx0cmbPC5jlEAv7pjI0siXDA9vN-ViV7fMwTzUzsS1neiYV6qTEUwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:57.602429 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKNYIz2ZvkoxswsrSEF8PQuqpaY7dH9VUDK7nUJ3YZaAb5upS4TdqeFdyarl-NAlPKtj9PZBhwwlVWEtPjHXCw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 04:54:57.602465 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKNYIz2ZvkoxswsrSEF8PQuqpaY7dH9VUDK7nUJ3YZaAb5upS4TdqeFdyarl-NAlPKtj9PZBhwwlVWEtPjHXCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKNYIz2ZvkoxswsrSEF8PQuqpaY7dH9VUDK7nUJ3YZaAb5upS4TdqeFdyarl-NAlPKtj9PZBhwwlVWEtPjHXCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 04:54:57 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo': 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/10/23 04:54:57 DEBUG : proton drive root link ID 'rclone-test-nupupar7tiwi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.77s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 04:55:08 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/dst" 2025/10/23 04:55:08 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Has cached credentials 2025/10/23 04:55:10 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 04:57:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/backup" 2025/10/23 04:57:16 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Has cached credentials 2025/10/23 04:57:18 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:01:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 05:01:30 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 05:01:30 DEBUG : two: Unchanged skipping 2025/10/23 05:01:30 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for checks to finish 2025/10/23 05:01:32.482573 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6-wbs_QdC4sTvJvzl9nfjXYmXveGHQmLBUr4X0fOMhrC1h7hUO_LCU-MkxrjA76308jDUoCD02TVxGyGLCoxQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 05:01:32.482610 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6-wbs_QdC4sTvJvzl9nfjXYmXveGHQmLBUr4X0fOMhrC1h7hUO_LCU-MkxrjA76308jDUoCD02TVxGyGLCoxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:01:32 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6-wbs_QdC4sTvJvzl9nfjXYmXveGHQmLBUr4X0fOMhrC1h7hUO_LCU-MkxrjA76308jDUoCD02TVxGyGLCoxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:01:32 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for transfers to finish 2025/10/23 05:01:32 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': not deleting files as there were IO errors 2025/10/23 05:01:32 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/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/X6-wbs_QdC4sTvJvzl9nfjXYmXveGHQmLBUr4X0fOMhrC1h7hUO_LCU-MkxrjA76308jDUoCD02TVxGyGLCoxQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (395.51s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 05:01:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/dst" 2025/10/23 05:01:44 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Has cached credentials 2025/10/23 05:01:45 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:03:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/backup" 2025/10/23 05:03:53 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Has cached credentials 2025/10/23 05:03:54 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:08:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 05:08:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 05:08:08 DEBUG : two: Unchanged skipping 2025/10/23 05:08:08 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for checks to finish 2025/10/23 05:08:10.646667 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/te7drsbCFnCryc_gAQfBTx86WIo8XIo5jWkaqmOJe4JDz1KEtcHEAeo-_0fxIpG-L1YVLgGKOxA2mdiRgdly-Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 05:08:10.646758 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/te7drsbCFnCryc_gAQfBTx86WIo8XIo5jWkaqmOJe4JDz1KEtcHEAeo-_0fxIpG-L1YVLgGKOxA2mdiRgdly-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:08:10 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/te7drsbCFnCryc_gAQfBTx86WIo8XIo5jWkaqmOJe4JDz1KEtcHEAeo-_0fxIpG-L1YVLgGKOxA2mdiRgdly-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:08:10 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for transfers to finish 2025/10/23 05:08:10 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': not deleting files as there were IO errors 2025/10/23 05:08:10 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/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/te7drsbCFnCryc_gAQfBTx86WIo8XIo5jWkaqmOJe4JDz1KEtcHEAeo-_0fxIpG-L1YVLgGKOxA2mdiRgdly-Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (398.18s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 05:08:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/dst" 2025/10/23 05:08:22 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Has cached credentials 2025/10/23 05:08:23 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:10:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/backup" 2025/10/23 05:10:30 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Has cached credentials 2025/10/23 05:10:31 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/backup': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:14:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 05:14:45 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 05:14:45 DEBUG : two: Unchanged skipping 2025/10/23 05:14:45 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for checks to finish 2025/10/23 05:14:47.718519 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OoFxrtFkM_fEPX4JHCRbf4Qs4Dh5m7Aox5laGmq3D4LO-biN8Sjd8VKemEj3gGhca5DzUkag6HIxBA1EN6l82A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 05:14:47.718607 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OoFxrtFkM_fEPX4JHCRbf4Qs4Dh5m7Aox5laGmq3D4LO-biN8Sjd8VKemEj3gGhca5DzUkag6HIxBA1EN6l82A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:14:47 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OoFxrtFkM_fEPX4JHCRbf4Qs4Dh5m7Aox5laGmq3D4LO-biN8Sjd8VKemEj3gGhca5DzUkag6HIxBA1EN6l82A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:14:47 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for transfers to finish 2025/10/23 05:14:47 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': not deleting files as there were IO errors 2025/10/23 05:14:47 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/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/OoFxrtFkM_fEPX4JHCRbf4Qs4Dh5m7Aox5laGmq3D4LO-biN8Sjd8VKemEj3gGhca5DzUkag6HIxBA1EN6l82A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (397.24s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-pavetiv7dixo'", Local "Local file system at /tmp/rclone3275052364", Modify Window "1s" 2025/10/23 05:14:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pavetiv7dixo/dst" 2025/10/23 05:14:59 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Has cached credentials 2025/10/23 05:15:01 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Used cached credential to initialize the ProtonDrive API 2025/10/23 05:17:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/23 05:17:12 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for checks to finish 2025/10/23 05:17:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/23 05:17:12 DEBUG : two: Unchanged skipping 2025/10/23 05:17:13.483126 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IfNAykyv7y_1q4_3YiECpQ-ycDodxgk4LigUcjM2EwDmKLR-CGCvVkYDqQmsVMY8sVtdkdkg5It9Gb6eYC3fw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/23 05:17:13.483172 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IfNAykyv7y_1q4_3YiECpQ-ycDodxgk4LigUcjM2EwDmKLR-CGCvVkYDqQmsVMY8sVtdkdkg5It9Gb6eYC3fw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:17:13 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7IfNAykyv7y_1q4_3YiECpQ-ycDodxgk4LigUcjM2EwDmKLR-CGCvVkYDqQmsVMY8sVtdkdkg5It9Gb6eYC3fw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/23 05:17:13 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': Waiting for transfers to finish 2025/10/23 05:17:13 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/dst': not deleting files as there were IO errors 2025/10/23 05:17:13 ERROR : proton drive root link ID 'rclone-test-pavetiv7dixo/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/7IfNAykyv7y_1q4_3YiECpQ-ycDodxgk4LigUcjM2EwDmKLR-CGCvVkYDqQmsVMY8sVtdkdkg5It9Gb6eYC3fw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (144.91s) FAIL 2025/10/23 05:17:16 DEBUG : proton drive root link ID 'rclone-test-pavetiv7dixo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 24m13.626181785s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]