"./operations.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list -test.run '^(TestCopyFileBackupDir|TestCopyFileCopyDest|TestDirMove|TestMoveFileBackupDir|TestMultithreadCopy|TestMultithreadCopyAbort|TestTouchDir)$'" - Starting (try 4/5) 2025/11/02 04:32:27 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi" 2025/11/02 04:32:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/02 04:32:28 DEBUG : Creating backend with remote "/tmp/rclone3882448498" === RUN TestMultithreadCopy run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" multithread_test.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/multithread_test.go:137 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/multithread_test.go:148 Error: Received unexpected error: expected a FileSseMode but found: '' (400 bad_request) Test: TestMultithreadCopy --- FAIL: TestMultithreadCopy (1.32s) === RUN TestMultithreadCopyAbort run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" multithread_test.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/multithread_test.go:137 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/multithread_test.go:293 Error: Received unexpected error: expected a FileSseMode but found: '' (400 bad_request) Test: TestMultithreadCopyAbort --- FAIL: TestMultithreadCopyAbort (0.54s) === RUN TestCopyFileBackupDir run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" 2025/11/02 04:32:32 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi/backup" 2025/11/02 04:32:33 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone3882448498) 2025/11/02 04:32:33 DEBUG : dst/file1: size = 18 (B2 bucket rclone-test-melafiy1qavi) 2025/11/02 04:32:33 DEBUG : dst/file1: Sizes differ 2025/11/02 04:32:34 ERROR : dst/file1: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:34 ERROR : dst/file1: Not deleting source as copy failed: expected a FileSseMode but found: '' (400 bad_request) 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: expected a FileSseMode but found: '' (400 bad_request) Test: TestCopyFileBackupDir --- FAIL: TestCopyFileBackupDir (4.68s) === RUN TestCopyFileCopyDest run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" 2025/11/02 04:32:34 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi/dst" 2025/11/02 04:32:36 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi/CopyDest" 2025/11/02 04:32:37 DEBUG : one: Need to transfer - File not found at Destination 2025/11/02 04:32:39 DEBUG : one: size = 3 OK 2025/11/02 04:32:39 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/11/02 04:32:39 INFO : one: Copied (new) 2025/11/02 04:32:40 DEBUG : one: size = 5 (Local file system at /tmp/rclone3882448498) 2025/11/02 04:32:40 DEBUG : one: size = 3 (B2 bucket rclone-test-melafiy1qavi path dst) 2025/11/02 04:32:40 DEBUG : one: Sizes differ 2025/11/02 04:32:40 DEBUG : one: size = 5 OK 2025/11/02 04:32:40 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/11/02 04:32:40 INFO : one: Copied (replaced existing) 2025/11/02 04:32:42 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi/BackupDir" 2025/11/02 04:32:43 DEBUG : one: size = 5 (Local file system at /tmp/rclone3882448498) 2025/11/02 04:32:43 DEBUG : one: size = 3 (B2 bucket rclone-test-melafiy1qavi path dst) 2025/11/02 04:32:43 DEBUG : one: Sizes differ 2025/11/02 04:32:43 DEBUG : one: size = 5 OK 2025/11/02 04:32:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2025/11/02 04:32:43 DEBUG : one: size = 5 (Local file system at /tmp/rclone3882448498) 2025/11/02 04:32:43 DEBUG : one: size = 3 (B2 bucket rclone-test-melafiy1qavi path dst) 2025/11/02 04:32:43 DEBUG : one: Sizes differ 2025/11/02 04:32:44 ERROR : one: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:44 ERROR : one: Not deleting source as copy failed: expected a FileSseMode but found: '' (400 bad_request) copy_test.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:321 Error: Received unexpected error: moving to --backup-dir failed: expected a FileSseMode but found: '' (400 bad_request) Test: TestCopyFileCopyDest --- FAIL: TestCopyFileCopyDest (10.67s) === RUN TestMoveFileBackupDir run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" 2025/11/02 04:32:46 DEBUG : Creating backend with remote "TestB2:rclone-test-melafiy1qavi/backup" 2025/11/02 04:32:47 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone3882448498) 2025/11/02 04:32:47 DEBUG : dst/file1: size = 18 (B2 bucket rclone-test-melafiy1qavi) 2025/11/02 04:32:47 DEBUG : dst/file1: Sizes differ 2025/11/02 04:32:49 ERROR : dst/file1: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:49 ERROR : dst/file1: Not deleting source as copy failed: expected a FileSseMode but found: '' (400 bad_request) 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: expected a FileSseMode but found: '' (400 bad_request) Test: TestMoveFileBackupDir --- FAIL: TestMoveFileBackupDir (4.00s) === RUN TestDirMove run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" 2025/11/02 04:32:51 INFO : A1/B2: Making directory 2025/11/02 04:32:51 INFO : A1/B1/C3: Making directory fstest.go:250: Filtering empty directory "A1/B2" fstest.go:250: Filtering empty directory "A1/B1/C3" 2025/11/02 04:32:52 ERROR : A1/B1/C2/five: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/B1/C2/five: Not deleting source as copy failed: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/B1/C1/four: Failed to copy: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/B1/C1/four: Not deleting source as copy failed: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/two: Failed to copy: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/two: Not deleting source as copy failed: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/one: Failed to copy: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/one: Not deleting source as copy failed: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/B1/three: Failed to copy: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:52 ERROR : A1/B1/three: Not deleting source as copy failed: Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": expected a FileSseMode but found: '' (400 bad_request) operations_test.go:1388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1388 Error: Received unexpected error: RenameDir renames: expected a FileSseMode but found: '' (400 bad_request) Test: TestDirMove --- FAIL: TestDirMove (4.58s) === RUN TestTouchDir run.go:185: Remote "B2 bucket rclone-test-melafiy1qavi", Local "Local file system at /tmp/rclone3882448498", Modify Window "1ms" 2025/11/02 04:32:55 DEBUG : B2 bucket rclone-test-melafiy1qavi: Touching "sub dir/potato3" 2025/11/02 04:32:55 DEBUG : B2 bucket rclone-test-melafiy1qavi: Touching "empty space" 2025/11/02 04:32:55 DEBUG : B2 bucket rclone-test-melafiy1qavi: Touching "potato2" 2025/11/02 04:32:56 ERROR : sub dir/potato3: failed to touch: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:56 ERROR : potato2: failed to touch: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:32:56 ERROR : empty space: failed to touch: expected a FileSseMode but found: '' (400 bad_request) operations_test.go:1687: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1687 Error: Should be true Test: TestTouchDir --- FAIL: TestTouchDir (2.83s) FAIL 2025/11/02 04:32:56 DEBUG : B2 bucket rclone-test-melafiy1qavi: Purge remote 2025/11/02 04:32:56 INFO : B2 bucket rclone-test-melafiy1qavi: cleaning bucket "rclone-test-melafiy1qavi" of all files 2025/11/02 04:32:57 DEBUG : A1/B1/C1/four: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f400b1d5622df4cd5_d20251102_m043253_c001_v7007000_t0000_u01762057973146") 2025/11/02 04:32:57 DEBUG : A1/B1/C1/four: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11239_d20251102_m043250_c001_v0001102_t0029_u01762057970987") 2025/11/02 04:32:57 DEBUG : A1/B1/C2/five: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f400b1d5622df4cd6_d20251102_m043253_c001_v7007000_t0000_u01762057973327") 2025/11/02 04:32:57 DEBUG : A1/B1/C2/five: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb1123d_d20251102_m043251_c001_v0001102_t0045_u01762057971389") 2025/11/02 04:32:57 DEBUG : A1/B1/three: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f400b1d5622df4cdb_d20251102_m043253_c001_v7007000_t0000_u01762057973511") 2025/11/02 04:32:57 DEBUG : A1/B1/three: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11237_d20251102_m043250_c001_v0001102_t0023_u01762057970583") 2025/11/02 04:32:57 DEBUG : A1/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f400b1d5622df4cde_d20251102_m043253_c001_v7007000_t0000_u01762057973692") 2025/11/02 04:32:57 DEBUG : A1/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11233_d20251102_m043249_c001_v0001102_t0027_u01762057969649") 2025/11/02 04:32:57 DEBUG : A1/two: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f400b1d5622df4ce0_d20251102_m043253_c001_v7007000_t0000_u01762057973874") 2025/11/02 04:32:57 DEBUG : A1/two: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11235_d20251102_m043250_c001_v0001102_t0022_u01762057970141") 2025/11/02 04:32:57 DEBUG : CopyDest/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f40777ab5f47bf27b_d20251102_m043245_c001_v7007000_t0000_u01762057965102") 2025/11/02 04:32:57 DEBUG : CopyDest/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11219_d20251102_m043241_c001_v0001102_t0056_u01762057961795") 2025/11/02 04:32:57 DEBUG : dst/file1: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f40777ab5f47bf27d_d20251102_m043249_c001_v7007000_t0000_u01762057969285") 2025/11/02 04:32:57 DEBUG : dst/file1: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11227_d20251102_m043245_c001_v0001102_t0019_u01762057965657") 2025/11/02 04:32:57 DEBUG : dst/file1: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f40777ab5f47bf257_d20251102_m043234_c001_v7007000_t0000_u01762057954612") 2025/11/02 04:32:57 DEBUG : dst/file1: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11208_d20251102_m043230_c001_v0001102_t0014_u01762057950859") 2025/11/02 04:32:57 DEBUG : dst/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f40777ab5f47bf27c_d20251102_m043245_c001_v7007000_t0000_u01762057965286") 2025/11/02 04:32:57 DEBUG : dst/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11217_d20251102_m043241_c001_v0001102_t0048_u01762057961491") 2025/11/02 04:32:57 DEBUG : dst/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f1006456a7ca607a9_d20251102_m043240_c001_v0001144_t0058_u01762057960360") 2025/11/02 04:32:57 DEBUG : dst/one: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f1006456a7ca607a5_d20251102_m043238_c001_v0001144_t0055_u01762057958916") 2025/11/02 04:32:57 DEBUG : empty space: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f403b71a19182ddea_d20251102_m043256_c001_v7007000_t0000_u01762057976328") 2025/11/02 04:32:57 DEBUG : empty space: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb1124b_d20251102_m043254_c001_v0001102_t0051_u01762057974676") 2025/11/02 04:32:57 DEBUG : potato2: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f403b71a19182ddeb_d20251102_m043256_c001_v7007000_t0000_u01762057976511") 2025/11/02 04:32:57 DEBUG : potato2: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb11249_d20251102_m043254_c001_v0001102_t0016_u01762057974235") 2025/11/02 04:32:57 DEBUG : sub dir/potato3: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f403b71a19182dded_d20251102_m043256_c001_v7007000_t0000_u01762057976694") 2025/11/02 04:32:58 DEBUG : sub dir/potato3: Deleting (id "4_zaf128de3d06d4b2b9fa80e1b_f109a39cc5eb1124d_d20251102_m043254_c001_v0001102_t0004_u01762057974976") "./operations.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list -test.run '^(TestCopyFileBackupDir|TestCopyFileCopyDest|TestDirMove|TestMoveFileBackupDir|TestMultithreadCopy|TestMultithreadCopyAbort|TestTouchDir)$'" - Finished ERROR in 31.204868433s (try 4/5): exit status 1: Failed [TestMultithreadCopy TestMultithreadCopyAbort TestCopyFileBackupDir TestCopyFileCopyDest TestMoveFileBackupDir TestDirMove TestTouchDir]