"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFileLu: -verbose -test.run '^(TestVFSIsMetadataFile|TestVFSMkdir|TestVFSMkdirAll|TestVFSOpenFile|TestVFSRename|TestVFSStatfs|TestWriteFileHandleFlush|TestWriteFileHandleMethods|TestWriteFileHandleRelease|TestWriteFileHandleWriteAt)$'" - Starting (try 4/5)
2025/12/01 04:11:58 DEBUG : Creating backend with remote "TestFileLu:rclone-test-hoqigeq2viki"
2025/12/01 04:11:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/01 04:11:58 DEBUG : Creating backend with remote "/tmp/rclone1197835117"
=== RUN   TestVFSOpenFile
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:11:58 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:11:58 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:11:59 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki" with ID 1562535
2025/12/01 04:12:04 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "file1"
2025/12/01 04:12:05 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/dir" with ID 1562540
2025/12/01 04:12:09 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "dir/file2"
2025/12/01 04:12:10 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2025/12/01 04:12:11 DEBUG : file1: Open: flags=O_RDONLY
2025/12/01 04:12:11 DEBUG : file1: >Open: fd=file1 (r), err=<nil>
2025/12/01 04:12:11 DEBUG : file1: >OpenFile: fd=file1 (r), err=<nil>
2025/12/01 04:12:11 DEBUG : dir: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2025/12/01 04:12:11 DEBUG : dir: >OpenFile: fd=dir/ (r), err=<nil>
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: >OpenFile: fd=<nil>, err=file does not exist
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:12:11 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt"
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: >Open: fd=dir/new_file.txt (w), err=<nil>
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: >OpenFile: fd=dir/new_file.txt (w), err=<nil>
2025/12/01 04:12:11 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt"
2025/12/01 04:12:11 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (0 bytes), uploading instead of streaming
2025/12/01 04:12:11 ERROR : dir/new_file.txt: WriteFileHandle.New Rcat failed: can't upload empty files to this remote
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: Remove: 
2025/12/01 04:12:11 DEBUG : dir: Added virtual directory entry vDel: "new_file.txt"
2025/12/01 04:12:11 DEBUG : dir/new_file.txt: >Remove: err=<nil>
2025/12/01 04:12:11 DEBUG : not found/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:12:11 DEBUG : not found/new_file.txt: >OpenFile: fd=<nil>, err=file does not exist
2025/12/01 04:12:11 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:12:11 DEBUG : dir: Looking for writers
2025/12/01 04:12:11 DEBUG : file2: reading active writers
2025/12/01 04:12:11 DEBUG : Looking for writers
2025/12/01 04:12:11 DEBUG : dir: reading active writers
2025/12/01 04:12:11 DEBUG : file1: reading active writers
2025/12/01 04:12:11 DEBUG : >WaitForWriters: 
2025/12/01 04:12:12 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/file1
2025/12/01 04:12:15 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/dir/file2
2025/12/01 04:12:16 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/dir"
--- PASS: TestVFSOpenFile (19.20s)
=== RUN   TestVFSRename
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:12:17 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:12:17 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:12:18 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/dir" with ID 1562548
2025/12/01 04:12:19 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "dir/file2"
2025/12/01 04:12:25 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/dir/file2
2025/12/01 04:12:25 INFO  : dir/file2: Moved (server-side) to: dir/file1
2025/12/01 04:12:25 DEBUG : dir/file1: Updating file with dir/file1 0xc0001aee40
2025/12/01 04:12:25 DEBUG : dir: Added virtual directory entry vDel: "file2"
2025/12/01 04:12:25 DEBUG : dir: Added virtual directory entry vAddFile: "file1"
2025/12/01 04:12:30 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/dir/file1
2025/12/01 04:12:30 INFO  : dir/file1: Moved (server-side) to: file0
2025/12/01 04:12:30 DEBUG : file0: Updating file with file0 0xc0001aee40
2025/12/01 04:12:30 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/12/01 04:12:30 DEBUG : Added virtual directory entry vAddFile: "file0"
2025/12/01 04:12:31 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:12:31 DEBUG : dir: Looking for writers
2025/12/01 04:12:31 DEBUG : Looking for writers
2025/12/01 04:12:31 DEBUG : file0: reading active writers
2025/12/01 04:12:31 DEBUG : dir: reading active writers
2025/12/01 04:12:31 DEBUG : >WaitForWriters: 
2025/12/01 04:12:31 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/file0
2025/12/01 04:12:33 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/dir"
--- PASS: TestVFSRename (16.30s)
=== RUN   TestVFSStatfs
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:12:33 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:12:33 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:12:34 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:12:34 DEBUG : Looking for writers
2025/12/01 04:12:34 DEBUG : >WaitForWriters: 
--- PASS: TestVFSStatfs (1.28s)
=== RUN   TestVFSMkdir
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:12:34 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:12:34 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:12:36 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki" with ID 1.562535e+06
2025/12/01 04:12:36 DEBUG : Added virtual directory entry vAddDir: "/"
2025/12/01 04:12:36 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/a" with ID 1562553
2025/12/01 04:12:36 DEBUG : Added virtual directory entry vAddDir: "a"
2025/12/01 04:12:38 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/b" with ID 1562555
2025/12/01 04:12:38 DEBUG : Added virtual directory entry vAddDir: "b"
2025/12/01 04:12:39 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/c" with ID 1562557
2025/12/01 04:12:39 DEBUG : Added virtual directory entry vAddDir: "c"
2025/12/01 04:12:45 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/d" with ID 1562560
2025/12/01 04:12:45 DEBUG : Added virtual directory entry vAddDir: "d"
2025/12/01 04:12:46 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:12:46 DEBUG : a: Looking for writers
2025/12/01 04:12:46 DEBUG : b: Looking for writers
2025/12/01 04:12:46 DEBUG : c: Looking for writers
2025/12/01 04:12:46 DEBUG : d: Looking for writers
2025/12/01 04:12:46 DEBUG : Looking for writers
2025/12/01 04:12:46 DEBUG : Looking for writers
2025/12/01 04:12:46 DEBUG : /: reading active writers
2025/12/01 04:12:46 DEBUG : a: reading active writers
2025/12/01 04:12:46 DEBUG : b: reading active writers
2025/12/01 04:12:46 DEBUG : c: reading active writers
2025/12/01 04:12:46 DEBUG : d: reading active writers
2025/12/01 04:12:46 DEBUG : >WaitForWriters: 
2025/12/01 04:12:49 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/d"
2025/12/01 04:12:51 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/c"
2025/12/01 04:12:52 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/b"
2025/12/01 04:12:53 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/a"
--- PASS: TestVFSMkdir (18.50s)
=== RUN   TestVFSMkdirAll
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:12:53 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:12:53 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:12:55 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/a" with ID 1562566
2025/12/01 04:12:55 DEBUG : Added virtual directory entry vAddDir: "a"
2025/12/01 04:12:56 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/a/b" with ID 1562570
2025/12/01 04:12:56 DEBUG : a: Added virtual directory entry vAddDir: "b"
2025/12/01 04:12:57 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/a/b/c" with ID 1562571
2025/12/01 04:12:57 DEBUG : a/b: Added virtual directory entry vAddDir: "c"
2025/12/01 04:12:57 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully created folder "rclone-test-hoqigeq2viki/a/b/c/d" with ID 1562574
2025/12/01 04:12:57 DEBUG : a/b/c: Added virtual directory entry vAddDir: "d"
2025/12/01 04:13:09 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:09 DEBUG : a/b/c/d: Looking for writers
2025/12/01 04:13:09 DEBUG : a/b/c: Looking for writers
2025/12/01 04:13:09 DEBUG : d: reading active writers
2025/12/01 04:13:09 DEBUG : a/b: Looking for writers
2025/12/01 04:13:09 DEBUG : c: reading active writers
2025/12/01 04:13:09 DEBUG : a: Looking for writers
2025/12/01 04:13:09 DEBUG : b: reading active writers
2025/12/01 04:13:09 DEBUG : Looking for writers
2025/12/01 04:13:09 DEBUG : a: reading active writers
2025/12/01 04:13:09 DEBUG : >WaitForWriters: 
2025/12/01 04:13:12 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/a/b/c/d"
2025/12/01 04:13:13 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/a/b/c"
2025/12/01 04:13:15 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/a/b"
2025/12/01 04:13:16 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki/a"
--- PASS: TestVFSMkdirAll (23.40s)
=== RUN   TestVFSIsMetadataFile
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:13:16 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:13:16 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:13:16 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:16 DEBUG : Looking for writers
2025/12/01 04:13:16 DEBUG : >WaitForWriters: 
--- PASS: TestVFSIsMetadataFile (0.98s)
=== RUN   TestWriteFileHandleMethods
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:13:17 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:13:17 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:13:17 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:18 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:18 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:18 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:18 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:18 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:18 ERROR : file1: WriteFileHandle: Read: Can't read and write to file without --vfs-cache-mode >= minimal
2025/12/01 04:13:18 ERROR : file1: WriteFileHandle: ReadAt: Can't read and write to file without --vfs-cache-mode >= minimal
2025/12/01 04:13:18 ERROR : file1: WriteFileHandle: Truncate: Can't change size without --vfs-cache-mode >= writes
2025/12/01 04:13:18 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (5 bytes), uploading instead of streaming
2025/12/01 04:13:19 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "file1"
2025/12/01 04:13:19 DEBUG : file1: size = 5 OK
2025/12/01 04:13:19 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2025/12/01 04:13:19 DEBUG : file1: Size of src and dst objects identical
2025/12/01 04:13:19 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:20 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:20 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 ERROR : file1: WriteFileHandle: Can't open for write without O_TRUNC on existing file without --vfs-cache-mode >= writes
2025/12/01 04:13:20 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx
2025/12/01 04:13:20 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (0 bytes), uploading instead of streaming
2025/12/01 04:13:20 ERROR : file1: WriteFileHandle.New Rcat failed: can't upload empty files to this remote
2025/12/01 04:13:20 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx
2025/12/01 04:13:20 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:20 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (7 bytes), uploading instead of streaming
2025/12/01 04:13:23 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "file1"
2025/12/01 04:13:23 DEBUG : file1: size = 7 OK
2025/12/01 04:13:23 DEBUG : file1: Size of src and dst objects identical
2025/12/01 04:13:23 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:23 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:23 DEBUG : Looking for writers
2025/12/01 04:13:23 DEBUG : file1: reading active writers
2025/12/01 04:13:23 DEBUG : >WaitForWriters: 
2025/12/01 04:13:24 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/file1
--- PASS: TestWriteFileHandleMethods (7.05s)
=== RUN   TestWriteFileHandleWriteAt
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:13:24 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:13:24 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:13:24 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:25 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:25 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:25 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:25 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:25 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:25 DEBUG : file1: waiting for in-sequence write to 100 for 1s
2025/12/01 04:13:26 DEBUG : file1: aborting in-sequence write wait, off=100
2025/12/01 04:13:26 DEBUG : file1: failed to wait for in-sequence write to 100
2025/12/01 04:13:26 ERROR : file1: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2025/12/01 04:13:26 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (11 bytes), uploading instead of streaming
2025/12/01 04:13:27 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "file1"
2025/12/01 04:13:27 DEBUG : file1: size = 11 OK
2025/12/01 04:13:27 DEBUG : file1: Size of src and dst objects identical
2025/12/01 04:13:27 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:27 ERROR : file1: WriteFileHandle.Write: error: Bad file descriptor
2025/12/01 04:13:28 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:28 DEBUG : Looking for writers
2025/12/01 04:13:28 DEBUG : file1: reading active writers
2025/12/01 04:13:28 DEBUG : >WaitForWriters: 
2025/12/01 04:13:29 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/file1
--- PASS: TestWriteFileHandleWriteAt (4.80s)
=== RUN   TestWriteFileHandleFlush
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:13:29 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:13:29 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:13:29 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:30 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:30 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:30 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:30 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:30 DEBUG : file1: WriteFileHandle.Flush unwritten handle, writing 0 bytes to avoid race conditions
2025/12/01 04:13:30 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:30 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (5 bytes), uploading instead of streaming
2025/12/01 04:13:31 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Put: Successfully uploaded new file "file1"
2025/12/01 04:13:31 DEBUG : file1: size = 5 OK
2025/12/01 04:13:31 DEBUG : file1: Size of src and dst objects identical
2025/12/01 04:13:31 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:31 DEBUG : file1: WriteFileHandle.Flush nothing to do
2025/12/01 04:13:31 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:31 DEBUG : Looking for writers
2025/12/01 04:13:31 DEBUG : file1: reading active writers
2025/12/01 04:13:31 DEBUG : >WaitForWriters: 
2025/12/01 04:13:32 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Successfully deleted file: /rclone-test-hoqigeq2viki/file1
--- PASS: TestWriteFileHandleFlush (3.28s)
=== RUN   TestWriteFileHandleRelease
    run.go:185: Remote "FileLu root 'rclone-test-hoqigeq2viki'", Local "Local file system at /tmp/rclone1197835117", Modify Window "876000h0m0s"
