"./vfs.test -test.v -test.timeout 1h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^(TestZipDirsInRoot|TestZipLargeFiles|TestZipManySubDirs)$'" - Starting (try 2/5)
2026/04/12 04:48:51 DEBUG : Creating backend with remote "TestInternxt:rclone-test-sasuruw6mowo"
2026/04/12 04:48:51 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/12 04:48:51 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2
2026/04/12 04:48:52 DEBUG : Creating backend with remote "/tmp/rclone2964809276"
=== RUN   TestZipManySubDirs
    run.go:185: Remote "Internxt root 'rclone-test-sasuruw6mowo'", Local "Local file system at /tmp/rclone2964809276", Modify Window "876000h0m0s"
2026/04/12 04:48:52 INFO  : Internxt root 'rclone-test-sasuruw6mowo': poll-interval is not supported by this remote
2026/04/12 04:48:52 NOTICE: Internxt root 'rclone-test-sasuruw6mowo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/04/12 04:49:00 DEBUG : a/b/c/deep.txt: Open: flags=O_RDONLY
2026/04/12 04:49:00 DEBUG : a/b/c/deep.txt: >Open: fd=a/b/c/deep.txt (r), err=<nil>
2026/04/12 04:49:00 DEBUG : a/b/c/deep.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:00 DEBUG : a/b/c/deep.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:00 DEBUG : a/b/c/deep.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:00 DEBUG : a/b/mid.txt: Open: flags=O_RDONLY
2026/04/12 04:49:00 DEBUG : a/b/mid.txt: >Open: fd=a/b/mid.txt (r), err=<nil>
2026/04/12 04:49:00 DEBUG : a/b/mid.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:00 DEBUG : a/b/mid.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:01 DEBUG : a/b/mid.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:01 DEBUG : a/top.txt: Open: flags=O_RDONLY
2026/04/12 04:49:01 DEBUG : a/top.txt: >Open: fd=a/top.txt (r), err=<nil>
2026/04/12 04:49:01 DEBUG : a/top.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:01 DEBUG : a/top.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:01 DEBUG : a/top.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:01 DEBUG : WaitForWriters: timeout=30s
2026/04/12 04:49:01 DEBUG : a/b/c: Looking for writers
2026/04/12 04:49:01 DEBUG : deep.txt: reading active writers
2026/04/12 04:49:01 DEBUG : a/b: Looking for writers
2026/04/12 04:49:01 DEBUG : c: reading active writers
2026/04/12 04:49:01 DEBUG : mid.txt: reading active writers
2026/04/12 04:49:01 DEBUG : a: Looking for writers
2026/04/12 04:49:01 DEBUG : b: reading active writers
2026/04/12 04:49:01 DEBUG : top.txt: reading active writers
2026/04/12 04:49:01 DEBUG : Looking for writers
2026/04/12 04:49:01 DEBUG : a: reading active writers
2026/04/12 04:49:01 DEBUG : >WaitForWriters: 
--- PASS: TestZipManySubDirs (14.99s)
=== RUN   TestZipLargeFiles
    run.go:185: Remote "Internxt root 'rclone-test-sasuruw6mowo'", Local "Local file system at /tmp/rclone2964809276", Modify Window "876000h0m0s"
