"./vfs.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestCaseSensitivity|TestDirCreate|TestDirFileOpen|TestDirForgetAll|TestDirForgetPath|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMetadataExtension|TestDirMethods|TestDirMkdir|TestDirMkdirSub|TestDirOpen|TestDirReadDirAll|TestDirRemove|TestDirRemoveAll|TestDirRemoveName|TestDirRename|TestDirSetModTime|TestDirStat|TestDirWalk|TestFileMethods|TestFileOpen|TestFileOpenRead|TestFileOpenWrite|TestFileReadAtNonZeroLength|TestFileReadAtZeroLength|TestFileRemove|TestFileRemoveAll|TestRWCacheUpdate|TestRWFileHandleFlushRead|TestRWFileHandleMethodsRead|TestRWFileHandleMethodsWrite|TestRWFileHandleReadAt|TestRWFileHandleReleaseRead|TestRWFileHandleSeek|TestRWFileHandleSizeCreateExisting|TestRWFileHandleSizeTruncateExisting|TestRWFileHandleWriteAt|TestRWFileHandleWriteNoWrite|TestRWFileModTimeWithOpenWriters|TestReadFileHandleFlush|TestReadFileHandleMethods|TestReadFileHandleReadAt|TestReadFileHandleRelease|TestReadFileHandleSeek|TestUnicodeNormalization|TestVFSOpenFile|TestVFSRename|TestVFSStat|TestVFSStatParent|TestWriteFileHandleFlush|TestWriteFileHandleMethods|TestWriteFileHandleRelease|TestWriteFileHandleWriteAt|TestWriteFileModTimeWithOpenWriters)$|^TestFileRename$/^(full,forceCache=false|minimal,forceCache=false|minimal,forceCache=true|off,forceCache=false|writes,forceCache=false|writes,forceCache=true)$|^TestFileSetModTime$/^(cache=full,open=false,write=false|cache=full,open=true,write=false|cache=full,open=true,write=true|cache=off,open=false,write=false|cache=off,open=true,write=false|cache=off,open=true,write=true)$'" - Starting (try 5/5)
2025/09/19 04:09:41 DEBUG : Creating backend with remote "TestStorj:rclone-test-hojober4zupi"
2025/09/19 04:09:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: connecting...
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: connected: <nil>
2025/09/19 04:09:42 DEBUG : Creating backend with remote "/tmp/rclone2481840405"
=== RUN   TestDirHandleMethods
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: mkdir -p ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:42 DEBUG : Looking for writers
2025/09/19 04:09:42 DEBUG : >WaitForWriters: 
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirHandleMethods (0.63s)
=== RUN   TestDirHandleReaddir
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:42 DEBUG : Looking for writers
2025/09/19 04:09:42 DEBUG : >WaitForWriters: 
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirHandleReaddir (0.22s)
=== RUN   TestDirHandleReaddirnames
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:42 DEBUG : Looking for writers
2025/09/19 04:09:42 DEBUG : >WaitForWriters: 
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirHandleReaddirnames (0.18s)
=== RUN   TestDirMethods
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirMethods (0.16s)
=== RUN   TestDirForgetAll
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirForgetAll (0.12s)
=== RUN   TestDirForgetPath
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirForgetPath (0.19s)
=== RUN   TestDirWalk
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirWalk (0.23s)
=== RUN   TestDirSetModTime
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirSetModTime (0.12s)
=== RUN   TestDirStat
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:43 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:43 DEBUG : Looking for writers
2025/09/19 04:09:43 DEBUG : >WaitForWriters: 
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirStat (0.13s)
=== RUN   TestDirReadDirAll
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirReadDirAll (0.12s)
=== RUN   TestDirOpen
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirOpen (0.12s)
=== RUN   TestDirCreate
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirCreate (0.12s)
=== RUN   TestDirMkdir
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirMkdir (0.20s)
=== RUN   TestDirMkdirSub
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirMkdirSub (0.12s)
=== RUN   TestDirRemove
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirRemove (0.12s)
=== RUN   TestDirRemoveAll
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:44 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:44 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:44 DEBUG : Looking for writers
2025/09/19 04:09:44 DEBUG : >WaitForWriters: 
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirRemoveAll (0.22s)
=== RUN   TestDirRemoveName
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirRemoveName (0.11s)
=== RUN   TestDirRename
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirRename (0.13s)
=== RUN   TestDirFileOpen
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirFileOpen (0.19s)
=== RUN   TestDirMetadataExtension
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestDirMetadataExtension (0.14s)
=== RUN   TestFileMethods
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileMethods (0.20s)
=== RUN   TestFileSetModTime
=== RUN   TestFileSetModTime/cache=off,open=false,write=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileSetModTime/cache=off,open=true,write=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:45 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:45 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:45 DEBUG : Looking for writers
2025/09/19 04:09:45 DEBUG : >WaitForWriters: 
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:45 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileSetModTime/cache=off,open=true,write=true
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileSetModTime/cache=full,open=false,write=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileSetModTime/cache=full,open=true,write=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileSetModTime/cache=full,open=true,write=true
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:46 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileSetModTime (0.90s)
    --- FAIL: TestFileSetModTime/cache=off,open=false,write=false (0.14s)
    --- FAIL: TestFileSetModTime/cache=off,open=true,write=false (0.10s)
    --- FAIL: TestFileSetModTime/cache=off,open=true,write=true (0.19s)
    --- FAIL: TestFileSetModTime/cache=full,open=false,write=false (0.12s)
    --- FAIL: TestFileSetModTime/cache=full,open=true,write=false (0.21s)
    --- FAIL: TestFileSetModTime/cache=full,open=true,write=true (0.13s)
=== RUN   TestFileOpenRead
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileOpenRead (0.15s)
=== RUN   TestFileOpenWrite
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:46 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:46 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:46 DEBUG : Looking for writers
2025/09/19 04:09:46 DEBUG : >WaitForWriters: 
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileOpenWrite (0.18s)
=== RUN   TestFileRemove
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileRemove (0.12s)
=== RUN   TestFileRemoveAll
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileRemoveAll (0.10s)
=== RUN   TestFileOpen
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileOpen (0.11s)
=== RUN   TestFileRename
=== RUN   TestFileRename/off,forceCache=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileRename/minimal,forceCache=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileRename/minimal,forceCache=true
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileRename/writes,forceCache=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:47 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:47 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:47 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:47 DEBUG : Looking for writers
2025/09/19 04:09:47 DEBUG : >WaitForWriters: 
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:47 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileRename/writes,forceCache=true
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:48 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:48 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
=== RUN   TestFileRename/full,forceCache=false
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:48 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:48 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 14
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileRename (1.06s)
    --- FAIL: TestFileRename/off,forceCache=false (0.13s)
    --- FAIL: TestFileRename/minimal,forceCache=false (0.14s)
    --- FAIL: TestFileRename/minimal,forceCache=true (0.15s)
    --- FAIL: TestFileRename/writes,forceCache=false (0.29s)
    --- FAIL: TestFileRename/writes,forceCache=true (0.20s)
    --- FAIL: TestFileRename/full,forceCache=false (0.16s)