2025/12/01 04:13:32 INFO  : FileLu root 'rclone-test-hoqigeq2viki': poll-interval is not supported by this remote
2025/12/01 04:13:32 NOTICE: FileLu root 'rclone-test-hoqigeq2viki': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/12/01 04:13:32 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/12/01 04:13:33 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/12/01 04:13:33 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:33 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/12/01 04:13:33 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/12/01 04:13:33 DEBUG : file1: WriteFileHandle.Release closing
2025/12/01 04:13:33 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/12/01 04:13:33 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': File to upload is small (0 bytes), uploading instead of streaming
2025/12/01 04:13:33 ERROR : file1: WriteFileHandle.New Rcat failed: can't upload empty files to this remote
2025/12/01 04:13:33 DEBUG : file1: Remove: 
2025/12/01 04:13:33 DEBUG : Added virtual directory entry vDel: "file1"
2025/12/01 04:13:33 DEBUG : file1: >Remove: err=<nil>
2025/12/01 04:13:33 ERROR : file1: WriteFileHandle.Release error: can't upload empty files to this remote
    write_test.go:276: skipping test: can't upload empty files to this remote
2025/12/01 04:13:33 DEBUG : WaitForWriters: timeout=30s
2025/12/01 04:13:33 DEBUG : Looking for writers
2025/12/01 04:13:33 DEBUG : >WaitForWriters: 
--- PASS: TestWriteFileHandleRelease (1.35s)
PASS
2025/12/01 04:13:34 DEBUG : FileLu root 'rclone-test-hoqigeq2viki': Purge remote
2025/12/01 04:13:35 INFO  : FileLu root 'rclone-test-hoqigeq2viki': Rmdir: successfully deleted "/rclone-test-hoqigeq2viki"
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFileLu: -verbose -test.run '^(TestVFSIsMetadataFile|TestVFSMkdir|TestVFSMkdirAll|TestVFSOpenFile|TestVFSRename|TestVFSStatfs|TestWriteFileHandleFlush|TestWriteFileHandleMethods|TestWriteFileHandleRelease|TestWriteFileHandleWriteAt)$'" - Finished OK in 1m37.230025691s (try 4/5)