"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 3/5) 2024/12/13 04:53:14 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja" 2024/12/13 04:53:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/12/13 04:53:14 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Has cached credentials 2024/12/13 04:53:16 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:53:16 DEBUG : Creating backend with remote "/tmp/rclone2629410136" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:53:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gopukon3doca" 2024/12/13 04:53:20 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Has cached credentials 2024/12/13 04:53:22 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Used cached credential to initialize the ProtonDrive API sync_test.go:671: Server side copy (if possible) proton drive root link ID 'rclone-test-dijowar2seja' -> proton drive root link ID 'rclone-test-gopukon3doca' 2024/12/13 04:53:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/12/13 04:53:23 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Waiting for checks to finish 2024/12/13 04:53:23 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Waiting for transfers to finish 2024/12/13 04:53:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/12/13 04:53:27 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:53:28.578128 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 2024/12/13 04:53:28.578156 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) 2024/12/13 04:53:31 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Using server-side directory move 2024/12/13 04:53:31 INFO : proton drive root link ID 'rclone-test-gopukon3doca': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:53:31 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/12/13 04:53:31 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Waiting for checks to finish 2024/12/13 04:53:31 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Waiting for transfers to finish 2024/12/13 04:53:32 INFO : sub dir/hello world: Deleted 2024/12/13 04:53:33.211271 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aeSe7Kjea49MizL6jqzWVk2KNQF5wLAppQ5IALu4sXJSFekT72gfa0audWi0NIAsnBxvs5CV6cUruJcKETcWuw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:53:33.211296 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aeSe7Kjea49MizL6jqzWVk2KNQF5wLAppQ5IALu4sXJSFekT72gfa0audWi0NIAsnBxvs5CV6cUruJcKETcWuw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:33 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aeSe7Kjea49MizL6jqzWVk2KNQF5wLAppQ5IALu4sXJSFekT72gfa0audWi0NIAsnBxvs5CV6cUruJcKETcWuw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:684: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:684 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/aeSe7Kjea49MizL6jqzWVk2KNQF5wLAppQ5IALu4sXJSFekT72gfa0audWi0NIAsnBxvs5CV6cUruJcKETcWuw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2024/12/13 04:53:33 DEBUG : proton drive root link ID 'rclone-test-gopukon3doca': Purge remote --- FAIL: TestServerSideMoveOverSelf (19.35s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" sync_test.go:1538: Can track renames: true 2024/12/13 04:53:36 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:36 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:36 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:53:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:53:36 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:36 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:53:38 INFO : potato: Copied (new) 2024/12/13 04:53:38 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:38 INFO : yam: Copied (new) 2024/12/13 04:53:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:53:39 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:53:39 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:39 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:39 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:39 DEBUG : potato: Unchanged skipping 2024/12/13 04:53:39 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:40.070678 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B-EQFEgi8v9qLlmL0vqQtXFnkTK3n6saOIZEiRvFP0bjxx1PX3G_FVRXojf4iNM0PvaccP0s5Ca4DIaZlDmNog==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:53:40.070701 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B-EQFEgi8v9qLlmL0vqQtXFnkTK3n6saOIZEiRvFP0bjxx1PX3G_FVRXojf4iNM0PvaccP0s5Ca4DIaZlDmNog==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:40 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B-EQFEgi8v9qLlmL0vqQtXFnkTK3n6saOIZEiRvFP0bjxx1PX3G_FVRXojf4iNM0PvaccP0s5Ca4DIaZlDmNog==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:40 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/B-EQFEgi8v9qLlmL0vqQtXFnkTK3n6saOIZEiRvFP0bjxx1PX3G_FVRXojf4iNM0PvaccP0s5Ca4DIaZlDmNog==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:40 DEBUG : yaml: Need to transfer - No matching file found at Destination 2024/12/13 04:53:40 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:41 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:41 INFO : yaml: Copied (new) 2024/12/13 04:53:41 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting files as there were IO errors 2024/12/13 04:53:41 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting directories as there were IO errors sync_test.go:1556: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1556 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (8.42s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" sync_test.go:1610: Can track renames: true 2024/12/13 04:53:44 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:44 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:44 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:44 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:53:44 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:53:44 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:44 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:46 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:53:46 INFO : potato: Copied (new) 2024/12/13 04:53:46 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:46 INFO : yam: Copied (new) 2024/12/13 04:53:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:53:47 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:53:47 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:47 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:47 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:47 DEBUG : potato: Unchanged skipping 2024/12/13 04:53:47 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:48.357908 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UJptVV-YDFD88EQsF_knsBR0GYPtU19ayDIL_xy_Hi6ig_AJYdWF29bqP6ZPWkdl3K2yH4jQYfk05T8e2IyGxA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:53:48.357931 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UJptVV-YDFD88EQsF_knsBR0GYPtU19ayDIL_xy_Hi6ig_AJYdWF29bqP6ZPWkdl3K2yH4jQYfk05T8e2IyGxA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:48 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UJptVV-YDFD88EQsF_knsBR0GYPtU19ayDIL_xy_Hi6ig_AJYdWF29bqP6ZPWkdl3K2yH4jQYfk05T8e2IyGxA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:48 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UJptVV-YDFD88EQsF_knsBR0GYPtU19ayDIL_xy_Hi6ig_AJYdWF29bqP6ZPWkdl3K2yH4jQYfk05T8e2IyGxA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:48 DEBUG : yaml: Need to transfer - No matching file found at Destination 2024/12/13 04:53:48 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:50 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:50 INFO : yaml: Copied (new) 2024/12/13 04:53:50 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting files as there were IO errors 2024/12/13 04:53:50 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting directories as there were IO errors sync_test.go:1628: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1628 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (8.39s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" sync_test.go:1649: Can track renames: true 2024/12/13 04:53:53 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:53 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:53 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:53 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/12/13 04:53:53 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/12/13 04:53:53 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:53 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:55 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/12/13 04:53:55 INFO : potato: Copied (new) 2024/12/13 04:53:55 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:55 INFO : sub/yam: Copied (new) 2024/12/13 04:53:55 DEBUG : Waiting for deletions to finish run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:53:56 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:53:56 DEBUG : potato: Unchanged skipping 2024/12/13 04:53:57 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Making map for --track-renames 2024/12/13 04:53:57 INFO : proton drive root link ID 'rclone-test-dijowar2seja': Finished making map for --track-renames 2024/12/13 04:53:57 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:53:57 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for renames to finish 2024/12/13 04:53:57.953108 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlKTP75qsodavDGb-6zB9KMLekup9e-iO3VtJ8u2ornW0GO_ZW_82jsbRCQNYw2ox63SSauO-97yxQwNAYOE7w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:53:57.953141 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlKTP75qsodavDGb-6zB9KMLekup9e-iO3VtJ8u2ornW0GO_ZW_82jsbRCQNYw2ox63SSauO-97yxQwNAYOE7w==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:57 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlKTP75qsodavDGb-6zB9KMLekup9e-iO3VtJ8u2ornW0GO_ZW_82jsbRCQNYw2ox63SSauO-97yxQwNAYOE7w==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:57 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AlKTP75qsodavDGb-6zB9KMLekup9e-iO3VtJ8u2ornW0GO_ZW_82jsbRCQNYw2ox63SSauO-97yxQwNAYOE7w==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:53:57 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/12/13 04:53:57 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:53:59 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/12/13 04:53:59 INFO : yam: Copied (new) 2024/12/13 04:53:59 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting files as there were IO errors 2024/12/13 04:53:59 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting directories as there were IO errors sync_test.go:1667: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1667 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (10.38s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:54:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/12/13 04:54:03 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/12/13 04:54:03 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for checks to finish 2024/12/13 04:54:03 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': Waiting for transfers to finish 2024/12/13 04:54:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/12/13 04:54:07 INFO : sub dir/hello world: Copied (new) 2024/12/13 04:54:07 INFO : sub dir/hello world: Deleted 2024/12/13 04:54:07 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/12/13 04:54:07 INFO : nested/sub dir/file: Copied (new) 2024/12/13 04:54:07 INFO : nested/sub dir/file: Deleted 2024/12/13 04:54:07 ERROR : Local file system at /tmp/rclone2629410136: not deleting directories as there were IO errors sync_test.go:1788: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1788 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (7.76s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:54:11 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-diyijoj3qeki" 2024/12/13 04:54:11 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Has cached credentials 2024/12/13 04:54:12 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-dijowar2seja' -> proton drive root link ID 'rclone-test-diyijoj3qeki' 2024/12/13 04:54:22 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Using server-side directory move 2024/12/13 04:54:22 INFO : proton drive root link ID 'rclone-test-diyijoj3qeki': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:54:23 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:54:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/12/13 04:54:23 DEBUG : empty space: Unchanged skipping 2024/12/13 04:54:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:54:23 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Waiting for checks to finish 2024/12/13 04:54:24 INFO : potato3: Deleted 2024/12/13 04:54:24 INFO : empty space: Deleted 2024/12/13 04:54:24 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Waiting for transfers to finish 2024/12/13 04:54:24.402395 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wpbD5SUg2LjT09Y7_H2cdpa7oo_cYs5XMHSwNC567N1FFSo7GqmmCdZVDGBdH6sABQf-jyrFoiZRIdpm8bFMFw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:24.402433 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wpbD5SUg2LjT09Y7_H2cdpa7oo_cYs5XMHSwNC567N1FFSo7GqmmCdZVDGBdH6sABQf-jyrFoiZRIdpm8bFMFw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:24 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wpbD5SUg2LjT09Y7_H2cdpa7oo_cYs5XMHSwNC567N1FFSo7GqmmCdZVDGBdH6sABQf-jyrFoiZRIdpm8bFMFw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:24.606494 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wprbi2cptPj2EYq6hcGTLX4fubgsMtNtj6BNrH0jc9fT6XJvMuT0e9ebm4De2DFV5X5QCnCYTSBjT84Enq1ljg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:24.606527 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wprbi2cptPj2EYq6hcGTLX4fubgsMtNtj6BNrH0jc9fT6XJvMuT0e9ebm4De2DFV5X5QCnCYTSBjT84Enq1ljg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:24 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wprbi2cptPj2EYq6hcGTLX4fubgsMtNtj6BNrH0jc9fT6XJvMuT0e9ebm4De2DFV5X5QCnCYTSBjT84Enq1ljg==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1881 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wprbi2cptPj2EYq6hcGTLX4fubgsMtNtj6BNrH0jc9fT6XJvMuT0e9ebm4De2DFV5X5QCnCYTSBjT84Enq1ljg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2024/12/13 04:54:24 DEBUG : proton drive root link ID 'rclone-test-diyijoj3qeki': Purge remote --- FAIL: TestServerSideMove (15.86s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:54:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gayoxub7qapo" 2024/12/13 04:54:26 DEBUG : proton drive root link ID 'rclone-test-gayoxub7qapo': Has cached credentials 2024/12/13 04:54:28 DEBUG : proton drive root link ID 'rclone-test-gayoxub7qapo': Used cached credential to initialize the ProtonDrive API sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-dijowar2seja' -> proton drive root link ID 'rclone-test-gayoxub7qapo' 2024/12/13 04:54:39 DEBUG : empty space: Excluded (Size Filter) 2024/12/13 04:54:39 DEBUG : empty space: Excluded 2024/12/13 04:54:39 DEBUG : empty space: Excluded (Size Filter) 2024/12/13 04:54:39 DEBUG : empty space: Excluded 2024/12/13 04:54:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:54:39 DEBUG : proton drive root link ID 'rclone-test-gayoxub7qapo': Waiting for checks to finish 2024/12/13 04:54:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:54:39 DEBUG : proton drive root link ID 'rclone-test-gayoxub7qapo': Waiting for transfers to finish 2024/12/13 04:54:39 INFO : potato3: Deleted 2024/12/13 04:54:40.024416 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00rZUD4Xib60DPobyjB7Hrzv_DllRVBGG5hYBr1-wIdQS9lXaG0wGU3tprp6aFw0OAMYLhtLtvlhoB4o5zHERg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:40.024453 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00rZUD4Xib60DPobyjB7Hrzv_DllRVBGG5hYBr1-wIdQS9lXaG0wGU3tprp6aFw0OAMYLhtLtvlhoB4o5zHERg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:40 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/00rZUD4Xib60DPobyjB7Hrzv_DllRVBGG5hYBr1-wIdQS9lXaG0wGU3tprp6aFw0OAMYLhtLtvlhoB4o5zHERg==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:40.366327 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bajXVFLfF3OAp9_BvxlUPlLYT2hB4vCXVfeyrf1HUmg8lDKgciiHkjd23Foq2cffV9UEMNpk4_jTh-IwtTtrtw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:40.366353 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bajXVFLfF3OAp9_BvxlUPlLYT2hB4vCXVfeyrf1HUmg8lDKgciiHkjd23Foq2cffV9UEMNpk4_jTh-IwtTtrtw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:40 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bajXVFLfF3OAp9_BvxlUPlLYT2hB4vCXVfeyrf1HUmg8lDKgciiHkjd23Foq2cffV9UEMNpk4_jTh-IwtTtrtw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/bajXVFLfF3OAp9_BvxlUPlLYT2hB4vCXVfeyrf1HUmg8lDKgciiHkjd23Foq2cffV9UEMNpk4_jTh-IwtTtrtw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2024/12/13 04:54:40 DEBUG : proton drive root link ID 'rclone-test-gayoxub7qapo': Purge remote --- FAIL: TestServerSideMoveWithFilter (16.47s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:54:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-vabicih7cira" 2024/12/13 04:54:43 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Has cached credentials 2024/12/13 04:54:44 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:54:49 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) proton drive root link ID 'rclone-test-dijowar2seja' -> proton drive root link ID 'rclone-test-vabicih7cira' 2024/12/13 04:54:56 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Using server-side directory move 2024/12/13 04:54:56 INFO : proton drive root link ID 'rclone-test-vabicih7cira': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/12/13 04:54:56 DEBUG : potato2: Need to transfer - File not found at Destination 2024/12/13 04:54:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/12/13 04:54:56 DEBUG : empty space: Unchanged skipping 2024/12/13 04:54:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/12/13 04:54:56 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Waiting for checks to finish 2024/12/13 04:54:57 INFO : empty space: Deleted 2024/12/13 04:54:57 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Waiting for transfers to finish 2024/12/13 04:54:57 INFO : potato3: Deleted 2024/12/13 04:54:57.529855 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mZop_f1Jfm7PRLCVEyXwB7mQoCgzPGNpTmKr5QchWrH4EKlxfIromaZJPM_4MhG5tlnsiHZ9MHJ2VvWsuf5ZA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:57.529895 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mZop_f1Jfm7PRLCVEyXwB7mQoCgzPGNpTmKr5QchWrH4EKlxfIromaZJPM_4MhG5tlnsiHZ9MHJ2VvWsuf5ZA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/-mZop_f1Jfm7PRLCVEyXwB7mQoCgzPGNpTmKr5QchWrH4EKlxfIromaZJPM_4MhG5tlnsiHZ9MHJ2VvWsuf5ZA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:57.811393 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uvmvqdZTjrvNW2I-htTn6z12s4o7GuiG00IkBjIQphPVDAOQj-s9wxNerqKvWRCehrIFUYopgaymI5oeF9uIpw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:54:57.811415 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uvmvqdZTjrvNW2I-htTn6z12s4o7GuiG00IkBjIQphPVDAOQj-s9wxNerqKvWRCehrIFUYopgaymI5oeF9uIpw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/uvmvqdZTjrvNW2I-htTn6z12s4o7GuiG00IkBjIQphPVDAOQj-s9wxNerqKvWRCehrIFUYopgaymI5oeF9uIpw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:54:57 ERROR : proton drive root link ID 'rclone-test-dijowar2seja': not deleting directories as there were IO errors sync_test.go:1716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1716 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1901 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2024/12/13 04:54:57 DEBUG : proton drive root link ID 'rclone-test-vabicih7cira': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (17.40s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:55:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 04:55:07 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 04:55:08 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:55:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/backup" 2024/12/13 04:55:38 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Has cached credentials 2024/12/13 04:55:39 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:56:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:56:39 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:56:39 DEBUG : two: Unchanged skipping 2024/12/13 04:56:39 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for checks to finish 2024/12/13 04:56:40.636319 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hO77wajKVK68nb_7CfTmSOSEw5RoZPgpydDExl5cTBU9a81XcwN26NLLK6ezxaKUj88_smXGBcqUMIBQkIRxxA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:56:40.636342 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hO77wajKVK68nb_7CfTmSOSEw5RoZPgpydDExl5cTBU9a81XcwN26NLLK6ezxaKUj88_smXGBcqUMIBQkIRxxA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:56:40 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hO77wajKVK68nb_7CfTmSOSEw5RoZPgpydDExl5cTBU9a81XcwN26NLLK6ezxaKUj88_smXGBcqUMIBQkIRxxA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:56:40 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for transfers to finish 2024/12/13 04:56:40 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting files as there were IO errors 2024/12/13 04:56:40 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hO77wajKVK68nb_7CfTmSOSEw5RoZPgpydDExl5cTBU9a81XcwN26NLLK6ezxaKUj88_smXGBcqUMIBQkIRxxA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (103.35s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:56:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 04:56:51 DEBUG : Config file has changed externally - reloading 2024/12/13 04:56:51 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 04:56:52 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:57:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/backup" 2024/12/13 04:57:21 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Has cached credentials 2024/12/13 04:57:22 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:58:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 04:58:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 04:58:20 DEBUG : two: Unchanged skipping 2024/12/13 04:58:20 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for checks to finish 2024/12/13 04:58:21.922971 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SKGCLEOiYvJIqY2B6-3u3oj0nwjzoysuN9SPIxymxzxngzbwVqydZPieoVQp0P8_ANc72l0CEpuz0G3FJRbzRQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 04:58:21.922999 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SKGCLEOiYvJIqY2B6-3u3oj0nwjzoysuN9SPIxymxzxngzbwVqydZPieoVQp0P8_ANc72l0CEpuz0G3FJRbzRQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:58:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SKGCLEOiYvJIqY2B6-3u3oj0nwjzoysuN9SPIxymxzxngzbwVqydZPieoVQp0P8_ANc72l0CEpuz0G3FJRbzRQ==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 04:58:21 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for transfers to finish 2024/12/13 04:58:21 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting files as there were IO errors 2024/12/13 04:58:21 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SKGCLEOiYvJIqY2B6-3u3oj0nwjzoysuN9SPIxymxzxngzbwVqydZPieoVQp0P8_ANc72l0CEpuz0G3FJRbzRQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (101.45s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 04:58:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 04:58:32 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 04:58:33 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 04:59:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/backup" 2024/12/13 04:59:02 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Has cached credentials 2024/12/13 04:59:03 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/backup': Used cached credential to initialize the ProtonDrive API 2024/12/13 05:00:01 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 05:00:01 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 05:00:01 DEBUG : two: Unchanged skipping 2024/12/13 05:00:01 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for checks to finish 2024/12/13 05:00:02.895431 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LsW3x_gZOYU0sKThvSN5TVZz5FOqMeZzLKhG868THgYsiGZ4EMhWwRYlyc6qeozvi9ruzXcqH7j4f_hlUs8GSw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 05:00:02.895455 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LsW3x_gZOYU0sKThvSN5TVZz5FOqMeZzLKhG868THgYsiGZ4EMhWwRYlyc6qeozvi9ruzXcqH7j4f_hlUs8GSw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:00:02 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LsW3x_gZOYU0sKThvSN5TVZz5FOqMeZzLKhG868THgYsiGZ4EMhWwRYlyc6qeozvi9ruzXcqH7j4f_hlUs8GSw==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:00:02 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for transfers to finish 2024/12/13 05:00:02 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting files as there were IO errors 2024/12/13 05:00:02 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/LsW3x_gZOYU0sKThvSN5TVZz5FOqMeZzLKhG868THgYsiGZ4EMhWwRYlyc6qeozvi9ruzXcqH7j4f_hlUs8GSw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (100.85s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 05:00:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 05:00:13 DEBUG : Config file has changed externally - reloading 2024/12/13 05:00:13 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 05:00:14 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 05:00:43 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 05:00:43 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for checks to finish 2024/12/13 05:00:43 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/12/13 05:00:43 DEBUG : two: Unchanged skipping 2024/12/13 05:00:44.378047 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KPYGe9Fd3HMV-W04TZTGa5SN7Br8OqtL5gf5U0oa67eO8UdoLpjF64siKkezwyC-GHfhuMtYBzKAV6tHrTOAig==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 05:00:44.378064 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KPYGe9Fd3HMV-W04TZTGa5SN7Br8OqtL5gf5U0oa67eO8UdoLpjF64siKkezwyC-GHfhuMtYBzKAV6tHrTOAig==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:00:44 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KPYGe9Fd3HMV-W04TZTGa5SN7Br8OqtL5gf5U0oa67eO8UdoLpjF64siKkezwyC-GHfhuMtYBzKAV6tHrTOAig==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:00:44 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Waiting for transfers to finish 2024/12/13 05:00:44 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting files as there were IO errors 2024/12/13 05:00:44 ERROR : proton drive root link ID 'rclone-test-dijowar2seja/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2439 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/KPYGe9Fd3HMV-W04TZTGa5SN7Br8OqtL5gf5U0oa67eO8UdoLpjF64siKkezwyC-GHfhuMtYBzKAV6tHrTOAig==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (40.97s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 05:00:54 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 05:00:54 DEBUG : Config file has changed externally - reloading 2024/12/13 05:00:54 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 05:00:55 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 05:01:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 05:01:25.556391 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SvrCsBz7NLDKUAR78BP5cfuNKcjxV8-TsoErnSyD1VRWVWlkcKCo7iSJxv--rBQRoPvo2NzZYAnkcoNwwdJB8Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 05:01:25.556429 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SvrCsBz7NLDKUAR78BP5cfuNKcjxV8-TsoErnSyD1VRWVWlkcKCo7iSJxv--rBQRoPvo2NzZYAnkcoNwwdJB8Q==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:01:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SvrCsBz7NLDKUAR78BP5cfuNKcjxV8-TsoErnSyD1VRWVWlkcKCo7iSJxv--rBQRoPvo2NzZYAnkcoNwwdJB8Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2523 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SvrCsBz7NLDKUAR78BP5cfuNKcjxV8-TsoErnSyD1VRWVWlkcKCo7iSJxv--rBQRoPvo2NzZYAnkcoNwwdJB8Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (41.18s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-dijowar2seja'", Local "Local file system at /tmp/rclone2629410136", Modify Window "1s" 2024/12/13 05:01:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-dijowar2seja/dst" 2024/12/13 05:01:35 DEBUG : Config file has changed externally - reloading 2024/12/13 05:01:35 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Has cached credentials 2024/12/13 05:01:36 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja/dst': Used cached credential to initialize the ProtonDrive API 2024/12/13 05:02:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/12/13 05:02:06.820714 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gdf5UZULdcJaixm-lm3gcJNncs2oAWAhw1P2fyeX0CtDTM7SgPNXbhGkclYfDjMkJfGp5e3UotiKpm9Udq5ABA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2024/12/13 05:02:06.820736 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gdf5UZULdcJaixm-lm3gcJNncs2oAWAhw1P2fyeX0CtDTM7SgPNXbhGkclYfDjMkJfGp5e3UotiKpm9Udq5ABA==/move: This value should not be blank. (Code=2000, Status=400) 2024/12/13 05:02:06 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gdf5UZULdcJaixm-lm3gcJNncs2oAWAhw1P2fyeX0CtDTM7SgPNXbhGkclYfDjMkJfGp5e3UotiKpm9Udq5ABA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2473: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2473 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Gdf5UZULdcJaixm-lm3gcJNncs2oAWAhw1P2fyeX0CtDTM7SgPNXbhGkclYfDjMkJfGp5e3UotiKpm9Udq5ABA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (41.40s) FAIL 2024/12/13 05:02:10 DEBUG : proton drive root link ID 'rclone-test-dijowar2seja': 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 8m55.665083481s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]