=== RUN   TestReadFileHandleMethods
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestReadFileHandleMethods (0.17s)
=== RUN   TestReadFileHandleSeek
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestReadFileHandleSeek (0.15s)
=== RUN   TestReadFileHandleReadAt
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestReadFileHandleReadAt (0.18s)
=== RUN   TestReadFileHandleFlush
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:48 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:48 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:48 DEBUG : Looking for writers
2025/09/19 04:09:48 DEBUG : >WaitForWriters: 
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:48 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestReadFileHandleFlush (0.12s)
=== RUN   TestReadFileHandleRelease
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestReadFileHandleRelease (0.14s)
=== RUN   TestRWFileHandleMethodsRead
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleMethodsRead (0.18s)
=== RUN   TestRWFileHandleSeek
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleSeek (0.15s)
=== RUN   TestRWFileHandleReadAt
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleReadAt (0.12s)
=== RUN   TestRWFileHandleFlushRead
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleFlushRead (0.12s)
=== RUN   TestRWFileHandleReleaseRead
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : >WaitForWriters: 
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleReleaseRead (0.11s)
=== RUN   TestRWFileHandleMethodsWrite
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:09:49 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:09:49 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:09:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2025/09/19 04:09:49 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:09:49 DEBUG : file1: newRWFileHandle: 
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): openPending: 
2025/09/19 04:09:49 DEBUG : file1: vfs cache: truncate to size=0 (not needed as size correct)
2025/09/19 04:09:49 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): >openPending: err=<nil>
2025/09/19 04:09:49 DEBUG : file1: >newRWFileHandle: err=<nil>
2025/09/19 04:09:49 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:09:49 DEBUG : file1: >Open: fd=file1 (rw), err=<nil>
2025/09/19 04:09:49 DEBUG : file1: >OpenFile: fd=file1 (rw), err=<nil>
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): _writeAt: size=5, off=0
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): >_writeAt: n=5, err=<nil>
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): _writeAt: size=7, off=5
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): >_writeAt: n=7, err=<nil>
2025/09/19 04:09:49 DEBUG : file1: vfs cache: truncate to size=11
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): close: 
2025/09/19 04:09:49 DEBUG : file1: vfs cache: setting modification time to 2025-09-19 04:09:49.893218667 +0000 UTC m=+7.918344400
2025/09/19 04:09:49 INFO  : file1: vfs cache: queuing for upload in 100ms
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): >close: err=<nil>
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): close: 
2025/09/19 04:09:49 DEBUG : file1(0xc00071b240): >close: err=file already closed
2025/09/19 04:09:49 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : file1: reading active writers
2025/09/19 04:09:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 10ms
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : file1: reading active writers
2025/09/19 04:09:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 20ms
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : file1: reading active writers
2025/09/19 04:09:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 40ms
2025/09/19 04:09:49 DEBUG : Looking for writers
2025/09/19 04:09:49 DEBUG : file1: reading active writers
2025/09/19 04:09:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 80ms
2025/09/19 04:09:49 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:49 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:50 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:50 ERROR : file1: vfs cache: failed to upload try #1, will retry in 200ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:50 DEBUG : Looking for writers
2025/09/19 04:09:50 DEBUG : file1: reading active writers
2025/09/19 04:09:50 DEBUG : Still 0 writers active and 1 cache items in use, waiting 160ms
2025/09/19 04:09:50 DEBUG : Looking for writers
2025/09/19 04:09:50 DEBUG : file1: reading active writers
2025/09/19 04:09:50 DEBUG : Still 0 writers active and 1 cache items in use, waiting 320ms
2025/09/19 04:09:50 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:50 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:50 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:50 ERROR : file1: vfs cache: failed to upload try #2, will retry in 400ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:50 DEBUG : Looking for writers
2025/09/19 04:09:50 DEBUG : file1: reading active writers
2025/09/19 04:09:50 DEBUG : Still 0 writers active and 1 cache items in use, waiting 640ms
2025/09/19 04:09:50 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:50 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:50 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:50 ERROR : file1: vfs cache: failed to upload try #3, will retry in 800ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:51 DEBUG : Looking for writers
2025/09/19 04:09:51 DEBUG : file1: reading active writers
2025/09/19 04:09:51 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:51 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:51 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:51 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:51 ERROR : file1: vfs cache: failed to upload try #4, will retry in 1.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:52 DEBUG : Looking for writers
2025/09/19 04:09:52 DEBUG : file1: reading active writers
2025/09/19 04:09:52 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:53 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:53 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:53 DEBUG : Looking for writers
2025/09/19 04:09:53 DEBUG : file1: reading active writers
2025/09/19 04:09:53 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:53 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:53 ERROR : file1: vfs cache: failed to upload try #5, will retry in 3.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:54 DEBUG : Looking for writers
2025/09/19 04:09:54 DEBUG : file1: reading active writers
2025/09/19 04:09:54 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:55 DEBUG : Looking for writers
2025/09/19 04:09:55 DEBUG : file1: reading active writers
2025/09/19 04:09:55 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:56 DEBUG : Looking for writers
2025/09/19 04:09:56 DEBUG : file1: reading active writers
2025/09/19 04:09:56 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:56 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:09:56 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:09:56 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:09:56 ERROR : file1: vfs cache: failed to upload try #6, will retry in 6.4s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:09:57 DEBUG : Looking for writers
2025/09/19 04:09:57 DEBUG : file1: reading active writers
2025/09/19 04:09:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:58 DEBUG : Looking for writers
2025/09/19 04:09:58 DEBUG : file1: reading active writers
2025/09/19 04:09:58 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:09:59 DEBUG : Looking for writers
2025/09/19 04:09:59 DEBUG : file1: reading active writers
2025/09/19 04:09:59 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:00 DEBUG : Looking for writers
2025/09/19 04:10:00 DEBUG : file1: reading active writers
2025/09/19 04:10:00 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:01 DEBUG : Looking for writers
2025/09/19 04:10:01 DEBUG : file1: reading active writers
2025/09/19 04:10:01 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:02 DEBUG : Looking for writers
2025/09/19 04:10:02 DEBUG : file1: reading active writers
2025/09/19 04:10:02 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:02 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:02 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:02 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:02 ERROR : file1: vfs cache: failed to upload try #7, will retry in 12.8s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:03 DEBUG : Looking for writers
2025/09/19 04:10:03 DEBUG : file1: reading active writers
2025/09/19 04:10:03 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:04 DEBUG : Looking for writers
2025/09/19 04:10:04 DEBUG : file1: reading active writers
2025/09/19 04:10:04 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:05 DEBUG : Looking for writers
2025/09/19 04:10:05 DEBUG : file1: reading active writers
2025/09/19 04:10:05 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:06 DEBUG : Looking for writers
2025/09/19 04:10:06 DEBUG : file1: reading active writers
2025/09/19 04:10:06 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:07 DEBUG : Looking for writers
2025/09/19 04:10:07 DEBUG : file1: reading active writers
2025/09/19 04:10:07 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:08 DEBUG : Looking for writers
2025/09/19 04:10:08 DEBUG : file1: reading active writers
2025/09/19 04:10:08 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:09 DEBUG : Looking for writers
2025/09/19 04:10:09 DEBUG : file1: reading active writers
2025/09/19 04:10:09 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:10 DEBUG : Looking for writers
2025/09/19 04:10:10 DEBUG : file1: reading active writers
2025/09/19 04:10:10 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:11 DEBUG : Looking for writers
2025/09/19 04:10:11 DEBUG : file1: reading active writers
2025/09/19 04:10:11 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:12 DEBUG : Looking for writers
2025/09/19 04:10:12 DEBUG : file1: reading active writers
2025/09/19 04:10:12 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:13 DEBUG : Looking for writers
2025/09/19 04:10:13 DEBUG : file1: reading active writers
2025/09/19 04:10:13 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:14 DEBUG : Looking for writers
2025/09/19 04:10:14 DEBUG : file1: reading active writers
2025/09/19 04:10:14 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:15 DEBUG : Looking for writers
2025/09/19 04:10:15 DEBUG : file1: reading active writers
2025/09/19 04:10:15 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:15 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:15 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:15 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:15 ERROR : file1: vfs cache: failed to upload try #8, will retry in 25.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:16 DEBUG : Looking for writers
2025/09/19 04:10:16 DEBUG : file1: reading active writers
2025/09/19 04:10:16 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:17 DEBUG : Looking for writers
2025/09/19 04:10:17 DEBUG : file1: reading active writers
2025/09/19 04:10:17 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:18 DEBUG : Looking for writers
2025/09/19 04:10:18 DEBUG : file1: reading active writers
2025/09/19 04:10:18 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:19 DEBUG : Looking for writers
2025/09/19 04:10:19 DEBUG : file1: reading active writers
2025/09/19 04:10:19 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:19 ERROR : Exiting even though 0 writers active and 1 cache items in use after 30s
Cache{
	"file1": &{c:0xc0008410e0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc0001e7d08 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824635718976} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368766307266411 ext:7918344400 loc:0x411a0a0} ATime:{wall:13991368766307352953 ext:7918430932 loc:0x411a0a0} Size:11 Rs:[{Pos:0 Size:11}] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:10:19 DEBUG : >WaitForWriters: 
2025/09/19 04:10:19 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:10:19 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2025/09/19 04:10:20 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:10:20 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2025/09/19 04:10:23 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:10:23 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:337
        	Error:      	Should be true
        	Test:       	TestRWFileHandleMethodsWrite
        	Messages:   	listing wrong, want
        	            	  file1 (11) got
        	            	  
    fstest.go:203: Not found "file1"
    fstest.go:206: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:337
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestRWFileHandleMethodsWrite
        	Messages:   	1 objects not found
2025/09/19 04:10:27 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 10ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 20ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 40ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 80ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 160ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 320ms
2025/09/19 04:10:27 DEBUG : Looking for writers
2025/09/19 04:10:27 DEBUG : file1: reading active writers
2025/09/19 04:10:27 DEBUG : Still 0 writers active and 1 cache items in use, waiting 640ms
2025/09/19 04:10:28 DEBUG : Looking for writers
2025/09/19 04:10:28 DEBUG : file1: reading active writers
2025/09/19 04:10:28 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:29 DEBUG : Looking for writers
2025/09/19 04:10:29 DEBUG : file1: reading active writers
2025/09/19 04:10:29 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:30 DEBUG : Looking for writers
2025/09/19 04:10:30 DEBUG : file1: reading active writers
2025/09/19 04:10:30 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:31 DEBUG : Looking for writers
2025/09/19 04:10:31 DEBUG : file1: reading active writers
2025/09/19 04:10:31 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:32 DEBUG : Looking for writers
2025/09/19 04:10:32 DEBUG : file1: reading active writers
2025/09/19 04:10:32 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:33 DEBUG : Looking for writers
2025/09/19 04:10:33 DEBUG : file1: reading active writers
2025/09/19 04:10:33 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:34 DEBUG : Looking for writers
2025/09/19 04:10:34 DEBUG : file1: reading active writers
2025/09/19 04:10:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:35 DEBUG : Looking for writers
2025/09/19 04:10:35 DEBUG : file1: reading active writers
2025/09/19 04:10:35 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:36 DEBUG : Looking for writers
2025/09/19 04:10:36 DEBUG : file1: reading active writers
2025/09/19 04:10:36 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:37 DEBUG : Looking for writers
2025/09/19 04:10:37 DEBUG : file1: reading active writers
2025/09/19 04:10:37 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:38 DEBUG : Looking for writers
2025/09/19 04:10:38 DEBUG : file1: reading active writers
2025/09/19 04:10:38 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:39 DEBUG : Looking for writers
2025/09/19 04:10:39 DEBUG : file1: reading active writers
2025/09/19 04:10:39 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:40 DEBUG : Looking for writers
2025/09/19 04:10:40 DEBUG : file1: reading active writers
2025/09/19 04:10:40 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:41 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:41 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:41 DEBUG : Looking for writers
2025/09/19 04:10:41 DEBUG : file1: reading active writers
2025/09/19 04:10:41 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:41 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:41 ERROR : file1: vfs cache: failed to upload try #9, will retry in 51.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:42 DEBUG : Looking for writers
2025/09/19 04:10:42 DEBUG : file1: reading active writers
2025/09/19 04:10:42 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:43 DEBUG : Looking for writers
2025/09/19 04:10:43 DEBUG : file1: reading active writers
2025/09/19 04:10:43 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:44 DEBUG : Looking for writers
2025/09/19 04:10:44 DEBUG : file1: reading active writers
2025/09/19 04:10:44 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:45 DEBUG : Looking for writers
2025/09/19 04:10:45 DEBUG : file1: reading active writers
2025/09/19 04:10:45 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:46 DEBUG : Looking for writers
2025/09/19 04:10:46 DEBUG : file1: reading active writers
2025/09/19 04:10:46 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:47 DEBUG : Looking for writers
2025/09/19 04:10:47 DEBUG : file1: reading active writers
2025/09/19 04:10:47 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:48 DEBUG : Looking for writers
2025/09/19 04:10:48 DEBUG : file1: reading active writers
2025/09/19 04:10:48 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:49 DEBUG : Looking for writers
2025/09/19 04:10:49 DEBUG : file1: reading active writers
2025/09/19 04:10:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:49 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache RemoveNotInUse (maxAge=3600000000000, emptyOnly=false): item file1 not removed, freed 0 bytes
2025/09/19 04:10:49 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 1 (was 1) in use 1, to upload 1, uploading 0, total size 11 (was 11)
2025/09/19 04:10:50 DEBUG : Looking for writers
2025/09/19 04:10:50 DEBUG : file1: reading active writers
2025/09/19 04:10:50 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:51 DEBUG : Looking for writers
2025/09/19 04:10:51 DEBUG : file1: reading active writers
2025/09/19 04:10:51 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:52 DEBUG : Looking for writers
2025/09/19 04:10:52 DEBUG : file1: reading active writers
2025/09/19 04:10:52 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:53 DEBUG : Looking for writers
2025/09/19 04:10:53 DEBUG : file1: reading active writers
2025/09/19 04:10:53 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:54 DEBUG : Looking for writers
2025/09/19 04:10:54 DEBUG : file1: reading active writers
2025/09/19 04:10:54 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:55 DEBUG : Looking for writers
2025/09/19 04:10:55 DEBUG : file1: reading active writers
2025/09/19 04:10:55 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:56 DEBUG : Looking for writers
2025/09/19 04:10:56 DEBUG : file1: reading active writers
2025/09/19 04:10:56 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:57 ERROR : Exiting even though 0 writers active and 1 cache items in use after 30s
Cache{
	"file1": &{c:0xc0008410e0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc0001e7d08 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824635718976} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368766307266411 ext:7918344400 loc:0x411a0a0} ATime:{wall:13991368766307352953 ext:7918430932 loc:0x411a0a0} Size:11 Rs:[{Pos:0 Size:11}] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:10:57 DEBUG : >WaitForWriters: 
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleMethodsWrite (67.39s)
=== RUN   TestRWFileHandleWriteAt
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:10:57 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : Config file has changed externally - reloading
2025/09/19 04:10:57 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:10:57 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:10:57 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:10:57 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:10:57 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2025/09/19 04:10:57 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:10:57 DEBUG : file1: newRWFileHandle: 
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): openPending: 
2025/09/19 04:10:57 DEBUG : file1: vfs cache: truncate to size=0 (not needed as size correct)
2025/09/19 04:10:57 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): >openPending: err=<nil>
2025/09/19 04:10:57 DEBUG : file1: >newRWFileHandle: err=<nil>
2025/09/19 04:10:57 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:10:57 DEBUG : file1: >Open: fd=file1 (rw), err=<nil>
2025/09/19 04:10:57 DEBUG : file1: >OpenFile: fd=file1 (rw), err=<nil>
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): _writeAt: size=7, off=0
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): >_writeAt: n=7, err=<nil>
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): _writeAt: size=6, off=5
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): >_writeAt: n=6, err=<nil>
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): close: 
2025/09/19 04:10:57 DEBUG : file1: vfs cache: setting modification time to 2025-09-19 04:10:57.314037484 +0000 UTC m=+75.339163187
2025/09/19 04:10:57 INFO  : file1: vfs cache: queuing for upload in 100ms
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): >close: err=<nil>
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): _writeAt: size=5, off=0
2025/09/19 04:10:57 DEBUG : file1(0xc000a210c0): >_writeAt: n=0, err=file already closed
2025/09/19 04:10:57 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 10ms
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 20ms
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 40ms
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 80ms
2025/09/19 04:10:57 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:57 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:57 ERROR : file1: vfs cache: failed to upload try #1, will retry in 200ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 160ms
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 320ms
2025/09/19 04:10:57 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:57 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:57 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:57 ERROR : file1: vfs cache: failed to upload try #2, will retry in 400ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:57 DEBUG : Looking for writers
2025/09/19 04:10:57 DEBUG : file1: reading active writers
2025/09/19 04:10:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 640ms
2025/09/19 04:10:58 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:58 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:58 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:58 ERROR : file1: vfs cache: failed to upload try #3, will retry in 800ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:58 DEBUG : Looking for writers
2025/09/19 04:10:58 DEBUG : file1: reading active writers
2025/09/19 04:10:58 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:10:58 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:10:58 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:10:59 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:10:59 ERROR : file1: vfs cache: failed to upload try #4, will retry in 1.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:10:59 DEBUG : Looking for writers
2025/09/19 04:10:59 DEBUG : file1: reading active writers
2025/09/19 04:10:59 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:00 DEBUG : Looking for writers
2025/09/19 04:11:00 DEBUG : file1: reading active writers
2025/09/19 04:11:00 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:00 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:11:00 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:11:00 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:11:00 ERROR : file1: vfs cache: failed to upload try #5, will retry in 3.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:11:01 DEBUG : Looking for writers
2025/09/19 04:11:01 DEBUG : file1: reading active writers
2025/09/19 04:11:01 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:02 DEBUG : Looking for writers
2025/09/19 04:11:02 DEBUG : file1: reading active writers
2025/09/19 04:11:02 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:03 DEBUG : Looking for writers
2025/09/19 04:11:03 DEBUG : file1: reading active writers
2025/09/19 04:11:03 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:03 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:11:03 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:11:03 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:11:03 ERROR : file1: vfs cache: failed to upload try #6, will retry in 6.4s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:11:04 DEBUG : Looking for writers
2025/09/19 04:11:04 DEBUG : file1: reading active writers
2025/09/19 04:11:04 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:05 DEBUG : Looking for writers
2025/09/19 04:11:05 DEBUG : file1: reading active writers
2025/09/19 04:11:05 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:06 DEBUG : Looking for writers
2025/09/19 04:11:06 DEBUG : file1: reading active writers
2025/09/19 04:11:06 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:07 DEBUG : Looking for writers
2025/09/19 04:11:07 DEBUG : file1: reading active writers
2025/09/19 04:11:07 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:08 DEBUG : Looking for writers
2025/09/19 04:11:08 DEBUG : file1: reading active writers
2025/09/19 04:11:08 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:09 DEBUG : Looking for writers
2025/09/19 04:11:09 DEBUG : file1: reading active writers
2025/09/19 04:11:09 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:10 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:11:10 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:11:10 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:11:10 ERROR : file1: vfs cache: failed to upload try #7, will retry in 12.8s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:11:10 DEBUG : Looking for writers
2025/09/19 04:11:10 DEBUG : file1: reading active writers
2025/09/19 04:11:10 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:11 DEBUG : Looking for writers
2025/09/19 04:11:11 DEBUG : file1: reading active writers
2025/09/19 04:11:11 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:12 DEBUG : Looking for writers
2025/09/19 04:11:12 DEBUG : file1: reading active writers
2025/09/19 04:11:12 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:13 DEBUG : Looking for writers
2025/09/19 04:11:13 DEBUG : file1: reading active writers
2025/09/19 04:11:13 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:14 DEBUG : Looking for writers
2025/09/19 04:11:14 DEBUG : file1: reading active writers
2025/09/19 04:11:14 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:15 DEBUG : Looking for writers
2025/09/19 04:11:15 DEBUG : file1: reading active writers
2025/09/19 04:11:15 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:16 DEBUG : Looking for writers
2025/09/19 04:11:16 DEBUG : file1: reading active writers
2025/09/19 04:11:16 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:17 DEBUG : Looking for writers
2025/09/19 04:11:17 DEBUG : file1: reading active writers
2025/09/19 04:11:17 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:18 DEBUG : Looking for writers
2025/09/19 04:11:18 DEBUG : file1: reading active writers
2025/09/19 04:11:18 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:19 DEBUG : Looking for writers
2025/09/19 04:11:19 DEBUG : file1: reading active writers
2025/09/19 04:11:19 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:20 DEBUG : Looking for writers
2025/09/19 04:11:20 DEBUG : file1: reading active writers
2025/09/19 04:11:20 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:21 DEBUG : Looking for writers
2025/09/19 04:11:21 DEBUG : file1: reading active writers
2025/09/19 04:11:21 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:22 DEBUG : Looking for writers
2025/09/19 04:11:22 DEBUG : file1: reading active writers
2025/09/19 04:11:22 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:23 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:11:23 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:11:23 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:11:23 ERROR : file1: vfs cache: failed to upload try #8, will retry in 25.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:11:23 DEBUG : Looking for writers
2025/09/19 04:11:23 DEBUG : file1: reading active writers
2025/09/19 04:11:23 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:24 DEBUG : Looking for writers
2025/09/19 04:11:24 DEBUG : file1: reading active writers
2025/09/19 04:11:24 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:25 DEBUG : Looking for writers
2025/09/19 04:11:25 DEBUG : file1: reading active writers
2025/09/19 04:11:25 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:26 DEBUG : Looking for writers
2025/09/19 04:11:26 DEBUG : file1: reading active writers
2025/09/19 04:11:26 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:27 ERROR : Exiting even though 0 writers active and 1 cache items in use after 30s
Cache{
	"file1": &{c:0xc000ab5a40 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000a4f508 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824644531520} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368838742529260 ext:75339163187 loc:0x411a0a0} ATime:{wall:13991368838742642203 ext:75339276130 loc:0x411a0a0} Size:11 Rs:[{Pos:0 Size:11}] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:11:27 DEBUG : >WaitForWriters: 
