"./vfs.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestDirMkdirSub|TestDirOpen|TestDirStat|TestDirWalk|TestFileMethods)$'" - Starting (try 2/5)
2025/10/15 04:34:41 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-gupozuf2dene"
2025/10/15 04:34:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/10/15 04:34:41 DEBUG : Creating backend with remote "/tmp/rclone137314200"
=== RUN   TestDirWalk
    run.go:180: Remote "HiDrive root 'rclone-test-gupozuf2dene'", Local "Local file system at /tmp/rclone137314200", Modify Window "1s"
2025/10/15 04:34:41 INFO  : HiDrive root 'rclone-test-gupozuf2dene': poll-interval is not supported by this remote
2025/10/15 04:34:41 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:41 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:41 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name fil
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name a
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name b
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name c
2025/10/15 04:34:42 DEBUG : forgetting directory cache
2025/10/15 04:34:42 DEBUG : dir: forgetting directory cache
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name fil
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name a
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name b
2025/10/15 04:34:42 DEBUG : WaitForWriters: timeout=30s
2025/10/15 04:34:42 DEBUG : dir: Looking for writers
2025/10/15 04:34:42 DEBUG : fil/a/b: Looking for writers
2025/10/15 04:34:42 DEBUG : fil/a: Looking for writers
2025/10/15 04:34:42 DEBUG : b: reading active writers
2025/10/15 04:34:42 DEBUG : fil: Looking for writers
2025/10/15 04:34:42 DEBUG : a: reading active writers
2025/10/15 04:34:42 DEBUG : Looking for writers
2025/10/15 04:34:42 DEBUG : dir: reading active writers
2025/10/15 04:34:42 DEBUG : fil: reading active writers
2025/10/15 04:34:42 DEBUG : >WaitForWriters: 
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name fil
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name a
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name b
2025/10/15 04:34:42 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name c
--- PASS: TestDirWalk (1.58s)
=== RUN   TestDirStat
    run.go:180: Remote "HiDrive root 'rclone-test-gupozuf2dene'", Local "Local file system at /tmp/rclone137314200", Modify Window "1s"
2025/10/15 04:34:43 INFO  : HiDrive root 'rclone-test-gupozuf2dene': poll-interval is not supported by this remote
    run.go:285: Failed to put "dir/file1" to "HiDrive root 'rclone-test-gupozuf2dene'": directory not found
2025/10/15 04:34:43 DEBUG : WaitForWriters: timeout=30s
2025/10/15 04:34:43 DEBUG : Looking for writers
2025/10/15 04:34:43 DEBUG : >WaitForWriters: 
2025/10/15 04:34:43 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
--- FAIL: TestDirStat (0.50s)
=== RUN   TestDirOpen
    run.go:180: Remote "HiDrive root 'rclone-test-gupozuf2dene'", Local "Local file system at /tmp/rclone137314200", Modify Window "1s"
2025/10/15 04:34:43 INFO  : HiDrive root 'rclone-test-gupozuf2dene': poll-interval is not supported by this remote
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 ERROR : dir/: Can only open directories read only
2025/10/15 04:34:44 DEBUG : WaitForWriters: timeout=30s
2025/10/15 04:34:44 DEBUG : dir: Looking for writers
2025/10/15 04:34:44 DEBUG : Looking for writers
2025/10/15 04:34:44 DEBUG : dir: reading active writers
2025/10/15 04:34:44 DEBUG : >WaitForWriters: 
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
--- PASS: TestDirOpen (0.61s)
=== RUN   TestDirMkdirSub
    run.go:180: Remote "HiDrive root 'rclone-test-gupozuf2dene'", Local "Local file system at /tmp/rclone137314200", Modify Window "1s"
2025/10/15 04:34:44 INFO  : HiDrive root 'rclone-test-gupozuf2dene': poll-interval is not supported by this remote
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:44 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/10/15 04:34:44 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub"
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:44 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name sub
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name subsub
2025/10/15 04:34:45 DEBUG : WaitForWriters: timeout=30s
2025/10/15 04:34:45 DEBUG : dir/sub/subsub: Looking for writers
2025/10/15 04:34:45 DEBUG : dir/sub: Looking for writers
2025/10/15 04:34:45 DEBUG : subsub: reading active writers
2025/10/15 04:34:45 DEBUG : dir: Looking for writers
2025/10/15 04:34:45 DEBUG : file1: reading active writers
2025/10/15 04:34:45 DEBUG : sub: reading active writers
2025/10/15 04:34:45 DEBUG : Looking for writers
2025/10/15 04:34:45 DEBUG : dir: reading active writers
2025/10/15 04:34:45 DEBUG : >WaitForWriters: 
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name sub
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name subsub
--- PASS: TestDirMkdirSub (1.17s)
=== RUN   TestFileMethods
    run.go:180: Remote "HiDrive root 'rclone-test-gupozuf2dene'", Local "Local file system at /tmp/rclone137314200", Modify Window "1s"
2025/10/15 04:34:45 INFO  : HiDrive root 'rclone-test-gupozuf2dene': poll-interval is not supported by this remote
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
2025/10/15 04:34:45 DEBUG : WaitForWriters: timeout=30s
2025/10/15 04:34:45 DEBUG : dir: Looking for writers
2025/10/15 04:34:45 DEBUG : file1: reading active writers
2025/10/15 04:34:45 DEBUG : Looking for writers
2025/10/15 04:34:45 DEBUG : dir: reading active writers
2025/10/15 04:34:45 DEBUG : >WaitForWriters: 
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name dir
2025/10/15 04:34:45 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': found directory-element with name file1
--- PASS: TestFileMethods (0.56s)
FAIL
2025/10/15 04:34:46 DEBUG : HiDrive root 'rclone-test-gupozuf2dene': Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestDirMkdirSub|TestDirOpen|TestDirStat|TestDirWalk|TestFileMethods)$'" - Finished ERROR in 4.746302164s (try 2/5): exit status 1: Failed [TestDirStat]