"./vfs.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestDirCreate|TestDirMkdir|TestDirRemoveName|TestFileReadAtZeroLength)$'" - Starting (try 2/5) 2024/04/13 01:07:20 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-nomejej0zebequy4vobakid2" 2024/04/13 01:07:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/13 01:07:21 DEBUG : Starting OpenDrive session with ID: 11cbd48f987487019a3051d64404950d461fb5f6ae9a93a54039625c668042f9 2024/04/13 01:07:21 DEBUG : Creating backend with remote "/tmp/rclone3379107303" === RUN TestDirCreate run.go:180: Remote "OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2'", Local "Local file system at /tmp/rclone3379107303", Modify Window "1s" 2024/04/13 01:07:21 INFO : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': poll-interval is not supported by this remote 2024/04/13 01:07:21 NOTICE: OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2024/04/13 01:07:23 DEBUG : dir/file1: Uploading chunk 0, size=14, remain=0 dir_test.go:351: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:351 Error: Should be true Test: TestDirCreate 2024/04/13 01:07:25 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE 2024/04/13 01:07:25 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2024/04/13 01:07:25 DEBUG : dir/potato: >Open: fd=dir/potato (w), err= 2024/04/13 01:07:25 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2024/04/13 01:07:25 DEBUG : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': File to upload is small (5 bytes), uploading instead of streaming 2024/04/13 01:07:26 DEBUG : dir/potato: Uploading chunk 0, size=5, remain=0 2024/04/13 01:07:27 DEBUG : dir/potato: md5 = 5d41402abc4b2a76b9719d911017c592 OK 2024/04/13 01:07:27 INFO : dir/potato: Copied (new) 2024/04/13 01:07:27 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2024/04/13 01:07:27 DEBUG : WaitForWriters: timeout=30s 2024/04/13 01:07:27 DEBUG : dir: Looking for writers 2024/04/13 01:07:27 DEBUG : file1: reading active writers 2024/04/13 01:07:27 DEBUG : potato: reading active writers 2024/04/13 01:07:27 DEBUG : : Looking for writers 2024/04/13 01:07:27 DEBUG : dir: reading active writers 2024/04/13 01:07:27 DEBUG : >WaitForWriters: --- FAIL: TestDirCreate (6.92s) === RUN TestDirMkdir run.go:180: Remote "OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2'", Local "Local file system at /tmp/rclone3379107303", Modify Window "1s" 2024/04/13 01:07:28 INFO : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': poll-interval is not supported by this remote 2024/04/13 01:07:28 NOTICE: OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2024/04/13 01:07:30 DEBUG : dir/file1: Uploading chunk 0, size=14, remain=0 2024/04/13 01:07:32 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2024/04/13 01:07:33 DEBUG : WaitForWriters: timeout=30s 2024/04/13 01:07:33 DEBUG : dir/sub: Looking for writers 2024/04/13 01:07:33 DEBUG : dir: Looking for writers 2024/04/13 01:07:33 DEBUG : file1: reading active writers 2024/04/13 01:07:33 DEBUG : sub: reading active writers 2024/04/13 01:07:33 DEBUG : : Looking for writers 2024/04/13 01:07:33 DEBUG : dir: reading active writers 2024/04/13 01:07:33 DEBUG : >WaitForWriters: --- PASS: TestDirMkdir (6.91s) === RUN TestDirRemoveName run.go:180: Remote "OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2'", Local "Local file system at /tmp/rclone3379107303", Modify Window "1s" 2024/04/13 01:07:35 INFO : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': poll-interval is not supported by this remote 2024/04/13 01:07:35 NOTICE: OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2024/04/13 01:07:36 DEBUG : dir/file1: Uploading chunk 0, size=14, remain=0 2024/04/13 01:07:38 DEBUG : dir/file1: Remove: 2024/04/13 01:07:39 DEBUG : dir: Added virtual directory entry vDel: "file1" 2024/04/13 01:07:39 DEBUG : dir/file1: >Remove: err= dir_test.go:501: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:501 Error: Should be true Test: TestDirRemoveName 2024/04/13 01:07:39 DEBUG : WaitForWriters: timeout=30s 2024/04/13 01:07:39 DEBUG : dir: Looking for writers 2024/04/13 01:07:39 DEBUG : : Looking for writers 2024/04/13 01:07:39 DEBUG : dir: reading active writers 2024/04/13 01:07:39 DEBUG : >WaitForWriters: --- FAIL: TestDirRemoveName (4.80s) === RUN TestFileReadAtZeroLength run.go:180: Remote "OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2'", Local "Local file system at /tmp/rclone3379107303", Modify Window "1s" 2024/04/13 01:07:40 INFO : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': poll-interval is not supported by this remote 2024/04/13 01:07:40 NOTICE: OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2024/04/13 01:07:40 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2024/04/13 01:07:40 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2024/04/13 01:07:40 DEBUG : : Added virtual directory entry vAddFile: "file1" 2024/04/13 01:07:40 DEBUG : file1: >Open: fd=file1 (w), err= 2024/04/13 01:07:40 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2024/04/13 01:07:40 DEBUG : : Added virtual directory entry vAddFile: "file1" 2024/04/13 01:07:40 DEBUG : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': File to upload is small (0 bytes), uploading instead of streaming 2024/04/13 01:07:43 DEBUG : file1: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/13 01:07:43 INFO : file1: Copied (new) 2024/04/13 01:07:43 DEBUG : : Added virtual directory entry vAddFile: "file1" 2024/04/13 01:07:43 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=---------- 2024/04/13 01:07:43 DEBUG : file1: Open: flags=O_RDONLY 2024/04/13 01:07:43 DEBUG : file1: >Open: fd=file1 (r), err= 2024/04/13 01:07:43 DEBUG : file1: >OpenFile: fd=file1 (r), err= 2024/04/13 01:07:43 DEBUG : file1: ChunkedReader.openRange at 0 length 134217728 2024/04/13 01:07:44 DEBUG : Couldn't decode error response: EOF write_test.go:370: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:370 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:380 Error: Received unexpected error: failed to open file): Unknown 416 Requested Range Not Satisfiable (Error 416) Test: TestFileReadAtZeroLength 2024/04/13 01:07:44 DEBUG : WaitForWriters: timeout=30s 2024/04/13 01:07:44 DEBUG : : Looking for writers 2024/04/13 01:07:44 DEBUG : file1: reading active writers 2024/04/13 01:07:44 DEBUG : >WaitForWriters: --- FAIL: TestFileReadAtZeroLength (4.21s) FAIL 2024/04/13 01:07:44 DEBUG : OpenDrive root 'rclone-test-nomejej0zebequy4vobakid2': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestDirCreate|TestDirMkdir|TestDirRemoveName|TestFileReadAtZeroLength)$'" - Finished ERROR in 24.542197041s (try 2/5): exit status 1: Failed [TestDirCreate TestDirRemoveName TestFileReadAtZeroLength]