2025/09/19 04:11:27 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:11:27 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2025/09/19 04:11:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:11:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2025/09/19 04:11:30 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:11:30 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:387
        	Error:      	Should be true
        	Test:       	TestRWFileHandleWriteAt
        	Messages:   	listing wrong, want
        	            	  file1 (11) got
        	            	  
    fstest.go:203: Not found "file1"
    fstest.go:206: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:387
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestRWFileHandleWriteAt
        	Messages:   	1 objects not found
2025/09/19 04:11:34 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 10ms
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 20ms
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 40ms
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 80ms
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 160ms
2025/09/19 04:11:34 DEBUG : Looking for writers
2025/09/19 04:11:34 DEBUG : file1: reading active writers
2025/09/19 04:11:34 DEBUG : Still 0 writers active and 1 cache items in use, waiting 320ms
2025/09/19 04:11:35 DEBUG : Looking for writers
2025/09/19 04:11:35 DEBUG : file1: reading active writers
2025/09/19 04:11:35 DEBUG : Still 0 writers active and 1 cache items in use, waiting 640ms
2025/09/19 04:11:35 DEBUG : Looking for writers
2025/09/19 04:11:35 DEBUG : file1: reading active writers
2025/09/19 04:11:35 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:36 DEBUG : Looking for writers
2025/09/19 04:11:36 DEBUG : file1: reading active writers
2025/09/19 04:11:36 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:37 DEBUG : Looking for writers
2025/09/19 04:11:37 DEBUG : file1: reading active writers
2025/09/19 04:11:37 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:38 DEBUG : Looking for writers
2025/09/19 04:11:38 DEBUG : file1: reading active writers
2025/09/19 04:11:38 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:39 DEBUG : Looking for writers
2025/09/19 04:11:39 DEBUG : file1: reading active writers
2025/09/19 04:11:39 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:40 DEBUG : Looking for writers
2025/09/19 04:11:40 DEBUG : file1: reading active writers
2025/09/19 04:11:40 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:41 DEBUG : Looking for writers
2025/09/19 04:11:41 DEBUG : file1: reading active writers
2025/09/19 04:11:41 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:42 DEBUG : Looking for writers
2025/09/19 04:11:42 DEBUG : file1: reading active writers
2025/09/19 04:11:42 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:43 DEBUG : Looking for writers
2025/09/19 04:11:43 DEBUG : file1: reading active writers
2025/09/19 04:11:43 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:44 DEBUG : Looking for writers
2025/09/19 04:11:44 DEBUG : file1: reading active writers
2025/09/19 04:11:44 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:45 DEBUG : Looking for writers
2025/09/19 04:11:45 DEBUG : file1: reading active writers
2025/09/19 04:11:45 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:46 DEBUG : Looking for writers
2025/09/19 04:11:46 DEBUG : file1: reading active writers
2025/09/19 04:11:46 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:47 DEBUG : Looking for writers
2025/09/19 04:11:47 DEBUG : file1: reading active writers
2025/09/19 04:11:47 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:48 DEBUG : Looking for writers
2025/09/19 04:11:48 DEBUG : file1: reading active writers
2025/09/19 04:11:48 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:48 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:11:48 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:11:49 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:11:49 ERROR : file1: vfs cache: failed to upload try #9, will retry in 51.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:11:49 DEBUG : Looking for writers
2025/09/19 04:11:49 DEBUG : file1: reading active writers
2025/09/19 04:11:49 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:50 DEBUG : Looking for writers
2025/09/19 04:11:50 DEBUG : file1: reading active writers
2025/09/19 04:11:50 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:51 DEBUG : Looking for writers
2025/09/19 04:11:51 DEBUG : file1: reading active writers
2025/09/19 04:11:51 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:52 DEBUG : Looking for writers
2025/09/19 04:11:52 DEBUG : file1: reading active writers
2025/09/19 04:11:52 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:53 DEBUG : Looking for writers
2025/09/19 04:11:53 DEBUG : file1: reading active writers
2025/09/19 04:11:53 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:54 DEBUG : Looking for writers
2025/09/19 04:11:54 DEBUG : file1: reading active writers
2025/09/19 04:11:54 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:55 DEBUG : Looking for writers
2025/09/19 04:11:55 DEBUG : file1: reading active writers
2025/09/19 04:11:55 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:56 DEBUG : Looking for writers
2025/09/19 04:11:56 DEBUG : file1: reading active writers
2025/09/19 04:11:56 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:57 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache RemoveNotInUse (maxAge=3600000000000, emptyOnly=false): item file1 not removed, freed 0 bytes
2025/09/19 04:11:57 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 1 (was 1) in use 1, to upload 1, uploading 0, total size 11 (was 11)
2025/09/19 04:11:57 DEBUG : Looking for writers
2025/09/19 04:11:57 DEBUG : file1: reading active writers
2025/09/19 04:11:57 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:58 DEBUG : Looking for writers
2025/09/19 04:11:58 DEBUG : file1: reading active writers
2025/09/19 04:11:58 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:11:59 DEBUG : Looking for writers
2025/09/19 04:11:59 DEBUG : file1: reading active writers
2025/09/19 04:11:59 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:12:00 DEBUG : Looking for writers
2025/09/19 04:12:00 DEBUG : file1: reading active writers
2025/09/19 04:12:00 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:12:01 DEBUG : Looking for writers
2025/09/19 04:12:01 DEBUG : file1: reading active writers
2025/09/19 04:12:01 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:12:02 DEBUG : Looking for writers
2025/09/19 04:12:02 DEBUG : file1: reading active writers
2025/09/19 04:12:02 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:12:03 DEBUG : Looking for writers
2025/09/19 04:12:03 DEBUG : file1: reading active writers
2025/09/19 04:12:03 DEBUG : Still 0 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:12:04 ERROR : Exiting even though 0 writers active and 1 cache items in use after 30s
Cache{
	"file1": &{c:0xc000ab5a40 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000a4f508 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824644531520} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368838742529260 ext:75339163187 loc:0x411a0a0} ATime:{wall:13991368838742642203 ext:75339276130 loc:0x411a0a0} Size:11 Rs:[{Pos:0 Size:11}] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:12:04 DEBUG : >WaitForWriters: 
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleWriteAt (67.45s)
=== RUN   TestRWFileHandleWriteNoWrite
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:12:04 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:12:04 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:12:04 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:12:04 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2025/09/19 04:12:04 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:12:04 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:12:04 DEBUG : file1: newRWFileHandle: 
2025/09/19 04:12:04 DEBUG : file1(0xc000b0dd00): openPending: 
2025/09/19 04:12:04 DEBUG : file1: vfs cache: truncate to size=0 (not needed as size correct)
2025/09/19 04:12:04 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:12:04 DEBUG : file1(0xc000b0dd00): >openPending: err=<nil>
2025/09/19 04:12:04 DEBUG : file1: >newRWFileHandle: err=<nil>
2025/09/19 04:12:04 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:12:04 DEBUG : file1: >Open: fd=file1 (rw), err=<nil>
2025/09/19 04:12:04 DEBUG : file1: >OpenFile: fd=file1 (rw), err=<nil>
2025/09/19 04:12:04 DEBUG : file1(0xc000b0dd00): close: 
2025/09/19 04:12:04 DEBUG : file1: vfs cache: setting modification time to 2025-09-19 04:12:04.726389517 +0000 UTC m=+142.751515200
2025/09/19 04:12:04 INFO  : file1: vfs cache: queuing for upload in 100ms
2025/09/19 04:12:04 DEBUG : file1(0xc000b0dd00): >close: err=<nil>
2025/09/19 04:12:04 DEBUG : file2: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx
2025/09/19 04:12:04 DEBUG : file2: Open: flags=O_WRONLY|O_CREATE|O_TRUNC
2025/09/19 04:12:04 DEBUG : file2: newRWFileHandle: 
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): openPending: 
2025/09/19 04:12:04 DEBUG : file2: vfs cache: truncate to size=0 (not needed as size correct)
2025/09/19 04:12:04 DEBUG : Added virtual directory entry vAddFile: "file2"
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): >openPending: err=<nil>
2025/09/19 04:12:04 DEBUG : file2: >newRWFileHandle: err=<nil>
2025/09/19 04:12:04 DEBUG : Added virtual directory entry vAddFile: "file2"
2025/09/19 04:12:04 DEBUG : file2: >Open: fd=file2 (rw), err=<nil>
2025/09/19 04:12:04 DEBUG : file2: >OpenFile: fd=file2 (rw), err=<nil>
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): RWFileHandle.Flush
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): RWFileHandle.Release
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): close: 
2025/09/19 04:12:04 DEBUG : file2: vfs cache: setting modification time to 2025-09-19 04:12:04.730947136 +0000 UTC m=+142.756072820
2025/09/19 04:12:04 INFO  : file2: vfs cache: queuing for upload in 100ms
2025/09/19 04:12:04 DEBUG : file2(0xc00078a2c0): >close: err=<nil>
2025/09/19 04:12:04 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:12:04 DEBUG : Looking for writers
2025/09/19 04:12:04 DEBUG : file1: reading active writers
2025/09/19 04:12:04 DEBUG : file2: reading active writers
2025/09/19 04:12:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 10ms
2025/09/19 04:12:04 DEBUG : Looking for writers
2025/09/19 04:12:04 DEBUG : file1: reading active writers
2025/09/19 04:12:04 DEBUG : file2: reading active writers
2025/09/19 04:12:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 20ms
2025/09/19 04:12:04 DEBUG : Looking for writers
2025/09/19 04:12:04 DEBUG : file1: reading active writers
2025/09/19 04:12:04 DEBUG : file2: reading active writers
2025/09/19 04:12:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 40ms
2025/09/19 04:12:04 DEBUG : Looking for writers
2025/09/19 04:12:04 DEBUG : file1: reading active writers
2025/09/19 04:12:04 DEBUG : file2: reading active writers
2025/09/19 04:12:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 80ms
2025/09/19 04:12:04 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:04 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:04 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:04 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:04 ERROR : file1: vfs cache: failed to upload try #1, will retry in 200ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:04 DEBUG : Looking for writers
2025/09/19 04:12:04 DEBUG : file2: reading active writers
2025/09/19 04:12:04 DEBUG : file1: reading active writers
2025/09/19 04:12:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 160ms
2025/09/19 04:12:04 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:04 ERROR : file2: vfs cache: failed to upload try #1, will retry in 200ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:05 DEBUG : Looking for writers
2025/09/19 04:12:05 DEBUG : file2: reading active writers
2025/09/19 04:12:05 DEBUG : file1: reading active writers
2025/09/19 04:12:05 DEBUG : Still 0 writers active and 2 cache items in use, waiting 320ms
2025/09/19 04:12:05 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:05 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:05 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:05 ERROR : file1: vfs cache: failed to upload try #2, will retry in 400ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:05 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:05 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:05 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:05 ERROR : file2: vfs cache: failed to upload try #2, will retry in 400ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:05 DEBUG : Looking for writers
2025/09/19 04:12:05 DEBUG : file1: reading active writers
2025/09/19 04:12:05 DEBUG : file2: reading active writers
2025/09/19 04:12:05 DEBUG : Still 0 writers active and 2 cache items in use, waiting 640ms
2025/09/19 04:12:05 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:05 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:05 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:05 ERROR : file1: vfs cache: failed to upload try #3, will retry in 800ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:05 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:05 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:05 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:05 ERROR : file2: vfs cache: failed to upload try #3, will retry in 800ms: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:06 DEBUG : Looking for writers
2025/09/19 04:12:06 DEBUG : file1: reading active writers
2025/09/19 04:12:06 DEBUG : file2: reading active writers
2025/09/19 04:12:06 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:06 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:06 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:06 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:06 ERROR : file1: vfs cache: failed to upload try #4, will retry in 1.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:06 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:06 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:06 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:06 ERROR : file2: vfs cache: failed to upload try #4, will retry in 1.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:07 DEBUG : Looking for writers
2025/09/19 04:12:07 DEBUG : file2: reading active writers
2025/09/19 04:12:07 DEBUG : file1: reading active writers
2025/09/19 04:12:07 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:08 DEBUG : Looking for writers
2025/09/19 04:12:08 DEBUG : file1: reading active writers
2025/09/19 04:12:08 DEBUG : file2: reading active writers
2025/09/19 04:12:08 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:08 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:08 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:08 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:08 ERROR : file1: vfs cache: failed to upload try #5, will retry in 3.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:08 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:08 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:08 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:08 ERROR : file2: vfs cache: failed to upload try #5, will retry in 3.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:09 DEBUG : Looking for writers
2025/09/19 04:12:09 DEBUG : file1: reading active writers
2025/09/19 04:12:09 DEBUG : file2: reading active writers
2025/09/19 04:12:09 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:10 DEBUG : Looking for writers
2025/09/19 04:12:10 DEBUG : file1: reading active writers
2025/09/19 04:12:10 DEBUG : file2: reading active writers
2025/09/19 04:12:10 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:11 DEBUG : Looking for writers
2025/09/19 04:12:11 DEBUG : file1: reading active writers
2025/09/19 04:12:11 DEBUG : file2: reading active writers
2025/09/19 04:12:11 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:11 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:11 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:11 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:11 ERROR : file1: vfs cache: failed to upload try #6, will retry in 6.4s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:11 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:11 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:11 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:11 ERROR : file2: vfs cache: failed to upload try #6, will retry in 6.4s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:12 DEBUG : Looking for writers
2025/09/19 04:12:12 DEBUG : file1: reading active writers
2025/09/19 04:12:12 DEBUG : file2: reading active writers
2025/09/19 04:12:12 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:13 DEBUG : Looking for writers
2025/09/19 04:12:13 DEBUG : file1: reading active writers
2025/09/19 04:12:13 DEBUG : file2: reading active writers
2025/09/19 04:12:13 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:14 DEBUG : Looking for writers
2025/09/19 04:12:14 DEBUG : file1: reading active writers
2025/09/19 04:12:14 DEBUG : file2: reading active writers
2025/09/19 04:12:14 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:15 DEBUG : Looking for writers
2025/09/19 04:12:15 DEBUG : file1: reading active writers
2025/09/19 04:12:15 DEBUG : file2: reading active writers
2025/09/19 04:12:15 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:16 DEBUG : Looking for writers
2025/09/19 04:12:16 DEBUG : file1: reading active writers
2025/09/19 04:12:16 DEBUG : file2: reading active writers
2025/09/19 04:12:16 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:17 DEBUG : Looking for writers
2025/09/19 04:12:17 DEBUG : file1: reading active writers
2025/09/19 04:12:17 DEBUG : file2: reading active writers
2025/09/19 04:12:17 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:17 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:17 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:17 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:17 ERROR : file1: vfs cache: failed to upload try #7, will retry in 12.8s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:17 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:17 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:17 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:17 ERROR : file2: vfs cache: failed to upload try #7, will retry in 12.8s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:18 DEBUG : Looking for writers
2025/09/19 04:12:18 DEBUG : file1: reading active writers
2025/09/19 04:12:18 DEBUG : file2: reading active writers
2025/09/19 04:12:18 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:19 DEBUG : Looking for writers
2025/09/19 04:12:19 DEBUG : file1: reading active writers
2025/09/19 04:12:19 DEBUG : file2: reading active writers
2025/09/19 04:12:19 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:20 DEBUG : Looking for writers
2025/09/19 04:12:20 DEBUG : file1: reading active writers
2025/09/19 04:12:20 DEBUG : file2: reading active writers
2025/09/19 04:12:20 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:21 DEBUG : Looking for writers
2025/09/19 04:12:21 DEBUG : file1: reading active writers
2025/09/19 04:12:21 DEBUG : file2: reading active writers
2025/09/19 04:12:21 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:22 DEBUG : Looking for writers
2025/09/19 04:12:22 DEBUG : file1: reading active writers
2025/09/19 04:12:22 DEBUG : file2: reading active writers
2025/09/19 04:12:22 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:23 DEBUG : Looking for writers
2025/09/19 04:12:23 DEBUG : file1: reading active writers
2025/09/19 04:12:23 DEBUG : file2: reading active writers
2025/09/19 04:12:23 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:24 DEBUG : Looking for writers
2025/09/19 04:12:24 DEBUG : file1: reading active writers
2025/09/19 04:12:24 DEBUG : file2: reading active writers
2025/09/19 04:12:24 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:25 DEBUG : Looking for writers
2025/09/19 04:12:25 DEBUG : file1: reading active writers
2025/09/19 04:12:25 DEBUG : file2: reading active writers
2025/09/19 04:12:25 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:26 DEBUG : Looking for writers
2025/09/19 04:12:26 DEBUG : file1: reading active writers
2025/09/19 04:12:26 DEBUG : file2: reading active writers
2025/09/19 04:12:26 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:27 DEBUG : Looking for writers
2025/09/19 04:12:27 DEBUG : file1: reading active writers
2025/09/19 04:12:27 DEBUG : file2: reading active writers
2025/09/19 04:12:27 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:28 DEBUG : Looking for writers
2025/09/19 04:12:28 DEBUG : file1: reading active writers
2025/09/19 04:12:28 DEBUG : file2: reading active writers
2025/09/19 04:12:28 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:29 DEBUG : Looking for writers
2025/09/19 04:12:29 DEBUG : file1: reading active writers
2025/09/19 04:12:29 DEBUG : file2: reading active writers
2025/09/19 04:12:29 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:30 DEBUG : Looking for writers
2025/09/19 04:12:30 DEBUG : file1: reading active writers
2025/09/19 04:12:30 DEBUG : file2: reading active writers
2025/09/19 04:12:30 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:30 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:30 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:30 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:30 ERROR : file1: vfs cache: failed to upload try #8, will retry in 25.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:30 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:30 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:30 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:30 ERROR : file2: vfs cache: failed to upload try #8, will retry in 25.6s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:31 DEBUG : Looking for writers
2025/09/19 04:12:31 DEBUG : file1: reading active writers
2025/09/19 04:12:31 DEBUG : file2: reading active writers
2025/09/19 04:12:31 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:32 DEBUG : Looking for writers
2025/09/19 04:12:32 DEBUG : file1: reading active writers
2025/09/19 04:12:32 DEBUG : file2: reading active writers
2025/09/19 04:12:32 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:33 DEBUG : Looking for writers
2025/09/19 04:12:33 DEBUG : file1: reading active writers
2025/09/19 04:12:33 DEBUG : file2: reading active writers
2025/09/19 04:12:33 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:34 DEBUG : Looking for writers
2025/09/19 04:12:34 DEBUG : file1: reading active writers
2025/09/19 04:12:34 DEBUG : file2: reading active writers
2025/09/19 04:12:34 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:34 ERROR : Exiting even though 0 writers active and 2 cache items in use after 30s
Cache{
	"file1": &{c:0xc0007373b0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000af3108 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824645202240} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368911095583501 ext:142751515200 loc:0x411a0a0} ATime:{wall:13991368911095856144 ext:142751787843 loc:0x411a0a0} Size:0 Rs:[] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
	"file2": &{c:0xc0007373b0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000af3208 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824645202496} name:file2 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368911100141120 ext:142756072820 loc:0x411a0a0} ATime:{wall:13991368911100387414 ext:142756319113 loc:0x411a0a0} Size:0 Rs:[] Fingerprint: Dirty:true} writeBackID:2 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:12:34 DEBUG : >WaitForWriters: 