2026/04/12 04:49:07 INFO  : Internxt root 'rclone-test-sasuruw6mowo': poll-interval is not supported by this remote
2026/04/12 04:49:07 NOTICE: Internxt root 'rclone-test-sasuruw6mowo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: Open: flags=O_RDONLY
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: >Open: fd=bigdir/big.bin (r), err=<nil>
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 0 length 4096 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 4096 length 8192 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 12288 length 16384 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 28672 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 61440 length 65536 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 126976 length 131072 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 258048 length 262144 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:10 DEBUG : bigdir/big.bin: ChunkedReader.Read at 520192 length 524288 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : bigdir/big.bin: ChunkedReader.Read at 1044480 length 1048576 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : bigdir/big.bin: ChunkedReader.Read at 2093056 length 1048576 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : bigdir/big.bin: ChunkedReader.Read at 3141632 length 1048576 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : bigdir/big.bin: ChunkedReader.Read at 4190208 length 1048576 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : bigdir/big.bin: ChunkedReader.Read at 5238784 length 1048576 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:11 DEBUG : WaitForWriters: timeout=30s
2026/04/12 04:49:11 DEBUG : bigdir: Looking for writers
2026/04/12 04:49:11 DEBUG : big.bin: reading active writers
2026/04/12 04:49:11 DEBUG : Looking for writers
2026/04/12 04:49:11 DEBUG : bigdir: reading active writers
2026/04/12 04:49:11 DEBUG : >WaitForWriters: 
--- PASS: TestZipLargeFiles (6.09s)
=== RUN   TestZipDirsInRoot
    run.go:185: Remote "Internxt root 'rclone-test-sasuruw6mowo'", Local "Local file system at /tmp/rclone2964809276", Modify Window "876000h0m0s"
2026/04/12 04:49:13 INFO  : Internxt root 'rclone-test-sasuruw6mowo': poll-interval is not supported by this remote
2026/04/12 04:49:13 NOTICE: Internxt root 'rclone-test-sasuruw6mowo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/04/12 04:49:17 DEBUG : dir1/a.txt: Open: flags=O_RDONLY
2026/04/12 04:49:17 DEBUG : dir1/a.txt: >Open: fd=dir1/a.txt (r), err=<nil>
2026/04/12 04:49:17 DEBUG : dir1/a.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:17 DEBUG : dir1/a.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:17 DEBUG : dir1/a.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:18 DEBUG : dir2/b.txt: Open: flags=O_RDONLY
2026/04/12 04:49:18 DEBUG : dir2/b.txt: >Open: fd=dir2/b.txt (r), err=<nil>
2026/04/12 04:49:18 DEBUG : dir2/b.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:18 DEBUG : dir2/b.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:18 DEBUG : dir2/b.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:18 DEBUG : dir3/c.txt: Open: flags=O_RDONLY
2026/04/12 04:49:18 DEBUG : dir3/c.txt: >Open: fd=dir3/c.txt (r), err=<nil>
2026/04/12 04:49:18 DEBUG : dir3/c.txt: Set virtual modtime to 2001-02-03 04:05:06 +0000 UTC
2026/04/12 04:49:18 DEBUG : dir3/c.txt: ChunkedReader.openRange at 0 length 134217728
2026/04/12 04:49:19 DEBUG : dir3/c.txt: ChunkedReader.Read at 0 length 32768 chunkOffset 0 chunkSize 134217728
2026/04/12 04:49:19 DEBUG : WaitForWriters: timeout=30s
2026/04/12 04:49:19 DEBUG : dir1: Looking for writers
2026/04/12 04:49:19 DEBUG : a.txt: reading active writers
2026/04/12 04:49:19 DEBUG : dir2: Looking for writers
2026/04/12 04:49:19 DEBUG : b.txt: reading active writers
2026/04/12 04:49:19 DEBUG : dir3: Looking for writers
2026/04/12 04:49:19 DEBUG : c.txt: reading active writers
2026/04/12 04:49:19 DEBUG : Looking for writers
2026/04/12 04:49:19 DEBUG : dir1: reading active writers
2026/04/12 04:49:19 DEBUG : dir2: reading active writers
2026/04/12 04:49:19 DEBUG : dir3: reading active writers
2026/04/12 04:49:19 DEBUG : >WaitForWriters: 
--- PASS: TestZipDirsInRoot (9.44s)
PASS
2026/04/12 04:49:22 DEBUG : Internxt root 'rclone-test-sasuruw6mowo': Purge dir ""
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^(TestZipDirsInRoot|TestZipLargeFiles|TestZipManySubDirs)$'" - Finished OK in 32.016446583s (try 2/5)