"./operations.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestCopyFileBackupDir|TestDirMove|TestMoveFileBackupDir|TestRemoveExisting)$'" - Starting (try 4/5) 2025/09/19 02:43:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qozazuf9yuku" 2025/09/19 02:43:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/19 02:43:15 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku': Has cached credentials 2025/09/19 02:43:17 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:43:18 DEBUG : Creating backend with remote "/tmp/rclone2392892811" === RUN TestCopyFileBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-qozazuf9yuku'", Local "Local file system at /tmp/rclone2392892811", Modify Window "1s" 2025/09/19 02:43:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qozazuf9yuku/backup" 2025/09/19 02:43:24 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku/backup': Has cached credentials 2025/09/19 02:43:27 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:45:21.897979 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=57&PageSize=150&ShowAll=1": read tcp 65.108.87.141:33564->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 02:46:51 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/09/19 02:46:52.710020 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7E_7KbTQk7loZmACFAgawXFWYD2SAmax94cpUpTWCAh7mbiupQEijx5OhlKPRIDpHZZeLOtFBDrCB34rcOgjzA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:46:52.710057 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7E_7KbTQk7loZmACFAgawXFWYD2SAmax94cpUpTWCAh7mbiupQEijx5OhlKPRIDpHZZeLOtFBDrCB34rcOgjzA==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 02:46:52 ERROR : dst/file1: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7E_7KbTQk7loZmACFAgawXFWYD2SAmax94cpUpTWCAh7mbiupQEijx5OhlKPRIDpHZZeLOtFBDrCB34rcOgjzA==/move: This value should not be blank. (Code=2000, Status=400) copy_test.go:186: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:186 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7E_7KbTQk7loZmACFAgawXFWYD2SAmax94cpUpTWCAh7mbiupQEijx5OhlKPRIDpHZZeLOtFBDrCB34rcOgjzA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestCopyFileBackupDir --- FAIL: TestCopyFileBackupDir (216.32s) === RUN TestMoveFileBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-qozazuf9yuku'", Local "Local file system at /tmp/rclone2392892811", Modify Window "1s" 2025/09/19 02:46:57 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-qozazuf9yuku/backup" 2025/09/19 02:46:57 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku/backup': Has cached credentials 2025/09/19 02:46:58 DEBUG : proton drive root link ID 'rclone-test-qozazuf9yuku/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:47:52.806211 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=28&PageSize=150&ShowAll=1": read tcp 65.108.87.141:42894->185.70.42.37:443: read: connection reset by peer, Attempt 1 2025/09/19 02:48:22.907989 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=28&PageSize=150&ShowAll=1": dial tcp 185.70.42.37:443: i/o timeout, Attempt 2 2025/09/19 02:48:53.037300 WARN RESTY Get "https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/folders/67GMGeDNFTj5DKqz5IX5-c-3o1CsW7SWmTd0TzGbQ5vRf4DA359WYkF2VvYdp-J9R586dYjCpQda1RURAGgtJw==/children?Page=28&PageSize=150&ShowAll=1": dial tcp 185.70.42.37:443: i/o timeout, Attempt 3 2025/09/19 02:51:49 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/09/19 02:51:53.081435 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UDNL81exUY1OyRpSqmB3umYOezWZuB-wkUzoQcP7zk4d94VO_ZZGibHzuc5nBjA9M4L1kdcRpK-dEEm1VXubWQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:51:53.081457 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UDNL81exUY1OyRpSqmB3umYOezWZuB-wkUzoQcP7zk4d94VO_ZZGibHzuc5nBjA9M4L1kdcRpK-dEEm1VXubWQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 02:51:53 ERROR : dst/file1: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UDNL81exUY1OyRpSqmB3umYOezWZuB-wkUzoQcP7zk4d94VO_ZZGibHzuc5nBjA9M4L1kdcRpK-dEEm1VXubWQ==/move: This value should not be blank. (Code=2000, Status=400) operations_test.go:1052: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1052 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UDNL81exUY1OyRpSqmB3umYOezWZuB-wkUzoQcP7zk4d94VO_ZZGibHzuc5nBjA9M4L1kdcRpK-dEEm1VXubWQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestMoveFileBackupDir --- FAIL: TestMoveFileBackupDir (303.56s) === RUN TestDirMove run.go:180: Remote "proton drive root link ID 'rclone-test-qozazuf9yuku'", Local "Local file system at /tmp/rclone2392892811", Modify Window "1s" 2025/09/19 02:52:13 INFO : A1/B2: Making directory 2025/09/19 02:52:13 INFO : A1/B1/C3: Making directory 2025/09/19 02:52:18.057988 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Lo0TXrk0jtJcXwA5uaIL52wM5syscIeLqdHuid-rU4bfxn4AOCjvb9tpaFW-4HnCyZB7g-ZHwk92l91okgDvEg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:52:18.058168 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Lo0TXrk0jtJcXwA5uaIL52wM5syscIeLqdHuid-rU4bfxn4AOCjvb9tpaFW-4HnCyZB7g-ZHwk92l91okgDvEg==/move: This value should not be blank. (Code=2000, Status=400) operations_test.go:1388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1388 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Lo0TXrk0jtJcXwA5uaIL52wM5syscIeLqdHuid-rU4bfxn4AOCjvb9tpaFW-4HnCyZB7g-ZHwk92l91okgDvEg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestDirMove --- FAIL: TestDirMove (31.39s) === RUN TestRemoveExisting run.go:180: Remote "proton drive root link ID 'rclone-test-qozazuf9yuku'", Local "Local file system at /tmp/rclone2392892811", Modify Window "1s" 2025/09/19 02:52:40 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.kayajiv9" before starting 2025/09/19 02:52:40.667461 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WjDr8ScAjU1O0Bt-JR07x7KjijZ5BBigW5jKC67TeQi-GjM2CtNxl9vE87dm1ffznQdOUJIqF4SEJGqg814rRg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:52:40.667621 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WjDr8ScAjU1O0Bt-JR07x7KjijZ5BBigW5jKC67TeQi-GjM2CtNxl9vE87dm1ffznQdOUJIqF4SEJGqg814rRg==/move: This value should not be blank. (Code=2000, Status=400) operations_test.go:1919: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1919 Error: Not equal: expected: *fmt.wrapError(&fmt.wrapError{msg:"TEST: failed to rename existing file: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/WjDr8ScAjU1O0Bt-JR07x7KjijZ5BBigW5jKC67TeQi-GjM2CtNxl9vE87dm1ffznQdOUJIqF4SEJGqg814rRg==/move: This value should not be blank. (Code=2000, Status=400)", err:(*fmt.wrapError)(0xc0098f8520)}) actual : () Test: TestRemoveExisting operations_test.go:1927: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1927 Error: " 11 sub dir/test remove existing\n 21 sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789\n" should not contain " 11 sub dir/test remove existing\n" Test: TestRemoveExisting operations_test.go:1928: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1928 Error: " 11 sub dir/test remove existing\n 21 sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789\n" does not contain " 11 sub dir/test remove existing." Test: TestRemoveExisting --- FAIL: TestRemoveExisting (16.25s) panic: runtime error: invalid memory address or nil pointer dereference [recovered] panic: runtime error: invalid memory address or nil pointer dereference [signal SIGSEGV: segmentation violation code=0x1 addr=0x0 pc=0x1f6efed] goroutine 1444 [running]: testing.tRunner.func1.2({0x22cb320, 0x3f73700}) /usr/local/go/src/testing/testing.go:1734 +0x21c testing.tRunner.func1() /usr/local/go/src/testing/testing.go:1737 +0x35e panic({0x22cb320?, 0x3f73700?}) /usr/local/go/src/runtime/panic.go:792 +0x132 github.com/rclone/rclone/fs/operations_test.TestRemoveExisting(0xc00054bdc0) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1931 +0x88d testing.tRunner(0xc00054bdc0, 0x28b5578) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 "./operations.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestCopyFileBackupDir|TestDirMove|TestMoveFileBackupDir|TestRemoveExisting)$'" - Finished ERROR in 9m30.256062612s (try 4/5): exit status 2: Failed [TestCopyFileBackupDir TestMoveFileBackupDir TestDirMove TestRemoveExisting]