"./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirFileOpen|TestFileReadAtNonZeroLength|TestVFSMkdir|TestVFSOpenFile|TestVFSRename)$'" - Starting (try 2/5) 2025/01/16 01:48:47 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-xosiluf5yuqe" 2025/01/16 01:48:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/16 01:48:48 DEBUG : Creating backend with remote "/tmp/rclone1287821014" === RUN TestDirFileOpen run.go:180: Remote "Linkbox root 'rclone-test-xosiluf5yuqe'", Local "Local file system at /tmp/rclone1287821014", Modify Window "876000h0m0s" 2025/01/16 01:48:48 INFO : Linkbox root 'rclone-test-xosiluf5yuqe': poll-interval is not supported by this remote 2025/01/16 01:48:48 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/16 01:48:55 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2025/01/16 01:48:55 DEBUG : dir/sub/file0: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2025/01/16 01:48:55 DEBUG : dir/sub/file0: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2025/01/16 01:48:55 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/16 01:48:55 DEBUG : dir/sub/file0: >Open: fd=dir/sub/file0 (w), err= 2025/01/16 01:48:55 DEBUG : dir/sub/file0: >OpenFile: fd=dir/sub/file0 (w), err= 2025/01/16 01:48:55 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/16 01:48:55 DEBUG : dir/sub/file2: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2025/01/16 01:48:55 DEBUG : dir/sub/file2: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2025/01/16 01:48:55 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2025/01/16 01:48:55 DEBUG : dir/sub/file2: >Open: fd=dir/sub/file2 (w), err= 2025/01/16 01:48:55 DEBUG : dir/sub/file2: >OpenFile: fd=dir/sub/file2 (w), err= 2025/01/16 01:48:55 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2025/01/16 01:48:55 DEBUG : Linkbox root 'rclone-test-xosiluf5yuqe': File to upload is small (12 bytes), uploading instead of streaming 2025/01/16 01:48:57 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.000001946CCC9EC5B15F02954A79CA2CZ9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGmhJVxznTfeCmgsIxGqtI/BGOsaI=PUT\n\n\n1736999336\nx-amz-cf-id:nX02-JSVV1iR4qHoIobh8atCxtcd3wq9az_fLDu6O2_YC8KXjzPurQ==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/fc3ff98e8c6a0d3087d515c0473f8677_1250 55 54 0a 0a 0a 31 37 33 36 39 39 39 33 33 36 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 6e 58 30 32 2d 4a 53 56 56 31 69 52 34 71 48 6f 49 6f 62 68 38 61 74 43 78 74 63 64 33 77 71 39 61 7a 5f 66 4c 44 75 36 4f 32 5f 59 43 38 4b 58 6a 7a 50 75 72 51 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/16 01:48:57 DEBUG : dir/sub/file2: Remove: 2025/01/16 01:48:57 DEBUG : dir/sub: Added virtual directory entry vDel: "file2" 2025/01/16 01:48:57 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.000001946CCC9EC5B15F02954A79CA2CZ9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGmhJVxznTfeCmgsIxGqtI/BGOsaI=PUT\n\n\n1736999336\nx-amz-cf-id:nX02-JSVV1iR4qHoIobh8atCxtcd3wq9az_fLDu6O2_YC8KXjzPurQ==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/fc3ff98e8c6a0d3087d515c0473f8677_1250 55 54 0a 0a 0a 31 37 33 36 39 39 39 33 33 36 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 6e 58 30 32 2d 4a 53 56 56 31 69 52 34 71 48 6f 49 6f 62 68 38 61 74 43 78 74 63 64 33 77 71 39 61 7a 5f 66 4c 44 75 36 4f 32 5f 59 43 38 4b 58 6a 7a 50 75 72 51 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/16 01:48:57 DEBUG : Linkbox root 'rclone-test-xosiluf5yuqe': File to upload is small (5 bytes), uploading instead of streaming 2025/01/16 01:48:59 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/01/16 01:48:59 DEBUG : dir/sub/file0: Size of src and dst objects identical 2025/01/16 01:48:59 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2025/01/16 01:48:59 DEBUG : WaitForWriters: timeout=30s 2025/01/16 01:48:59 DEBUG : dir/sub: Looking for writers 2025/01/16 01:48:59 DEBUG : file0: reading active writers 2025/01/16 01:48:59 DEBUG : dir: Looking for writers 2025/01/16 01:48:59 DEBUG : file1: reading active writers 2025/01/16 01:48:59 DEBUG : sub: reading active writers 2025/01/16 01:48:59 DEBUG : : Looking for writers 2025/01/16 01:48:59 DEBUG : dir: reading active writers 2025/01/16 01:48:59 DEBUG : >WaitForWriters: --- FAIL: TestDirFileOpen (17.78s) === RUN TestVFSOpenFile run.go:180: Remote "Linkbox root 'rclone-test-xosiluf5yuqe'", Local "Local file system at /tmp/rclone1287821014", Modify Window "876000h0m0s" 2025/01/16 01:49:05 INFO : Linkbox root 'rclone-test-xosiluf5yuqe': poll-interval is not supported by this remote 2025/01/16 01:49:05 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/16 01:49:11 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/16 01:49:12 DEBUG : file1: Open: flags=O_RDONLY 2025/01/16 01:49:12 DEBUG : file1: >Open: fd=file1 (r), err= 2025/01/16 01:49:12 DEBUG : file1: >OpenFile: fd=file1 (r), err= 2025/01/16 01:49:12 DEBUG : dir: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/16 01:49:12 DEBUG : dir: >OpenFile: fd=dir/ (r), err= 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: >OpenFile: fd=, err=file does not exist 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: Open: flags=O_WRONLY|O_CREATE 2025/01/16 01:49:12 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt" 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: >Open: fd=dir/new_file.txt (w), err= 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: >OpenFile: fd=dir/new_file.txt (w), err= 2025/01/16 01:49:12 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt" 2025/01/16 01:49:12 DEBUG : Linkbox root 'rclone-test-xosiluf5yuqe': File to upload is small (0 bytes), uploading instead of streaming 2025/01/16 01:49:12 ERROR : dir/new_file.txt: WriteFileHandle.New Rcat failed: can't upload empty files to this remote 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: Remove: 2025/01/16 01:49:12 DEBUG : dir: Added virtual directory entry vDel: "new_file.txt" 2025/01/16 01:49:12 DEBUG : dir/new_file.txt: >Remove: err= 2025/01/16 01:49:12 DEBUG : not found/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/16 01:49:12 DEBUG : not found/new_file.txt: >OpenFile: fd=, err=file does not exist 2025/01/16 01:49:12 DEBUG : WaitForWriters: timeout=30s 2025/01/16 01:49:12 DEBUG : dir: Looking for writers 2025/01/16 01:49:12 DEBUG : file2: reading active writers 2025/01/16 01:49:12 DEBUG : : Looking for writers 2025/01/16 01:49:12 DEBUG : dir: reading active writers 2025/01/16 01:49:12 DEBUG : file1: reading active writers 2025/01/16 01:49:12 DEBUG : >WaitForWriters: --- PASS: TestVFSOpenFile (11.47s) === RUN TestVFSRename run.go:180: Remote "Linkbox root 'rclone-test-xosiluf5yuqe'", Local "Local file system at /tmp/rclone1287821014", Modify Window "876000h0m0s" 2025/01/16 01:49:17 INFO : Linkbox root 'rclone-test-xosiluf5yuqe': poll-interval is not supported by this remote 2025/01/16 01:49:17 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream vfs_test.go:292: skip as can't rename files 2025/01/16 01:49:17 DEBUG : WaitForWriters: timeout=30s 2025/01/16 01:49:17 DEBUG : : Looking for writers 2025/01/16 01:49:17 DEBUG : >WaitForWriters: --- SKIP: TestVFSRename (0.43s) === RUN TestVFSMkdir run.go:180: Remote "Linkbox root 'rclone-test-xosiluf5yuqe'", Local "Local file system at /tmp/rclone1287821014", Modify Window "876000h0m0s" 2025/01/16 01:49:17 INFO : Linkbox root 'rclone-test-xosiluf5yuqe': poll-interval is not supported by this remote 2025/01/16 01:49:17 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/16 01:49:18 DEBUG : : Added virtual directory entry vAddDir: "/" 2025/01/16 01:49:19 DEBUG : : Added virtual directory entry vAddDir: "a" 2025/01/16 01:49:22 DEBUG : : Added virtual directory entry vAddDir: "b" 2025/01/16 01:49:24 DEBUG : : Added virtual directory entry vAddDir: "c" 2025/01/16 01:49:26 DEBUG : : Added virtual directory entry vAddDir: "d" 2025/01/16 01:49:27 DEBUG : WaitForWriters: timeout=30s 2025/01/16 01:49:27 DEBUG : d: Looking for writers 2025/01/16 01:49:27 DEBUG : : Looking for writers 2025/01/16 01:49:27 DEBUG : a: Looking for writers 2025/01/16 01:49:27 DEBUG : b: Looking for writers 2025/01/16 01:49:27 DEBUG : c: Looking for writers 2025/01/16 01:49:27 DEBUG : : Looking for writers 2025/01/16 01:49:27 DEBUG : /: reading active writers 2025/01/16 01:49:27 DEBUG : a: reading active writers 2025/01/16 01:49:27 DEBUG : b: reading active writers 2025/01/16 01:49:27 DEBUG : c: reading active writers 2025/01/16 01:49:27 DEBUG : d: reading active writers 2025/01/16 01:49:27 DEBUG : >WaitForWriters: --- PASS: TestVFSMkdir (17.58s) === RUN TestFileReadAtNonZeroLength run.go:180: Remote "Linkbox root 'rclone-test-xosiluf5yuqe'", Local "Local file system at /tmp/rclone1287821014", Modify Window "876000h0m0s" 2025/01/16 01:49:35 INFO : Linkbox root 'rclone-test-xosiluf5yuqe': poll-interval is not supported by this remote 2025/01/16 01:49:35 NOTICE: Linkbox root 'rclone-test-xosiluf5yuqe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/01/16 01:49:35 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2025/01/16 01:49:35 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2025/01/16 01:49:35 DEBUG : : Added virtual directory entry vAddFile: "file1" 2025/01/16 01:49:35 DEBUG : file1: >Open: fd=file1 (w), err= 2025/01/16 01:49:35 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2025/01/16 01:49:35 DEBUG : : Added virtual directory entry vAddFile: "file1" 2025/01/16 01:49:35 DEBUG : Linkbox root 'rclone-test-xosiluf5yuqe': File to upload is small (100 bytes), uploading instead of streaming 2025/01/16 01:49:36 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.000001946CCD39A0B11DCFE20E4B0D85Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGqpnMgXLsO0ZN05j2L3M0S8GyDhI=PUT\n\n\n1736999375\nx-amz-cf-id:H_khHVLxb4tkFC4MvfH9U02BCQYyiLpa-u5ru9WbdQKOKgBW6_zelw==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/82feb3e32a92efe4706caf2176d48f86_10050 55 54 0a 0a 0a 31 37 33 36 39 39 39 33 37 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 48 5f 6b 68 48 56 4c 78 62 34 74 6b 46 43 34 4d 76 66 48 39 55 30 32 42 43 51 59 79 69 4c 70 61 2d 75 35 72 75 39 57 62 64 51 4b 4f 4b 67 42 57 36 5f 7a 65 6c 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 38 32 66 65 62 33 65 33 32 61 39 32 65 66 65 34 37 30 36 63 61 66 32 31 37 36 64 34 38 66 38 36 5f 31 30 30" 2025/01/16 01:49:36 DEBUG : file1: Remove: 2025/01/16 01:49:36 DEBUG : : Added virtual directory entry vDel: "file1" 2025/01/16 01:49:36 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.000001946CCD39A0B11DCFE20E4B0D85Z9v+cC1sRnaWw6x0vi8pxxYA0YVnKxbYHUPAFpnxkX8sLV44u5b02Z+ailn2wCnRZAUGMKBTPLNX0FBOCABGqpnMgXLsO0ZN05j2L3M0S8GyDhI=PUT\n\n\n1736999375\nx-amz-cf-id:H_khHVLxb4tkFC4MvfH9U02BCQYyiLpa-u5ru9WbdQKOKgBW6_zelw==\n/ozadj95fviptne/tmp/recycle/1d/user/922460207/82feb3e32a92efe4706caf2176d48f86_10050 55 54 0a 0a 0a 31 37 33 36 39 39 39 33 37 35 0a 78 2d 61 6d 7a 2d 63 66 2d 69 64 3a 48 5f 6b 68 48 56 4c 78 62 34 74 6b 46 43 34 4d 76 66 48 39 55 30 32 42 43 51 59 79 69 4c 70 61 2d 75 35 72 75 39 57 62 64 51 4b 4f 4b 67 42 57 36 5f 7a 65 6c 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 38 32 66 65 62 33 65 33 32 61 39 32 65 66 65 34 37 30 36 63 61 66 32 31 37 36 64 34 38 66 38 36 5f 31 30 30" Test: TestFileReadAtNonZeroLength 2025/01/16 01:49:36 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=---------- 2025/01/16 01:49:36 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/16 01:49:36 DEBUG : WaitForWriters: timeout=30s 2025/01/16 01:49:36 DEBUG : : Looking for writers 2025/01/16 01:49:36 DEBUG : >WaitForWriters: --- FAIL: TestFileReadAtNonZeroLength (1.85s) FAIL 2025/01/16 01:49:37 DEBUG : Linkbox root 'rclone-test-xosiluf5yuqe': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirFileOpen|TestFileReadAtNonZeroLength|TestVFSMkdir|TestVFSOpenFile|TestVFSRename)$'" - Finished ERROR in 50.994260199s (try 2/5): exit status 1: Failed [TestDirFileOpen TestFileReadAtNonZeroLength]