"./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/09/18 03:25:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa" 2025/09/18 03:25:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/18 03:25:22 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Has cached credentials 2025/09/18 03:25:24 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:25:25 DEBUG : Creating backend with remote "/tmp/rclone448746427" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:25:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-wowicip8casu" 2025/09/18 03:25:29 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Has cached credentials 2025/09/18 03:25:30 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-focucif5baqa' -> proton drive root link ID 'rclone-test-wowicip8casu' 2025/09/18 03:25:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/18 03:25:31 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Waiting for checks to finish 2025/09/18 03:25:31 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Waiting for transfers to finish 2025/09/18 03:25:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/18 03:25:36 INFO : sub dir/hello world: Copied (new) 2025/09/18 03:25:38.251168 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/09/18 03:25:38.251206 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/09/18 03:25:40 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Using server-side directory move 2025/09/18 03:25:40 INFO : proton drive root link ID 'rclone-test-wowicip8casu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/18 03:25:41 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/09/18 03:25:41 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Waiting for checks to finish 2025/09/18 03:25:41 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Waiting for transfers to finish 2025/09/18 03:25:42 INFO : sub dir/hello world: Deleted 2025/09/18 03:25:43.316746 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2AcvgfFnySTIy-Kt6o_Vwxi_3Yy5aSP3onQs90v7CVK5YoRcoFNd3ve9hprYSTbR71jZdk8TFzDaTmmfBsECTQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:25:43.316777 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2AcvgfFnySTIy-Kt6o_Vwxi_3Yy5aSP3onQs90v7CVK5YoRcoFNd3ve9hprYSTbR71jZdk8TFzDaTmmfBsECTQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:43 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2AcvgfFnySTIy-Kt6o_Vwxi_3Yy5aSP3onQs90v7CVK5YoRcoFNd3ve9hprYSTbR71jZdk8TFzDaTmmfBsECTQ==/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/2AcvgfFnySTIy-Kt6o_Vwxi_3Yy5aSP3onQs90v7CVK5YoRcoFNd3ve9hprYSTbR71jZdk8TFzDaTmmfBsECTQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/09/18 03:25:43 DEBUG : proton drive root link ID 'rclone-test-wowicip8casu': Purge remote --- FAIL: TestServerSideMoveOverSelf (21.39s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/09/18 03:25:46 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:25:46 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:25:46 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:25:46 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:25:46 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/18 03:25:46 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/18 03:25:46 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:25:48 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:25:48 INFO : yam: Copied (new) 2025/09/18 03:25:48 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/18 03:25:48 INFO : potato: Copied (new) 2025/09/18 03:25:48 DEBUG : Waiting for deletions to finish 2025/09/18 03:25:49 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:25:49 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:25:49 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:25:49 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:25:49 DEBUG : potato: Unchanged skipping 2025/09/18 03:25:49 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:25:50.355383 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J1ID5NHokStyBcHH5DGnQp9ICt4mf-hKTvoLlkjdHiF9izGbBSDv7k_3q9Rx_KGxNv0z7EII6RdX65wTJ329oQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:25:50.355411 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J1ID5NHokStyBcHH5DGnQp9ICt4mf-hKTvoLlkjdHiF9izGbBSDv7k_3q9Rx_KGxNv0z7EII6RdX65wTJ329oQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:50 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J1ID5NHokStyBcHH5DGnQp9ICt4mf-hKTvoLlkjdHiF9izGbBSDv7k_3q9Rx_KGxNv0z7EII6RdX65wTJ329oQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:50 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/J1ID5NHokStyBcHH5DGnQp9ICt4mf-hKTvoLlkjdHiF9izGbBSDv7k_3q9Rx_KGxNv0z7EII6RdX65wTJ329oQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:50 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/18 03:25:50 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:25:51 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:25:51 INFO : yaml: Copied (new) 2025/09/18 03:25:51 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': not deleting files as there were IO errors 2025/09/18 03:25:51 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.02s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/09/18 03:25:54 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:25:54 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:25:54 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:25:54 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/18 03:25:54 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/18 03:25:54 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:25:54 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:25:56 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:25:56 INFO : yam: Copied (new) 2025/09/18 03:25:56 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/18 03:25:56 INFO : potato: Copied (new) 2025/09/18 03:25:56 DEBUG : Waiting for deletions to finish 2025/09/18 03:25:57 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:25:57 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:25:57 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:25:57 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:25:57 DEBUG : potato: Unchanged skipping 2025/09/18 03:25:57 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:25:58.416163 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZbyLnktd08LkQYJy2Ejcjag8M2a5Q-ozgWyZnqsFOHAWb-slXwE6_M1doCJhFbhtB0_5KbDN1IqCbM_Zf331A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:25:58.416188 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZbyLnktd08LkQYJy2Ejcjag8M2a5Q-ozgWyZnqsFOHAWb-slXwE6_M1doCJhFbhtB0_5KbDN1IqCbM_Zf331A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:58 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZbyLnktd08LkQYJy2Ejcjag8M2a5Q-ozgWyZnqsFOHAWb-slXwE6_M1doCJhFbhtB0_5KbDN1IqCbM_Zf331A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:58 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vZbyLnktd08LkQYJy2Ejcjag8M2a5Q-ozgWyZnqsFOHAWb-slXwE6_M1doCJhFbhtB0_5KbDN1IqCbM_Zf331A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:25:58 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/09/18 03:25:58 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:25:59 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:25:59 INFO : yaml: Copied (new) 2025/09/18 03:25:59 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': not deleting files as there were IO errors 2025/09/18 03:25:59 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': 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 (7.96s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/09/18 03:26:02 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:26:02 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:26:02 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:26:02 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/09/18 03:26:02 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:26:02 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/09/18 03:26:02 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:26:04 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/09/18 03:26:04 INFO : potato: Copied (new) 2025/09/18 03:26:05 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:26:05 INFO : sub/yam: Copied (new) 2025/09/18 03:26:05 DEBUG : Waiting for deletions to finish 2025/09/18 03:26:06 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:26:06 DEBUG : potato: Unchanged skipping 2025/09/18 03:26:07 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Making map for --track-renames 2025/09/18 03:26:07 INFO : proton drive root link ID 'rclone-test-focucif5baqa': Finished making map for --track-renames 2025/09/18 03:26:07 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:26:07 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for renames to finish 2025/09/18 03:26:07.942501 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tzaD1rt2LKoyK3iCByxB4pIugQ5pH_6OTWUNDayE_3uzS9otOe5vP_X4VF4Paza0_s1OX84Bty3COl4LRpLoXQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:26:07.942538 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tzaD1rt2LKoyK3iCByxB4pIugQ5pH_6OTWUNDayE_3uzS9otOe5vP_X4VF4Paza0_s1OX84Bty3COl4LRpLoXQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:07 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tzaD1rt2LKoyK3iCByxB4pIugQ5pH_6OTWUNDayE_3uzS9otOe5vP_X4VF4Paza0_s1OX84Bty3COl4LRpLoXQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:07 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/tzaD1rt2LKoyK3iCByxB4pIugQ5pH_6OTWUNDayE_3uzS9otOe5vP_X4VF4Paza0_s1OX84Bty3COl4LRpLoXQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:07 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/09/18 03:26:07 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:26:09 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/09/18 03:26:09 INFO : yam: Copied (new) 2025/09/18 03:26:09 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': not deleting files as there were IO errors 2025/09/18 03:26:09 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (10.46s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:26:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/09/18 03:26:13 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/09/18 03:26:13 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for checks to finish 2025/09/18 03:26:13 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': Waiting for transfers to finish 2025/09/18 03:26:17 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/09/18 03:26:17 INFO : sub dir/hello world: Copied (new) 2025/09/18 03:26:17 INFO : sub dir/hello world: Deleted 2025/09/18 03:26:17 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/09/18 03:26:17 INFO : nested/sub dir/file: Copied (new) 2025/09/18 03:26:17 INFO : nested/sub dir/file: Deleted 2025/09/18 03:26:17 ERROR : Local file system at /tmp/rclone448746427: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (8.34s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:26:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-susofex2give" 2025/09/18 03:26:21 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Has cached credentials 2025/09/18 03:26:22 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-focucif5baqa' -> proton drive root link ID 'rclone-test-susofex2give' 2025/09/18 03:26:32 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Using server-side directory move 2025/09/18 03:26:32 INFO : proton drive root link ID 'rclone-test-susofex2give': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/18 03:26:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/18 03:26:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/18 03:26:33 DEBUG : empty space: Unchanged skipping 2025/09/18 03:26:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/18 03:26:33 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Waiting for checks to finish 2025/09/18 03:26:34 INFO : potato3: Deleted 2025/09/18 03:26:34 INFO : empty space: Deleted 2025/09/18 03:26:34 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Waiting for transfers to finish 2025/09/18 03:26:34.417313 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBrGxM-QEezWyEHXRdGubEqdTum-MUfBQvO_Ck5H72taeFp1SlfNgPSRf-dqWUfprnDrCheFQqTRnSWLYb57Yg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:26:34.417332 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBrGxM-QEezWyEHXRdGubEqdTum-MUfBQvO_Ck5H72taeFp1SlfNgPSRf-dqWUfprnDrCheFQqTRnSWLYb57Yg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:34 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YBrGxM-QEezWyEHXRdGubEqdTum-MUfBQvO_Ck5H72taeFp1SlfNgPSRf-dqWUfprnDrCheFQqTRnSWLYb57Yg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:34.681285 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AZzxru8nKR0qYvjx63v-QNSFBdA35VSCE_GFQIIPGpee_4I9lpB8hAEC5vNPn19TYa4RuC7_a20vi0ut2B1joA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:26:34.681317 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AZzxru8nKR0qYvjx63v-QNSFBdA35VSCE_GFQIIPGpee_4I9lpB8hAEC5vNPn19TYa4RuC7_a20vi0ut2B1joA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:34 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AZzxru8nKR0qYvjx63v-QNSFBdA35VSCE_GFQIIPGpee_4I9lpB8hAEC5vNPn19TYa4RuC7_a20vi0ut2B1joA==/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/AZzxru8nKR0qYvjx63v-QNSFBdA35VSCE_GFQIIPGpee_4I9lpB8hAEC5vNPn19TYa4RuC7_a20vi0ut2B1joA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/09/18 03:26:34 DEBUG : proton drive root link ID 'rclone-test-susofex2give': Purge remote --- FAIL: TestServerSideMove (16.16s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:26:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yoyalof5fawu" 2025/09/18 03:26:37 DEBUG : proton drive root link ID 'rclone-test-yoyalof5fawu': Has cached credentials 2025/09/18 03:26:38 DEBUG : proton drive root link ID 'rclone-test-yoyalof5fawu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-focucif5baqa' -> proton drive root link ID 'rclone-test-yoyalof5fawu' 2025/09/18 03:26:49 DEBUG : empty space: Excluded (Size Filter) 2025/09/18 03:26:49 DEBUG : empty space: Excluded 2025/09/18 03:26:49 DEBUG : empty space: Excluded (Size Filter) 2025/09/18 03:26:49 DEBUG : empty space: Excluded 2025/09/18 03:26:49 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/18 03:26:49 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/18 03:26:49 DEBUG : proton drive root link ID 'rclone-test-yoyalof5fawu': Waiting for checks to finish 2025/09/18 03:26:49 DEBUG : proton drive root link ID 'rclone-test-yoyalof5fawu': Waiting for transfers to finish 2025/09/18 03:26:50 INFO : potato3: Deleted 2025/09/18 03:26:50.512141 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IRx146Fbkcd-u6xCg71suabh_1WtIPhvTHvxL1q6GA_2uG8yK116YzpkVP8YR3miYyQzxlyBkeY4SmJNGuw-bw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:26:50.512178 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IRx146Fbkcd-u6xCg71suabh_1WtIPhvTHvxL1q6GA_2uG8yK116YzpkVP8YR3miYyQzxlyBkeY4SmJNGuw-bw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:50 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/IRx146Fbkcd-u6xCg71suabh_1WtIPhvTHvxL1q6GA_2uG8yK116YzpkVP8YR3miYyQzxlyBkeY4SmJNGuw-bw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:50.830524 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dquUYxfC3BARPUlkZ0zY39s7NZGBpU8PVP-gJPZpyztFCBkJNE26u0IBrq_l0OTnrVK1toxfLt2QZId6Nqg57A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:26:50.830568 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dquUYxfC3BARPUlkZ0zY39s7NZGBpU8PVP-gJPZpyztFCBkJNE26u0IBrq_l0OTnrVK1toxfLt2QZId6Nqg57A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:26:50 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dquUYxfC3BARPUlkZ0zY39s7NZGBpU8PVP-gJPZpyztFCBkJNE26u0IBrq_l0OTnrVK1toxfLt2QZId6Nqg57A==/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/dquUYxfC3BARPUlkZ0zY39s7NZGBpU8PVP-gJPZpyztFCBkJNE26u0IBrq_l0OTnrVK1toxfLt2QZId6Nqg57A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/09/18 03:26:50 DEBUG : proton drive root link ID 'rclone-test-yoyalof5fawu': Purge remote --- FAIL: TestServerSideMoveWithFilter (16.82s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:26:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tabutad7kemi" 2025/09/18 03:26:54 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Has cached credentials 2025/09/18 03:26:55 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:27:00 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-focucif5baqa' -> proton drive root link ID 'rclone-test-tabutad7kemi' 2025/09/18 03:27:06 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Using server-side directory move 2025/09/18 03:27:06 INFO : proton drive root link ID 'rclone-test-tabutad7kemi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/09/18 03:27:07 DEBUG : potato2: Need to transfer - File not found at Destination 2025/09/18 03:27:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/09/18 03:27:07 DEBUG : empty space: Unchanged skipping 2025/09/18 03:27:07 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/09/18 03:27:07 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Waiting for checks to finish 2025/09/18 03:27:07 INFO : empty space: Deleted 2025/09/18 03:27:07 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Waiting for transfers to finish 2025/09/18 03:27:07 INFO : potato3: Deleted 2025/09/18 03:27:08.257292 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i4AkOIv44_Tv2UiY2V5lxBaRQGfJpSvHiIYc-8PAPRO-mssIPVg0QHByltdb5PzwuDhVMEaRJFqBrPsodxksjA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:27:08.257320 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i4AkOIv44_Tv2UiY2V5lxBaRQGfJpSvHiIYc-8PAPRO-mssIPVg0QHByltdb5PzwuDhVMEaRJFqBrPsodxksjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:27:08 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/i4AkOIv44_Tv2UiY2V5lxBaRQGfJpSvHiIYc-8PAPRO-mssIPVg0QHByltdb5PzwuDhVMEaRJFqBrPsodxksjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:27:08.457038 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6Ll0PonUb7eu38EBSnMpVBN7sdGG5iwTIUfDFRF2zIsvAY-6sVrl7gflrsyArKKGjbG6MUsnFXam20pb50iog==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:27:08.457056 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6Ll0PonUb7eu38EBSnMpVBN7sdGG5iwTIUfDFRF2zIsvAY-6sVrl7gflrsyArKKGjbG6MUsnFXam20pb50iog==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:27:08 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/X6Ll0PonUb7eu38EBSnMpVBN7sdGG5iwTIUfDFRF2zIsvAY-6sVrl7gflrsyArKKGjbG6MUsnFXam20pb50iog==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:27:08 ERROR : proton drive root link ID 'rclone-test-focucif5baqa': 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/09/18 03:27:08 DEBUG : proton drive root link ID 'rclone-test-tabutad7kemi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (17.67s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:27:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:27:18 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:27:19 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:29:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/backup" 2025/09/18 03:29:21 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Has cached credentials 2025/09/18 03:29:22 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:33:28 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:33:28 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for checks to finish 2025/09/18 03:33:28 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:33:28 DEBUG : two: Unchanged skipping 2025/09/18 03:33:30.497367 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SH_QHjboKLNsfTrA0z-1iQGgi1uDejWHkLcMW9SDeb3UF1pOzF3scbAqbA2kY5laXppja1C1o0fPwHT9USZETg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:33:30.497403 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SH_QHjboKLNsfTrA0z-1iQGgi1uDejWHkLcMW9SDeb3UF1pOzF3scbAqbA2kY5laXppja1C1o0fPwHT9USZETg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:33:30 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SH_QHjboKLNsfTrA0z-1iQGgi1uDejWHkLcMW9SDeb3UF1pOzF3scbAqbA2kY5laXppja1C1o0fPwHT9USZETg==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:33:30 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for transfers to finish 2025/09/18 03:33:30 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/dst': not deleting files as there were IO errors 2025/09/18 03:33:30 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/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/SH_QHjboKLNsfTrA0z-1iQGgi1uDejWHkLcMW9SDeb3UF1pOzF3scbAqbA2kY5laXppja1C1o0fPwHT9USZETg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (382.87s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:33:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:33:41 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:33:42 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:35:48 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/backup" 2025/09/18 03:35:48 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Has cached credentials 2025/09/18 03:35:49 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:39:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:39:49 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for checks to finish 2025/09/18 03:39:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:39:49 DEBUG : two: Unchanged skipping 2025/09/18 03:39:51.460073 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jnCUOIYdCzIo8lsLywbeYSwEsaUXHet8G35CARm27sUClNPGZmcQ638HP_10iKeJJPJ36Q6H1PiGZ9KJbdON9Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:39:51.460112 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jnCUOIYdCzIo8lsLywbeYSwEsaUXHet8G35CARm27sUClNPGZmcQ638HP_10iKeJJPJ36Q6H1PiGZ9KJbdON9Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:39:51 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jnCUOIYdCzIo8lsLywbeYSwEsaUXHet8G35CARm27sUClNPGZmcQ638HP_10iKeJJPJ36Q6H1PiGZ9KJbdON9Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:39:51 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for transfers to finish 2025/09/18 03:39:51 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/dst': not deleting files as there were IO errors 2025/09/18 03:39:51 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/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/jnCUOIYdCzIo8lsLywbeYSwEsaUXHet8G35CARm27sUClNPGZmcQ638HP_10iKeJJPJ36Q6H1PiGZ9KJbdON9Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (381.01s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:40:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:40:02 DEBUG : Config file has changed externally - reloading 2025/09/18 03:40:02 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:40:03 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:42:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/backup" 2025/09/18 03:42:00 DEBUG : Config file has changed externally - reloading 2025/09/18 03:42:00 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Has cached credentials 2025/09/18 03:42:01 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/backup': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:45:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:45:52 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:45:52 DEBUG : two: Unchanged skipping 2025/09/18 03:45:52 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for checks to finish 2025/09/18 03:45:54.294627 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/umr_2i5cQWMx26-NhSztV07CQ10XDSBHXc8-3-5qB-cwJZ98b-I-x-tHfxwfxAf1irNRNtvN_nYAQ-XVimbk8A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:45:54.294655 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/umr_2i5cQWMx26-NhSztV07CQ10XDSBHXc8-3-5qB-cwJZ98b-I-x-tHfxwfxAf1irNRNtvN_nYAQ-XVimbk8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:45:54 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/umr_2i5cQWMx26-NhSztV07CQ10XDSBHXc8-3-5qB-cwJZ98b-I-x-tHfxwfxAf1irNRNtvN_nYAQ-XVimbk8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:45:54 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for transfers to finish 2025/09/18 03:45:54 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/dst': not deleting files as there were IO errors 2025/09/18 03:45:54 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/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/umr_2i5cQWMx26-NhSztV07CQ10XDSBHXc8-3-5qB-cwJZ98b-I-x-tHfxwfxAf1irNRNtvN_nYAQ-XVimbk8A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (362.77s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:46:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:46:05 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:46:06 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:48:02 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for checks to finish 2025/09/18 03:48:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:48:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/09/18 03:48:02 DEBUG : two: Unchanged skipping 2025/09/18 03:48:03.283397 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0If-hsVki4rnOtixCTC7PgmXFlzeG3cs2vsRYwlLMzzULI71S-JIYOWVQIeat3lpUkWCKthy3dtO-66-Ghx8dQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:48:03.283433 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0If-hsVki4rnOtixCTC7PgmXFlzeG3cs2vsRYwlLMzzULI71S-JIYOWVQIeat3lpUkWCKthy3dtO-66-Ghx8dQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:48:03 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0If-hsVki4rnOtixCTC7PgmXFlzeG3cs2vsRYwlLMzzULI71S-JIYOWVQIeat3lpUkWCKthy3dtO-66-Ghx8dQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:48:03 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Waiting for transfers to finish 2025/09/18 03:48:03 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/dst': not deleting files as there were IO errors 2025/09/18 03:48:03 ERROR : proton drive root link ID 'rclone-test-focucif5baqa/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/0If-hsVki4rnOtixCTC7PgmXFlzeG3cs2vsRYwlLMzzULI71S-JIYOWVQIeat3lpUkWCKthy3dtO-66-Ghx8dQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (128.57s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:48:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:48:13 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:48:14 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:50:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:50:17.607178 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/S_hOmTHQ-Jf4ItLDfhR3MYKQpAaFR3tFWatTxpV7uDXMpQXrxQj61N3BEHGpuys-X1BTr0hDmYUu9WANfDlN1A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:50:17.607202 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/S_hOmTHQ-Jf4ItLDfhR3MYKQpAaFR3tFWatTxpV7uDXMpQXrxQj61N3BEHGpuys-X1BTr0hDmYUu9WANfDlN1A==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:50:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/S_hOmTHQ-Jf4ItLDfhR3MYKQpAaFR3tFWatTxpV7uDXMpQXrxQj61N3BEHGpuys-X1BTr0hDmYUu9WANfDlN1A==/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/S_hOmTHQ-Jf4ItLDfhR3MYKQpAaFR3tFWatTxpV7uDXMpQXrxQj61N3BEHGpuys-X1BTr0hDmYUu9WANfDlN1A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (134.26s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-focucif5baqa'", Local "Local file system at /tmp/rclone448746427", Modify Window "1s" 2025/09/18 03:50:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-focucif5baqa/dst" 2025/09/18 03:50:27 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Has cached credentials 2025/09/18 03:50:29 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa/dst': Used cached credential to initialize the ProtonDrive API 2025/09/18 03:52:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/09/18 03:52:31.339318 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GU1HgeB-hn7nlfT6P6krQqFHhGFlq8jU4_Tp32nYE9e5azg_KfxvSI3RpXrlD7fI3yiC12xeK_Kjy7G2H7tOjQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/18 03:52:31.339349 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GU1HgeB-hn7nlfT6P6krQqFHhGFlq8jU4_Tp32nYE9e5azg_KfxvSI3RpXrlD7fI3yiC12xeK_Kjy7G2H7tOjQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/18 03:52:31 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/GU1HgeB-hn7nlfT6P6krQqFHhGFlq8jU4_Tp32nYE9e5azg_KfxvSI3RpXrlD7fI3yiC12xeK_Kjy7G2H7tOjQ==/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/GU1HgeB-hn7nlfT6P6krQqFHhGFlq8jU4_Tp32nYE9e5azg_KfxvSI3RpXrlD7fI3yiC12xeK_Kjy7G2H7tOjQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (133.67s) FAIL 2025/09/18 03:52:35 DEBUG : proton drive root link ID 'rclone-test-focucif5baqa': 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 27m12.695091155s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]