"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 3/5) 2025/08/24 05:54:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje" 2025/08/24 05:54:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/24 05:54:45 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Has cached credentials 2025/08/24 05:54:47 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Used cached credential to initialize the ProtonDrive API 2025/08/24 05:54:48 DEBUG : Creating backend with remote "/tmp/rclone968977251" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:54:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-sikamoq9xuzo" 2025/08/24 05:54:52 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Has cached credentials 2025/08/24 05:54:54 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-yisavuf2peje' -> proton drive root link ID 'rclone-test-sikamoq9xuzo' 2025/08/24 05:54:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/24 05:54:56 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Waiting for checks to finish 2025/08/24 05:54:56 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Waiting for transfers to finish 2025/08/24 05:55:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/24 05:55:02 INFO : sub dir/hello world: Copied (new) 2025/08/24 05:55:04.521877 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/08/24 05:55:04.521918 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/08/24 05:55:07 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Using server-side directory move 2025/08/24 05:55:07 INFO : proton drive root link ID 'rclone-test-sikamoq9xuzo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/24 05:55:09 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/24 05:55:09 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Waiting for checks to finish 2025/08/24 05:55:09 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Waiting for transfers to finish 2025/08/24 05:55:09 INFO : sub dir/hello world: Deleted 2025/08/24 05:55:11.223634 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wgfhGvH4tNNB18p1b2TIsTWVPA64dK61ek88odgipeYmfWiF28Q2Q3ASynWMoqqcinUiaCaY1xsBxiU9PvkvTA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:55:11.223700 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wgfhGvH4tNNB18p1b2TIsTWVPA64dK61ek88odgipeYmfWiF28Q2Q3ASynWMoqqcinUiaCaY1xsBxiU9PvkvTA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:11 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wgfhGvH4tNNB18p1b2TIsTWVPA64dK61ek88odgipeYmfWiF28Q2Q3ASynWMoqqcinUiaCaY1xsBxiU9PvkvTA==/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/wgfhGvH4tNNB18p1b2TIsTWVPA64dK61ek88odgipeYmfWiF28Q2Q3ASynWMoqqcinUiaCaY1xsBxiU9PvkvTA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/24 05:55:11 DEBUG : proton drive root link ID 'rclone-test-sikamoq9xuzo': Purge remote --- FAIL: TestServerSideMoveOverSelf (27.18s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/24 05:55:16 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:16 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:16 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:16 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/24 05:55:16 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:16 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/24 05:55:16 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:17 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/24 05:55:17 INFO : potato: Copied (new) 2025/08/24 05:55:18 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:18 INFO : yam: Copied (new) 2025/08/24 05:55:18 DEBUG : Waiting for deletions to finish 2025/08/24 05:55:19 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 05:55:19 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:19 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:19 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:19 DEBUG : potato: Unchanged skipping 2025/08/24 05:55:19 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:20.678907 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iHBoxkmJ43SLKIJCMp22Gj65ungR2SVUvsWAFL3N8uI4o2gOIG-WliMcJehvJZhXD8EaTvEHAmMkA2l3JAibMg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:55:20.678948 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iHBoxkmJ43SLKIJCMp22Gj65ungR2SVUvsWAFL3N8uI4o2gOIG-WliMcJehvJZhXD8EaTvEHAmMkA2l3JAibMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:20 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iHBoxkmJ43SLKIJCMp22Gj65ungR2SVUvsWAFL3N8uI4o2gOIG-WliMcJehvJZhXD8EaTvEHAmMkA2l3JAibMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:20 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iHBoxkmJ43SLKIJCMp22Gj65ungR2SVUvsWAFL3N8uI4o2gOIG-WliMcJehvJZhXD8EaTvEHAmMkA2l3JAibMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:20 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/24 05:55:20 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:22 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:22 INFO : yaml: Copied (new) 2025/08/24 05:55:22 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': not deleting files as there were IO errors 2025/08/24 05:55:22 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': 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 (10.36s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/24 05:55:26 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:26 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:26 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:26 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/24 05:55:26 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/24 05:55:26 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:26 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:27 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/24 05:55:27 INFO : potato: Copied (new) 2025/08/24 05:55:27 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:27 INFO : yam: Copied (new) 2025/08/24 05:55:27 DEBUG : Waiting for deletions to finish 2025/08/24 05:55:29 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 05:55:29 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:29 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:29 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:29 DEBUG : potato: Unchanged skipping 2025/08/24 05:55:29 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:30.903269 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qCB7zVsByMhisPEq90R1snwtj7RqskYSuEKCTM9r3Cf_PyZp4nwfV1GQK9Ly7ejeb2CJZWFggcfKAURW93DOIg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:55:30.903296 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qCB7zVsByMhisPEq90R1snwtj7RqskYSuEKCTM9r3Cf_PyZp4nwfV1GQK9Ly7ejeb2CJZWFggcfKAURW93DOIg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:30 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qCB7zVsByMhisPEq90R1snwtj7RqskYSuEKCTM9r3Cf_PyZp4nwfV1GQK9Ly7ejeb2CJZWFggcfKAURW93DOIg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:30 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/qCB7zVsByMhisPEq90R1snwtj7RqskYSuEKCTM9r3Cf_PyZp4nwfV1GQK9Ly7ejeb2CJZWFggcfKAURW93DOIg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:30 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/24 05:55:30 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:32 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:32 INFO : yaml: Copied (new) 2025/08/24 05:55:32 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': not deleting files as there were IO errors 2025/08/24 05:55:32 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': 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 (10.17s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/24 05:55:36 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:36 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:36 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:36 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/24 05:55:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/24 05:55:36 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:36 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:38 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/24 05:55:38 INFO : potato: Copied (new) 2025/08/24 05:55:39 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:39 INFO : sub/yam: Copied (new) 2025/08/24 05:55:39 DEBUG : Waiting for deletions to finish 2025/08/24 05:55:41 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 05:55:41 DEBUG : potato: Unchanged skipping 2025/08/24 05:55:42 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Making map for --track-renames 2025/08/24 05:55:42 INFO : proton drive root link ID 'rclone-test-yisavuf2peje': Finished making map for --track-renames 2025/08/24 05:55:42 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:42 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for renames to finish 2025/08/24 05:55:42.891119 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N_a49BC3DHzQDijSY8C7C7AfFcChkVJqJVqH9-kIlRBDqhyRfhUwzngnXt9wKjGugd3gQQeQTTsfVgoTbZhvaQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:55:42.891162 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N_a49BC3DHzQDijSY8C7C7AfFcChkVJqJVqH9-kIlRBDqhyRfhUwzngnXt9wKjGugd3gQQeQTTsfVgoTbZhvaQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:42 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N_a49BC3DHzQDijSY8C7C7AfFcChkVJqJVqH9-kIlRBDqhyRfhUwzngnXt9wKjGugd3gQQeQTTsfVgoTbZhvaQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:42 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/N_a49BC3DHzQDijSY8C7C7AfFcChkVJqJVqH9-kIlRBDqhyRfhUwzngnXt9wKjGugd3gQQeQTTsfVgoTbZhvaQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:55:42 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/24 05:55:42 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/24 05:55:44 INFO : yam: Copied (new) 2025/08/24 05:55:44 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': not deleting files as there were IO errors 2025/08/24 05:55:44 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': 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 (12.66s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:55:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/24 05:55:49 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/24 05:55:49 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for checks to finish 2025/08/24 05:55:49 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': Waiting for transfers to finish 2025/08/24 05:55:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/24 05:55:53 INFO : sub dir/hello world: Copied (new) 2025/08/24 05:55:53 INFO : sub dir/hello world: Deleted 2025/08/24 05:55:53 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/24 05:55:53 INFO : nested/sub dir/file: Copied (new) 2025/08/24 05:55:53 INFO : nested/sub dir/file: Deleted 2025/08/24 05:55:53 ERROR : Local file system at /tmp/rclone968977251: 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 (10.24s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:55:58 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-pemogay8nete" 2025/08/24 05:55:58 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Has cached credentials 2025/08/24 05:56:01 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-yisavuf2peje' -> proton drive root link ID 'rclone-test-pemogay8nete' 2025/08/24 05:56:13 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Using server-side directory move 2025/08/24 05:56:13 INFO : proton drive root link ID 'rclone-test-pemogay8nete': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/24 05:56:14 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/24 05:56:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/24 05:56:14 DEBUG : empty space: Unchanged skipping 2025/08/24 05:56:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/24 05:56:14 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Waiting for checks to finish 2025/08/24 05:56:15 INFO : potato3: Deleted 2025/08/24 05:56:15 INFO : empty space: Deleted 2025/08/24 05:56:15 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Waiting for transfers to finish 2025/08/24 05:56:15.504453 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Z2f5nEj7wqkzRNul8F80oBSN1PnjPn0sh135jj6BSVYTUOP5Zr-846cCFgtnFmFOQbL8vsyHcEL202O554-Kig==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:15.504493 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Z2f5nEj7wqkzRNul8F80oBSN1PnjPn0sh135jj6BSVYTUOP5Zr-846cCFgtnFmFOQbL8vsyHcEL202O554-Kig==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:15 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Z2f5nEj7wqkzRNul8F80oBSN1PnjPn0sh135jj6BSVYTUOP5Zr-846cCFgtnFmFOQbL8vsyHcEL202O554-Kig==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:15.801275 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vu-r9YcoCc4gcIsAL1AHGf9WZQGy_BGZmJDVr3zjOSZ3hU2NLth_UX-zJr3HLNHzIhchiiguI8aZvFP-W4UbKA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:15.801313 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vu-r9YcoCc4gcIsAL1AHGf9WZQGy_BGZmJDVr3zjOSZ3hU2NLth_UX-zJr3HLNHzIhchiiguI8aZvFP-W4UbKA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:15 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vu-r9YcoCc4gcIsAL1AHGf9WZQGy_BGZmJDVr3zjOSZ3hU2NLth_UX-zJr3HLNHzIhchiiguI8aZvFP-W4UbKA==/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/vu-r9YcoCc4gcIsAL1AHGf9WZQGy_BGZmJDVr3zjOSZ3hU2NLth_UX-zJr3HLNHzIhchiiguI8aZvFP-W4UbKA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/24 05:56:15 DEBUG : proton drive root link ID 'rclone-test-pemogay8nete': Purge remote --- FAIL: TestServerSideMove (20.20s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:56:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiwubus9wano" 2025/08/24 05:56:19 DEBUG : proton drive root link ID 'rclone-test-kiwubus9wano': Has cached credentials 2025/08/24 05:56:21 DEBUG : proton drive root link ID 'rclone-test-kiwubus9wano': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-yisavuf2peje' -> proton drive root link ID 'rclone-test-kiwubus9wano' 2025/08/24 05:56:34 DEBUG : empty space: Excluded (Size Filter) 2025/08/24 05:56:34 DEBUG : empty space: Excluded 2025/08/24 05:56:34 DEBUG : empty space: Excluded (Size Filter) 2025/08/24 05:56:34 DEBUG : empty space: Excluded 2025/08/24 05:56:34 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/24 05:56:34 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/24 05:56:34 DEBUG : proton drive root link ID 'rclone-test-kiwubus9wano': Waiting for checks to finish 2025/08/24 05:56:34 DEBUG : proton drive root link ID 'rclone-test-kiwubus9wano': Waiting for transfers to finish 2025/08/24 05:56:34 INFO : potato3: Deleted 2025/08/24 05:56:35.340661 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jDXLgQzj8_b2ilNCqokuTEtcVyCbbrNrXylBl7-k1mJRIpts29NlSgsNj5sD_5XJRpKhln6iCwmztWAEohoUxQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:35.340699 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jDXLgQzj8_b2ilNCqokuTEtcVyCbbrNrXylBl7-k1mJRIpts29NlSgsNj5sD_5XJRpKhln6iCwmztWAEohoUxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:35 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/jDXLgQzj8_b2ilNCqokuTEtcVyCbbrNrXylBl7-k1mJRIpts29NlSgsNj5sD_5XJRpKhln6iCwmztWAEohoUxQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:35.738736 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/h5iF6BWI3io6Aj6Mf3WvJlkn7z2vUSgQJp15h-q33GTljFn2rtgiYdlfEZX2cJOSq1HVgHYDQOSw1Zbh-BBJvg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:35.738770 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/h5iF6BWI3io6Aj6Mf3WvJlkn7z2vUSgQJp15h-q33GTljFn2rtgiYdlfEZX2cJOSq1HVgHYDQOSw1Zbh-BBJvg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:35 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/h5iF6BWI3io6Aj6Mf3WvJlkn7z2vUSgQJp15h-q33GTljFn2rtgiYdlfEZX2cJOSq1HVgHYDQOSw1Zbh-BBJvg==/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/h5iF6BWI3io6Aj6Mf3WvJlkn7z2vUSgQJp15h-q33GTljFn2rtgiYdlfEZX2cJOSq1HVgHYDQOSw1Zbh-BBJvg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/24 05:56:35 DEBUG : proton drive root link ID 'rclone-test-kiwubus9wano': Purge remote --- FAIL: TestServerSideMoveWithFilter (20.73s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:56:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-vovokob8toco" 2025/08/24 05:56:39 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Has cached credentials 2025/08/24 05:56:42 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Used cached credential to initialize the ProtonDrive API 2025/08/24 05:56:47 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-yisavuf2peje' -> proton drive root link ID 'rclone-test-vovokob8toco' 2025/08/24 05:56:55 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Using server-side directory move 2025/08/24 05:56:55 INFO : proton drive root link ID 'rclone-test-vovokob8toco': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/24 05:56:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/24 05:56:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/24 05:56:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/24 05:56:56 DEBUG : empty space: Unchanged skipping 2025/08/24 05:56:56 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Waiting for checks to finish 2025/08/24 05:56:56 INFO : empty space: Deleted 2025/08/24 05:56:56 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Waiting for transfers to finish 2025/08/24 05:56:57 INFO : potato3: Deleted 2025/08/24 05:56:57.435823 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5P4uSh6lZG6GKXqdhdZq81fgLJy-vbzh3ooNQmaRiS4f_-4QtrF_H5rwGtykHhTXFMs_pim5DPp9yiNXPuJ9Og==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:57.435874 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5P4uSh6lZG6GKXqdhdZq81fgLJy-vbzh3ooNQmaRiS4f_-4QtrF_H5rwGtykHhTXFMs_pim5DPp9yiNXPuJ9Og==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5P4uSh6lZG6GKXqdhdZq81fgLJy-vbzh3ooNQmaRiS4f_-4QtrF_H5rwGtykHhTXFMs_pim5DPp9yiNXPuJ9Og==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:57.789772 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eMuw1Vgh33iNWF23DV7bDmuIj4ia0SABbZCIihHUDKqA0IBzIhgqOpd8PvH_BC79q2Ci7UdmFQBNlt8JClMC1Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 05:56:57.789808 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eMuw1Vgh33iNWF23DV7bDmuIj4ia0SABbZCIihHUDKqA0IBzIhgqOpd8PvH_BC79q2Ci7UdmFQBNlt8JClMC1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/eMuw1Vgh33iNWF23DV7bDmuIj4ia0SABbZCIihHUDKqA0IBzIhgqOpd8PvH_BC79q2Ci7UdmFQBNlt8JClMC1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 05:56:57 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/08/24 05:56:57 DEBUG : proton drive root link ID 'rclone-test-vovokob8toco': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.26s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 05:57:09 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 05:57:09 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 05:57:11 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 05:58:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/backup" 2025/08/24 05:58:41 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Has cached credentials 2025/08/24 05:58:43 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:01:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:01:46 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 06:01:46 DEBUG : two: Unchanged skipping 2025/08/24 06:01:46 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for checks to finish 2025/08/24 06:01:49.158270 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4J1nBoUe1AtkscXqZDKbK6r0fdOzqE1jVvIHzPpM7zAo6FQdEx-M2U8WEaqC9ZbMPyyKH1IgZGXg0pCzG2z0Gw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:01:49.158311 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4J1nBoUe1AtkscXqZDKbK6r0fdOzqE1jVvIHzPpM7zAo6FQdEx-M2U8WEaqC9ZbMPyyKH1IgZGXg0pCzG2z0Gw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:01:49 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4J1nBoUe1AtkscXqZDKbK6r0fdOzqE1jVvIHzPpM7zAo6FQdEx-M2U8WEaqC9ZbMPyyKH1IgZGXg0pCzG2z0Gw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:01:49 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for transfers to finish 2025/08/24 06:01:49 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/dst': not deleting files as there were IO errors 2025/08/24 06:01:49 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/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/4J1nBoUe1AtkscXqZDKbK6r0fdOzqE1jVvIHzPpM7zAo6FQdEx-M2U8WEaqC9ZbMPyyKH1IgZGXg0pCzG2z0Gw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (292.63s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 06:02:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 06:02:02 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 06:02:04 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:03:35 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/backup" 2025/08/24 06:03:35 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Has cached credentials 2025/08/24 06:03:38 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:06:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:06:40 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 06:06:40 DEBUG : two: Unchanged skipping 2025/08/24 06:06:40 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for checks to finish 2025/08/24 06:06:42.442938 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6e52CUWo_UGMqbLRCEkuYq3bObQBihxuLWMtmZdijJLPlBRNp4yfYD30ETJqOSJvz8XKSI1BhapuTl3enaDqzA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:06:42.442978 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6e52CUWo_UGMqbLRCEkuYq3bObQBihxuLWMtmZdijJLPlBRNp4yfYD30ETJqOSJvz8XKSI1BhapuTl3enaDqzA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:06:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6e52CUWo_UGMqbLRCEkuYq3bObQBihxuLWMtmZdijJLPlBRNp4yfYD30ETJqOSJvz8XKSI1BhapuTl3enaDqzA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:06:42 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for transfers to finish 2025/08/24 06:06:42 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/dst': not deleting files as there were IO errors 2025/08/24 06:06:42 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/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/6e52CUWo_UGMqbLRCEkuYq3bObQBihxuLWMtmZdijJLPlBRNp4yfYD30ETJqOSJvz8XKSI1BhapuTl3enaDqzA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (293.53s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 06:06:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 06:06:55 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 06:06:57 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:08:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/backup" 2025/08/24 06:08:30 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Has cached credentials 2025/08/24 06:08:32 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/backup': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:11:35 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:11:35 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 06:11:35 DEBUG : two: Unchanged skipping 2025/08/24 06:11:35 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for checks to finish 2025/08/24 06:11:37.808535 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcKrR-89RA_ArNuLdFqpbXAgorjjYD2r3ygkWR099W8CHWlj4pcrNwbAGgD_0cSHzHFBtO9wwN97ZjhpBQlkFg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:11:37.808572 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcKrR-89RA_ArNuLdFqpbXAgorjjYD2r3ygkWR099W8CHWlj4pcrNwbAGgD_0cSHzHFBtO9wwN97ZjhpBQlkFg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:11:37 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcKrR-89RA_ArNuLdFqpbXAgorjjYD2r3ygkWR099W8CHWlj4pcrNwbAGgD_0cSHzHFBtO9wwN97ZjhpBQlkFg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:11:37 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for transfers to finish 2025/08/24 06:11:37 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/dst': not deleting files as there were IO errors 2025/08/24 06:11:37 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/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/XcKrR-89RA_ArNuLdFqpbXAgorjjYD2r3ygkWR099W8CHWlj4pcrNwbAGgD_0cSHzHFBtO9wwN97ZjhpBQlkFg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (295.20s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 06:11:52 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 06:11:52 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 06:11:54 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:13:36 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/24 06:13:36 DEBUG : two: Unchanged skipping 2025/08/24 06:13:36 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:13:36 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for checks to finish 2025/08/24 06:13:37.573389 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hmVzCF5PjgNwz4tumEVabIVDYKnTy8jyHf4fa5Lt-hJZEkYaCKvw-dJAEDwGWz-vfbre3nB8ABN7BgL7Z3Ul-g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:13:37.573427 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hmVzCF5PjgNwz4tumEVabIVDYKnTy8jyHf4fa5Lt-hJZEkYaCKvw-dJAEDwGWz-vfbre3nB8ABN7BgL7Z3Ul-g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:13:37 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/hmVzCF5PjgNwz4tumEVabIVDYKnTy8jyHf4fa5Lt-hJZEkYaCKvw-dJAEDwGWz-vfbre3nB8ABN7BgL7Z3Ul-g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:13:37 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Waiting for transfers to finish 2025/08/24 06:13:37 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/dst': not deleting files as there were IO errors 2025/08/24 06:13:37 ERROR : proton drive root link ID 'rclone-test-yisavuf2peje/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/hmVzCF5PjgNwz4tumEVabIVDYKnTy8jyHf4fa5Lt-hJZEkYaCKvw-dJAEDwGWz-vfbre3nB8ABN7BgL7Z3Ul-g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (118.63s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 06:13:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 06:13:49 DEBUG : Config file has changed externally - reloading 2025/08/24 06:13:49 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 06:13:51 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:15:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:15:31.679321 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YLnDbp3L062Sns_LmjwgI4kx59uHoAcEw6ON9nABmP3wrPE2IBC6HZY8Gi4mt07CHrng13bi1SsmAya4gwQGSQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:15:31.679360 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YLnDbp3L062Sns_LmjwgI4kx59uHoAcEw6ON9nABmP3wrPE2IBC6HZY8Gi4mt07CHrng13bi1SsmAya4gwQGSQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:15:31 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/YLnDbp3L062Sns_LmjwgI4kx59uHoAcEw6ON9nABmP3wrPE2IBC6HZY8Gi4mt07CHrng13bi1SsmAya4gwQGSQ==/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/YLnDbp3L062Sns_LmjwgI4kx59uHoAcEw6ON9nABmP3wrPE2IBC6HZY8Gi4mt07CHrng13bi1SsmAya4gwQGSQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (114.15s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-yisavuf2peje'", Local "Local file system at /tmp/rclone968977251", Modify Window "1s" 2025/08/24 06:15:43 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-yisavuf2peje/dst" 2025/08/24 06:15:43 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Has cached credentials 2025/08/24 06:15:46 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje/dst': Used cached credential to initialize the ProtonDrive API 2025/08/24 06:17:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/24 06:17:24.961209 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iymMJD2tWidCVP7OFR-POa1izt2KO4e5n38inyGVJTpacTH4BpELgkl9dDqFZQfD0rAR_U8d5MIjuodUZqXCXA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/24 06:17:24.961248 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iymMJD2tWidCVP7OFR-POa1izt2KO4e5n38inyGVJTpacTH4BpELgkl9dDqFZQfD0rAR_U8d5MIjuodUZqXCXA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/24 06:17:24 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/iymMJD2tWidCVP7OFR-POa1izt2KO4e5n38inyGVJTpacTH4BpELgkl9dDqFZQfD0rAR_U8d5MIjuodUZqXCXA==/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/iymMJD2tWidCVP7OFR-POa1izt2KO4e5n38inyGVJTpacTH4BpELgkl9dDqFZQfD0rAR_U8d5MIjuodUZqXCXA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (113.85s) FAIL 2025/08/24 06:17:30 DEBUG : proton drive root link ID 'rclone-test-yisavuf2peje': 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 22m45.444394284s (try 3/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]