2025/09/19 04:12:34 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:12:34 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2025/09/19 04:12:35 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:12:35 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2025/09/19 04:12:37 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:12:37 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:420
        	Error:      	Should be true
        	Test:       	TestRWFileHandleWriteNoWrite
        	Messages:   	listing wrong, want
        	            	  file1 (0), file2 (0) got
        	            	  
    fstest.go:203: Not found "file1"
    fstest.go:203: Not found "file2"
    fstest.go:206: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/read_write_test.go:420
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 2
        	Test:       	TestRWFileHandleWriteNoWrite
        	Messages:   	2 objects not found
2025/09/19 04:12:41 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:12:41 DEBUG : Looking for writers
2025/09/19 04:12:41 DEBUG : file1: reading active writers
2025/09/19 04:12:41 DEBUG : file2: reading active writers
2025/09/19 04:12:41 DEBUG : Still 0 writers active and 2 cache items in use, waiting 10ms
2025/09/19 04:12:41 DEBUG : Looking for writers
2025/09/19 04:12:41 DEBUG : file1: reading active writers
2025/09/19 04:12:41 DEBUG : file2: reading active writers
2025/09/19 04:12:41 DEBUG : Still 0 writers active and 2 cache items in use, waiting 20ms
2025/09/19 04:12:41 DEBUG : Looking for writers
2025/09/19 04:12:41 DEBUG : file1: reading active writers
2025/09/19 04:12:41 DEBUG : file2: reading active writers
2025/09/19 04:12:41 DEBUG : Still 0 writers active and 2 cache items in use, waiting 40ms
2025/09/19 04:12:41 DEBUG : Looking for writers
2025/09/19 04:12:41 DEBUG : file1: reading active writers
2025/09/19 04:12:41 DEBUG : file2: reading active writers
2025/09/19 04:12:41 DEBUG : Still 0 writers active and 2 cache items in use, waiting 80ms
2025/09/19 04:12:41 DEBUG : Looking for writers
2025/09/19 04:12:41 DEBUG : file1: reading active writers
2025/09/19 04:12:41 DEBUG : file2: reading active writers
2025/09/19 04:12:41 DEBUG : Still 0 writers active and 2 cache items in use, waiting 160ms
2025/09/19 04:12:42 DEBUG : Looking for writers
2025/09/19 04:12:42 DEBUG : file1: reading active writers
2025/09/19 04:12:42 DEBUG : file2: reading active writers
2025/09/19 04:12:42 DEBUG : Still 0 writers active and 2 cache items in use, waiting 320ms
2025/09/19 04:12:42 DEBUG : Looking for writers
2025/09/19 04:12:42 DEBUG : file1: reading active writers
2025/09/19 04:12:42 DEBUG : file2: reading active writers
2025/09/19 04:12:42 DEBUG : Still 0 writers active and 2 cache items in use, waiting 640ms
2025/09/19 04:12:43 DEBUG : Looking for writers
2025/09/19 04:12:43 DEBUG : file1: reading active writers
2025/09/19 04:12:43 DEBUG : file2: reading active writers
2025/09/19 04:12:43 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:44 DEBUG : Looking for writers
2025/09/19 04:12:44 DEBUG : file1: reading active writers
2025/09/19 04:12:44 DEBUG : file2: reading active writers
2025/09/19 04:12:44 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:45 DEBUG : Looking for writers
2025/09/19 04:12:45 DEBUG : file2: reading active writers
2025/09/19 04:12:45 DEBUG : file1: reading active writers
2025/09/19 04:12:45 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:46 DEBUG : Looking for writers
2025/09/19 04:12:46 DEBUG : file1: reading active writers
2025/09/19 04:12:46 DEBUG : file2: reading active writers
2025/09/19 04:12:46 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:47 DEBUG : Looking for writers
2025/09/19 04:12:47 DEBUG : file1: reading active writers
2025/09/19 04:12:47 DEBUG : file2: reading active writers
2025/09/19 04:12:47 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:48 DEBUG : Looking for writers
2025/09/19 04:12:48 DEBUG : file1: reading active writers
2025/09/19 04:12:48 DEBUG : file2: reading active writers
2025/09/19 04:12:48 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:49 DEBUG : Looking for writers
2025/09/19 04:12:49 DEBUG : file1: reading active writers
2025/09/19 04:12:49 DEBUG : file2: reading active writers
2025/09/19 04:12:49 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:50 DEBUG : Looking for writers
2025/09/19 04:12:50 DEBUG : file1: reading active writers
2025/09/19 04:12:50 DEBUG : file2: reading active writers
2025/09/19 04:12:50 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:51 DEBUG : Looking for writers
2025/09/19 04:12:51 DEBUG : file2: reading active writers
2025/09/19 04:12:51 DEBUG : file1: reading active writers
2025/09/19 04:12:51 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:52 DEBUG : Looking for writers
2025/09/19 04:12:52 DEBUG : file1: reading active writers
2025/09/19 04:12:52 DEBUG : file2: reading active writers
2025/09/19 04:12:52 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:53 DEBUG : Looking for writers
2025/09/19 04:12:53 DEBUG : file1: reading active writers
2025/09/19 04:12:53 DEBUG : file2: reading active writers
2025/09/19 04:12:53 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:54 DEBUG : Looking for writers
2025/09/19 04:12:54 DEBUG : file2: reading active writers
2025/09/19 04:12:54 DEBUG : file1: reading active writers
2025/09/19 04:12:54 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:55 DEBUG : Looking for writers
2025/09/19 04:12:55 DEBUG : file1: reading active writers
2025/09/19 04:12:55 DEBUG : file2: reading active writers
2025/09/19 04:12:55 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:56 DEBUG : Looking for writers
2025/09/19 04:12:56 DEBUG : file1: reading active writers
2025/09/19 04:12:56 DEBUG : file2: reading active writers
2025/09/19 04:12:56 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:56 DEBUG : file1: vfs cache: starting upload
2025/09/19 04:12:56 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:12:56 ERROR : file1: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:56 ERROR : file1: vfs cache: failed to upload try #9, will retry in 51.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:56 DEBUG : file2: vfs cache: starting upload
2025/09/19 04:12:56 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file2 # [HashesOption([])] 0
2025/09/19 04:12:56 ERROR : file2: Failed to copy: uplink: segments limit exceeded
2025/09/19 04:12:56 ERROR : file2: vfs cache: failed to upload try #9, will retry in 51.2s: vfs cache: failed to transfer file from cache to remote: uplink: segments limit exceeded
2025/09/19 04:12:57 DEBUG : Looking for writers
2025/09/19 04:12:57 DEBUG : file1: reading active writers
2025/09/19 04:12:57 DEBUG : file2: reading active writers
2025/09/19 04:12:57 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:58 DEBUG : Looking for writers
2025/09/19 04:12:58 DEBUG : file1: reading active writers
2025/09/19 04:12:58 DEBUG : file2: reading active writers
2025/09/19 04:12:58 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:12:59 DEBUG : Looking for writers
2025/09/19 04:12:59 DEBUG : file1: reading active writers
2025/09/19 04:12:59 DEBUG : file2: reading active writers
2025/09/19 04:12:59 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:00 DEBUG : Looking for writers
2025/09/19 04:13:00 DEBUG : file1: reading active writers
2025/09/19 04:13:00 DEBUG : file2: reading active writers
2025/09/19 04:13:00 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:01 DEBUG : Looking for writers
2025/09/19 04:13:01 DEBUG : file1: reading active writers
2025/09/19 04:13:01 DEBUG : file2: reading active writers
2025/09/19 04:13:01 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:02 DEBUG : Looking for writers
2025/09/19 04:13:02 DEBUG : file1: reading active writers
2025/09/19 04:13:02 DEBUG : file2: reading active writers
2025/09/19 04:13:02 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:03 DEBUG : Looking for writers
2025/09/19 04:13:03 DEBUG : file1: reading active writers
2025/09/19 04:13:03 DEBUG : file2: reading active writers
2025/09/19 04:13:03 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:04 DEBUG : Looking for writers
2025/09/19 04:13:04 DEBUG : file1: reading active writers
2025/09/19 04:13:04 DEBUG : file2: reading active writers
2025/09/19 04:13:04 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache RemoveNotInUse (maxAge=3600000000000, emptyOnly=false): item file1 not removed, freed 0 bytes
2025/09/19 04:13:04 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache RemoveNotInUse (maxAge=3600000000000, emptyOnly=false): item file2 not removed, freed 0 bytes
2025/09/19 04:13:04 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 2 (was 2) in use 2, to upload 2, uploading 0, total size 0 (was 0)
2025/09/19 04:13:05 DEBUG : Looking for writers
2025/09/19 04:13:05 DEBUG : file1: reading active writers
2025/09/19 04:13:05 DEBUG : file2: reading active writers
2025/09/19 04:13:05 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:06 DEBUG : Looking for writers
2025/09/19 04:13:06 DEBUG : file1: reading active writers
2025/09/19 04:13:06 DEBUG : file2: reading active writers
2025/09/19 04:13:06 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:07 DEBUG : Looking for writers
2025/09/19 04:13:07 DEBUG : file2: reading active writers
2025/09/19 04:13:07 DEBUG : file1: reading active writers
2025/09/19 04:13:07 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:08 DEBUG : Looking for writers
2025/09/19 04:13:08 DEBUG : file1: reading active writers
2025/09/19 04:13:08 DEBUG : file2: reading active writers
2025/09/19 04:13:08 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:09 DEBUG : Looking for writers
2025/09/19 04:13:09 DEBUG : file1: reading active writers
2025/09/19 04:13:09 DEBUG : file2: reading active writers
2025/09/19 04:13:09 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:10 DEBUG : Looking for writers
2025/09/19 04:13:10 DEBUG : file1: reading active writers
2025/09/19 04:13:10 DEBUG : file2: reading active writers
2025/09/19 04:13:10 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:11 DEBUG : Looking for writers
2025/09/19 04:13:11 DEBUG : file1: reading active writers
2025/09/19 04:13:11 DEBUG : file2: reading active writers
2025/09/19 04:13:11 DEBUG : Still 0 writers active and 2 cache items in use, waiting 1s
2025/09/19 04:13:11 ERROR : Exiting even though 0 writers active and 2 cache items in use after 30s
Cache{
	"file1": &{c:0xc0007373b0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000af3108 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824645202240} name:file1 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368911095583501 ext:142751515200 loc:0x411a0a0} ATime:{wall:13991368911095856144 ext:142751787843 loc:0x411a0a0} Size:0 Rs:[] Fingerprint: Dirty:true} writeBackID:1 pendingAccesses:0 modified:false beingReset:false},
	"file2": &{c:0xc0007373b0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc000af3208 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824645202496} name:file2 opens:0 downloaders:<nil> o:<nil> fd:<nil> info:{ModTime:{wall:13991368911100141120 ext:142756072820 loc:0x411a0a0} ATime:{wall:13991368911100387414 ext:142756319113 loc:0x411a0a0} Size:0 Rs:[] Fingerprint: Dirty:true} writeBackID:2 pendingAccesses:0 modified:false beingReset:false},
}
2025/09/19 04:13:11 DEBUG : >WaitForWriters: 
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleWriteNoWrite (67.23s)
=== RUN   TestRWFileHandleSizeTruncateExisting
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:11 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:11 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:11 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:13:11 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:11 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:11 DEBUG : Looking for writers
2025/09/19 04:13:11 DEBUG : >WaitForWriters: 
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:11 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleSizeTruncateExisting (0.14s)
=== RUN   TestRWFileHandleSizeCreateExisting
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:12 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:12 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:12 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file1 # [] 16
2025/09/19 04:13:12 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "dir/file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:12 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : >WaitForWriters: 
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileHandleSizeCreateExisting (0.11s)
=== RUN   TestRWFileModTimeWithOpenWriters
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:12 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:12 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:12 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:12 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:13:12 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2025/09/19 04:13:12 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:13:12 DEBUG : file1: newRWFileHandle: 
2025/09/19 04:13:12 DEBUG : file1(0xc000b2b9c0): openPending: 
2025/09/19 04:13:12 DEBUG : file1: vfs cache: truncate to size=0 (not needed as size correct)
2025/09/19 04:13:12 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:12 DEBUG : file1(0xc000b2b9c0): >openPending: err=<nil>
2025/09/19 04:13:12 DEBUG : file1: >newRWFileHandle: err=<nil>
2025/09/19 04:13:12 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:12 DEBUG : file1: >Open: fd=file1 (rw), err=<nil>
2025/09/19 04:13:12 DEBUG : file1: >OpenFile: fd=file1 (rw), err=<nil>
2025/09/19 04:13:12 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./time_test # [] 5
    run.go:285: Failed to put "time_test" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:12 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 10ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 20ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 40ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 80ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 160ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 320ms
