"./operations.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestCheck|TestCheckDownload|TestCheckSizeOnly|TestCopyFileBackupDir|TestDeduplicateNewestByHash|TestDirMove|TestMoveFileBackupDir|TestRemoveExisting)$'" - Starting (try 2/5) 2025/09/19 02:24:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gidilic1wica" 2025/09/19 02:24:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/19 02:24:18 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica': Has cached credentials 2025/09/19 02:24:20 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:24:21 DEBUG : Creating backend with remote "/tmp/rclone2215563648" === RUN TestCheck run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" === RUN TestCheck/1 === RUN TestCheck/2 === RUN TestCheck/3 === RUN TestCheck/4 === RUN TestCheck/5 === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (25.54s) --- PASS: TestCheck/1 (0.75s) --- PASS: TestCheck/2 (0.75s) --- PASS: TestCheck/3 (0.89s) --- PASS: TestCheck/4 (1.20s) --- PASS: TestCheck/5 (1.19s) --- PASS: TestCheck/6 (1.69s) --- PASS: TestCheck/7 (1.49s) === RUN TestCheckDownload run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 === RUN TestCheckDownload/3 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (32.97s) --- PASS: TestCheckDownload/1 (2.18s) --- PASS: TestCheckDownload/2 (1.85s) --- PASS: TestCheckDownload/3 (2.07s) --- PASS: TestCheckDownload/4 (2.71s) --- PASS: TestCheckDownload/5 (2.45s) --- PASS: TestCheckDownload/6 (2.72s) --- PASS: TestCheckDownload/7 (2.72s) === RUN TestCheckSizeOnly run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 === RUN TestCheckSizeOnly/3 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (23.66s) --- PASS: TestCheckSizeOnly/1 (0.66s) --- PASS: TestCheckSizeOnly/2 (0.65s) --- PASS: TestCheckSizeOnly/3 (0.94s) --- PASS: TestCheckSizeOnly/4 (1.33s) --- PASS: TestCheckSizeOnly/5 (1.20s) --- PASS: TestCheckSizeOnly/6 (1.41s) --- PASS: TestCheckSizeOnly/7 (1.45s) === RUN TestCopyFileBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" 2025/09/19 02:25:48 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gidilic1wica/backup" 2025/09/19 02:25:48 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica/backup': Has cached credentials 2025/09/19 02:25:50 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:29:02 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/09/19 02:29:05.263198 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Nbrwmij9KtUjgvsuI7V4XpYem_qoB-9K2aTLH-c6SsiILUg3L2XNdfpIx4VWk012yS2A-2YY431POoNJkSPc5w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:29:05.263229 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Nbrwmij9KtUjgvsuI7V4XpYem_qoB-9K2aTLH-c6SsiILUg3L2XNdfpIx4VWk012yS2A-2YY431POoNJkSPc5w==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 02:29:05 ERROR : dst/file1: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Nbrwmij9KtUjgvsuI7V4XpYem_qoB-9K2aTLH-c6SsiILUg3L2XNdfpIx4VWk012yS2A-2YY431POoNJkSPc5w==/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/Nbrwmij9KtUjgvsuI7V4XpYem_qoB-9K2aTLH-c6SsiILUg3L2XNdfpIx4VWk012yS2A-2YY431POoNJkSPc5w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestCopyFileBackupDir --- FAIL: TestCopyFileBackupDir (206.44s) === RUN TestDeduplicateNewestByHash run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" 2025/09/19 02:29:20 INFO : proton drive root link ID 'rclone-test-gidilic1wica': Looking for duplicate sha1 hashes using newest mode. 2025/09/19 02:29:22 NOTICE: f5d503dd495e2f5e734f9732071787ef65ac2b9d: Found 3 files with duplicate sha1 hashes 2025/09/19 02:29:23 INFO : one: Deleted 2025/09/19 02:29:23 INFO : also/one: Deleted 2025/09/19 02:29:23 NOTICE: f5d503dd495e2f5e734f9732071787ef65ac2b9d: Deleted 2 extra copies --- PASS: TestDeduplicateNewestByHash (18.85s) === RUN TestMoveFileBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" 2025/09/19 02:29:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gidilic1wica/backup" 2025/09/19 02:29:33 DEBUG : Config file has changed externally - reloading 2025/09/19 02:29:33 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica/backup': Has cached credentials 2025/09/19 02:29:35 DEBUG : proton drive root link ID 'rclone-test-gidilic1wica/backup': Used cached credential to initialize the ProtonDrive API 2025/09/19 02:32:53 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/09/19 02:32:57.019487 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/igMilQBXX9VBMNRa_HTxdxykGFVJKj_u8DReFLWpEcRD58Yc13sblM9_tV1MBY4FsiInrM14bKQyHoVI_VbBCw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:32:57.019659 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/igMilQBXX9VBMNRa_HTxdxykGFVJKj_u8DReFLWpEcRD58Yc13sblM9_tV1MBY4FsiInrM14bKQyHoVI_VbBCw==/move: This value should not be blank. (Code=2000, Status=400) 2025/09/19 02:32:57 ERROR : dst/file1: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/igMilQBXX9VBMNRa_HTxdxykGFVJKj_u8DReFLWpEcRD58Yc13sblM9_tV1MBY4FsiInrM14bKQyHoVI_VbBCw==/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/igMilQBXX9VBMNRa_HTxdxykGFVJKj_u8DReFLWpEcRD58Yc13sblM9_tV1MBY4FsiInrM14bKQyHoVI_VbBCw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestMoveFileBackupDir --- FAIL: TestMoveFileBackupDir (212.94s) === RUN TestDirMove run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" 2025/09/19 02:33:16 INFO : A1/B2: Making directory 2025/09/19 02:33:16 INFO : A1/B1/C3: Making directory 2025/09/19 02:33:21.476845 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pTHqL5R3VXART3qtRo0kXeG9-OQKSxNcio2f483H2KM01Cfd_0L_ATY8y4kDKoQEIUwC5n7UmW5sZosIbzJnfg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:33:21.476960 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/pTHqL5R3VXART3qtRo0kXeG9-OQKSxNcio2f483H2KM01Cfd_0L_ATY8y4kDKoQEIUwC5n7UmW5sZosIbzJnfg==/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/pTHqL5R3VXART3qtRo0kXeG9-OQKSxNcio2f483H2KM01Cfd_0L_ATY8y4kDKoQEIUwC5n7UmW5sZosIbzJnfg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestDirMove --- FAIL: TestDirMove (30.83s) === RUN TestRemoveExisting run.go:180: Remote "proton drive root link ID 'rclone-test-gidilic1wica'", Local "Local file system at /tmp/rclone2215563648", Modify Window "1s" 2025/09/19 02:33:42 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.givucub7" before starting 2025/09/19 02:33:43.703113 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/S1lK0MilogImZYDy_WzXvxZ4Kx6P6vQ0T05ynwR7FCoI0sWvprxHZshFZdQQXIxIGFn6038RSK74ptJo_zmozg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/09/19 02:33:43.703149 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/S1lK0MilogImZYDy_WzXvxZ4Kx6P6vQ0T05ynwR7FCoI0sWvprxHZshFZdQQXIxIGFn6038RSK74ptJo_zmozg==/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/S1lK0MilogImZYDy_WzXvxZ4Kx6P6vQ0T05ynwR7FCoI0sWvprxHZshFZdQQXIxIGFn6038RSK74ptJo_zmozg==/move: This value should not be blank. (Code=2000, Status=400)", err:(*fmt.wrapError)(0xc0002d90a0)}) 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.48s) 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 2889 [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(0xc0003eaa80) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1931 +0x88d testing.tRunner(0xc0003eaa80, 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 '^(TestCheck|TestCheckDownload|TestCheckSizeOnly|TestCopyFileBackupDir|TestDeduplicateNewestByHash|TestDirMove|TestMoveFileBackupDir|TestRemoveExisting)$'" - Finished ERROR in 9m31.012624295s (try 2/5): exit status 2: Failed [TestCopyFileBackupDir TestMoveFileBackupDir TestDirMove TestRemoveExisting]