"./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 3/5) 2025/08/26 03:52:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo" 2025/08/26 03:52:35 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/26 03:52:35 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Has cached credentials 2025/08/26 03:52:37 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Used cached credential to initialize the ProtonDrive API 2025/08/26 03:52:38 DEBUG : Creating backend with remote "/tmp/rclone1853695938" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:52:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xorobum5suse" 2025/08/26 03:52:43 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Has cached credentials 2025/08/26 03:52:45 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-begukoh2sivo' -> proton drive root link ID 'rclone-test-xorobum5suse' 2025/08/26 03:52:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/26 03:52:47 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Waiting for checks to finish 2025/08/26 03:52:47 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Waiting for transfers to finish 2025/08/26 03:52:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/26 03:52:53 INFO : sub dir/hello world: Copied (new) 2025/08/26 03:52:55.499521 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/26 03:52:55.499554 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/26 03:52:58 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Using server-side directory move 2025/08/26 03:52:58 INFO : proton drive root link ID 'rclone-test-xorobum5suse': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/26 03:53:00 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/26 03:53:00 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Waiting for checks to finish 2025/08/26 03:53:00 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Waiting for transfers to finish 2025/08/26 03:53:00 INFO : sub dir/hello world: Deleted 2025/08/26 03:53:02.046056 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7ag58y0Xa-xbMPGw1eyWvIQh-pAFYQK3dr100xUiMRg3nbjc7Kq6GCi0m0eFSkPxgtlHJSg6vLzzi6FPdOGH3A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:53:02.046103 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7ag58y0Xa-xbMPGw1eyWvIQh-pAFYQK3dr100xUiMRg3nbjc7Kq6GCi0m0eFSkPxgtlHJSg6vLzzi6FPdOGH3A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:02 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7ag58y0Xa-xbMPGw1eyWvIQh-pAFYQK3dr100xUiMRg3nbjc7Kq6GCi0m0eFSkPxgtlHJSg6vLzzi6FPdOGH3A==/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/7ag58y0Xa-xbMPGw1eyWvIQh-pAFYQK3dr100xUiMRg3nbjc7Kq6GCi0m0eFSkPxgtlHJSg6vLzzi6FPdOGH3A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/26 03:53:02 DEBUG : proton drive root link ID 'rclone-test-xorobum5suse': Purge remote --- FAIL: TestServerSideMoveOverSelf (27.72s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/26 03:53:06 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:06 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:06 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:06 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:06 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/26 03:53:06 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/26 03:53:06 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:07 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/26 03:53:07 INFO : potato: Copied (new) 2025/08/26 03:53:08 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:08 INFO : yam: Copied (new) 2025/08/26 03:53:08 DEBUG : Waiting for deletions to finish 2025/08/26 03:53:10 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 03:53:10 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:10 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:10 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:10 DEBUG : potato: Unchanged skipping 2025/08/26 03:53:10 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:11.206246 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jidNveSMB6mM1kqWptjNMTRAa8hzwM7HZnA7hn5OBhlKNTIpYr4l5a4fa8vtdXqbt6iOvyiOh97TLe4F_UPqYQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:53:11.206279 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jidNveSMB6mM1kqWptjNMTRAa8hzwM7HZnA7hn5OBhlKNTIpYr4l5a4fa8vtdXqbt6iOvyiOh97TLe4F_UPqYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:11 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jidNveSMB6mM1kqWptjNMTRAa8hzwM7HZnA7hn5OBhlKNTIpYr4l5a4fa8vtdXqbt6iOvyiOh97TLe4F_UPqYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:11 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jidNveSMB6mM1kqWptjNMTRAa8hzwM7HZnA7hn5OBhlKNTIpYr4l5a4fa8vtdXqbt6iOvyiOh97TLe4F_UPqYQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:11 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/26 03:53:11 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:12 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:12 INFO : yaml: Copied (new) 2025/08/26 03:53:12 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': not deleting files as there were IO errors 2025/08/26 03:53:12 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': 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 (10.17s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/26 03:53:16 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:16 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:16 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:16 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/26 03:53:16 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/26 03:53:16 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:16 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:17 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:17 INFO : yam: Copied (new) 2025/08/26 03:53:18 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/26 03:53:18 INFO : potato: Copied (new) 2025/08/26 03:53:18 DEBUG : Waiting for deletions to finish 2025/08/26 03:53:20 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 03:53:20 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:20 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:20 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:20 DEBUG : potato: Unchanged skipping 2025/08/26 03:53:20 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:21.137287 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJESv4u7xVxM-6HZuPkSsBRtGQ8SOLdxGYg6mqWUJ2_ds0yPuwSNIrPY1xGf7OU0rm5mu2ETpdj5y2bxV45HNA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:53:21.137317 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJESv4u7xVxM-6HZuPkSsBRtGQ8SOLdxGYg6mqWUJ2_ds0yPuwSNIrPY1xGf7OU0rm5mu2ETpdj5y2bxV45HNA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:21 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJESv4u7xVxM-6HZuPkSsBRtGQ8SOLdxGYg6mqWUJ2_ds0yPuwSNIrPY1xGf7OU0rm5mu2ETpdj5y2bxV45HNA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:21 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jJESv4u7xVxM-6HZuPkSsBRtGQ8SOLdxGYg6mqWUJ2_ds0yPuwSNIrPY1xGf7OU0rm5mu2ETpdj5y2bxV45HNA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:21 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/26 03:53:21 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:22 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:22 INFO : yaml: Copied (new) 2025/08/26 03:53:22 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': not deleting files as there were IO errors 2025/08/26 03:53:22 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': 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 (10.39s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/26 03:53:27 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:27 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:27 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:27 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/26 03:53:27 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/26 03:53:27 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:27 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/26 03:53:29 INFO : potato: Copied (new) 2025/08/26 03:53:29 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:29 INFO : sub/yam: Copied (new) 2025/08/26 03:53:29 DEBUG : Waiting for deletions to finish 2025/08/26 03:53:32 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 03:53:32 DEBUG : potato: Unchanged skipping 2025/08/26 03:53:32 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Making map for --track-renames 2025/08/26 03:53:32 INFO : proton drive root link ID 'rclone-test-begukoh2sivo': Finished making map for --track-renames 2025/08/26 03:53:32 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:32 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for renames to finish 2025/08/26 03:53:33.788186 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pIlAj0xOob8M15G8cmV7mWRPu7pqUcfcCT16M6vWaUTclfigSdd-sdwi1_Qi9Rlb5iAMkVqb-Pc_jNS0-ycq-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:53:33.788209 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pIlAj0xOob8M15G8cmV7mWRPu7pqUcfcCT16M6vWaUTclfigSdd-sdwi1_Qi9Rlb5iAMkVqb-Pc_jNS0-ycq-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:33 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pIlAj0xOob8M15G8cmV7mWRPu7pqUcfcCT16M6vWaUTclfigSdd-sdwi1_Qi9Rlb5iAMkVqb-Pc_jNS0-ycq-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:33 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pIlAj0xOob8M15G8cmV7mWRPu7pqUcfcCT16M6vWaUTclfigSdd-sdwi1_Qi9Rlb5iAMkVqb-Pc_jNS0-ycq-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:53:33 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/26 03:53:33 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:35 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/26 03:53:35 INFO : yam: Copied (new) 2025/08/26 03:53:35 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': not deleting files as there were IO errors 2025/08/26 03:53:35 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': 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 (13.94s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:53:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/26 03:53:40 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/26 03:53:40 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for checks to finish 2025/08/26 03:53:40 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': Waiting for transfers to finish 2025/08/26 03:53:45 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/26 03:53:45 INFO : nested/sub dir/file: Copied (new) 2025/08/26 03:53:45 INFO : nested/sub dir/file: Deleted 2025/08/26 03:53:45 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/26 03:53:45 INFO : sub dir/hello world: Copied (new) 2025/08/26 03:53:45 INFO : sub dir/hello world: Deleted 2025/08/26 03:53:45 ERROR : Local file system at /tmp/rclone1853695938: 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 (9.84s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:53:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-topumej8vepi" 2025/08/26 03:53:50 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Has cached credentials 2025/08/26 03:53:52 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-begukoh2sivo' -> proton drive root link ID 'rclone-test-topumej8vepi' 2025/08/26 03:54:03 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Using server-side directory move 2025/08/26 03:54:03 INFO : proton drive root link ID 'rclone-test-topumej8vepi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/26 03:54:04 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/26 03:54:04 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/26 03:54:04 DEBUG : empty space: Unchanged skipping 2025/08/26 03:54:04 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Waiting for checks to finish 2025/08/26 03:54:04 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/26 03:54:05 INFO : potato3: Deleted 2025/08/26 03:54:05 INFO : empty space: Deleted 2025/08/26 03:54:05 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Waiting for transfers to finish 2025/08/26 03:54:06.008233 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8N8aGkhcuYPl5Ck3930tVyi13OA88ISfhM7maRZbybIPfsadaFb0U5ve2RWkeZ12pRjmrTU1HL6YS_yvWSsWwQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:06.008269 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8N8aGkhcuYPl5Ck3930tVyi13OA88ISfhM7maRZbybIPfsadaFb0U5ve2RWkeZ12pRjmrTU1HL6YS_yvWSsWwQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:06 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8N8aGkhcuYPl5Ck3930tVyi13OA88ISfhM7maRZbybIPfsadaFb0U5ve2RWkeZ12pRjmrTU1HL6YS_yvWSsWwQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:06.160826 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v4pA-LTdD1OSPz-xmbn7rsfh4MGLKGdnYWMq5xSrdO6UsT4LBfuJ1Mmotw6d92l9lu_lfwAnaZ9eguiephQiDw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:06.160861 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v4pA-LTdD1OSPz-xmbn7rsfh4MGLKGdnYWMq5xSrdO6UsT4LBfuJ1Mmotw6d92l9lu_lfwAnaZ9eguiephQiDw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:06 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/v4pA-LTdD1OSPz-xmbn7rsfh4MGLKGdnYWMq5xSrdO6UsT4LBfuJ1Mmotw6d92l9lu_lfwAnaZ9eguiephQiDw==/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/v4pA-LTdD1OSPz-xmbn7rsfh4MGLKGdnYWMq5xSrdO6UsT4LBfuJ1Mmotw6d92l9lu_lfwAnaZ9eguiephQiDw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/26 03:54:06 DEBUG : proton drive root link ID 'rclone-test-topumej8vepi': Purge remote --- FAIL: TestServerSideMove (19.94s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:54:10 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hubeger1pigu" 2025/08/26 03:54:10 DEBUG : proton drive root link ID 'rclone-test-hubeger1pigu': Has cached credentials 2025/08/26 03:54:12 DEBUG : proton drive root link ID 'rclone-test-hubeger1pigu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-begukoh2sivo' -> proton drive root link ID 'rclone-test-hubeger1pigu' 2025/08/26 03:54:26 DEBUG : empty space: Excluded (Size Filter) 2025/08/26 03:54:26 DEBUG : empty space: Excluded 2025/08/26 03:54:26 DEBUG : empty space: Excluded (Size Filter) 2025/08/26 03:54:26 DEBUG : empty space: Excluded 2025/08/26 03:54:26 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/26 03:54:26 DEBUG : proton drive root link ID 'rclone-test-hubeger1pigu': Waiting for checks to finish 2025/08/26 03:54:26 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/26 03:54:26 DEBUG : proton drive root link ID 'rclone-test-hubeger1pigu': Waiting for transfers to finish 2025/08/26 03:54:27 INFO : potato3: Deleted 2025/08/26 03:54:28.004842 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LizxYSExkdlG1f_vQ29fR3Ly1n0fprHOs5g6AanRKtQWFdAN9KixKscjbFS1_VUCtf8qGtvy_go97Zm0rvoYjg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:28.004882 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LizxYSExkdlG1f_vQ29fR3Ly1n0fprHOs5g6AanRKtQWFdAN9KixKscjbFS1_VUCtf8qGtvy_go97Zm0rvoYjg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:28 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LizxYSExkdlG1f_vQ29fR3Ly1n0fprHOs5g6AanRKtQWFdAN9KixKscjbFS1_VUCtf8qGtvy_go97Zm0rvoYjg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:28.349010 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dv4782dBkh76-oCRH78NFcnDTjIl2Lb9tdHIcDkQY9OnAClAcPIhInjFP2LTVN_gM-iww7RVsC8xr3lBVU2IOw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:28.349050 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dv4782dBkh76-oCRH78NFcnDTjIl2Lb9tdHIcDkQY9OnAClAcPIhInjFP2LTVN_gM-iww7RVsC8xr3lBVU2IOw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:28 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dv4782dBkh76-oCRH78NFcnDTjIl2Lb9tdHIcDkQY9OnAClAcPIhInjFP2LTVN_gM-iww7RVsC8xr3lBVU2IOw==/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/dv4782dBkh76-oCRH78NFcnDTjIl2Lb9tdHIcDkQY9OnAClAcPIhInjFP2LTVN_gM-iww7RVsC8xr3lBVU2IOw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/26 03:54:28 DEBUG : proton drive root link ID 'rclone-test-hubeger1pigu': Purge remote --- FAIL: TestServerSideMoveWithFilter (22.19s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:54:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wimoquf5zuga" 2025/08/26 03:54:32 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Has cached credentials 2025/08/26 03:54:34 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Used cached credential to initialize the ProtonDrive API 2025/08/26 03:54:39 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-begukoh2sivo' -> proton drive root link ID 'rclone-test-wimoquf5zuga' 2025/08/26 03:54:47 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Using server-side directory move 2025/08/26 03:54:47 INFO : proton drive root link ID 'rclone-test-wimoquf5zuga': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/26 03:54:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/26 03:54:48 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/26 03:54:48 DEBUG : empty space: Unchanged skipping 2025/08/26 03:54:48 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/26 03:54:49 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Waiting for checks to finish 2025/08/26 03:54:49 INFO : empty space: Deleted 2025/08/26 03:54:49 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Waiting for transfers to finish 2025/08/26 03:54:49 INFO : potato3: Deleted 2025/08/26 03:54:49.901063 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xHmRhRuh2EqyzZfHT-RKWMUwUfnKoWQ4VPn4ePHzEAw3d19ay6GpBEd_02Q4xHUaQrfsXLNbgLfhZHYMfOq5yw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:49.901089 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xHmRhRuh2EqyzZfHT-RKWMUwUfnKoWQ4VPn4ePHzEAw3d19ay6GpBEd_02Q4xHUaQrfsXLNbgLfhZHYMfOq5yw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:49 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xHmRhRuh2EqyzZfHT-RKWMUwUfnKoWQ4VPn4ePHzEAw3d19ay6GpBEd_02Q4xHUaQrfsXLNbgLfhZHYMfOq5yw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:50.225944 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jsOLlH2Hp6KiJ9IghW8yUbF4va9mp4ZH5SNM2Ei06Hf8CD5e8Jr0h2Z3IcgmPgUcOdCOZZEkZHNfvSuR3CDO7w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:54:50.225971 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jsOLlH2Hp6KiJ9IghW8yUbF4va9mp4ZH5SNM2Ei06Hf8CD5e8Jr0h2Z3IcgmPgUcOdCOZZEkZHNfvSuR3CDO7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:50 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jsOLlH2Hp6KiJ9IghW8yUbF4va9mp4ZH5SNM2Ei06Hf8CD5e8Jr0h2Z3IcgmPgUcOdCOZZEkZHNfvSuR3CDO7w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:54:50 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/26 03:54:50 DEBUG : proton drive root link ID 'rclone-test-wimoquf5zuga': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.15s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 03:55:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 03:55:02 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 03:55:04 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 03:56:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/backup" 2025/08/26 03:56:39 DEBUG : Config file has changed externally - reloading 2025/08/26 03:56:39 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Has cached credentials 2025/08/26 03:56:41 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Used cached credential to initialize the ProtonDrive API 2025/08/26 03:59:52 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 03:59:52 DEBUG : two: Unchanged skipping 2025/08/26 03:59:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 03:59:52 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for checks to finish 2025/08/26 03:59:54.826300 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZRlnVWahOZD52Q32oGuY9xOBpUTxZ9nw22w7_r96CwJMD8xaifGUU7OckIxhBCoFmu0amRViqSqVhSZWcn6iwg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 03:59:54.826378 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZRlnVWahOZD52Q32oGuY9xOBpUTxZ9nw22w7_r96CwJMD8xaifGUU7OckIxhBCoFmu0amRViqSqVhSZWcn6iwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:59:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZRlnVWahOZD52Q32oGuY9xOBpUTxZ9nw22w7_r96CwJMD8xaifGUU7OckIxhBCoFmu0amRViqSqVhSZWcn6iwg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 03:59:54 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for transfers to finish 2025/08/26 03:59:54 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/dst': not deleting files as there were IO errors 2025/08/26 03:59:54 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/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/ZRlnVWahOZD52Q32oGuY9xOBpUTxZ9nw22w7_r96CwJMD8xaifGUU7OckIxhBCoFmu0amRViqSqVhSZWcn6iwg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (305.57s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 04:00:08 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 04:00:08 DEBUG : Config file has changed externally - reloading 2025/08/26 04:00:08 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 04:00:10 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:01:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/backup" 2025/08/26 04:01:45 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Has cached credentials 2025/08/26 04:01:47 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:04:58 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 04:04:58 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for checks to finish 2025/08/26 04:04:58 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 04:04:58 DEBUG : two: Unchanged skipping 2025/08/26 04:05:00.859769 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUUhr-7XIAhPYICvDxlOffu8XL99jU9mBHlYjeAgvY5WFcPvvQdp2xEbndP-RHQjwEMGt3JnzaqnAPeyQ256_A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 04:05:00.859798 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUUhr-7XIAhPYICvDxlOffu8XL99jU9mBHlYjeAgvY5WFcPvvQdp2xEbndP-RHQjwEMGt3JnzaqnAPeyQ256_A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:05:00 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UUUhr-7XIAhPYICvDxlOffu8XL99jU9mBHlYjeAgvY5WFcPvvQdp2xEbndP-RHQjwEMGt3JnzaqnAPeyQ256_A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:05:00 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for transfers to finish 2025/08/26 04:05:00 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/dst': not deleting files as there were IO errors 2025/08/26 04:05:00 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/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/UUUhr-7XIAhPYICvDxlOffu8XL99jU9mBHlYjeAgvY5WFcPvvQdp2xEbndP-RHQjwEMGt3JnzaqnAPeyQ256_A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (306.30s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 04:05:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 04:05:14 DEBUG : Config file has changed externally - reloading 2025/08/26 04:05:14 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 04:05:16 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:06:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/backup" 2025/08/26 04:06:51 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Has cached credentials 2025/08/26 04:06:54 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/backup': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:10:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 04:10:06 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for checks to finish 2025/08/26 04:10:06 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 04:10:06 DEBUG : two: Unchanged skipping 2025/08/26 04:10:09.230029 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hwAA0KUbkdb0q9iCDNmQIqfMWIUZ8cB437ROCh0rkFAuO8AvR44Iq-xidcv6aw97vJdRkRaCHdcyHg4MgpZp-w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 04:10:09.230093 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hwAA0KUbkdb0q9iCDNmQIqfMWIUZ8cB437ROCh0rkFAuO8AvR44Iq-xidcv6aw97vJdRkRaCHdcyHg4MgpZp-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:10:09 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hwAA0KUbkdb0q9iCDNmQIqfMWIUZ8cB437ROCh0rkFAuO8AvR44Iq-xidcv6aw97vJdRkRaCHdcyHg4MgpZp-w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:10:09 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for transfers to finish 2025/08/26 04:10:09 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/dst': not deleting files as there were IO errors 2025/08/26 04:10:09 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/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/hwAA0KUbkdb0q9iCDNmQIqfMWIUZ8cB437ROCh0rkFAuO8AvR44Iq-xidcv6aw97vJdRkRaCHdcyHg4MgpZp-w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (308.01s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 04:10:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 04:10:22 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 04:10:25 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:12:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 04:12:14 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for checks to finish 2025/08/26 04:12:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/26 04:12:14 DEBUG : two: Unchanged skipping 2025/08/26 04:12:14.793366 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R5IeP0J7hMJxsLQSG7SLuXVYc5QFWhY9cOGpT-zHTtHCR69ZNq_sctT3idY95_Sumaa3gcr8KY3HvBk9GQVUkg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 04:12:14.793403 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R5IeP0J7hMJxsLQSG7SLuXVYc5QFWhY9cOGpT-zHTtHCR69ZNq_sctT3idY95_Sumaa3gcr8KY3HvBk9GQVUkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:12:14 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R5IeP0J7hMJxsLQSG7SLuXVYc5QFWhY9cOGpT-zHTtHCR69ZNq_sctT3idY95_Sumaa3gcr8KY3HvBk9GQVUkg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:12:14 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Waiting for transfers to finish 2025/08/26 04:12:14 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/dst': not deleting files as there were IO errors 2025/08/26 04:12:14 ERROR : proton drive root link ID 'rclone-test-begukoh2sivo/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/R5IeP0J7hMJxsLQSG7SLuXVYc5QFWhY9cOGpT-zHTtHCR69ZNq_sctT3idY95_Sumaa3gcr8KY3HvBk9GQVUkg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (124.94s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 04:12:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 04:12:26 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 04:12:28 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:14:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 04:14:07.130023 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BL_sWJfgeEqn5GBGMs41UPQckpyAv-VlhN9ckiywmE18-ekRY3sDguwOurtRr1pyL4r9ZztiK9O4829v1NRxgA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 04:14:07.130052 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BL_sWJfgeEqn5GBGMs41UPQckpyAv-VlhN9ckiywmE18-ekRY3sDguwOurtRr1pyL4r9ZztiK9O4829v1NRxgA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:14:07 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BL_sWJfgeEqn5GBGMs41UPQckpyAv-VlhN9ckiywmE18-ekRY3sDguwOurtRr1pyL4r9ZztiK9O4829v1NRxgA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BL_sWJfgeEqn5GBGMs41UPQckpyAv-VlhN9ckiywmE18-ekRY3sDguwOurtRr1pyL4r9ZztiK9O4829v1NRxgA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (112.08s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-begukoh2sivo'", Local "Local file system at /tmp/rclone1853695938", Modify Window "1s" 2025/08/26 04:14:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-begukoh2sivo/dst" 2025/08/26 04:14:18 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Has cached credentials 2025/08/26 04:14:21 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo/dst': Used cached credential to initialize the ProtonDrive API 2025/08/26 04:15:56 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/26 04:15:57.969169 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ShCPeiwPnQyVaIPAm8fHx7TOeDKQyPo6JGXiHzYhydTbELHWZCbYhf3McsmcqCsdCXAaF_Gy3ci2sW_QblXJBg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/26 04:15:57.969207 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ShCPeiwPnQyVaIPAm8fHx7TOeDKQyPo6JGXiHzYhydTbELHWZCbYhf3McsmcqCsdCXAaF_Gy3ci2sW_QblXJBg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/26 04:15:57 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ShCPeiwPnQyVaIPAm8fHx7TOeDKQyPo6JGXiHzYhydTbELHWZCbYhf3McsmcqCsdCXAaF_Gy3ci2sW_QblXJBg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ShCPeiwPnQyVaIPAm8fHx7TOeDKQyPo6JGXiHzYhydTbELHWZCbYhf3McsmcqCsdCXAaF_Gy3ci2sW_QblXJBg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (111.08s) FAIL 2025/08/26 04:16:02 DEBUG : proton drive root link ID 'rclone-test-begukoh2sivo': 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 23m28.029822628s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]