2025/09/19 04:13:12 DEBUG : Looking for writers
2025/09/19 04:13:12 DEBUG : file1: reading active writers
2025/09/19 04:13:12 DEBUG : file1: active writers 1
2025/09/19 04:13:12 DEBUG : Still 1 writers active and 1 cache items in use, waiting 640ms
2025/09/19 04:13:13 DEBUG : Looking for writers
2025/09/19 04:13:13 DEBUG : file1: reading active writers
2025/09/19 04:13:13 DEBUG : file1: active writers 1
2025/09/19 04:13:13 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:14 DEBUG : Looking for writers
2025/09/19 04:13:14 DEBUG : file1: reading active writers
2025/09/19 04:13:14 DEBUG : file1: active writers 1
2025/09/19 04:13:14 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:15 DEBUG : Looking for writers
2025/09/19 04:13:15 DEBUG : file1: reading active writers
2025/09/19 04:13:15 DEBUG : file1: active writers 1
2025/09/19 04:13:15 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:16 DEBUG : Looking for writers
2025/09/19 04:13:16 DEBUG : file1: reading active writers
2025/09/19 04:13:16 DEBUG : file1: active writers 1
2025/09/19 04:13:16 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:17 DEBUG : Looking for writers
2025/09/19 04:13:17 DEBUG : file1: reading active writers
2025/09/19 04:13:17 DEBUG : file1: active writers 1
2025/09/19 04:13:17 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:18 DEBUG : Looking for writers
2025/09/19 04:13:18 DEBUG : file1: reading active writers
2025/09/19 04:13:18 DEBUG : file1: active writers 1
2025/09/19 04:13:18 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:19 DEBUG : Looking for writers
2025/09/19 04:13:19 DEBUG : file1: reading active writers
2025/09/19 04:13:19 DEBUG : file1: active writers 1
2025/09/19 04:13:19 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:20 DEBUG : Looking for writers
2025/09/19 04:13:20 DEBUG : file1: reading active writers
2025/09/19 04:13:20 DEBUG : file1: active writers 1
2025/09/19 04:13:20 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:21 DEBUG : Looking for writers
2025/09/19 04:13:21 DEBUG : file1: reading active writers
2025/09/19 04:13:21 DEBUG : file1: active writers 1
2025/09/19 04:13:21 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:22 DEBUG : Looking for writers
2025/09/19 04:13:22 DEBUG : file1: reading active writers
2025/09/19 04:13:22 DEBUG : file1: active writers 1
2025/09/19 04:13:22 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:23 DEBUG : Looking for writers
2025/09/19 04:13:23 DEBUG : file1: reading active writers
2025/09/19 04:13:23 DEBUG : file1: active writers 1
2025/09/19 04:13:23 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:24 DEBUG : Looking for writers
2025/09/19 04:13:24 DEBUG : file1: reading active writers
2025/09/19 04:13:24 DEBUG : file1: active writers 1
2025/09/19 04:13:24 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:25 DEBUG : Looking for writers
2025/09/19 04:13:25 DEBUG : file1: reading active writers
2025/09/19 04:13:25 DEBUG : file1: active writers 1
2025/09/19 04:13:25 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:26 DEBUG : Looking for writers
2025/09/19 04:13:26 DEBUG : file1: reading active writers
2025/09/19 04:13:26 DEBUG : file1: active writers 1
2025/09/19 04:13:26 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:27 DEBUG : Looking for writers
2025/09/19 04:13:27 DEBUG : file1: reading active writers
2025/09/19 04:13:27 DEBUG : file1: active writers 1
2025/09/19 04:13:27 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:28 DEBUG : Looking for writers
2025/09/19 04:13:28 DEBUG : file1: reading active writers
2025/09/19 04:13:28 DEBUG : file1: active writers 1
2025/09/19 04:13:28 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:29 DEBUG : Looking for writers
2025/09/19 04:13:29 DEBUG : file1: reading active writers
2025/09/19 04:13:29 DEBUG : file1: active writers 1
2025/09/19 04:13:29 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:30 DEBUG : Looking for writers
2025/09/19 04:13:30 DEBUG : file1: reading active writers
2025/09/19 04:13:30 DEBUG : file1: active writers 1
2025/09/19 04:13:30 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:31 DEBUG : Looking for writers
2025/09/19 04:13:31 DEBUG : file1: reading active writers
2025/09/19 04:13:31 DEBUG : file1: active writers 1
2025/09/19 04:13:31 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:32 DEBUG : Looking for writers
2025/09/19 04:13:32 DEBUG : file1: reading active writers
2025/09/19 04:13:32 DEBUG : file1: active writers 1
2025/09/19 04:13:32 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:33 DEBUG : Looking for writers
2025/09/19 04:13:33 DEBUG : file1: reading active writers
2025/09/19 04:13:33 DEBUG : file1: active writers 1
2025/09/19 04:13:33 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:34 DEBUG : Looking for writers
2025/09/19 04:13:34 DEBUG : file1: reading active writers
2025/09/19 04:13:34 DEBUG : file1: active writers 1
2025/09/19 04:13:34 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:35 DEBUG : Looking for writers
2025/09/19 04:13:35 DEBUG : file1: reading active writers
2025/09/19 04:13:35 DEBUG : file1: active writers 1
2025/09/19 04:13:35 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:36 DEBUG : Looking for writers
2025/09/19 04:13:36 DEBUG : file1: reading active writers
2025/09/19 04:13:36 DEBUG : file1: active writers 1
2025/09/19 04:13:36 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:37 DEBUG : Looking for writers
2025/09/19 04:13:37 DEBUG : file1: reading active writers
2025/09/19 04:13:37 DEBUG : file1: active writers 1
2025/09/19 04:13:37 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:38 DEBUG : Looking for writers
2025/09/19 04:13:38 DEBUG : file1: reading active writers
2025/09/19 04:13:38 DEBUG : file1: active writers 1
2025/09/19 04:13:38 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:39 DEBUG : Looking for writers
2025/09/19 04:13:39 DEBUG : file1: reading active writers
2025/09/19 04:13:39 DEBUG : file1: active writers 1
2025/09/19 04:13:39 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:40 DEBUG : Looking for writers
2025/09/19 04:13:40 DEBUG : file1: reading active writers
2025/09/19 04:13:40 DEBUG : file1: active writers 1
2025/09/19 04:13:40 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:41 DEBUG : Looking for writers
2025/09/19 04:13:41 DEBUG : file1: reading active writers
2025/09/19 04:13:41 DEBUG : file1: active writers 1
2025/09/19 04:13:41 DEBUG : Still 1 writers active and 1 cache items in use, waiting 1s
2025/09/19 04:13:42 ERROR : Exiting even though 1 writers active and 1 cache items in use after 30s
Cache{
	"file1": &{c:0xc0007da1e0 mu:{_:{} mu:{state:0 sema:0}} cond:{noCopy:{} L:0xc00059bd08 notify:{wait:0 notify:0 lock:0 head:<nil> tail:<nil>} checker:824639601984} name:file1 opens:1 downloaders:<nil> o:<nil> fd:0xc00014e658 info:{ModTime:{wall:13991368983595262325 ext:210236750011 loc:0x411a0a0} ATime:{wall:13991368983595262325 ext:210236750011 loc:0x411a0a0} Size:0 Rs:[] Fingerprint: Dirty:true} writeBackID:0 pendingAccesses:0 modified:true beingReset:false},
}
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWFileModTimeWithOpenWriters (30.14s)
=== RUN   TestRWCacheUpdate
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: root is "/home/rclone/.cache/rclone"
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:42 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name
2025/09/19 04:13:42 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestStorj/rclone-test-hojober4zupi"
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./TestRWCacheUpdate # [] 20
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
    run.go:285: Failed to put "TestRWCacheUpdate" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:42 DEBUG : Looking for writers
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: vfs cache: cleaner exiting
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestRWCacheUpdate (0.10s)
=== RUN   TestCaseSensitivity
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./FiLeA # [] 5
    run.go:285: Failed to put "FiLeA" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : forgetting directory cache
