"./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 5/5) 2025/08/14 06:50:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi" 2025/08/14 06:50:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/14 06:50:52 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Has cached credentials 2025/08/14 06:50:54 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Used cached credential to initialize the ProtonDrive API 2025/08/14 06:50:55 DEBUG : Creating backend with remote "/tmp/rclone1060811320" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:51:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pukefom1lufo" 2025/08/14 06:51:00 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Has cached credentials 2025/08/14 06:51:01 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-xivisox5miwi' -> proton drive root link ID 'rclone-test-pukefom1lufo' 2025/08/14 06:51:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/14 06:51:02 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Waiting for checks to finish 2025/08/14 06:51:02 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Waiting for transfers to finish 2025/08/14 06:51:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/14 06:51:07 INFO : sub dir/hello world: Copied (new) 2025/08/14 06:51:09.616271 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/14 06:51:09.616317 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/14 06:51:12 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Using server-side directory move 2025/08/14 06:51:12 INFO : proton drive root link ID 'rclone-test-pukefom1lufo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/14 06:51:13 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/14 06:51:13 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Waiting for checks to finish 2025/08/14 06:51:13 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Waiting for transfers to finish 2025/08/14 06:51:14 INFO : sub dir/hello world: Deleted 2025/08/14 06:51:15.401971 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6gsDj09HF0Socz96b1mwpzSxqcvKdkGziyOHHfd3w4ocnxxQVX3MbVSbHh9QUQH3x6qPz5gsIEfU1uphG0d7hw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:51:15.402045 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6gsDj09HF0Socz96b1mwpzSxqcvKdkGziyOHHfd3w4ocnxxQVX3MbVSbHh9QUQH3x6qPz5gsIEfU1uphG0d7hw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:15 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6gsDj09HF0Socz96b1mwpzSxqcvKdkGziyOHHfd3w4ocnxxQVX3MbVSbHh9QUQH3x6qPz5gsIEfU1uphG0d7hw==/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/6gsDj09HF0Socz96b1mwpzSxqcvKdkGziyOHHfd3w4ocnxxQVX3MbVSbHh9QUQH3x6qPz5gsIEfU1uphG0d7hw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/14 06:51:15 DEBUG : proton drive root link ID 'rclone-test-pukefom1lufo': Purge remote --- FAIL: TestServerSideMoveOverSelf (23.40s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/14 06:51:18 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:18 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:18 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:18 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/14 06:51:18 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/14 06:51:18 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:18 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:20 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:20 INFO : yam: Copied (new) 2025/08/14 06:51:20 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/14 06:51:20 INFO : potato: Copied (new) 2025/08/14 06:51:20 DEBUG : Waiting for deletions to finish 2025/08/14 06:51:22 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 06:51:22 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:22 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:22 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:22 DEBUG : potato: Unchanged skipping 2025/08/14 06:51:22 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:23.092098 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6RVVCjES-O15Y8Y0WbnV5PwbOZsWkdc8UPHoKDVSND28oEs6pZmHurH4evmGtysjpUn_7brAFLpySs8FPRvbbg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:51:23.092145 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6RVVCjES-O15Y8Y0WbnV5PwbOZsWkdc8UPHoKDVSND28oEs6pZmHurH4evmGtysjpUn_7brAFLpySs8FPRvbbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:23 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6RVVCjES-O15Y8Y0WbnV5PwbOZsWkdc8UPHoKDVSND28oEs6pZmHurH4evmGtysjpUn_7brAFLpySs8FPRvbbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:23 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6RVVCjES-O15Y8Y0WbnV5PwbOZsWkdc8UPHoKDVSND28oEs6pZmHurH4evmGtysjpUn_7brAFLpySs8FPRvbbg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:23 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/14 06:51:23 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:25 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:25 INFO : yaml: Copied (new) 2025/08/14 06:51:25 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': not deleting files as there were IO errors 2025/08/14 06:51:25 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': 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 (9.20s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/14 06:51:28 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:28 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:28 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:28 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/14 06:51:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/14 06:51:28 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/14 06:51:29 INFO : potato: Copied (new) 2025/08/14 06:51:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:29 INFO : yam: Copied (new) 2025/08/14 06:51:29 DEBUG : Waiting for deletions to finish 2025/08/14 06:51:31 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 06:51:31 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:31 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:31 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:31 DEBUG : potato: Unchanged skipping 2025/08/14 06:51:31 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:32.300549 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yPp_DcDZeCt9e84imKbICL3KPFS3zNdw-hQZeZEjpkLSJ94Ql5Xy6M7aca2oicMXObpKKeibywrOXYKG-jPTlA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:51:32.300616 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yPp_DcDZeCt9e84imKbICL3KPFS3zNdw-hQZeZEjpkLSJ94Ql5Xy6M7aca2oicMXObpKKeibywrOXYKG-jPTlA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:32 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yPp_DcDZeCt9e84imKbICL3KPFS3zNdw-hQZeZEjpkLSJ94Ql5Xy6M7aca2oicMXObpKKeibywrOXYKG-jPTlA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:32 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yPp_DcDZeCt9e84imKbICL3KPFS3zNdw-hQZeZEjpkLSJ94Ql5Xy6M7aca2oicMXObpKKeibywrOXYKG-jPTlA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:32 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/14 06:51:32 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:34 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:34 INFO : yaml: Copied (new) 2025/08/14 06:51:34 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': not deleting files as there were IO errors 2025/08/14 06:51:34 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': 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 (9.23s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/14 06:51:37 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:37 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:37 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:37 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/14 06:51:37 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/14 06:51:37 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:37 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:40 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/14 06:51:40 INFO : potato: Copied (new) 2025/08/14 06:51:40 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:40 INFO : sub/yam: Copied (new) 2025/08/14 06:51:40 DEBUG : Waiting for deletions to finish 2025/08/14 06:51:41 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 06:51:41 DEBUG : potato: Unchanged skipping 2025/08/14 06:51:42 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Making map for --track-renames 2025/08/14 06:51:42 INFO : proton drive root link ID 'rclone-test-xivisox5miwi': Finished making map for --track-renames 2025/08/14 06:51:42 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:42 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for renames to finish 2025/08/14 06:51:43.180800 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bHFWd8YnHy8qliFOuk4ON5GrmS0IN4bOfoxKMd25FcvR-rsQj-48tuD6aBTMjEoo3LTk3iRBC7J3-u2R8mPvvg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:51:43.180846 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bHFWd8YnHy8qliFOuk4ON5GrmS0IN4bOfoxKMd25FcvR-rsQj-48tuD6aBTMjEoo3LTk3iRBC7J3-u2R8mPvvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:43 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bHFWd8YnHy8qliFOuk4ON5GrmS0IN4bOfoxKMd25FcvR-rsQj-48tuD6aBTMjEoo3LTk3iRBC7J3-u2R8mPvvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:43 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bHFWd8YnHy8qliFOuk4ON5GrmS0IN4bOfoxKMd25FcvR-rsQj-48tuD6aBTMjEoo3LTk3iRBC7J3-u2R8mPvvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:51:43 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/14 06:51:43 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:45 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/14 06:51:45 INFO : yam: Copied (new) 2025/08/14 06:51:45 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': not deleting files as there were IO errors 2025/08/14 06:51:45 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': 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 (11.99s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:51:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/14 06:51:49 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/14 06:51:49 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for checks to finish 2025/08/14 06:51:49 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': Waiting for transfers to finish 2025/08/14 06:51:54 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/14 06:51:54 INFO : sub dir/hello world: Copied (new) 2025/08/14 06:51:54 INFO : sub dir/hello world: Deleted 2025/08/14 06:51:54 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/14 06:51:54 INFO : nested/sub dir/file: Copied (new) 2025/08/14 06:51:54 INFO : nested/sub dir/file: Deleted 2025/08/14 06:51:54 ERROR : Local file system at /tmp/rclone1060811320: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (9.62s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:51:58 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-zoramec7dota" 2025/08/14 06:51:58 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Has cached credentials 2025/08/14 06:52:00 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xivisox5miwi' -> proton drive root link ID 'rclone-test-zoramec7dota' 2025/08/14 06:52:12 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Using server-side directory move 2025/08/14 06:52:12 INFO : proton drive root link ID 'rclone-test-zoramec7dota': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/14 06:52:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/14 06:52:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/14 06:52:13 DEBUG : empty space: Unchanged skipping 2025/08/14 06:52:13 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Waiting for checks to finish 2025/08/14 06:52:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/14 06:52:13 INFO : empty space: Deleted 2025/08/14 06:52:13 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Waiting for transfers to finish 2025/08/14 06:52:13 INFO : potato3: Deleted 2025/08/14 06:52:14.419525 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cYenLXCwueB5SMW6jA8r1Z4bKa34phPId3qKaJt1X9Ylo1A2H6hNIJKXqVRom0CdO0DzbKb7RadSjShrI7IlFw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:14.419548 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cYenLXCwueB5SMW6jA8r1Z4bKa34phPId3qKaJt1X9Ylo1A2H6hNIJKXqVRom0CdO0DzbKb7RadSjShrI7IlFw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:14 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cYenLXCwueB5SMW6jA8r1Z4bKa34phPId3qKaJt1X9Ylo1A2H6hNIJKXqVRom0CdO0DzbKb7RadSjShrI7IlFw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:14.686115 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/be6qBOfhMjlNGnzwkIpW6uHXN1amIPuOdiMn9hicBa-Y-1wKbW-z5kb363-pJRP-_eHZwcjVBhcf9rYOpKPRQw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:14.686167 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/be6qBOfhMjlNGnzwkIpW6uHXN1amIPuOdiMn9hicBa-Y-1wKbW-z5kb363-pJRP-_eHZwcjVBhcf9rYOpKPRQw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:14 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/be6qBOfhMjlNGnzwkIpW6uHXN1amIPuOdiMn9hicBa-Y-1wKbW-z5kb363-pJRP-_eHZwcjVBhcf9rYOpKPRQw==/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/be6qBOfhMjlNGnzwkIpW6uHXN1amIPuOdiMn9hicBa-Y-1wKbW-z5kb363-pJRP-_eHZwcjVBhcf9rYOpKPRQw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/14 06:52:14 DEBUG : proton drive root link ID 'rclone-test-zoramec7dota': Purge remote --- FAIL: TestServerSideMove (19.06s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:52:17 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pirivam1cegi" 2025/08/14 06:52:17 DEBUG : proton drive root link ID 'rclone-test-pirivam1cegi': Has cached credentials 2025/08/14 06:52:19 DEBUG : proton drive root link ID 'rclone-test-pirivam1cegi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xivisox5miwi' -> proton drive root link ID 'rclone-test-pirivam1cegi' 2025/08/14 06:52:32 DEBUG : empty space: Excluded (Size Filter) 2025/08/14 06:52:32 DEBUG : empty space: Excluded 2025/08/14 06:52:32 DEBUG : empty space: Excluded (Size Filter) 2025/08/14 06:52:32 DEBUG : empty space: Excluded 2025/08/14 06:52:32 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/14 06:52:32 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/14 06:52:32 DEBUG : proton drive root link ID 'rclone-test-pirivam1cegi': Waiting for checks to finish 2025/08/14 06:52:32 DEBUG : proton drive root link ID 'rclone-test-pirivam1cegi': Waiting for transfers to finish 2025/08/14 06:52:33 INFO : potato3: Deleted 2025/08/14 06:52:33.708356 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqiFBNvfkXo2zuzW6ia_A_aTf_kouJ8RTiUD9MQF5qje_tl48PUsteRutrUtYYyshMfxwNEtkfftGH-9Voc1Uw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:33.708400 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqiFBNvfkXo2zuzW6ia_A_aTf_kouJ8RTiUD9MQF5qje_tl48PUsteRutrUtYYyshMfxwNEtkfftGH-9Voc1Uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:33 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rqiFBNvfkXo2zuzW6ia_A_aTf_kouJ8RTiUD9MQF5qje_tl48PUsteRutrUtYYyshMfxwNEtkfftGH-9Voc1Uw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:33.993012 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4VDQDQEwQUElBT_tgScWnR6r0eSYpGQ4SK4tIBNUb8HBuX8w0cfwMdhsIu2fRTYefrHbzdrxIwgmmtrKRlSmnQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:33.993054 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4VDQDQEwQUElBT_tgScWnR6r0eSYpGQ4SK4tIBNUb8HBuX8w0cfwMdhsIu2fRTYefrHbzdrxIwgmmtrKRlSmnQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:33 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4VDQDQEwQUElBT_tgScWnR6r0eSYpGQ4SK4tIBNUb8HBuX8w0cfwMdhsIu2fRTYefrHbzdrxIwgmmtrKRlSmnQ==/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/4VDQDQEwQUElBT_tgScWnR6r0eSYpGQ4SK4tIBNUb8HBuX8w0cfwMdhsIu2fRTYefrHbzdrxIwgmmtrKRlSmnQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/14 06:52:33 DEBUG : proton drive root link ID 'rclone-test-pirivam1cegi': Purge remote --- FAIL: TestServerSideMoveWithFilter (19.98s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:52:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yetazip1weti" 2025/08/14 06:52:37 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Has cached credentials 2025/08/14 06:52:39 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Used cached credential to initialize the ProtonDrive API 2025/08/14 06:52:45 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xivisox5miwi' -> proton drive root link ID 'rclone-test-yetazip1weti' 2025/08/14 06:52:53 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Using server-side directory move 2025/08/14 06:52:53 INFO : proton drive root link ID 'rclone-test-yetazip1weti': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/14 06:52:54 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/14 06:52:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/14 06:52:54 DEBUG : empty space: Unchanged skipping 2025/08/14 06:52:54 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/14 06:52:54 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Waiting for checks to finish 2025/08/14 06:52:54 INFO : empty space: Deleted 2025/08/14 06:52:54 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Waiting for transfers to finish 2025/08/14 06:52:54 INFO : potato3: Deleted 2025/08/14 06:52:55.044650 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Trf4oHSAdCSCMapYCh1ovPY94uG9-yQU3Twgl7tj81hl2O0ajYVtkYLlSrPoorKdTHYic5s1CBlgMZYS6318qg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:55.044690 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Trf4oHSAdCSCMapYCh1ovPY94uG9-yQU3Twgl7tj81hl2O0ajYVtkYLlSrPoorKdTHYic5s1CBlgMZYS6318qg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:55 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Trf4oHSAdCSCMapYCh1ovPY94uG9-yQU3Twgl7tj81hl2O0ajYVtkYLlSrPoorKdTHYic5s1CBlgMZYS6318qg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:55.380419 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFcfRdDnRAPnTUnQUn8G4IB6gIk_DpHee1myxMTgX02qu1P-uvs7Y0O9m-1wCtNlhN2zvFSTPPbGDwNYPC9g8A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:52:55.380475 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFcfRdDnRAPnTUnQUn8G4IB6gIk_DpHee1myxMTgX02qu1P-uvs7Y0O9m-1wCtNlhN2zvFSTPPbGDwNYPC9g8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:55 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RFcfRdDnRAPnTUnQUn8G4IB6gIk_DpHee1myxMTgX02qu1P-uvs7Y0O9m-1wCtNlhN2zvFSTPPbGDwNYPC9g8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:52:55 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/14 06:52:55 DEBUG : proton drive root link ID 'rclone-test-yetazip1weti': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (21.53s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:53:06 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 06:53:06 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 06:53:08 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 06:54:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/backup" 2025/08/14 06:54:53 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Has cached credentials 2025/08/14 06:54:55 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Used cached credential to initialize the ProtonDrive API 2025/08/14 06:58:26 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 06:58:26 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for checks to finish 2025/08/14 06:58:26 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 06:58:26 DEBUG : two: Unchanged skipping 2025/08/14 06:58:28.525992 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/goE8P9YZ0fC2aHFk9L23_fyi8bR4ke4R1jGYNuc64xttyAQQA0DRumNCKzTah8mhFkNIZIY5_la51sFf4XAjNw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 06:58:28.526033 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/goE8P9YZ0fC2aHFk9L23_fyi8bR4ke4R1jGYNuc64xttyAQQA0DRumNCKzTah8mhFkNIZIY5_la51sFf4XAjNw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:58:28 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/goE8P9YZ0fC2aHFk9L23_fyi8bR4ke4R1jGYNuc64xttyAQQA0DRumNCKzTah8mhFkNIZIY5_la51sFf4XAjNw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 06:58:28 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for transfers to finish 2025/08/14 06:58:28 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/dst': not deleting files as there were IO errors 2025/08/14 06:58:28 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/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/goE8P9YZ0fC2aHFk9L23_fyi8bR4ke4R1jGYNuc64xttyAQQA0DRumNCKzTah8mhFkNIZIY5_la51sFf4XAjNw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (333.83s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 06:58:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 06:58:41 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 06:58:42 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:00:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/backup" 2025/08/14 07:00:27 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Has cached credentials 2025/08/14 07:00:29 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:04:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 07:04:00 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 07:04:00 DEBUG : two: Unchanged skipping 2025/08/14 07:04:00 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for checks to finish 2025/08/14 07:04:02.936421 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY4thkM6sn4nZ8yXAV-soXiqIxNdQdEa9MFNWnC0jjiyopfqsE4F8F3EUARN5-UzX4V2cqX_YBYLD-k56-gW8A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 07:04:02.936455 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY4thkM6sn4nZ8yXAV-soXiqIxNdQdEa9MFNWnC0jjiyopfqsE4F8F3EUARN5-UzX4V2cqX_YBYLD-k56-gW8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:04:02 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY4thkM6sn4nZ8yXAV-soXiqIxNdQdEa9MFNWnC0jjiyopfqsE4F8F3EUARN5-UzX4V2cqX_YBYLD-k56-gW8A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:04:02 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for transfers to finish 2025/08/14 07:04:02 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/dst': not deleting files as there were IO errors 2025/08/14 07:04:02 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/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/CY4thkM6sn4nZ8yXAV-soXiqIxNdQdEa9MFNWnC0jjiyopfqsE4F8F3EUARN5-UzX4V2cqX_YBYLD-k56-gW8A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (334.44s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 07:04:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 07:04:15 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 07:04:17 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:06:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/backup" 2025/08/14 07:06:03 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Has cached credentials 2025/08/14 07:06:04 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/backup': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:09:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 07:09:37 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for checks to finish 2025/08/14 07:09:37 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 07:09:37 DEBUG : two: Unchanged skipping 2025/08/14 07:09:40.056888 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wvYnIyoXYZLvB52P8o5iggp8u_h6qwyPLu87YsbP_Hk__h7TasTteq6oEixNs3FHMc0Q-VAZjFVS2wmMdCh32w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 07:09:40.056995 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wvYnIyoXYZLvB52P8o5iggp8u_h6qwyPLu87YsbP_Hk__h7TasTteq6oEixNs3FHMc0Q-VAZjFVS2wmMdCh32w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:09:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wvYnIyoXYZLvB52P8o5iggp8u_h6qwyPLu87YsbP_Hk__h7TasTteq6oEixNs3FHMc0Q-VAZjFVS2wmMdCh32w==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:09:40 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for transfers to finish 2025/08/14 07:09:40 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/dst': not deleting files as there were IO errors 2025/08/14 07:09:40 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/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/wvYnIyoXYZLvB52P8o5iggp8u_h6qwyPLu87YsbP_Hk__h7TasTteq6oEixNs3FHMc0Q-VAZjFVS2wmMdCh32w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (337.13s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 07:09:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 07:09:52 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 07:09:54 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:11:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 07:11:41 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/14 07:11:41 DEBUG : two: Unchanged skipping 2025/08/14 07:11:41 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for checks to finish 2025/08/14 07:11:42.577720 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pWDlUCG_wsUnP-0k_RFJcTpd0JAFYPd8H2PocQVmmcyjQBP1eBzMuN-sZaS2I_61586sPdH7uejdvBRpb3f8Hw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 07:11:42.577761 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pWDlUCG_wsUnP-0k_RFJcTpd0JAFYPd8H2PocQVmmcyjQBP1eBzMuN-sZaS2I_61586sPdH7uejdvBRpb3f8Hw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:11:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pWDlUCG_wsUnP-0k_RFJcTpd0JAFYPd8H2PocQVmmcyjQBP1eBzMuN-sZaS2I_61586sPdH7uejdvBRpb3f8Hw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:11:42 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Waiting for transfers to finish 2025/08/14 07:11:42 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/dst': not deleting files as there were IO errors 2025/08/14 07:11:42 ERROR : proton drive root link ID 'rclone-test-xivisox5miwi/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/pWDlUCG_wsUnP-0k_RFJcTpd0JAFYPd8H2PocQVmmcyjQBP1eBzMuN-sZaS2I_61586sPdH7uejdvBRpb3f8Hw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (121.88s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 07:11:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 07:11:54 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 07:11:55 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:13:43 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 07:13:43.939655 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6p0bCLA7OjxAh3uJEcTQv0RK9TeHbiCIOkD_jXazpJmN5fQbsml5GclIqQ-QWC9OtXmJafIOJAcT280UATr77A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 07:13:43.939692 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6p0bCLA7OjxAh3uJEcTQv0RK9TeHbiCIOkD_jXazpJmN5fQbsml5GclIqQ-QWC9OtXmJafIOJAcT280UATr77A==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:13:43 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6p0bCLA7OjxAh3uJEcTQv0RK9TeHbiCIOkD_jXazpJmN5fQbsml5GclIqQ-QWC9OtXmJafIOJAcT280UATr77A==/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/6p0bCLA7OjxAh3uJEcTQv0RK9TeHbiCIOkD_jXazpJmN5fQbsml5GclIqQ-QWC9OtXmJafIOJAcT280UATr77A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (121.28s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-xivisox5miwi'", Local "Local file system at /tmp/rclone1060811320", Modify Window "1s" 2025/08/14 07:13:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xivisox5miwi/dst" 2025/08/14 07:13:55 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Has cached credentials 2025/08/14 07:13:57 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi/dst': Used cached credential to initialize the ProtonDrive API 2025/08/14 07:15:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/14 07:15:45.136827 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5YfXC23687-zybKspEskCSuzH2wJeNBXJtai-QLZSSUPzAeG6A1pKoRbIrXno9wTRxT-V7YCt8F9rpwZJrdPrg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/14 07:15:45.136861 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5YfXC23687-zybKspEskCSuzH2wJeNBXJtai-QLZSSUPzAeG6A1pKoRbIrXno9wTRxT-V7YCt8F9rpwZJrdPrg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/14 07:15:45 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5YfXC23687-zybKspEskCSuzH2wJeNBXJtai-QLZSSUPzAeG6A1pKoRbIrXno9wTRxT-V7YCt8F9rpwZJrdPrg==/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/5YfXC23687-zybKspEskCSuzH2wJeNBXJtai-QLZSSUPzAeG6A1pKoRbIrXno9wTRxT-V7YCt8F9rpwZJrdPrg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (121.41s) FAIL 2025/08/14 07:15:49 DEBUG : proton drive root link ID 'rclone-test-xivisox5miwi': 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 24m56.928440627s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]