"./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirFileOpen|TestFileReadAtNonZeroLength|TestReadFileHandleMethods|TestVFSOpenFile)$'" - Starting (try 2/5) 2025/01/26 05:02:45 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-talidoq5zaro" 2025/01/26 05:02:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/26 05:02:46 DEBUG : Creating backend with remote "/tmp/rclone1281235008" === RUN TestDirFileOpen run.go:180: Remote "Linkbox root 'rclone-test-talidoq5zaro'", Local "Local file system at /tmp/rclone1281235008", Modify Window "876000h0m0s" 2025/01/26 05:02:46 INFO : Linkbox root 'rclone-test-talidoq5zaro': poll-interval is not supported by this remote 2025/01/26 05:02:46 NOTICE: Linkbox root 'rclone-test-talidoq5zaro': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/26 05:02:54 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2025/01/26 05:02:54 DEBUG : dir/sub/file0: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2025/01/26 05:02:54 DEBUG : dir/sub/file0: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2025/01/26 05:02:54 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/26 05:02:54 DEBUG : dir/sub/file0: >Open: fd=dir/sub/file0 (w), err= 2025/01/26 05:02:54 DEBUG : dir/sub/file0: >OpenFile: fd=dir/sub/file0 (w), err= 2025/01/26 05:02:54 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/26 05:02:54 DEBUG : dir/sub/file2: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2025/01/26 05:02:54 DEBUG : dir/sub/file2: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2025/01/26 05:02:54 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2025/01/26 05:02:54 DEBUG : dir/sub/file2: >Open: fd=dir/sub/file2 (w), err= 2025/01/26 05:02:54 DEBUG : dir/sub/file2: >OpenFile: fd=dir/sub/file2 (w), err= 2025/01/26 05:02:54 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2025/01/26 05:02:54 DEBUG : Linkbox root 'rclone-test-talidoq5zaro': File to upload is small (12 bytes), uploading instead of streaming 2025/01/26 05:02:55 ERROR : dir/sub/file2: WriteFileHandle.New Rcat failed: update err in uploading file: HTTP error 403 (403 Forbidden) returned body: "SignatureDoesNotMatchThe request signature we calculated does not match the signature you provided. Check your key and signing method.00000194A0FDCF35B1186C1830A2B9D9Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGoFI/1+F2rNmi+CsUs7tXM6mq5js=PUT\n\n\n1737874975\nx-amz-cf-id:hPYYFG-8xp1tiGZ7mJdkSfD2Wl7ubQ_NYh1jAoCZBaOT8-4h4o_64w==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/fc3ff98e8c6a0d3087d515c0473f8677_1250 55 54 0a 0a 0a 31 37 33 37 38 37 34 39 37 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 68 50 59 59 46 47 2d 38 78 70 31 74 69 47 5a 37 6d 4a 64 6b 53 66 44 32 57 6c 37 75 62 51 5f 4e 59 68 31 6a 41 6f 43 5a 42 61 4f 54 38 2d 34 68 34 6f 5f 36 34 77 3d 3d 0a 2f 6f 7a 61 64 6a 39 35 66 76 69 70 74 6e 65 2f 74 6d 70 2f 72 65 63 79 63 6c 65 2f 31 64 2f 75 73 65 72 2f 39 32 32 34 36 30 32 30 37 2f 66 63 33 66 66 39 38 65 38 63 36 61 30 64 33 30 38 37 64 35 31 35 63 30 34 37 33 66 38 36 37 37 5f 31 32" 2025/01/26 05:02:55 DEBUG : dir/sub/file2: Remove: 2025/01/26 05:02:55 DEBUG : dir/sub: Added virtual directory entry vDel: "file2" 2025/01/26 05:02:55 DEBUG : dir/sub/file2: >Remove: err= dir_test.go:636: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:636 Error: Received unexpected error: update err in uploading file: HTTP error 403 (403 Forbidden) returned body: "SignatureDoesNotMatchThe request signature we calculated does not match the signature you provided. Check your key and signing method.00000194A0FDCF35B1186C1830A2B9D9Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGoFI/1+F2rNmi+CsUs7tXM6mq5js=PUT\n\n\n1737874975\nx-amz-cf-id:hPYYFG-8xp1tiGZ7mJdkSfD2Wl7ubQ_NYh1jAoCZBaOT8-4h4o_64w==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/fc3ff98e8c6a0d3087d515c0473f8677_1250 55 54 0a 0a 0a 31 37 33 37 38 37 34 39 37 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 68 50 59 59 46 47 2d 38 78 70 31 74 69 47 5a 37 6d 4a 64 6b 53 66 44 32 57 6c 37 75 62 51 5f 4e 59 68 31 6a 41 6f 43 5a 42 61 4f 54 38 2d 34 68 34 6f 5f 36 34 77 3d 3d 0a 2f 6f 7a 61 64 6a 39 35 66 76 69 70 74 6e 65 2f 74 6d 70 2f 72 65 63 79 63 6c 65 2f 31 64 2f 75 73 65 72 2f 39 32 32 34 36 30 32 30 37 2f 66 63 33 66 66 39 38 65 38 63 36 61 30 64 33 30 38 37 64 35 31 35 63 30 34 37 33 66 38 36 37 37 5f 31 32" Test: TestDirFileOpen 2025/01/26 05:02:55 DEBUG : Linkbox root 'rclone-test-talidoq5zaro': File to upload is small (5 bytes), uploading instead of streaming 2025/01/26 05:02:58 NOTICE: Linkbox root 'rclone-test-talidoq5zaro': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/01/26 05:02:58 DEBUG : dir/sub/file0: Size of src and dst objects identical 2025/01/26 05:02:58 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/26 05:02:58 DEBUG : WaitForWriters: timeout=30s 2025/01/26 05:02:58 DEBUG : dir/sub: Looking for writers 2025/01/26 05:02:58 DEBUG : file0: reading active writers 2025/01/26 05:02:58 DEBUG : dir: Looking for writers 2025/01/26 05:02:58 DEBUG : file1: reading active writers 2025/01/26 05:02:58 DEBUG : sub: reading active writers 2025/01/26 05:02:58 DEBUG : : Looking for writers 2025/01/26 05:02:58 DEBUG : dir: reading active writers 2025/01/26 05:02:58 DEBUG : >WaitForWriters: --- FAIL: TestDirFileOpen (18.42s) === RUN TestReadFileHandleMethods run.go:180: Remote "Linkbox root 'rclone-test-talidoq5zaro'", Local "Local file system at /tmp/rclone1281235008", Modify Window "876000h0m0s" 2025/01/26 05:03:04 INFO : Linkbox root 'rclone-test-talidoq5zaro': poll-interval is not supported by this remote 2025/01/26 05:03:04 NOTICE: Linkbox root 'rclone-test-talidoq5zaro': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/26 05:03:09 DEBUG : dir/file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/26 05:03:09 DEBUG : dir/file1: Open: flags=O_RDONLY 2025/01/26 05:03:09 DEBUG : dir/file1: >Open: fd=dir/file1 (r), err= 2025/01/26 05:03:09 DEBUG : dir/file1: >OpenFile: fd=dir/file1 (r), err= 2025/01/26 05:03:09 DEBUG : dir/file1: ChunkedReader.openRange at 0 length 134217728 2025/01/26 05:03:09 DEBUG : dir/file1: ChunkedReader.Read at 0 length 1 chunkOffset 0 chunkSize 134217728 2025/01/26 05:03:09 DEBUG : dir/file1: ChunkedReader.Read at 1 length 256 chunkOffset 0 chunkSize 134217728 2025/01/26 05:03:09 DEBUG : WaitForWriters: timeout=30s 2025/01/26 05:03:09 DEBUG : dir: Looking for writers 2025/01/26 05:03:09 DEBUG : file1: reading active writers 2025/01/26 05:03:09 DEBUG : : Looking for writers 2025/01/26 05:03:09 DEBUG : dir: reading active writers 2025/01/26 05:03:09 DEBUG : >WaitForWriters: --- PASS: TestReadFileHandleMethods (8.70s) === RUN TestVFSOpenFile run.go:180: Remote "Linkbox root 'rclone-test-talidoq5zaro'", Local "Local file system at /tmp/rclone1281235008", Modify Window "876000h0m0s" 2025/01/26 05:03:13 INFO : Linkbox root 'rclone-test-talidoq5zaro': poll-interval is not supported by this remote 2025/01/26 05:03:13 NOTICE: Linkbox root 'rclone-test-talidoq5zaro': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/26 05:03:19 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/26 05:03:19 DEBUG : file1: Open: flags=O_RDONLY 2025/01/26 05:03:19 DEBUG : file1: >Open: fd=file1 (r), err= 2025/01/26 05:03:19 DEBUG : file1: >OpenFile: fd=file1 (r), err= 2025/01/26 05:03:19 DEBUG : dir: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/26 05:03:19 DEBUG : dir: >OpenFile: fd=dir/ (r), err= 2025/01/26 05:03:19 DEBUG : dir/new_file.txt: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: >OpenFile: fd=, err=file does not exist 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: Open: flags=O_WRONLY|O_CREATE 2025/01/26 05:03:20 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt" 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: >Open: fd=dir/new_file.txt (w), err= 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: >OpenFile: fd=dir/new_file.txt (w), err= 2025/01/26 05:03:20 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt" 2025/01/26 05:03:20 DEBUG : Linkbox root 'rclone-test-talidoq5zaro': File to upload is small (0 bytes), uploading instead of streaming 2025/01/26 05:03:20 ERROR : dir/new_file.txt: WriteFileHandle.New Rcat failed: can't upload empty files to this remote 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: Remove: 2025/01/26 05:03:20 DEBUG : dir: Added virtual directory entry vDel: "new_file.txt" 2025/01/26 05:03:20 DEBUG : dir/new_file.txt: >Remove: err= 2025/01/26 05:03:20 DEBUG : not found/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/26 05:03:20 DEBUG : not found/new_file.txt: >OpenFile: fd=, err=file does not exist 2025/01/26 05:03:20 DEBUG : WaitForWriters: timeout=30s 2025/01/26 05:03:20 DEBUG : dir: Looking for writers 2025/01/26 05:03:20 DEBUG : file2: reading active writers 2025/01/26 05:03:20 DEBUG : : Looking for writers 2025/01/26 05:03:20 DEBUG : dir: reading active writers 2025/01/26 05:03:20 DEBUG : file1: reading active writers 2025/01/26 05:03:20 DEBUG : >WaitForWriters: --- PASS: TestVFSOpenFile (11.22s) === RUN TestFileReadAtNonZeroLength run.go:180: Remote "Linkbox root 'rclone-test-talidoq5zaro'", Local "Local file system at /tmp/rclone1281235008", Modify Window "876000h0m0s" 2025/01/26 05:03:24 INFO : Linkbox root 'rclone-test-talidoq5zaro': poll-interval is not supported by this remote 2025/01/26 05:03:24 NOTICE: Linkbox root 'rclone-test-talidoq5zaro': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/26 05:03:24 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/26 05:03:25 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2025/01/26 05:03:25 DEBUG : : Added virtual directory entry vAddFile: "file1" 2025/01/26 05:03:25 DEBUG : file1: >Open: fd=file1 (w), err= 2025/01/26 05:03:25 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2025/01/26 05:03:25 DEBUG : : Added virtual directory entry vAddFile: "file1" 2025/01/26 05:03:25 DEBUG : Linkbox root 'rclone-test-talidoq5zaro': File to upload is small (100 bytes), uploading instead of streaming 2025/01/26 05:03:26 ERROR : file1: WriteFileHandle.New Rcat failed: update err in uploading file: HTTP error 403 (403 Forbidden) returned body: "SignatureDoesNotMatchThe request signature we calculated does not match the signature you provided. Check your key and signing method.00000194A0FE4538B0DA4A91A8A03D79Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGA+8QCk5Y7ismdtQDMnIRlfu/GK8=PUT\n\n\n1737875005\nx-amz-cf-id:V-8urgStmehtWPCfK4ltBHQ_BQ4SNrq84ODUEHBUWfEJL_hEHDCHHw==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/a1c9f50ab327fbeec55f610e5d7c9ba5_10050 55 54 0a 0a 0a 31 37 33 37 38 37 35 30 30 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 56 2d 38 75 72 67 53 74 6d 65 68 74 57 50 43 66 4b 34 6c 74 42 48 51 5f 42 51 34 53 4e 72 71 38 34 4f 44 55 45 48 42 55 57 66 45 4a 4c 5f 68 45 48 44 43 48 48 77 3d 3d 0a 2f 6f 7a 61 64 6a 39 35 66 76 69 70 74 6e 65 2f 74 6d 70 2f 72 65 63 79 63 6c 65 2f 31 64 2f 75 73 65 72 2f 39 32 32 34 36 30 32 30 37 2f 61 31 63 39 66 35 30 61 62 33 32 37 66 62 65 65 63 35 35 66 36 31 30 65 35 64 37 63 39 62 61 35 5f 31 30 30" 2025/01/26 05:03:26 DEBUG : file1: Remove: 2025/01/26 05:03:26 DEBUG : : Added virtual directory entry vDel: "file1" 2025/01/26 05:03:26 DEBUG : file1: >Remove: err= write_test.go:360: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:360 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:384 Error: Received unexpected error: update err in uploading file: HTTP error 403 (403 Forbidden) returned body: "SignatureDoesNotMatchThe request signature we calculated does not match the signature you provided. Check your key and signing method.00000194A0FE4538B0DA4A91A8A03D79Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGA+8QCk5Y7ismdtQDMnIRlfu/GK8=PUT\n\n\n1737875005\nx-amz-cf-id:V-8urgStmehtWPCfK4ltBHQ_BQ4SNrq84ODUEHBUWfEJL_hEHDCHHw==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/a1c9f50ab327fbeec55f610e5d7c9ba5_10050 55 54 0a 0a 0a 31 37 33 37 38 37 35 30 30 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 56 2d 38 75 72 67 53 74 6d 65 68 74 57 50 43 66 4b 34 6c 74 42 48 51 5f 42 51 34 53 4e 72 71 38 34 4f 44 55 45 48 42 55 57 66 45 4a 4c 5f 68 45 48 44 43 48 48 77 3d 3d 0a 2f 6f 7a 61 64 6a 39 35 66 76 69 70 74 6e 65 2f 74 6d 70 2f 72 65 63 79 63 6c 65 2f 31 64 2f 75 73 65 72 2f 39 32 32 34 36 30 32 30 37 2f 61 31 63 39 66 35 30 61 62 33 32 37 66 62 65 65 63 35 35 66 36 31 30 65 35 64 37 63 39 62 61 35 5f 31 30 30" Test: TestFileReadAtNonZeroLength 2025/01/26 05:03:26 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=---------- 2025/01/26 05:03:26 DEBUG : file1: >OpenFile: fd=, err=file does not exist write_test.go:365: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:365 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:384 Error: Received unexpected error: file does not exist Test: TestFileReadAtNonZeroLength 2025/01/26 05:03:26 DEBUG : WaitForWriters: timeout=30s 2025/01/26 05:03:26 DEBUG : : Looking for writers 2025/01/26 05:03:26 DEBUG : >WaitForWriters: --- FAIL: TestFileReadAtNonZeroLength (1.80s) FAIL 2025/01/26 05:03:26 DEBUG : Linkbox root 'rclone-test-talidoq5zaro': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirFileOpen|TestFileReadAtNonZeroLength|TestReadFileHandleMethods|TestVFSOpenFile)$'" - Finished ERROR in 42.389127609s (try 2/5): exit status 1: Failed [TestDirFileOpen TestFileReadAtNonZeroLength]