--- FAIL: TestCaseSensitivity (0.10s)
=== RUN   TestUnicodeNormalization
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./normal name with no special characters.txt # [] 5
    run.go:285: Failed to put "normal name with no special characters.txt" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestUnicodeNormalization (0.10s)
=== RUN   TestVFSStat
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [] 14
    run.go:285: Failed to put "file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:42 DEBUG : Looking for writers
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestVFSStat (0.10s)
=== RUN   TestVFSStatParent
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [] 14
    run.go:285: Failed to put "file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:42 DEBUG : Looking for writers
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestVFSStatParent (0.10s)
=== RUN   TestVFSOpenFile
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [] 14
    run.go:285: Failed to put "file1" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:42 DEBUG : Looking for writers
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestVFSOpenFile (0.10s)
=== RUN   TestVFSRename
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:42 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./dir/file2 # [] 14
    run.go:285: Failed to put "dir/file2" to "FS sj://rclone-test-hojober4zupi": uplink: segments limit exceeded
2025/09/19 04:13:42 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:42 DEBUG : Looking for writers
2025/09/19 04:13:42 DEBUG : >WaitForWriters: 
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:42 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestVFSRename (0.10s)
=== RUN   TestWriteFileHandleMethods
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:13:43 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:13:43 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:13:43 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:13:43 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:43 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:13:43 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:13:43 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:43 ERROR : file1: WriteFileHandle: Read: Can't read and write to file without --vfs-cache-mode >= minimal
2025/09/19 04:13:43 ERROR : file1: WriteFileHandle: ReadAt: Can't read and write to file without --vfs-cache-mode >= minimal
2025/09/19 04:13:43 ERROR : file1: WriteFileHandle: Truncate: Can't change size without --vfs-cache-mode >= writes
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (5 bytes), uploading instead of streaming
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 5
2025/09/19 04:13:43 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:13:43 DEBUG : file1: Remove: 
2025/09/19 04:13:43 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:13:43 DEBUG : file1: >Remove: err=<nil>
    write_test.go:144: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:144
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileHandleMethods
    dir_test.go:250: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:153
        	Error:      	Not equal: 
        	            	expected: []string{"file1,5,false"}
        	            	actual  : []string(nil)
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,4 +1,2 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=13) "file1,5,false"
        	            	-}
        	            	+([]string) <nil>
        	            	 
        	Test:       	TestWriteFileHandleMethods
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:43 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2025/09/19 04:13:44 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:44 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2025/09/19 04:13:46 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:13:46 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:157
        	Error:      	Should be true
        	Test:       	TestWriteFileHandleMethods
        	Messages:   	listing wrong, want
        	            	  file1 (5) got
        	            	  
    fstest.go:203: Not found "file1"
    fstest.go:206: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:157
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestWriteFileHandleMethods
        	Messages:   	1 objects not found
