"./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 4/5) 2025/10/15 03:12:40 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma" 2025/10/15 03:12:40 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/15 03:12:40 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Has cached credentials 2025/10/15 03:12:41 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:12:41 DEBUG : Creating backend with remote "/tmp/rclone3147743568" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:12:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxujax5vuco" 2025/10/15 03:12:44 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Has cached credentials 2025/10/15 03:12:45 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-mofimal4soma' -> proton drive root link ID 'rclone-test-goxujax5vuco' 2025/10/15 03:12:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/15 03:12:46 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Waiting for checks to finish 2025/10/15 03:12:46 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Waiting for transfers to finish 2025/10/15 03:12:49 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/15 03:12:49 INFO : sub dir/hello world: Copied (new) 2025/10/15 03:12:50.626667 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/10/15 03:12:50.626739 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/10/15 03:12:52 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Using server-side directory move 2025/10/15 03:12:52 INFO : proton drive root link ID 'rclone-test-goxujax5vuco': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/15 03:12:53 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/15 03:12:53 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Waiting for checks to finish 2025/10/15 03:12:53 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Waiting for transfers to finish 2025/10/15 03:12:53 INFO : sub dir/hello world: Deleted 2025/10/15 03:12:54.163443 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OBRhGtLASL2GRnGO4bzDbwKFxeQplDjxXX0-guN3FWEXmQVXnTUDeiy5f6ZLGD2GsbCRPP3a1QNSugFgVVBg5Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:12:54.163485 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OBRhGtLASL2GRnGO4bzDbwKFxeQplDjxXX0-guN3FWEXmQVXnTUDeiy5f6ZLGD2GsbCRPP3a1QNSugFgVVBg5Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:12:54 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OBRhGtLASL2GRnGO4bzDbwKFxeQplDjxXX0-guN3FWEXmQVXnTUDeiy5f6ZLGD2GsbCRPP3a1QNSugFgVVBg5Q==/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/OBRhGtLASL2GRnGO4bzDbwKFxeQplDjxXX0-guN3FWEXmQVXnTUDeiy5f6ZLGD2GsbCRPP3a1QNSugFgVVBg5Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/10/15 03:12:54 DEBUG : proton drive root link ID 'rclone-test-goxujax5vuco': Purge remote --- FAIL: TestServerSideMoveOverSelf (14.40s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/10/15 03:12:56 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:12:56 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:12:56 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:12:56 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:12:56 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/15 03:12:56 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/15 03:12:56 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:12:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:12:57 INFO : yam: Copied (new) 2025/10/15 03:12:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/15 03:12:57 INFO : potato: Copied (new) 2025/10/15 03:12:57 DEBUG : Waiting for deletions to finish 2025/10/15 03:12:58 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:12:58 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:12:58 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:12:58 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:12:58 DEBUG : potato: Unchanged skipping 2025/10/15 03:12:58 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:12:58.867249 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hxy0wF69vfAM1x5TbG8MovFgdYhHUp9Km-nMWZJJ6c0TMj4UhPHWhAdXx5Akhtm-Ow26ctmVTB9H0Vpwr-JFHw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:12:58.867292 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hxy0wF69vfAM1x5TbG8MovFgdYhHUp9Km-nMWZJJ6c0TMj4UhPHWhAdXx5Akhtm-Ow26ctmVTB9H0Vpwr-JFHw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:12:58 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hxy0wF69vfAM1x5TbG8MovFgdYhHUp9Km-nMWZJJ6c0TMj4UhPHWhAdXx5Akhtm-Ow26ctmVTB9H0Vpwr-JFHw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:12:58 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hxy0wF69vfAM1x5TbG8MovFgdYhHUp9Km-nMWZJJ6c0TMj4UhPHWhAdXx5Akhtm-Ow26ctmVTB9H0Vpwr-JFHw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:12:58 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/15 03:12:58 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:00 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:13:00 INFO : yaml: Copied (new) 2025/10/15 03:13:00 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': not deleting files as there were IO errors 2025/10/15 03:13:00 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': 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 (5.94s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/10/15 03:13:02 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:13:02 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:13:02 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:13:02 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:13:02 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/15 03:13:02 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/15 03:13:02 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:03 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/15 03:13:03 INFO : potato: Copied (new) 2025/10/15 03:13:03 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:13:03 INFO : yam: Copied (new) 2025/10/15 03:13:03 DEBUG : Waiting for deletions to finish 2025/10/15 03:13:04 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:13:04 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:13:04 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:13:04 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:13:04 DEBUG : potato: Unchanged skipping 2025/10/15 03:13:04 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:13:05.152345 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/d8-6bnWBDgX67uxLRn-kmQHVh4uz-MrFL9xBnLHKCHZmOnRh_vm0wryGu8iCnP4mqllo2l9QI5MU7C42f2fUSw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:05.152391 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/d8-6bnWBDgX67uxLRn-kmQHVh4uz-MrFL9xBnLHKCHZmOnRh_vm0wryGu8iCnP4mqllo2l9QI5MU7C42f2fUSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:05 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/d8-6bnWBDgX67uxLRn-kmQHVh4uz-MrFL9xBnLHKCHZmOnRh_vm0wryGu8iCnP4mqllo2l9QI5MU7C42f2fUSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:05 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/d8-6bnWBDgX67uxLRn-kmQHVh4uz-MrFL9xBnLHKCHZmOnRh_vm0wryGu8iCnP4mqllo2l9QI5MU7C42f2fUSw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:05 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/15 03:13:05 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:06 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:13:06 INFO : yaml: Copied (new) 2025/10/15 03:13:06 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': not deleting files as there were IO errors 2025/10/15 03:13:06 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': 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 (5.96s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/10/15 03:13:08 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:13:08 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:13:08 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:13:08 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/15 03:13:08 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:13:08 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/10/15 03:13:08 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:10 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/15 03:13:10 INFO : potato: Copied (new) 2025/10/15 03:13:10 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:13:10 INFO : sub/yam: Copied (new) 2025/10/15 03:13:10 DEBUG : Waiting for deletions to finish 2025/10/15 03:13:11 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:13:11 DEBUG : potato: Unchanged skipping 2025/10/15 03:13:11 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Making map for --track-renames 2025/10/15 03:13:11 INFO : proton drive root link ID 'rclone-test-mofimal4soma': Finished making map for --track-renames 2025/10/15 03:13:11 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:13:11 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for renames to finish 2025/10/15 03:13:12.042790 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xx3dsflG5aFvARYeHktQ-HdGGu62HxnVCsbfOq9sygaZk6P6Vfzir37okhee4kKGluOzSz1f2vdkx0XXrPirRg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:12.042839 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xx3dsflG5aFvARYeHktQ-HdGGu62HxnVCsbfOq9sygaZk6P6Vfzir37okhee4kKGluOzSz1f2vdkx0XXrPirRg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:12 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xx3dsflG5aFvARYeHktQ-HdGGu62HxnVCsbfOq9sygaZk6P6Vfzir37okhee4kKGluOzSz1f2vdkx0XXrPirRg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:12 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xx3dsflG5aFvARYeHktQ-HdGGu62HxnVCsbfOq9sygaZk6P6Vfzir37okhee4kKGluOzSz1f2vdkx0XXrPirRg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:12 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/15 03:13:12 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/15 03:13:13 INFO : yam: Copied (new) 2025/10/15 03:13:13 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': not deleting files as there were IO errors 2025/10/15 03:13:13 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': 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 (7.72s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:13:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/15 03:13:15 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/10/15 03:13:15 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for checks to finish 2025/10/15 03:13:15 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': Waiting for transfers to finish 2025/10/15 03:13:18 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/15 03:13:18 INFO : sub dir/hello world: Copied (new) 2025/10/15 03:13:18 INFO : sub dir/hello world: Deleted 2025/10/15 03:13:18 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/10/15 03:13:18 INFO : nested/sub dir/file: Copied (new) 2025/10/15 03:13:18 INFO : nested/sub dir/file: Deleted 2025/10/15 03:13:18 ERROR : Local file system at /tmp/rclone3147743568: 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 (5.39s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:13:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-ziwesox8cizi" 2025/10/15 03:13:20 DEBUG : Config file has changed externally - reloading 2025/10/15 03:13:20 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Has cached credentials 2025/10/15 03:13:22 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mofimal4soma' -> proton drive root link ID 'rclone-test-ziwesox8cizi' 2025/10/15 03:13:32 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Using server-side directory move 2025/10/15 03:13:32 INFO : proton drive root link ID 'rclone-test-ziwesox8cizi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/15 03:13:32 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/15 03:13:32 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/15 03:13:32 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Waiting for checks to finish 2025/10/15 03:13:32 DEBUG : empty space: Unchanged skipping 2025/10/15 03:13:32 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/15 03:13:32 INFO : empty space: Deleted 2025/10/15 03:13:32 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Waiting for transfers to finish 2025/10/15 03:13:32 INFO : potato3: Deleted 2025/10/15 03:13:33.060363 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qb5vAncLFOGZNoiPEbwERalxczVCg7-N8V36Vu-2fM-ADTBv71Z_ZG8i0lPMHdbJBmYfeZ2ruHg5fhpIaRentQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:33.060398 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qb5vAncLFOGZNoiPEbwERalxczVCg7-N8V36Vu-2fM-ADTBv71Z_ZG8i0lPMHdbJBmYfeZ2ruHg5fhpIaRentQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:33 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Qb5vAncLFOGZNoiPEbwERalxczVCg7-N8V36Vu-2fM-ADTBv71Z_ZG8i0lPMHdbJBmYfeZ2ruHg5fhpIaRentQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:33.067305 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RNyudRLlSVDaaw0ScLvlDrOeFsighjfPV51w6OpTgKjWHjT_FLOxOr2kFirskEQSyEcrCvwKUL16J5X5uyx4yQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:33.067348 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RNyudRLlSVDaaw0ScLvlDrOeFsighjfPV51w6OpTgKjWHjT_FLOxOr2kFirskEQSyEcrCvwKUL16J5X5uyx4yQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:33 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/RNyudRLlSVDaaw0ScLvlDrOeFsighjfPV51w6OpTgKjWHjT_FLOxOr2kFirskEQSyEcrCvwKUL16J5X5uyx4yQ==/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/RNyudRLlSVDaaw0ScLvlDrOeFsighjfPV51w6OpTgKjWHjT_FLOxOr2kFirskEQSyEcrCvwKUL16J5X5uyx4yQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/10/15 03:13:33 DEBUG : proton drive root link ID 'rclone-test-ziwesox8cizi': Purge remote --- FAIL: TestServerSideMove (13.46s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:13:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-jecoxar1josi" 2025/10/15 03:13:34 DEBUG : proton drive root link ID 'rclone-test-jecoxar1josi': Has cached credentials 2025/10/15 03:13:35 DEBUG : proton drive root link ID 'rclone-test-jecoxar1josi': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mofimal4soma' -> proton drive root link ID 'rclone-test-jecoxar1josi' 2025/10/15 03:13:44 DEBUG : empty space: Excluded (Size Filter) 2025/10/15 03:13:44 DEBUG : empty space: Excluded 2025/10/15 03:13:44 DEBUG : empty space: Excluded (Size Filter) 2025/10/15 03:13:44 DEBUG : empty space: Excluded 2025/10/15 03:13:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/15 03:13:44 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/15 03:13:44 DEBUG : proton drive root link ID 'rclone-test-jecoxar1josi': Waiting for checks to finish 2025/10/15 03:13:44 DEBUG : proton drive root link ID 'rclone-test-jecoxar1josi': Waiting for transfers to finish 2025/10/15 03:13:44 INFO : potato3: Deleted 2025/10/15 03:13:44.849233 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vhQKHurksWEBTLedn7pCn7i59MUNkHoA6_uIpWURZZL9sdt_yggFqwIj4uA3GF5VN4VHZ2vP5HbkeIsEkBEc3A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:44.849266 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vhQKHurksWEBTLedn7pCn7i59MUNkHoA6_uIpWURZZL9sdt_yggFqwIj4uA3GF5VN4VHZ2vP5HbkeIsEkBEc3A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:44 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vhQKHurksWEBTLedn7pCn7i59MUNkHoA6_uIpWURZZL9sdt_yggFqwIj4uA3GF5VN4VHZ2vP5HbkeIsEkBEc3A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:44.959612 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sRpBCJ_SqXYssXkOAGjxCyA9xwMvUZ3TepdJH3hkRfE4hniLSPD31r2DB7bUBYEMo5waYYXQ8-6OeEB1Wi41Lg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:44.959654 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sRpBCJ_SqXYssXkOAGjxCyA9xwMvUZ3TepdJH3hkRfE4hniLSPD31r2DB7bUBYEMo5waYYXQ8-6OeEB1Wi41Lg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:44 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/sRpBCJ_SqXYssXkOAGjxCyA9xwMvUZ3TepdJH3hkRfE4hniLSPD31r2DB7bUBYEMo5waYYXQ8-6OeEB1Wi41Lg==/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/sRpBCJ_SqXYssXkOAGjxCyA9xwMvUZ3TepdJH3hkRfE4hniLSPD31r2DB7bUBYEMo5waYYXQ8-6OeEB1Wi41Lg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/10/15 03:13:44 DEBUG : proton drive root link ID 'rclone-test-jecoxar1josi': Purge remote --- FAIL: TestServerSideMoveWithFilter (12.23s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:13:46 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-supugop3kodi" 2025/10/15 03:13:46 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Has cached credentials 2025/10/15 03:13:47 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:13:52 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-mofimal4soma' -> proton drive root link ID 'rclone-test-supugop3kodi' 2025/10/15 03:13:57 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Using server-side directory move 2025/10/15 03:13:57 INFO : proton drive root link ID 'rclone-test-supugop3kodi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/15 03:13:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/15 03:13:57 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/15 03:13:57 DEBUG : empty space: Unchanged skipping 2025/10/15 03:13:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/15 03:13:57 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Waiting for checks to finish 2025/10/15 03:13:58 INFO : potato3: Deleted 2025/10/15 03:13:58 INFO : empty space: Deleted 2025/10/15 03:13:58 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Waiting for transfers to finish 2025/10/15 03:13:58.235624 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3EVVCMQVKddTozXhj6PFdvyRgglYLY8_cq7ndCGRASyg3IWqBB0fgr0UF0hIzmC3qJELa23g8uNFZlNeICmBpA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:58.235664 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3EVVCMQVKddTozXhj6PFdvyRgglYLY8_cq7ndCGRASyg3IWqBB0fgr0UF0hIzmC3qJELa23g8uNFZlNeICmBpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:58 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3EVVCMQVKddTozXhj6PFdvyRgglYLY8_cq7ndCGRASyg3IWqBB0fgr0UF0hIzmC3qJELa23g8uNFZlNeICmBpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:58.346076 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AEdJYaZfFZ8mNQPYoIPGbuf69bNM3y0DZwvD4rKffOfEznG2XJz3-lZI6XblO7MhonwjteMARHJaOkoeIiBs5Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:13:58.346114 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AEdJYaZfFZ8mNQPYoIPGbuf69bNM3y0DZwvD4rKffOfEznG2XJz3-lZI6XblO7MhonwjteMARHJaOkoeIiBs5Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:58 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AEdJYaZfFZ8mNQPYoIPGbuf69bNM3y0DZwvD4rKffOfEznG2XJz3-lZI6XblO7MhonwjteMARHJaOkoeIiBs5Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:13:58 ERROR : proton drive root link ID 'rclone-test-mofimal4soma': 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/10/15 03:13:58 DEBUG : proton drive root link ID 'rclone-test-supugop3kodi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (13.37s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:14:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:14:05 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:14:06 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:15:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/backup" 2025/10/15 03:15:55 DEBUG : Config file has changed externally - reloading 2025/10/15 03:15:55 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Has cached credentials 2025/10/15 03:15:56 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:19:31 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:19:31 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:19:31 DEBUG : two: Unchanged skipping 2025/10/15 03:19:31 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for checks to finish 2025/10/15 03:19:32.489009 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f559m-hYJ-w2W4hjQ_cnVKY3_SjnvDePRp5G5KF5o8aOhi9NQ989Qr3Ki5uNM-ZLPSc9N4MR8xuVGa4U0aPUOQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:19:32.489037 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f559m-hYJ-w2W4hjQ_cnVKY3_SjnvDePRp5G5KF5o8aOhi9NQ989Qr3Ki5uNM-ZLPSc9N4MR8xuVGa4U0aPUOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:19:32 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f559m-hYJ-w2W4hjQ_cnVKY3_SjnvDePRp5G5KF5o8aOhi9NQ989Qr3Ki5uNM-ZLPSc9N4MR8xuVGa4U0aPUOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:19:32 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for transfers to finish 2025/10/15 03:19:32 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/dst': not deleting files as there were IO errors 2025/10/15 03:19:32 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/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/f559m-hYJ-w2W4hjQ_cnVKY3_SjnvDePRp5G5KF5o8aOhi9NQ989Qr3Ki5uNM-ZLPSc9N4MR8xuVGa4U0aPUOQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (334.44s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:19:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:19:39 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:19:40 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:21:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/backup" 2025/10/15 03:21:26 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Has cached credentials 2025/10/15 03:21:27 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:25:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:25:02 DEBUG : two: Unchanged skipping 2025/10/15 03:25:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:25:02 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for checks to finish 2025/10/15 03:25:03.230175 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3BJW3rf7WcqD2WZ9lTbEuAx3Upi8lotY3vU6oldJIooczM9KSgO5r8uUctL1xZOx8m3SROG8P52RD-oyQWbOog==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:25:03.230217 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3BJW3rf7WcqD2WZ9lTbEuAx3Upi8lotY3vU6oldJIooczM9KSgO5r8uUctL1xZOx8m3SROG8P52RD-oyQWbOog==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:25:03 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/3BJW3rf7WcqD2WZ9lTbEuAx3Upi8lotY3vU6oldJIooczM9KSgO5r8uUctL1xZOx8m3SROG8P52RD-oyQWbOog==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:25:03 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for transfers to finish 2025/10/15 03:25:03 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/dst': not deleting files as there were IO errors 2025/10/15 03:25:03 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/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/3BJW3rf7WcqD2WZ9lTbEuAx3Upi8lotY3vU6oldJIooczM9KSgO5r8uUctL1xZOx8m3SROG8P52RD-oyQWbOog==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (330.96s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:25:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:25:11 DEBUG : Config file has changed externally - reloading 2025/10/15 03:25:11 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:25:12 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:26:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/backup" 2025/10/15 03:26:56 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Has cached credentials 2025/10/15 03:26:57 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/backup': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:30:25 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:30:25 DEBUG : two: Unchanged skipping 2025/10/15 03:30:25 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for checks to finish 2025/10/15 03:30:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:30:26.383568 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UIAy0mH21QVfVLN0RqPpmuL1EZq3PSfSWCMoQmwkOxveaBqpVz1-jp5VjL7TGACK9D_rBBgjw_86xrTu6BGO3g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:30:26.383605 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UIAy0mH21QVfVLN0RqPpmuL1EZq3PSfSWCMoQmwkOxveaBqpVz1-jp5VjL7TGACK9D_rBBgjw_86xrTu6BGO3g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:30:26 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UIAy0mH21QVfVLN0RqPpmuL1EZq3PSfSWCMoQmwkOxveaBqpVz1-jp5VjL7TGACK9D_rBBgjw_86xrTu6BGO3g==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:30:26 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for transfers to finish 2025/10/15 03:30:26 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/dst': not deleting files as there were IO errors 2025/10/15 03:30:26 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/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/UIAy0mH21QVfVLN0RqPpmuL1EZq3PSfSWCMoQmwkOxveaBqpVz1-jp5VjL7TGACK9D_rBBgjw_86xrTu6BGO3g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (323.16s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:30:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:30:34 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:30:35 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:32:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:32:17 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/15 03:32:17 DEBUG : two: Unchanged skipping 2025/10/15 03:32:17 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for checks to finish 2025/10/15 03:32:18.059433 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qjQ0BbjcqGN0eLkHSBEAv0OVm1aGtXT8wWXnkJaYmWPFXOC4is6nTpWlZYqtd7cKGPFYSe0T5wXYO0N210fonw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:32:18.059467 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qjQ0BbjcqGN0eLkHSBEAv0OVm1aGtXT8wWXnkJaYmWPFXOC4is6nTpWlZYqtd7cKGPFYSe0T5wXYO0N210fonw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:32:18 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qjQ0BbjcqGN0eLkHSBEAv0OVm1aGtXT8wWXnkJaYmWPFXOC4is6nTpWlZYqtd7cKGPFYSe0T5wXYO0N210fonw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:32:18 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Waiting for transfers to finish 2025/10/15 03:32:18 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/dst': not deleting files as there were IO errors 2025/10/15 03:32:18 ERROR : proton drive root link ID 'rclone-test-mofimal4soma/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/qjQ0BbjcqGN0eLkHSBEAv0OVm1aGtXT8wWXnkJaYmWPFXOC4is6nTpWlZYqtd7cKGPFYSe0T5wXYO0N210fonw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (111.20s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:32:25 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:32:25 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:32:26 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:34:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:34:11.335546 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/69rtoBJPFp6K35pRvj22isvZmYGDKxxIPZ5quDj-BdXAgB2VUM5cP1OO3mNmq4zWpttXyivVpFEmnjL08YK_pA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:34:11.335580 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/69rtoBJPFp6K35pRvj22isvZmYGDKxxIPZ5quDj-BdXAgB2VUM5cP1OO3mNmq4zWpttXyivVpFEmnjL08YK_pA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:34:11 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/69rtoBJPFp6K35pRvj22isvZmYGDKxxIPZ5quDj-BdXAgB2VUM5cP1OO3mNmq4zWpttXyivVpFEmnjL08YK_pA==/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/69rtoBJPFp6K35pRvj22isvZmYGDKxxIPZ5quDj-BdXAgB2VUM5cP1OO3mNmq4zWpttXyivVpFEmnjL08YK_pA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (113.94s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-mofimal4soma'", Local "Local file system at /tmp/rclone3147743568", Modify Window "1s" 2025/10/15 03:34:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-mofimal4soma/dst" 2025/10/15 03:34:19 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Has cached credentials 2025/10/15 03:34:20 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma/dst': Used cached credential to initialize the ProtonDrive API 2025/10/15 03:36:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/15 03:36:04.894879 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I6WonpCVdHAEeWdPML2DwMrLfzdxsFs-xhPWctNYQgSLB3DJ7aXqNv7D02n0rlltNlURCzqwNdTymNF21086EQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/15 03:36:04.894915 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I6WonpCVdHAEeWdPML2DwMrLfzdxsFs-xhPWctNYQgSLB3DJ7aXqNv7D02n0rlltNlURCzqwNdTymNF21086EQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/15 03:36:04 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/I6WonpCVdHAEeWdPML2DwMrLfzdxsFs-xhPWctNYQgSLB3DJ7aXqNv7D02n0rlltNlURCzqwNdTymNF21086EQ==/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/I6WonpCVdHAEeWdPML2DwMrLfzdxsFs-xhPWctNYQgSLB3DJ7aXqNv7D02n0rlltNlURCzqwNdTymNF21086EQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (113.54s) FAIL 2025/10/15 03:36:07 DEBUG : proton drive root link ID 'rclone-test-mofimal4soma': 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 23m27.288989955s (try 4/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]