"./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 5/5) 2025/11/02 04:33:04 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke" 2025/11/02 04:33:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/02 04:33:05 DEBUG : Creating backend with remote "/tmp/rclone2825698580" === RUN TestMultithreadCopy run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", 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.35s) === RUN TestMultithreadCopyAbort run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", 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-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", Modify Window "1ms" 2025/11/02 04:33:08 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke/backup" 2025/11/02 04:33:10 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone2825698580) 2025/11/02 04:33:10 DEBUG : dst/file1: size = 18 (B2 bucket rclone-test-xehutax2muke) 2025/11/02 04:33:10 DEBUG : dst/file1: Sizes differ 2025/11/02 04:33:11 ERROR : dst/file1: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:11 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.24s) === RUN TestCopyFileCopyDest run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", Modify Window "1ms" 2025/11/02 04:33:11 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke/dst" 2025/11/02 04:33:12 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke/CopyDest" 2025/11/02 04:33:14 DEBUG : one: Need to transfer - File not found at Destination 2025/11/02 04:33:15 DEBUG : one: size = 3 OK 2025/11/02 04:33:15 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/11/02 04:33:15 INFO : one: Copied (new) 2025/11/02 04:33:16 DEBUG : one: size = 5 (Local file system at /tmp/rclone2825698580) 2025/11/02 04:33:16 DEBUG : one: size = 3 (B2 bucket rclone-test-xehutax2muke path dst) 2025/11/02 04:33:16 DEBUG : one: Sizes differ 2025/11/02 04:33:16 DEBUG : one: size = 5 OK 2025/11/02 04:33:16 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/11/02 04:33:16 INFO : one: Copied (replaced existing) 2025/11/02 04:33:18 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke/BackupDir" 2025/11/02 04:33:19 DEBUG : one: size = 5 (Local file system at /tmp/rclone2825698580) 2025/11/02 04:33:19 DEBUG : one: size = 3 (B2 bucket rclone-test-xehutax2muke path dst) 2025/11/02 04:33:19 DEBUG : one: Sizes differ 2025/11/02 04:33:19 DEBUG : one: size = 5 OK 2025/11/02 04:33:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2025/11/02 04:33:19 DEBUG : one: size = 5 (Local file system at /tmp/rclone2825698580) 2025/11/02 04:33:19 DEBUG : one: size = 3 (B2 bucket rclone-test-xehutax2muke path dst) 2025/11/02 04:33:19 DEBUG : one: Sizes differ 2025/11/02 04:33:20 ERROR : one: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:20 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 (9.77s) === RUN TestMoveFileBackupDir run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", Modify Window "1ms" 2025/11/02 04:33:22 DEBUG : Creating backend with remote "TestB2:rclone-test-xehutax2muke/backup" 2025/11/02 04:33:23 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone2825698580) 2025/11/02 04:33:23 DEBUG : dst/file1: size = 18 (B2 bucket rclone-test-xehutax2muke) 2025/11/02 04:33:23 DEBUG : dst/file1: Sizes differ 2025/11/02 04:33:24 ERROR : dst/file1: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:24 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 (3.68s) === RUN TestDirMove run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", Modify Window "1ms" 2025/11/02 04:33:26 INFO : A1/B2: Making directory 2025/11/02 04:33:26 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:33:27 ERROR : A1/B1/C1/four: Failed to copy: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:27 ERROR : A1/B1/C1/four: Not deleting source as copy failed: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:27 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:33:27 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:33:27 ERROR : A1/B1/C2/five: 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:33:27 ERROR : A1/B1/C2/five: 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:33:27 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:33:27 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) 2025/11/02 04:33:27 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:33:27 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) 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 (3.45s) === RUN TestTouchDir run.go:185: Remote "B2 bucket rclone-test-xehutax2muke", Local "Local file system at /tmp/rclone2825698580", Modify Window "1ms" 2025/11/02 04:33:29 DEBUG : B2 bucket rclone-test-xehutax2muke: Touching "sub dir/potato3" 2025/11/02 04:33:29 DEBUG : B2 bucket rclone-test-xehutax2muke: Touching "empty space" 2025/11/02 04:33:29 DEBUG : B2 bucket rclone-test-xehutax2muke: Touching "potato2" 2025/11/02 04:33:29 ERROR : sub dir/potato3: failed to touch: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:30 ERROR : empty space: failed to touch: expected a FileSseMode but found: '' (400 bad_request) 2025/11/02 04:33:30 ERROR : potato2: 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.62s) FAIL 2025/11/02 04:33:31 DEBUG : B2 bucket rclone-test-xehutax2muke: Purge remote 2025/11/02 04:33:31 INFO : B2 bucket rclone-test-xehutax2muke: cleaning bucket "rclone-test-xehutax2muke" of all files 2025/11/02 04:33:31 DEBUG : A1/B1/C1/four: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b7164b_d20251102_m043327_c001_v7007000_t0000_u01762058007609") 2025/11/02 04:33:31 DEBUG : A1/B1/C1/four: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78f9_d20251102_m043326_c001_v0001177_t0018_u01762058006211") 2025/11/02 04:33:31 DEBUG : A1/B1/C2/five: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b7164e_d20251102_m043327_c001_v7007000_t0000_u01762058007790") 2025/11/02 04:33:31 DEBUG : A1/B1/C2/five: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78fb_d20251102_m043326_c001_v0001177_t0020_u01762058006417") 2025/11/02 04:33:31 DEBUG : A1/B1/three: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71652_d20251102_m043327_c001_v7007000_t0000_u01762058007973") 2025/11/02 04:33:31 DEBUG : A1/B1/three: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78f7_d20251102_m043325_c001_v0001177_t0027_u01762058005720") 2025/11/02 04:33:31 DEBUG : A1/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71655_d20251102_m043328_c001_v7007000_t0000_u01762058008154") 2025/11/02 04:33:31 DEBUG : A1/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78f3_d20251102_m043325_c001_v0001177_t0001_u01762058005249") 2025/11/02 04:33:31 DEBUG : A1/two: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71659_d20251102_m043328_c001_v7007000_t0000_u01762058008335") 2025/11/02 04:33:31 DEBUG : A1/two: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78f5_d20251102_m043325_c001_v0001177_t0053_u01762058005460") 2025/11/02 04:33:31 DEBUG : CopyDest/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b715f9_d20251102_m043321_c001_v7007000_t0000_u01762058001025") 2025/11/02 04:33:31 DEBUG : CopyDest/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78df_d20251102_m043317_c001_v0001177_t0022_u01762057997785") 2025/11/02 04:33:31 DEBUG : dst/file1: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71626_d20251102_m043324_c001_v7007000_t0000_u01762058004887") 2025/11/02 04:33:31 DEBUG : dst/file1: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78e7_d20251102_m043321_c001_v0001177_t0037_u01762058001573") 2025/11/02 04:33:31 DEBUG : dst/file1: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b715c5_d20251102_m043311_c001_v7007000_t0000_u01762057991432") 2025/11/02 04:33:32 DEBUG : dst/file1: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78c3_d20251102_m043308_c001_v0001177_t0011_u01762057988102") 2025/11/02 04:33:32 DEBUG : dst/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b715fc_d20251102_m043321_c001_v7007000_t0000_u01762058001207") 2025/11/02 04:33:32 DEBUG : dst/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d78dd_d20251102_m043317_c001_v0001177_t0055_u01762057997546") 2025/11/02 04:33:32 DEBUG : dst/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f11578e474b4ed3b0_d20251102_m043316_c001_v0001153_t0012_u01762057996688") 2025/11/02 04:33:32 DEBUG : dst/one: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f11578e474b4ed3a8_d20251102_m043315_c001_v0001153_t0023_u01762057995646") 2025/11/02 04:33:32 DEBUG : empty space: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b7167f_d20251102_m043330_c001_v7007000_t0000_u01762058010583") 2025/11/02 04:33:32 DEBUG : empty space: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d7902_d20251102_m043328_c001_v0001177_t0044_u01762058008912") 2025/11/02 04:33:32 DEBUG : potato2: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71682_d20251102_m043330_c001_v7007000_t0000_u01762058010768") 2025/11/02 04:33:32 DEBUG : potato2: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d7900_d20251102_m043328_c001_v0001177_t0039_u01762058008696") 2025/11/02 04:33:32 DEBUG : sub dir/potato3: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f41673bf139b71685_d20251102_m043330_c001_v7007000_t0000_u01762058010948") 2025/11/02 04:33:32 DEBUG : sub dir/potato3: Deleting (id "4_z0f422d03d07d4b2b9fa80e1b_f115bda1bbe6d7904_d20251102_m043329_c001_v0001177_t0046_u01762058009118") "./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 28.265716685s (try 5/5): exit status 1: Failed [TestMultithreadCopy TestMultithreadCopyAbort TestCopyFileBackupDir TestCopyFileCopyDest TestMoveFileBackupDir TestDirMove TestTouchDir]