2025/09/19 04:13:50 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:13:50 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:13:50 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:50 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:13:50 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:13:50 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:50 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (0 bytes), uploading instead of streaming
2025/09/19 04:13:50 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:13:50 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:13:50 DEBUG : file1: Remove: 
2025/09/19 04:13:50 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:13:50 DEBUG : file1: >Remove: err=<nil>
    write_test.go:163: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:163
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileHandleMethods
    dir_test.go:250: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:164
        	Error:      	Not equal: 
        	            	expected: []string{"file1,5,false"}
        	            	actual  : []string(nil)
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,4 +1,2 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=13) "file1,5,false"
        	            	-}
        	            	+([]string) <nil>
        	            	 
        	Test:       	TestWriteFileHandleMethods
2025/09/19 04:13:50 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:13:50 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:13:50 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:13:50 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:13:50 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:13:50 DEBUG : Added virtual directory entry vAddFile: "file1"
    write_test.go:171: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:171
        	Error:      	Not equal: 
        	            	expected: *errors.errorString(&errors.errorString{s:"permission denied"})
        	            	actual  : <nil>(<nil>)
        	Test:       	TestWriteFileHandleMethods
2025/09/19 04:13:50 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 10ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 20ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 40ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 80ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 160ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 320ms
2025/09/19 04:13:50 DEBUG : Looking for writers
2025/09/19 04:13:50 DEBUG : file1: reading active writers
2025/09/19 04:13:50 DEBUG : file1: active writers 1
2025/09/19 04:13:50 DEBUG : Still 1 writers active and 0 cache items in use, waiting 640ms
2025/09/19 04:13:51 DEBUG : Looking for writers
2025/09/19 04:13:51 DEBUG : file1: reading active writers
2025/09/19 04:13:51 DEBUG : file1: active writers 1
2025/09/19 04:13:51 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:52 DEBUG : Looking for writers
2025/09/19 04:13:52 DEBUG : file1: reading active writers
2025/09/19 04:13:52 DEBUG : file1: active writers 1
2025/09/19 04:13:52 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:53 DEBUG : Looking for writers
2025/09/19 04:13:53 DEBUG : file1: reading active writers
2025/09/19 04:13:53 DEBUG : file1: active writers 1
2025/09/19 04:13:53 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:54 DEBUG : Looking for writers
2025/09/19 04:13:54 DEBUG : file1: reading active writers
2025/09/19 04:13:54 DEBUG : file1: active writers 1
2025/09/19 04:13:54 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:55 DEBUG : Looking for writers
2025/09/19 04:13:55 DEBUG : file1: reading active writers
2025/09/19 04:13:55 DEBUG : file1: active writers 1
2025/09/19 04:13:55 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:56 DEBUG : Looking for writers
2025/09/19 04:13:56 DEBUG : file1: reading active writers
2025/09/19 04:13:56 DEBUG : file1: active writers 1
2025/09/19 04:13:56 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:57 DEBUG : Looking for writers
2025/09/19 04:13:57 DEBUG : file1: reading active writers
2025/09/19 04:13:57 DEBUG : file1: active writers 1
2025/09/19 04:13:57 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:58 DEBUG : Looking for writers
2025/09/19 04:13:58 DEBUG : file1: reading active writers
2025/09/19 04:13:58 DEBUG : file1: active writers 1
2025/09/19 04:13:58 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:13:59 DEBUG : Looking for writers
2025/09/19 04:13:59 DEBUG : file1: reading active writers
2025/09/19 04:13:59 DEBUG : file1: active writers 1
2025/09/19 04:13:59 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:00 DEBUG : Looking for writers
2025/09/19 04:14:00 DEBUG : file1: reading active writers
2025/09/19 04:14:00 DEBUG : file1: active writers 1
2025/09/19 04:14:00 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:01 DEBUG : Looking for writers
2025/09/19 04:14:01 DEBUG : file1: reading active writers
2025/09/19 04:14:01 DEBUG : file1: active writers 1
2025/09/19 04:14:01 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:02 DEBUG : Looking for writers
2025/09/19 04:14:02 DEBUG : file1: reading active writers
2025/09/19 04:14:02 DEBUG : file1: active writers 1
2025/09/19 04:14:02 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:03 DEBUG : Looking for writers
2025/09/19 04:14:03 DEBUG : file1: reading active writers
2025/09/19 04:14:03 DEBUG : file1: active writers 1
2025/09/19 04:14:03 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:04 DEBUG : Looking for writers
2025/09/19 04:14:04 DEBUG : file1: reading active writers
2025/09/19 04:14:04 DEBUG : file1: active writers 1
2025/09/19 04:14:04 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:05 DEBUG : Looking for writers
2025/09/19 04:14:05 DEBUG : file1: reading active writers
2025/09/19 04:14:05 DEBUG : file1: active writers 1
2025/09/19 04:14:05 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:06 DEBUG : Looking for writers
2025/09/19 04:14:06 DEBUG : file1: reading active writers
2025/09/19 04:14:06 DEBUG : file1: active writers 1
2025/09/19 04:14:06 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:07 DEBUG : Looking for writers
2025/09/19 04:14:07 DEBUG : file1: reading active writers
2025/09/19 04:14:07 DEBUG : file1: active writers 1
2025/09/19 04:14:07 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:08 DEBUG : Looking for writers
2025/09/19 04:14:08 DEBUG : file1: reading active writers
2025/09/19 04:14:08 DEBUG : file1: active writers 1
2025/09/19 04:14:08 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:09 DEBUG : Looking for writers
2025/09/19 04:14:09 DEBUG : file1: reading active writers
2025/09/19 04:14:09 DEBUG : file1: active writers 1
2025/09/19 04:14:09 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:10 DEBUG : Looking for writers
2025/09/19 04:14:10 DEBUG : file1: reading active writers
2025/09/19 04:14:10 DEBUG : file1: active writers 1
2025/09/19 04:14:10 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:11 DEBUG : Looking for writers
2025/09/19 04:14:11 DEBUG : file1: reading active writers
2025/09/19 04:14:11 DEBUG : file1: active writers 1
2025/09/19 04:14:11 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:12 DEBUG : Looking for writers
2025/09/19 04:14:12 DEBUG : file1: reading active writers
2025/09/19 04:14:12 DEBUG : file1: active writers 1
2025/09/19 04:14:12 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:13 DEBUG : Looking for writers
2025/09/19 04:14:13 DEBUG : file1: reading active writers
2025/09/19 04:14:13 DEBUG : file1: active writers 1
2025/09/19 04:14:13 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:14 DEBUG : Looking for writers
2025/09/19 04:14:14 DEBUG : file1: reading active writers
2025/09/19 04:14:14 DEBUG : file1: active writers 1
2025/09/19 04:14:14 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:15 DEBUG : Looking for writers
2025/09/19 04:14:15 DEBUG : file1: reading active writers
2025/09/19 04:14:15 DEBUG : file1: active writers 1
2025/09/19 04:14:15 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:16 DEBUG : Looking for writers
2025/09/19 04:14:16 DEBUG : file1: reading active writers
2025/09/19 04:14:16 DEBUG : file1: active writers 1
2025/09/19 04:14:16 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:17 DEBUG : Looking for writers
2025/09/19 04:14:17 DEBUG : file1: reading active writers
2025/09/19 04:14:17 DEBUG : file1: active writers 1
2025/09/19 04:14:17 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:18 DEBUG : Looking for writers
2025/09/19 04:14:18 DEBUG : file1: reading active writers
2025/09/19 04:14:18 DEBUG : file1: active writers 1
2025/09/19 04:14:18 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:19 DEBUG : Looking for writers
2025/09/19 04:14:19 DEBUG : file1: reading active writers
2025/09/19 04:14:19 DEBUG : file1: active writers 1
2025/09/19 04:14:19 DEBUG : Still 1 writers active and 0 cache items in use, waiting 1s
2025/09/19 04:14:20 ERROR : Exiting even though 1 writers active and 0 cache items in use after 30s
Cache: <nil>
2025/09/19 04:14:20 DEBUG : >WaitForWriters: 
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestWriteFileHandleMethods (37.28s)
=== RUN   TestWriteFileHandleWriteAt
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:20 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:20 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:20 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:20 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:20 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:20 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:20 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:20 DEBUG : file1: waiting for in-sequence write to 100 for 1s
2025/09/19 04:14:21 DEBUG : file1: aborting in-sequence write wait, off=100
2025/09/19 04:14:21 DEBUG : file1: failed to wait for in-sequence write to 100
2025/09/19 04:14:21 ERROR : file1: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2025/09/19 04:14:21 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (11 bytes), uploading instead of streaming
2025/09/19 04:14:21 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 11
2025/09/19 04:14:21 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:21 DEBUG : file1: Remove: 
2025/09/19 04:14:21 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:21 DEBUG : file1: >Remove: err=<nil>
    write_test.go:221: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:221
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileHandleWriteAt
2025/09/19 04:14:21 ERROR : file1: WriteFileHandle.Write: error: Bad file descriptor
    dir_test.go:250: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:231
        	Error:      	Not equal: 
        	            	expected: []string{"file1,11,false"}
        	            	actual  : []string(nil)
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,4 +1,2 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=14) "file1,11,false"
        	            	-}
        	            	+([]string) <nil>
        	            	 
        	Test:       	TestWriteFileHandleWriteAt
