"./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/06/28 05:58:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi" 2025/06/28 05:58:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/28 05:58:39 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Has cached credentials 2025/06/28 05:58:41 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Used cached credential to initialize the ProtonDrive API 2025/06/28 05:58:42 DEBUG : Creating backend with remote "/tmp/rclone2624921138" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 05:58:47 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-riroyip1yimi" 2025/06/28 05:58:47 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Has cached credentials 2025/06/28 05:58:49 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Used cached credential to initialize the ProtonDrive API sync_test.go:672: Server side copy (if possible) proton drive root link ID 'rclone-test-tubozaf7hapi' -> proton drive root link ID 'rclone-test-riroyip1yimi' 2025/06/28 05:58:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/28 05:58:51 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Waiting for checks to finish 2025/06/28 05:58:51 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Waiting for transfers to finish 2025/06/28 05:58:56 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/28 05:58:56 INFO : sub dir/hello world: Copied (new) 2025/06/28 05:58:59.041985 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/06/28 05:58:59.042034 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/06/28 05:59:02 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Using server-side directory move 2025/06/28 05:59:02 INFO : proton drive root link ID 'rclone-test-riroyip1yimi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 05:59:03 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/28 05:59:03 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Waiting for checks to finish 2025/06/28 05:59:03 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Waiting for transfers to finish 2025/06/28 05:59:03 INFO : sub dir/hello world: Deleted 2025/06/28 05:59:05.276951 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kiFR--oBX_9guP6BRk9NgNWZqXC-HoS964krfRmHr4jmlem49YWzFNYw-k3GO4Twt98zrcscjrMKldHeS7KWYw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 05:59:05.277018 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kiFR--oBX_9guP6BRk9NgNWZqXC-HoS964krfRmHr4jmlem49YWzFNYw-k3GO4Twt98zrcscjrMKldHeS7KWYw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:05 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kiFR--oBX_9guP6BRk9NgNWZqXC-HoS964krfRmHr4jmlem49YWzFNYw-k3GO4Twt98zrcscjrMKldHeS7KWYw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:685 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kiFR--oBX_9guP6BRk9NgNWZqXC-HoS964krfRmHr4jmlem49YWzFNYw-k3GO4Twt98zrcscjrMKldHeS7KWYw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/06/28 05:59:05 DEBUG : proton drive root link ID 'rclone-test-riroyip1yimi': Purge remote --- FAIL: TestServerSideMoveOverSelf (27.13s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" sync_test.go:1539: Can track renames: true 2025/06/28 05:59:09 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:09 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:09 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:09 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 05:59:09 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:09 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 05:59:09 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:11 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:11 INFO : yam: Copied (new) 2025/06/28 05:59:11 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 05:59:11 INFO : potato: Copied (new) 2025/06/28 05:59:11 DEBUG : Waiting for deletions to finish 2025/06/28 05:59:13 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 05:59:13 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:13 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:13 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:13 DEBUG : potato: Unchanged skipping 2025/06/28 05:59:13 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:14.435440 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DNoN1aqUvFwy_T0q57Yg6snYUi6wiJ9rpXludO_6xtMhpIyHoxoFBkt7HaIMAg0Z8X3z9jzRMfY_IEDg_bPrBw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 05:59:14.435531 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DNoN1aqUvFwy_T0q57Yg6snYUi6wiJ9rpXludO_6xtMhpIyHoxoFBkt7HaIMAg0Z8X3z9jzRMfY_IEDg_bPrBw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:14 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DNoN1aqUvFwy_T0q57Yg6snYUi6wiJ9rpXludO_6xtMhpIyHoxoFBkt7HaIMAg0Z8X3z9jzRMfY_IEDg_bPrBw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:14 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/DNoN1aqUvFwy_T0q57Yg6snYUi6wiJ9rpXludO_6xtMhpIyHoxoFBkt7HaIMAg0Z8X3z9jzRMfY_IEDg_bPrBw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:14 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/28 05:59:14 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:16 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:16 INFO : yaml: Copied (new) 2025/06/28 05:59:16 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting files as there were IO errors 2025/06/28 05:59:16 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting directories as there were IO errors sync_test.go:1557: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1557 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (10.40s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" sync_test.go:1611: Can track renames: true 2025/06/28 05:59:20 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:20 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:20 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 05:59:20 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 05:59:20 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:20 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:21 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 05:59:21 INFO : potato: Copied (new) 2025/06/28 05:59:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:21 INFO : yam: Copied (new) 2025/06/28 05:59:21 DEBUG : Waiting for deletions to finish 2025/06/28 05:59:23 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 05:59:23 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:23 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:23 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:23 DEBUG : potato: Unchanged skipping 2025/06/28 05:59:23 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:24.439969 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ziPcrQ8Ffuel-TbbUiPbGhXWkYY7DBMJ3jFyKeg377XW08mC7Ri8F8K5zyIXDLKeV_R6xnePVK608xpLyoD6Tw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 05:59:24.440011 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ziPcrQ8Ffuel-TbbUiPbGhXWkYY7DBMJ3jFyKeg377XW08mC7Ri8F8K5zyIXDLKeV_R6xnePVK608xpLyoD6Tw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:24 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ziPcrQ8Ffuel-TbbUiPbGhXWkYY7DBMJ3jFyKeg377XW08mC7Ri8F8K5zyIXDLKeV_R6xnePVK608xpLyoD6Tw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:24 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ziPcrQ8Ffuel-TbbUiPbGhXWkYY7DBMJ3jFyKeg377XW08mC7Ri8F8K5zyIXDLKeV_R6xnePVK608xpLyoD6Tw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:24 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/06/28 05:59:24 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:26 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:26 INFO : yaml: Copied (new) 2025/06/28 05:59:26 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting files as there were IO errors 2025/06/28 05:59:26 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting directories as there were IO errors sync_test.go:1629: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1629 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (10.12s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" sync_test.go:1650: Can track renames: true 2025/06/28 05:59:30 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:30 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:30 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:30 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/28 05:59:30 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/28 05:59:30 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:30 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:32 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:32 INFO : sub/yam: Copied (new) 2025/06/28 05:59:32 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/06/28 05:59:32 INFO : potato: Copied (new) 2025/06/28 05:59:32 DEBUG : Waiting for deletions to finish 2025/06/28 05:59:34 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 05:59:34 DEBUG : potato: Unchanged skipping 2025/06/28 05:59:35 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Making map for --track-renames 2025/06/28 05:59:35 INFO : proton drive root link ID 'rclone-test-tubozaf7hapi': Finished making map for --track-renames 2025/06/28 05:59:35 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:35 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for renames to finish 2025/06/28 05:59:36.052722 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/g-RWszRbgINc5BmIixeV-WZTqdyBrQf39qpL6h1mCmWwvz7YBURW3AWsiwFiIxP9Oi454DU8fhzI96LGD6XQxw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 05:59:36.052766 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/g-RWszRbgINc5BmIixeV-WZTqdyBrQf39qpL6h1mCmWwvz7YBURW3AWsiwFiIxP9Oi454DU8fhzI96LGD6XQxw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:36 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/g-RWszRbgINc5BmIixeV-WZTqdyBrQf39qpL6h1mCmWwvz7YBURW3AWsiwFiIxP9Oi454DU8fhzI96LGD6XQxw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:36 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/g-RWszRbgINc5BmIixeV-WZTqdyBrQf39qpL6h1mCmWwvz7YBURW3AWsiwFiIxP9Oi454DU8fhzI96LGD6XQxw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 05:59:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/28 05:59:36 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:37 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/06/28 05:59:37 INFO : yam: Copied (new) 2025/06/28 05:59:37 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting files as there were IO errors 2025/06/28 05:59:37 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting directories as there were IO errors sync_test.go:1668: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1668 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (13.25s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 05:59:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/28 05:59:43 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/28 05:59:43 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for checks to finish 2025/06/28 05:59:43 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': Waiting for transfers to finish 2025/06/28 05:59:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/06/28 05:59:48 INFO : sub dir/hello world: Copied (new) 2025/06/28 05:59:48 INFO : sub dir/hello world: Deleted 2025/06/28 05:59:48 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/06/28 05:59:48 INFO : nested/sub dir/file: Copied (new) 2025/06/28 05:59:48 INFO : nested/sub dir/file: Deleted 2025/06/28 05:59:48 ERROR : Local file system at /tmp/rclone2624921138: not deleting directories as there were IO errors sync_test.go:1789: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1789 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (10.33s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 05:59:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-cacanay5hapo" 2025/06/28 05:59:53 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Has cached credentials 2025/06/28 05:59:55 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-tubozaf7hapi' -> proton drive root link ID 'rclone-test-cacanay5hapo' 2025/06/28 06:00:08 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Using server-side directory move 2025/06/28 06:00:08 INFO : proton drive root link ID 'rclone-test-cacanay5hapo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 06:00:09 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:00:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/28 06:00:09 DEBUG : empty space: Unchanged skipping 2025/06/28 06:00:09 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:00:09 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Waiting for checks to finish 2025/06/28 06:00:09 INFO : potato3: Deleted 2025/06/28 06:00:10 INFO : empty space: Deleted 2025/06/28 06:00:10 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Waiting for transfers to finish 2025/06/28 06:00:10.543473 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-Q5rppgQAK7ns5waWHH1cJet2fRrBXPPR1fkCI7kuZmvuE2td-NHbMiy9DOhD-4bMbsDfnLF-MikCP3lO-L8w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:10.543516 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-Q5rppgQAK7ns5waWHH1cJet2fRrBXPPR1fkCI7kuZmvuE2td-NHbMiy9DOhD-4bMbsDfnLF-MikCP3lO-L8w==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:10 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/z-Q5rppgQAK7ns5waWHH1cJet2fRrBXPPR1fkCI7kuZmvuE2td-NHbMiy9DOhD-4bMbsDfnLF-MikCP3lO-L8w==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:10.733801 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MGXSp1B7U3ln_qO_MFcJF06qAVDJtlryNU2bH5XkRLyr4hMyQD2C6B6cHyDTA9ASPTbo69-IG5kn9M2lApseUQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:10.733831 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MGXSp1B7U3ln_qO_MFcJF06qAVDJtlryNU2bH5XkRLyr4hMyQD2C6B6cHyDTA9ASPTbo69-IG5kn9M2lApseUQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:10 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MGXSp1B7U3ln_qO_MFcJF06qAVDJtlryNU2bH5XkRLyr4hMyQD2C6B6cHyDTA9ASPTbo69-IG5kn9M2lApseUQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1882 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MGXSp1B7U3ln_qO_MFcJF06qAVDJtlryNU2bH5XkRLyr4hMyQD2C6B6cHyDTA9ASPTbo69-IG5kn9M2lApseUQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/06/28 06:00:10 DEBUG : proton drive root link ID 'rclone-test-cacanay5hapo': Purge remote --- FAIL: TestServerSideMove (21.06s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:00:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-doguzip8diho" 2025/06/28 06:00:14 DEBUG : proton drive root link ID 'rclone-test-doguzip8diho': Has cached credentials 2025/06/28 06:00:16 DEBUG : proton drive root link ID 'rclone-test-doguzip8diho': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-tubozaf7hapi' -> proton drive root link ID 'rclone-test-doguzip8diho' 2025/06/28 06:00:28 DEBUG : empty space: Excluded (Size Filter) 2025/06/28 06:00:28 DEBUG : empty space: Excluded 2025/06/28 06:00:28 DEBUG : empty space: Excluded (Size Filter) 2025/06/28 06:00:28 DEBUG : empty space: Excluded 2025/06/28 06:00:28 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:00:28 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:00:28 DEBUG : proton drive root link ID 'rclone-test-doguzip8diho': Waiting for checks to finish 2025/06/28 06:00:28 DEBUG : proton drive root link ID 'rclone-test-doguzip8diho': Waiting for transfers to finish 2025/06/28 06:00:29 INFO : potato3: Deleted 2025/06/28 06:00:30.044155 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/52B_fkpqXg23Ks6fgsmKTMC2RddZNER42Qu9F9UYTVtsY4pGytFFnL8ZPzTCSMIA0He_g7ehOy4ID3Jwwt9rhQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:30.044205 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/52B_fkpqXg23Ks6fgsmKTMC2RddZNER42Qu9F9UYTVtsY4pGytFFnL8ZPzTCSMIA0He_g7ehOy4ID3Jwwt9rhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:30 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/52B_fkpqXg23Ks6fgsmKTMC2RddZNER42Qu9F9UYTVtsY4pGytFFnL8ZPzTCSMIA0He_g7ehOy4ID3Jwwt9rhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:30.264954 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlAqqYX7f7DYktSjcz-4oK0eNuz2_MFBbQCJL9tEai5ktuqoUeBf3gZ81_GQT-KFXna8u-uC1xS3LsU3rbB-Jw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:30.264992 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlAqqYX7f7DYktSjcz-4oK0eNuz2_MFBbQCJL9tEai5ktuqoUeBf3gZ81_GQT-KFXna8u-uC1xS3LsU3rbB-Jw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:30 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlAqqYX7f7DYktSjcz-4oK0eNuz2_MFBbQCJL9tEai5ktuqoUeBf3gZ81_GQT-KFXna8u-uC1xS3LsU3rbB-Jw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1895 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlAqqYX7f7DYktSjcz-4oK0eNuz2_MFBbQCJL9tEai5ktuqoUeBf3gZ81_GQT-KFXna8u-uC1xS3LsU3rbB-Jw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/06/28 06:00:30 DEBUG : proton drive root link ID 'rclone-test-doguzip8diho': Purge remote --- FAIL: TestServerSideMoveWithFilter (20.36s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:00:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wuqatib5xuwa" 2025/06/28 06:00:34 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Has cached credentials 2025/06/28 06:00:36 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:00:42 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-tubozaf7hapi' -> proton drive root link ID 'rclone-test-wuqatib5xuwa' 2025/06/28 06:00:50 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Using server-side directory move 2025/06/28 06:00:50 INFO : proton drive root link ID 'rclone-test-wuqatib5xuwa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/28 06:00:52 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/28 06:00:52 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/06/28 06:00:52 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/28 06:00:52 DEBUG : empty space: Unchanged skipping 2025/06/28 06:00:52 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Waiting for checks to finish 2025/06/28 06:00:52 INFO : empty space: Deleted 2025/06/28 06:00:52 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Waiting for transfers to finish 2025/06/28 06:00:52 INFO : potato3: Deleted 2025/06/28 06:00:53.145891 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_qq_JLBi1I6LjsTc7xIPc_c5bzW0EFgrlnoLoE25lOev4ILGqw0-Qp84O-lSgP0OyMkA6AyeMjKvgRDspAg78A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:53.145937 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_qq_JLBi1I6LjsTc7xIPc_c5bzW0EFgrlnoLoE25lOev4ILGqw0-Qp84O-lSgP0OyMkA6AyeMjKvgRDspAg78A==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:53 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_qq_JLBi1I6LjsTc7xIPc_c5bzW0EFgrlnoLoE25lOev4ILGqw0-Qp84O-lSgP0OyMkA6AyeMjKvgRDspAg78A==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:53.552182 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wZscTDagV9BzIekdyfHpX5bRcjKX0XCug4sOK5cJsJcwl381goPecSrDk3BcclYjA6JcGccIxBZ0BdBDCGnqiw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:00:53.552226 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wZscTDagV9BzIekdyfHpX5bRcjKX0XCug4sOK5cJsJcwl381goPecSrDk3BcclYjA6JcGccIxBZ0BdBDCGnqiw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:53 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wZscTDagV9BzIekdyfHpX5bRcjKX0XCug4sOK5cJsJcwl381goPecSrDk3BcclYjA6JcGccIxBZ0BdBDCGnqiw==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:00:53 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi': not deleting directories as there were IO errors sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1902 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/06/28 06:00:53 DEBUG : proton drive root link ID 'rclone-test-wuqatib5xuwa': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (23.22s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:01:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:01:06 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:01:08 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:02:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/backup" 2025/06/28 06:02:25 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Has cached credentials 2025/06/28 06:02:28 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:04:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:04:40 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:04:40 DEBUG : two: Unchanged skipping 2025/06/28 06:04:40 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for checks to finish 2025/06/28 06:04:42.901153 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tGeEO1bYrpHdSD7f8OWKp_AcNEwpNdFV8MqoD91kxKQElY8K_LxXjvIn3eklsIpwTb5ZmI5GxUnn2dxVZdiUJA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:04:42.901228 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tGeEO1bYrpHdSD7f8OWKp_AcNEwpNdFV8MqoD91kxKQElY8K_LxXjvIn3eklsIpwTb5ZmI5GxUnn2dxVZdiUJA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:04:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tGeEO1bYrpHdSD7f8OWKp_AcNEwpNdFV8MqoD91kxKQElY8K_LxXjvIn3eklsIpwTb5ZmI5GxUnn2dxVZdiUJA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:04:42 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for transfers to finish 2025/06/28 06:04:42 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting files as there were IO errors 2025/06/28 06:04:42 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tGeEO1bYrpHdSD7f8OWKp_AcNEwpNdFV8MqoD91kxKQElY8K_LxXjvIn3eklsIpwTb5ZmI5GxUnn2dxVZdiUJA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (230.89s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:04:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:04:56 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:04:59 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:06:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/backup" 2025/06/28 06:06:05 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Has cached credentials 2025/06/28 06:06:07 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:08:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:08:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:08:20 DEBUG : two: Unchanged skipping 2025/06/28 06:08:20 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for checks to finish 2025/06/28 06:08:23.218745 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KeGcMlsCmFDZiSDE79ghrFi3utEG_o8mXEC-JOLmNIaJVreOBNXBYthkTz12Bt-ssMGIG3FGvKSlylXa6FpUHA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:08:23.218809 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KeGcMlsCmFDZiSDE79ghrFi3utEG_o8mXEC-JOLmNIaJVreOBNXBYthkTz12Bt-ssMGIG3FGvKSlylXa6FpUHA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:08:23 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KeGcMlsCmFDZiSDE79ghrFi3utEG_o8mXEC-JOLmNIaJVreOBNXBYthkTz12Bt-ssMGIG3FGvKSlylXa6FpUHA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:08:23 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for transfers to finish 2025/06/28 06:08:23 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting files as there were IO errors 2025/06/28 06:08:23 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2432 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KeGcMlsCmFDZiSDE79ghrFi3utEG_o8mXEC-JOLmNIaJVreOBNXBYthkTz12Bt-ssMGIG3FGvKSlylXa6FpUHA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (220.02s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:08:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:08:37 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:08:39 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:09:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/backup" 2025/06/28 06:09:45 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Has cached credentials 2025/06/28 06:09:48 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/backup': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:12:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:12:00 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:12:00 DEBUG : two: Unchanged skipping 2025/06/28 06:12:00 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for checks to finish 2025/06/28 06:12:02.796552 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VFCdBJjxBVVQmkPJeLp-SCO_MGy5MvdBNEuJlKhVjF0XHJfhUzRpl2yiVW-nxxUT3-xGN7-lNIkNN35wd8ZO0g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:12:02.796596 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VFCdBJjxBVVQmkPJeLp-SCO_MGy5MvdBNEuJlKhVjF0XHJfhUzRpl2yiVW-nxxUT3-xGN7-lNIkNN35wd8ZO0g==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:12:02 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VFCdBJjxBVVQmkPJeLp-SCO_MGy5MvdBNEuJlKhVjF0XHJfhUzRpl2yiVW-nxxUT3-xGN7-lNIkNN35wd8ZO0g==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:12:02 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for transfers to finish 2025/06/28 06:12:02 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting files as there were IO errors 2025/06/28 06:12:02 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2436 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/VFCdBJjxBVVQmkPJeLp-SCO_MGy5MvdBNEuJlKhVjF0XHJfhUzRpl2yiVW-nxxUT3-xGN7-lNIkNN35wd8ZO0g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (219.65s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:12:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:12:16 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:12:18 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:13:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:13:25 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/06/28 06:13:25 DEBUG : two: Unchanged skipping 2025/06/28 06:13:25 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for checks to finish 2025/06/28 06:13:26.498608 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wTMOu6D0kXpax6h_4E-OamN86k3JRJZZOi5laSZw64lF4kgfJMWcr-ccB3Ot3xKOA6BXsIXaAzDdr_UQ1ol7ig==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:13:26.498650 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wTMOu6D0kXpax6h_4E-OamN86k3JRJZZOi5laSZw64lF4kgfJMWcr-ccB3Ot3xKOA6BXsIXaAzDdr_UQ1ol7ig==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:13:26 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wTMOu6D0kXpax6h_4E-OamN86k3JRJZZOi5laSZw64lF4kgfJMWcr-ccB3Ot3xKOA6BXsIXaAzDdr_UQ1ol7ig==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:13:26 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Waiting for transfers to finish 2025/06/28 06:13:26 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting files as there were IO errors 2025/06/28 06:13:26 ERROR : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2440 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wTMOu6D0kXpax6h_4E-OamN86k3JRJZZOi5laSZw64lF4kgfJMWcr-ccB3Ot3xKOA6BXsIXaAzDdr_UQ1ol7ig==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (82.33s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:13:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:13:39 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:13:41 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:14:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:14:49.193474 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ceCeaTcyMcSyIYZQHzRK84s8lAj2amQhaGj6KdU-gWdWeyx9npjARtnL07dh4FWzwoFd7Yo-SXL2lIoZQscSXA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:14:49.193562 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ceCeaTcyMcSyIYZQHzRK84s8lAj2amQhaGj6KdU-gWdWeyx9npjARtnL07dh4FWzwoFd7Yo-SXL2lIoZQscSXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:14:49 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ceCeaTcyMcSyIYZQHzRK84s8lAj2amQhaGj6KdU-gWdWeyx9npjARtnL07dh4FWzwoFd7Yo-SXL2lIoZQscSXA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /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/ceCeaTcyMcSyIYZQHzRK84s8lAj2amQhaGj6KdU-gWdWeyx9npjARtnL07dh4FWzwoFd7Yo-SXL2lIoZQscSXA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (83.03s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-tubozaf7hapi'", Local "Local file system at /tmp/rclone2624921138", Modify Window "1s" 2025/06/28 06:15:01 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tubozaf7hapi/dst" 2025/06/28 06:15:01 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Has cached credentials 2025/06/28 06:15:03 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi/dst': Used cached credential to initialize the ProtonDrive API 2025/06/28 06:16:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/28 06:16:11.027477 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2CcGGqtNadKE6Xgh8-m7ooB3K85MyLR0kRFLoG6Dwj5DiFiTmfEEfdLbMwiROdG0pm6BhjjdPid-hH14KdgpBQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/06/28 06:16:11.027547 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2CcGGqtNadKE6Xgh8-m7ooB3K85MyLR0kRFLoG6Dwj5DiFiTmfEEfdLbMwiROdG0pm6BhjjdPid-hH14KdgpBQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/06/28 06:16:11 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2CcGGqtNadKE6Xgh8-m7ooB3K85MyLR0kRFLoG6Dwj5DiFiTmfEEfdLbMwiROdG0pm6BhjjdPid-hH14KdgpBQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2525 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2CcGGqtNadKE6Xgh8-m7ooB3K85MyLR0kRFLoG6Dwj5DiFiTmfEEfdLbMwiROdG0pm6BhjjdPid-hH14KdgpBQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (81.86s) FAIL 2025/06/28 06:16:15 DEBUG : proton drive root link ID 'rclone-test-tubozaf7hapi': 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 17m37.610815596s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]