"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5) 2025/03/29 04:45:46 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena" 2025/03/29 04:45:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/29 04:45:46 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Has cached credentials 2025/03/29 04:45:48 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:45:48 DEBUG : Creating backend with remote "/tmp/rclone3658693979" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:45:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-geboxuk8razi" 2025/03/29 04:45:52 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Has cached credentials 2025/03/29 04:45:54 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-wocurod3gena' -> proton drive root link ID 'rclone-test-geboxuk8razi' 2025/03/29 04:45:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/29 04:45:55 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Waiting for checks to finish 2025/03/29 04:45:55 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Waiting for transfers to finish 2025/03/29 04:45:59 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/03/29 04:45:59 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:00.842268 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/03/29 04:46:00.842302 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/03/29 04:46:03 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Using server-side directory move 2025/03/29 04:46:03 INFO : proton drive root link ID 'rclone-test-geboxuk8razi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/29 04:46:04 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/29 04:46:04 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Waiting for checks to finish 2025/03/29 04:46:04 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Waiting for transfers to finish 2025/03/29 04:46:04 INFO : sub dir/hello world: Deleted 2025/03/29 04:46:05.770147 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UnbZacEo6UEosNytD0AGnR26vbwQRHoPGtlzean7UvKvap8aDyucagVZRj83cs0I9HXf6J40NOso5wNdVxqFhA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:05.770194 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UnbZacEo6UEosNytD0AGnR26vbwQRHoPGtlzean7UvKvap8aDyucagVZRj83cs0I9HXf6J40NOso5wNdVxqFhA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:05 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UnbZacEo6UEosNytD0AGnR26vbwQRHoPGtlzean7UvKvap8aDyucagVZRj83cs0I9HXf6J40NOso5wNdVxqFhA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UnbZacEo6UEosNytD0AGnR26vbwQRHoPGtlzean7UvKvap8aDyucagVZRj83cs0I9HXf6J40NOso5wNdVxqFhA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/03/29 04:46:05 DEBUG : proton drive root link ID 'rclone-test-geboxuk8razi': Purge remote --- FAIL: TestServerSideMoveOverSelf (20.38s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/03/29 04:46:09 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:09 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:09 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:09 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/29 04:46:09 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/29 04:46:09 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:09 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:10 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/29 04:46:10 INFO : potato: Copied (new) 2025/03/29 04:46:11 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:11 INFO : yam: Copied (new) 2025/03/29 04:46:11 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:12 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:46:12 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:12 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:12 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:12 DEBUG : potato: Unchanged skipping 2025/03/29 04:46:12 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:13.083461 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T3e5Avq7ij9mAshnaNwGxEMSbawA1I7gEbxpC5TydTk_Bglv-I3ZB2p7djIM-fY5Rhf30plHrJyq7lQMZw8VDA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:13.083494 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T3e5Avq7ij9mAshnaNwGxEMSbawA1I7gEbxpC5TydTk_Bglv-I3ZB2p7djIM-fY5Rhf30plHrJyq7lQMZw8VDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:13 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T3e5Avq7ij9mAshnaNwGxEMSbawA1I7gEbxpC5TydTk_Bglv-I3ZB2p7djIM-fY5Rhf30plHrJyq7lQMZw8VDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:13 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/T3e5Avq7ij9mAshnaNwGxEMSbawA1I7gEbxpC5TydTk_Bglv-I3ZB2p7djIM-fY5Rhf30plHrJyq7lQMZw8VDA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:13 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/03/29 04:46:13 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:14 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:14 INFO : yaml: Copied (new) 2025/03/29 04:46:14 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting files as there were IO errors 2025/03/29 04:46:14 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.72s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/03/29 04:46:17 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:17 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:17 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:17 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/29 04:46:17 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:17 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/29 04:46:17 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:19 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:19 INFO : yam: Copied (new) 2025/03/29 04:46:19 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/29 04:46:19 INFO : potato: Copied (new) 2025/03/29 04:46:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:20 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:46:20 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:20 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:20 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:20 DEBUG : potato: Unchanged skipping 2025/03/29 04:46:20 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:21.481356 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4W043tXLRRE_d4n9n2psGCEeamxY57QE4jKkh6Onkd5nznIbvnhWse6KPSW9GY0K7IXuUjRp9oxx9l2OsMKmVg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:21.481400 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4W043tXLRRE_d4n9n2psGCEeamxY57QE4jKkh6Onkd5nznIbvnhWse6KPSW9GY0K7IXuUjRp9oxx9l2OsMKmVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:21 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4W043tXLRRE_d4n9n2psGCEeamxY57QE4jKkh6Onkd5nznIbvnhWse6KPSW9GY0K7IXuUjRp9oxx9l2OsMKmVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:21 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4W043tXLRRE_d4n9n2psGCEeamxY57QE4jKkh6Onkd5nznIbvnhWse6KPSW9GY0K7IXuUjRp9oxx9l2OsMKmVg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:21 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/03/29 04:46:21 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:23 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:23 INFO : yaml: Copied (new) 2025/03/29 04:46:23 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting files as there were IO errors 2025/03/29 04:46:23 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (8.52s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/03/29 04:46:26 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:26 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:26 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:26 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/29 04:46:26 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/03/29 04:46:26 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:26 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:28 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/03/29 04:46:28 INFO : potato: Copied (new) 2025/03/29 04:46:28 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:28 INFO : sub/yam: Copied (new) 2025/03/29 04:46:28 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:30 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:46:30 DEBUG : potato: Unchanged skipping 2025/03/29 04:46:30 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Making map for --track-renames 2025/03/29 04:46:30 INFO : proton drive root link ID 'rclone-test-wocurod3gena': Finished making map for --track-renames 2025/03/29 04:46:30 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:30 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for renames to finish 2025/03/29 04:46:31.406941 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3sZ0hKc0siB9o8tPTS3yK7dfYkf5QqRA9WRXCCqb9oxIhiJFH7opsQRoQj89J--jRyTXJTk11wluL5hKHevGMg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:31.406996 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3sZ0hKc0siB9o8tPTS3yK7dfYkf5QqRA9WRXCCqb9oxIhiJFH7opsQRoQj89J--jRyTXJTk11wluL5hKHevGMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:31 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3sZ0hKc0siB9o8tPTS3yK7dfYkf5QqRA9WRXCCqb9oxIhiJFH7opsQRoQj89J--jRyTXJTk11wluL5hKHevGMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:31 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3sZ0hKc0siB9o8tPTS3yK7dfYkf5QqRA9WRXCCqb9oxIhiJFH7opsQRoQj89J--jRyTXJTk11wluL5hKHevGMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:31 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/29 04:46:31 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:33 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/03/29 04:46:33 INFO : yam: Copied (new) 2025/03/29 04:46:33 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting files as there were IO errors 2025/03/29 04:46:33 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (10.90s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/29 04:46:37 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/29 04:46:37 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for checks to finish 2025/03/29 04:46:37 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Waiting for transfers to finish 2025/03/29 04:46:41 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/03/29 04:46:41 INFO : nested/sub dir/file: Copied (new) 2025/03/29 04:46:41 INFO : nested/sub dir/file: Deleted 2025/03/29 04:46:41 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/03/29 04:46:41 INFO : sub dir/hello world: Copied (new) 2025/03/29 04:46:41 INFO : sub dir/hello world: Deleted 2025/03/29 04:46:41 ERROR : Local file system at /tmp/rclone3658693979: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (8.12s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:46:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-vamarid2xaye" 2025/03/29 04:46:45 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Has cached credentials 2025/03/29 04:46:46 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-wocurod3gena' -> proton drive root link ID 'rclone-test-vamarid2xaye' 2025/03/29 04:46:57 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Using server-side directory move 2025/03/29 04:46:57 INFO : proton drive root link ID 'rclone-test-vamarid2xaye': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/29 04:46:58 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/29 04:46:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/03/29 04:46:58 DEBUG : empty space: Unchanged skipping 2025/03/29 04:46:58 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/29 04:46:58 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Waiting for checks to finish 2025/03/29 04:46:58 INFO : potato3: Deleted 2025/03/29 04:46:58 INFO : empty space: Deleted 2025/03/29 04:46:58 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Waiting for transfers to finish 2025/03/29 04:46:58.801099 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b4WEE2Tl7tFK1IM1Q4yhVF2LOp2xiN8yhjbyu9r_wrh1HVZliWewlM3NwQp-MaRXBbu8APsmeSFw2ZwB6w7tkg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:58.801143 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b4WEE2Tl7tFK1IM1Q4yhVF2LOp2xiN8yhjbyu9r_wrh1HVZliWewlM3NwQp-MaRXBbu8APsmeSFw2ZwB6w7tkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/b4WEE2Tl7tFK1IM1Q4yhVF2LOp2xiN8yhjbyu9r_wrh1HVZliWewlM3NwQp-MaRXBbu8APsmeSFw2ZwB6w7tkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:58.981296 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GO63A-vhT32FpwjfsrE4um4aXsC1q0dUsPCgsaKLQ9eEFFAWFaxEwV4hv0etYAlq6tVtJKKnQHgtZnbtC-sjrQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:46:58.981333 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GO63A-vhT32FpwjfsrE4um4aXsC1q0dUsPCgsaKLQ9eEFFAWFaxEwV4hv0etYAlq6tVtJKKnQHgtZnbtC-sjrQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:46:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GO63A-vhT32FpwjfsrE4um4aXsC1q0dUsPCgsaKLQ9eEFFAWFaxEwV4hv0etYAlq6tVtJKKnQHgtZnbtC-sjrQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GO63A-vhT32FpwjfsrE4um4aXsC1q0dUsPCgsaKLQ9eEFFAWFaxEwV4hv0etYAlq6tVtJKKnQHgtZnbtC-sjrQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/03/29 04:46:58 DEBUG : proton drive root link ID 'rclone-test-vamarid2xaye': Purge remote --- FAIL: TestServerSideMove (16.23s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:47:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wadilus1woca" 2025/03/29 04:47:01 DEBUG : proton drive root link ID 'rclone-test-wadilus1woca': Has cached credentials 2025/03/29 04:47:02 DEBUG : proton drive root link ID 'rclone-test-wadilus1woca': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-wocurod3gena' -> proton drive root link ID 'rclone-test-wadilus1woca' 2025/03/29 04:47:13 DEBUG : empty space: Excluded (Size Filter) 2025/03/29 04:47:13 DEBUG : empty space: Excluded 2025/03/29 04:47:13 DEBUG : empty space: Excluded (Size Filter) 2025/03/29 04:47:13 DEBUG : empty space: Excluded 2025/03/29 04:47:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/29 04:47:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/29 04:47:13 DEBUG : proton drive root link ID 'rclone-test-wadilus1woca': Waiting for checks to finish 2025/03/29 04:47:13 DEBUG : proton drive root link ID 'rclone-test-wadilus1woca': Waiting for transfers to finish 2025/03/29 04:47:14 INFO : potato3: Deleted 2025/03/29 04:47:14.578831 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OfZEOS86ioz6PW2QHi4_45t3xDjn-w33d-Md6DilnqTA4B195e3lPzX6AomucSYrDKwFCzaNASye0EnIy0DHtg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:47:14.578866 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OfZEOS86ioz6PW2QHi4_45t3xDjn-w33d-Md6DilnqTA4B195e3lPzX6AomucSYrDKwFCzaNASye0EnIy0DHtg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:14 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OfZEOS86ioz6PW2QHi4_45t3xDjn-w33d-Md6DilnqTA4B195e3lPzX6AomucSYrDKwFCzaNASye0EnIy0DHtg==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:14.938852 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GDODMPoV9fyz7h5V1nGbKb-apgiVdpMljKiyxvJ-3CVDMZO3o4dTeK-X319NhomM7LUGc111iFu0BTvzfu82DA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:47:14.938878 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GDODMPoV9fyz7h5V1nGbKb-apgiVdpMljKiyxvJ-3CVDMZO3o4dTeK-X319NhomM7LUGc111iFu0BTvzfu82DA==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:14 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GDODMPoV9fyz7h5V1nGbKb-apgiVdpMljKiyxvJ-3CVDMZO3o4dTeK-X319NhomM7LUGc111iFu0BTvzfu82DA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GDODMPoV9fyz7h5V1nGbKb-apgiVdpMljKiyxvJ-3CVDMZO3o4dTeK-X319NhomM7LUGc111iFu0BTvzfu82DA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/03/29 04:47:14 DEBUG : proton drive root link ID 'rclone-test-wadilus1woca': Purge remote --- FAIL: TestServerSideMoveWithFilter (16.51s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:47:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zulojiv3cubi" 2025/03/29 04:47:17 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Has cached credentials 2025/03/29 04:47:19 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:47:24 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-wocurod3gena' -> proton drive root link ID 'rclone-test-zulojiv3cubi' 2025/03/29 04:47:31 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Using server-side directory move 2025/03/29 04:47:31 INFO : proton drive root link ID 'rclone-test-zulojiv3cubi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/29 04:47:31 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/29 04:47:31 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/03/29 04:47:31 DEBUG : empty space: Unchanged skipping 2025/03/29 04:47:31 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/29 04:47:31 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Waiting for checks to finish 2025/03/29 04:47:32 INFO : potato3: Deleted 2025/03/29 04:47:32 INFO : empty space: Deleted 2025/03/29 04:47:32 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Waiting for transfers to finish 2025/03/29 04:47:32.412667 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7_a7cUCJf76n-TigT4zEdRaB-H6tEbDRSOfnfTbBP8dX2CnZkmm7izbhaWRntXhLTIpShlBYkMmW8wmMfJ2viw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:47:32.412716 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7_a7cUCJf76n-TigT4zEdRaB-H6tEbDRSOfnfTbBP8dX2CnZkmm7izbhaWRntXhLTIpShlBYkMmW8wmMfJ2viw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:32 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7_a7cUCJf76n-TigT4zEdRaB-H6tEbDRSOfnfTbBP8dX2CnZkmm7izbhaWRntXhLTIpShlBYkMmW8wmMfJ2viw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:32.652225 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4MBriSdYCaNO2yBe2Iue_LC8Uz0AgDISpCv8VfJce7d3ziwaXyKV2pQQyP1UNKknCAZors2-noslsepVgIp3mQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:47:32.652255 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4MBriSdYCaNO2yBe2Iue_LC8Uz0AgDISpCv8VfJce7d3ziwaXyKV2pQQyP1UNKknCAZors2-noslsepVgIp3mQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:32 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4MBriSdYCaNO2yBe2Iue_LC8Uz0AgDISpCv8VfJce7d3ziwaXyKV2pQQyP1UNKknCAZors2-noslsepVgIp3mQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:47:32 ERROR : proton drive root link ID 'rclone-test-wocurod3gena': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/03/29 04:47:32 DEBUG : proton drive root link ID 'rclone-test-zulojiv3cubi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (17.82s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:47:42 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:47:42 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:47:43 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:48:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/backup" 2025/03/29 04:48:34 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Has cached credentials 2025/03/29 04:48:35 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:50:16 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for checks to finish 2025/03/29 04:50:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:50:16 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:50:16 DEBUG : two: Unchanged skipping 2025/03/29 04:50:17.992015 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CLsEu3sgOJMXUtKfbVjuUjsr4w1l-3qQIdiY9jLThzdz8sBZwzz3lhwmz22prFBVYkiVXf_e95DroN4_WeIjPw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:50:17.992049 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CLsEu3sgOJMXUtKfbVjuUjsr4w1l-3qQIdiY9jLThzdz8sBZwzz3lhwmz22prFBVYkiVXf_e95DroN4_WeIjPw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:50:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CLsEu3sgOJMXUtKfbVjuUjsr4w1l-3qQIdiY9jLThzdz8sBZwzz3lhwmz22prFBVYkiVXf_e95DroN4_WeIjPw==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:50:17 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for transfers to finish 2025/03/29 04:50:17 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting files as there were IO errors 2025/03/29 04:50:17 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CLsEu3sgOJMXUtKfbVjuUjsr4w1l-3qQIdiY9jLThzdz8sBZwzz3lhwmz22prFBVYkiVXf_e95DroN4_WeIjPw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (165.86s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:50:28 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:50:28 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:50:29 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:51:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/backup" 2025/03/29 04:51:19 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Has cached credentials 2025/03/29 04:51:21 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:52:58 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:52:58 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:52:58 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for checks to finish 2025/03/29 04:52:58 DEBUG : two: Unchanged skipping 2025/03/29 04:52:59.815380 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cb4KTqUc-7dA0CfhnTaAblj10kMMO2ulTxD9d8XRz2b7kvnodvhShEFQzMYKe8SKqTwUNG4i2rMP9Do36U944w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:52:59.815415 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cb4KTqUc-7dA0CfhnTaAblj10kMMO2ulTxD9d8XRz2b7kvnodvhShEFQzMYKe8SKqTwUNG4i2rMP9Do36U944w==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:52:59 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cb4KTqUc-7dA0CfhnTaAblj10kMMO2ulTxD9d8XRz2b7kvnodvhShEFQzMYKe8SKqTwUNG4i2rMP9Do36U944w==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:52:59 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for transfers to finish 2025/03/29 04:52:59 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting files as there were IO errors 2025/03/29 04:52:59 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Cb4KTqUc-7dA0CfhnTaAblj10kMMO2ulTxD9d8XRz2b7kvnodvhShEFQzMYKe8SKqTwUNG4i2rMP9Do36U944w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (162.10s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:53:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:53:10 DEBUG : Config file has changed externally - reloading 2025/03/29 04:53:10 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:53:12 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:54:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/backup" 2025/03/29 04:54:01 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Has cached credentials 2025/03/29 04:54:02 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/backup': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:55:38 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:55:38 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for checks to finish 2025/03/29 04:55:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:55:38 DEBUG : two: Unchanged skipping 2025/03/29 04:55:40.448555 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VppYhE20EBiOjmzXR-OEJ-gEh3E8R4b0xZyyg5MJxZyvQFKETQ9aOZjV5RFWgohzLjixoQujt2CeWjejY7B4ug==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:55:40.448597 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VppYhE20EBiOjmzXR-OEJ-gEh3E8R4b0xZyyg5MJxZyvQFKETQ9aOZjV5RFWgohzLjixoQujt2CeWjejY7B4ug==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:55:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VppYhE20EBiOjmzXR-OEJ-gEh3E8R4b0xZyyg5MJxZyvQFKETQ9aOZjV5RFWgohzLjixoQujt2CeWjejY7B4ug==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:55:40 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for transfers to finish 2025/03/29 04:55:40 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting files as there were IO errors 2025/03/29 04:55:40 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VppYhE20EBiOjmzXR-OEJ-gEh3E8R4b0xZyyg5MJxZyvQFKETQ9aOZjV5RFWgohzLjixoQujt2CeWjejY7B4ug==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (160.52s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:55:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:55:51 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:55:52 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:56:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:56:41 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for checks to finish 2025/03/29 04:56:41 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/03/29 04:56:41 DEBUG : two: Unchanged skipping 2025/03/29 04:56:42.627850 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKgmqEx3-Rhk8SzHPxzjU2XZVICZGVoVq0P0FtCmvYPwzW-q4XHWNirRgqeldUSBB7Kmh_vnY5nfIq_9hf_1WQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:56:42.627890 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKgmqEx3-Rhk8SzHPxzjU2XZVICZGVoVq0P0FtCmvYPwzW-q4XHWNirRgqeldUSBB7Kmh_vnY5nfIq_9hf_1WQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:56:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKgmqEx3-Rhk8SzHPxzjU2XZVICZGVoVq0P0FtCmvYPwzW-q4XHWNirRgqeldUSBB7Kmh_vnY5nfIq_9hf_1WQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:56:42 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Waiting for transfers to finish 2025/03/29 04:56:42 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting files as there were IO errors 2025/03/29 04:56:42 ERROR : proton drive root link ID 'rclone-test-wocurod3gena/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kKgmqEx3-Rhk8SzHPxzjU2XZVICZGVoVq0P0FtCmvYPwzW-q4XHWNirRgqeldUSBB7Kmh_vnY5nfIq_9hf_1WQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (61.54s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:56:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:56:52 DEBUG : Config file has changed externally - reloading 2025/03/29 04:56:52 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:56:53 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:57:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:57:45.203426 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PXPxVhaOGKix8pjgSpYXRe5c0-ZZLcbZQAULL-pdnP43WqLM9o5MCFHrs6Q0aR2JI5_O_2L-x-mWSO63HrvI5Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:57:45.203461 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PXPxVhaOGKix8pjgSpYXRe5c0-ZZLcbZQAULL-pdnP43WqLM9o5MCFHrs6Q0aR2JI5_O_2L-x-mWSO63HrvI5Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:57:45 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PXPxVhaOGKix8pjgSpYXRe5c0-ZZLcbZQAULL-pdnP43WqLM9o5MCFHrs6Q0aR2JI5_O_2L-x-mWSO63HrvI5Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/PXPxVhaOGKix8pjgSpYXRe5c0-ZZLcbZQAULL-pdnP43WqLM9o5MCFHrs6Q0aR2JI5_O_2L-x-mWSO63HrvI5Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (62.58s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-wocurod3gena'", Local "Local file system at /tmp/rclone3658693979", Modify Window "1s" 2025/03/29 04:57:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wocurod3gena/dst" 2025/03/29 04:57:55 DEBUG : Config file has changed externally - reloading 2025/03/29 04:57:55 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Has cached credentials 2025/03/29 04:57:56 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena/dst': Used cached credential to initialize the ProtonDrive API 2025/03/29 04:58:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/29 04:58:47.383675 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/il7qMkfApkzm2L2ylmbZYR0NnSkRxTe_LdPNeaXlFlg4W0rNPwZEgcUiY6sskTdTppt4a_iZczT5382Wuy9R9A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/03/29 04:58:47.383699 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/il7qMkfApkzm2L2ylmbZYR0NnSkRxTe_LdPNeaXlFlg4W0rNPwZEgcUiY6sskTdTppt4a_iZczT5382Wuy9R9A==/move: This value should not be blank. (Code=2000, Status=400) 2025/03/29 04:58:47 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/il7qMkfApkzm2L2ylmbZYR0NnSkRxTe_LdPNeaXlFlg4W0rNPwZEgcUiY6sskTdTppt4a_iZczT5382Wuy9R9A==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/il7qMkfApkzm2L2ylmbZYR0NnSkRxTe_LdPNeaXlFlg4W0rNPwZEgcUiY6sskTdTppt4a_iZczT5382Wuy9R9A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (62.12s) FAIL 2025/03/29 04:58:50 DEBUG : proton drive root link ID 'rclone-test-wocurod3gena': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 13m4.149632788s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]