2025/09/19 04:14:21 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:21 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2025/09/19 04:14:22 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:22 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2025/09/19 04:14:24 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:24 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:235
        	Error:      	Should be true
        	Test:       	TestWriteFileHandleWriteAt
        	Messages:   	listing wrong, want
        	            	  file1 (11) got
        	            	  
    fstest.go:203: Not found "file1"
    fstest.go:206: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:235
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestWriteFileHandleWriteAt
        	Messages:   	1 objects not found
2025/09/19 04:14:28 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:28 DEBUG : Looking for writers
2025/09/19 04:14:28 DEBUG : >WaitForWriters: 
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestWriteFileHandleWriteAt (8.24s)
=== RUN   TestWriteFileHandleFlush
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:28 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:28 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:28 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: WriteFileHandle.Flush unwritten handle, writing 0 bytes to avoid race conditions
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (5 bytes), uploading instead of streaming
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 5
2025/09/19 04:14:28 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:28 DEBUG : file1: Remove: 
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Remove: err=<nil>
2025/09/19 04:14:28 ERROR : file1: WriteFileHandle.Flush error: uplink: segments limit exceeded
    write_test.go:256: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:256
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileHandleFlush
2025/09/19 04:14:28 DEBUG : file1: WriteFileHandle.Flush nothing to do
    dir_test.go:250: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:267
        	Error:      	Not equal: 
        	            	expected: []string{"file1,5,false"}
        	            	actual  : []string(nil)
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,4 +1,2 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=13) "file1,5,false"
        	            	-}
        	            	+([]string) <nil>
        	            	 
        	Test:       	TestWriteFileHandleFlush
2025/09/19 04:14:28 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:28 DEBUG : Looking for writers
2025/09/19 04:14:28 DEBUG : >WaitForWriters: 
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestWriteFileHandleFlush (0.13s)
=== RUN   TestWriteFileHandleRelease
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:28 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:28 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:28 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: WriteFileHandle.Release closing
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (0 bytes), uploading instead of streaming
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:14:28 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:28 DEBUG : file1: Remove: 
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Remove: err=<nil>
2025/09/19 04:14:28 ERROR : file1: WriteFileHandle.Release error: uplink: segments limit exceeded
    write_test.go:279: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:279
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileHandleRelease
2025/09/19 04:14:28 DEBUG : file1: WriteFileHandle.Release nothing to do
2025/09/19 04:14:28 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:28 DEBUG : Looking for writers
2025/09/19 04:14:28 DEBUG : >WaitForWriters: 
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestWriteFileHandleRelease (0.13s)
=== RUN   TestWriteFileModTimeWithOpenWriters
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:28 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:28 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:28 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (2 bytes), uploading instead of streaming
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 2
2025/09/19 04:14:28 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:28 DEBUG : file1: Remove: 
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Remove: err=<nil>
    write_test.go:333: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:333
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestWriteFileModTimeWithOpenWriters
2025/09/19 04:14:28 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:28 DEBUG : Looking for writers
2025/09/19 04:14:28 DEBUG : >WaitForWriters: 
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestWriteFileModTimeWithOpenWriters (0.13s)
=== RUN   TestFileReadAtZeroLength
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:28 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:28 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:28 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:28 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (0 bytes), uploading instead of streaming
2025/09/19 04:14:28 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 0
2025/09/19 04:14:29 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:29 DEBUG : file1: Remove: 
2025/09/19 04:14:29 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:29 DEBUG : file1: >Remove: err=<nil>
    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:380
        	Error:      	Received unexpected error:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestFileReadAtZeroLength
2025/09/19 04:14:29 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=----------
2025/09/19 04:14:29 DEBUG : file1: >OpenFile: fd=<nil>, 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:380
        	Error:      	Received unexpected error:
        	            	file does not exist
        	Test:       	TestFileReadAtZeroLength
2025/09/19 04:14:29 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:29 DEBUG : Looking for writers
2025/09/19 04:14:29 DEBUG : >WaitForWriters: 
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileReadAtZeroLength (0.14s)
=== RUN   TestFileReadAtNonZeroLength
    run.go:180: Remote "FS sj://rclone-test-hojober4zupi", Local "Local file system at /tmp/rclone2481840405", Modify Window "1ns"
2025/09/19 04:14:29 INFO  : FS sj://rclone-test-hojober4zupi: poll-interval is not supported by this remote
2025/09/19 04:14:29 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: ls ./
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2025/09/19 04:14:29 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE
2025/09/19 04:14:29 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:29 DEBUG : file1: >Open: fd=file1 (w), err=<nil>
2025/09/19 04:14:29 DEBUG : file1: >OpenFile: fd=file1 (w), err=<nil>
2025/09/19 04:14:29 DEBUG : Added virtual directory entry vAddFile: "file1"
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: File to upload is small (100 bytes), uploading instead of streaming
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: cp input ./file1 # [HashesOption([])] 100
2025/09/19 04:14:29 ERROR : file1: WriteFileHandle.New Rcat failed: uplink: segments limit exceeded
2025/09/19 04:14:29 DEBUG : file1: Remove: 
2025/09/19 04:14:29 DEBUG : Added virtual directory entry vDel: "file1"
2025/09/19 04:14:29 DEBUG : file1: >Remove: err=<nil>
    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:
        	            	uplink: segments limit exceeded
        	            		storj.io/uplink.convertKnownErrors:78
        	            		storj.io/uplink.(*Upload).Commit:219
        	            		github.com/rclone/rclone/backend/storj.(*Fs).put:588
        	            		github.com/rclone/rclone/backend/storj.(*Fs).Put:533
        	            		github.com/rclone/rclone/fs/operations.rcatSrc.func4:1453
        	            		github.com/rclone/rclone/fs/operations.Retry:736
        	            		github.com/rclone/rclone/fs/operations.rcatSrc:1448
        	            		github.com/rclone/rclone/fs/operations.Rcat:1349
        	            		github.com/rclone/rclone/vfs.(*WriteFileHandle).openPending.func1:74
        	Test:       	TestFileReadAtNonZeroLength
2025/09/19 04:14:29 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=----------
2025/09/19 04:14:29 DEBUG : file1: >OpenFile: fd=<nil>, 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/09/19 04:14:29 DEBUG : WaitForWriters: timeout=30s
2025/09/19 04:14:29 DEBUG : Looking for writers
2025/09/19 04:14:29 DEBUG : >WaitForWriters: 
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: ls -R ./
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: OBJ ls -R ./ ("rclone-test-hojober4zupi", "")
--- FAIL: TestFileReadAtNonZeroLength (0.37s)
FAIL
2025/09/19 04:14:29 DEBUG : FS sj://rclone-test-hojober4zupi: Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestCaseSensitivity|TestDirCreate|TestDirFileOpen|TestDirForgetAll|TestDirForgetPath|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMetadataExtension|TestDirMethods|TestDirMkdir|TestDirMkdirSub|TestDirOpen|TestDirReadDirAll|TestDirRemove|TestDirRemoveAll|TestDirRemoveName|TestDirRename|TestDirSetModTime|TestDirStat|TestDirWalk|TestFileMethods|TestFileOpen|TestFileOpenRead|TestFileOpenWrite|TestFileReadAtNonZeroLength|TestFileReadAtZeroLength|TestFileRemove|TestFileRemoveAll|TestRWCacheUpdate|TestRWFileHandleFlushRead|TestRWFileHandleMethodsRead|TestRWFileHandleMethodsWrite|TestRWFileHandleReadAt|TestRWFileHandleReleaseRead|TestRWFileHandleSeek|TestRWFileHandleSizeCreateExisting|TestRWFileHandleSizeTruncateExisting|TestRWFileHandleWriteAt|TestRWFileHandleWriteNoWrite|TestRWFileModTimeWithOpenWriters|TestReadFileHandleFlush|TestReadFileHandleMethods|TestReadFileHandleReadAt|TestReadFileHandleRelease|TestReadFileHandleSeek|TestUnicodeNormalization|TestVFSOpenFile|TestVFSRename|TestVFSStat|TestVFSStatParent|TestWriteFileHandleFlush|TestWriteFileHandleMethods|TestWriteFileHandleRelease|TestWriteFileHandleWriteAt|TestWriteFileModTimeWithOpenWriters)$|^TestFileRename$/^(full,forceCache=false|minimal,forceCache=false|minimal,forceCache=true|off,forceCache=false|writes,forceCache=false|writes,forceCache=true)$|^TestFileSetModTime$/^(cache=full,open=false,write=false|cache=full,open=true,write=false|cache=full,open=true,write=true|cache=off,open=false,write=false|cache=off,open=true,write=false|cache=off,open=true,write=true)$'" - Finished ERROR in 4m47.554206005s (try 5/5): exit status 1: Failed [TestDirHandleMethods TestDirHandleReaddir TestDirHandleReaddirnames TestDirMethods TestDirForgetAll TestDirForgetPath TestDirWalk TestDirSetModTime TestDirStat TestDirReadDirAll TestDirOpen TestDirCreate TestDirMkdir TestDirMkdirSub TestDirRemove TestDirRemoveAll TestDirRemoveName TestDirRename TestDirFileOpen TestDirMetadataExtension TestFileMethods TestFileSetModTime/cache=off,open=false,write=false TestFileSetModTime/cache=off,open=true,write=false TestFileSetModTime/cache=off,open=true,write=true TestFileSetModTime/cache=full,open=false,write=false TestFileSetModTime/cache=full,open=true,write=false TestFileSetModTime/cache=full,open=true,write=true TestFileOpenRead TestFileOpenWrite TestFileRemove TestFileRemoveAll TestFileOpen TestFileRename/off,forceCache=false TestFileRename/minimal,forceCache=false TestFileRename/minimal,forceCache=true TestFileRename/writes,forceCache=false TestFileRename/writes,forceCache=true TestFileRename/full,forceCache=false TestReadFileHandleMethods TestReadFileHandleSeek TestReadFileHandleReadAt TestReadFileHandleFlush TestReadFileHandleRelease TestRWFileHandleMethodsRead TestRWFileHandleSeek TestRWFileHandleReadAt TestRWFileHandleFlushRead TestRWFileHandleReleaseRead TestRWFileHandleMethodsWrite TestRWFileHandleWriteAt TestRWFileHandleWriteNoWrite TestRWFileHandleSizeTruncateExisting TestRWFileHandleSizeCreateExisting TestRWFileModTimeWithOpenWriters TestRWCacheUpdate TestCaseSensitivity TestUnicodeNormalization TestVFSStat TestVFSStatParent TestVFSOpenFile TestVFSRename TestWriteFileHandleMethods TestWriteFileHandleWriteAt TestWriteFileHandleFlush TestWriteFileHandleRelease TestWriteFileModTimeWithOpenWriters TestFileReadAtZeroLength TestFileReadAtNonZeroLength]