"./vfs.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCaseSensitivity|TestDirSetModTime)$'" - Starting (try 2/5)
2024/11/08 03:22:01 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-wexover8wipa"
2024/11/08 03:22:01 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/08 03:22:01 DEBUG : Creating backend with remote "TestYandex:rclone-test-wexover8wipa"
2024/11/08 03:22:02 DEBUG : Reset feature "ListR"
2024/11/08 03:22:02 DEBUG : Creating backend with remote "/tmp/rclone2381408219"
=== RUN   TestDirSetModTime
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa'", Local "Local file system at /tmp/rclone2381408219", Modify Window "1ns"
2024/11/08 03:22:02 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa': poll-interval is not supported by this remote
2024/11/08 03:22:07 INFO  : dir/file1.rclone_chunk.001_m9l1br: Moved (server-side) to: dir/file1
2024/11/08 03:22:08 DEBUG : WaitForWriters: timeout=30s
2024/11/08 03:22:08 DEBUG : dir: Looking for writers
2024/11/08 03:22:08 DEBUG : : Looking for writers
2024/11/08 03:22:08 DEBUG : dir: reading active writers
2024/11/08 03:22:08 DEBUG : >WaitForWriters: 
--- PASS: TestDirSetModTime (10.08s)
=== RUN   TestCaseSensitivity
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa'", Local "Local file system at /tmp/rclone2381408219", Modify Window "1ns"
2024/11/08 03:22:18 INFO  : FiLeA.rclone_chunk.001_m9lajy: Moved (server-side) to: FiLeA
2024/11/08 03:22:23 INFO  : FiLeB.rclone_chunk.001_m9lglb: Moved (server-side) to: FiLeB
2024/11/08 03:22:30 INFO  : FilEb.rclone_chunk.001_m9ll2y: Moved (server-side) to: FilEb
2024/11/08 03:22:30 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa': poll-interval is not supported by this remote
2024/11/08 03:22:30 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa': poll-interval is not supported by this remote
2024/11/08 03:22:30 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:30 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:30 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:30 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:30 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:31 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:31 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:31 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:31 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:31 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:31 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:32 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:32 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:32 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:32 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:32 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:32 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:32 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:32 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:32 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/08 03:22:32 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:32 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:32 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:33 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:33 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:33 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/08 03:22:33 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/08 03:22:33 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/08 03:22:33 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:33 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:33 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:33 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:33 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:33 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:33 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:34 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:34 DEBUG : fileA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:34 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:34 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:34 DEBUG : fileA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:34 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:34 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:34 DEBUG : filea: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:34 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:34 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:34 DEBUG : filea: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:34 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:35 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:35 DEBUG : FILEA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:35 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:35 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:35 DEBUG : FILEA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:35 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:35 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:35 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:35 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/08 03:22:35 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:35 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:35 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:36 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:36 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:36 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/08 03:22:36 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/08 03:22:36 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/08 03:22:36 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:36 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:36 DEBUG : fileb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:36 ERROR : /: Dir.Stat error: duplicate filename "fileb" detected with case/unicode normalization settings
2024/11/08 03:22:36 DEBUG : fileb: >OpenFile: fd=<nil>, err=duplicate filename "fileb" detected with case/unicode normalization settings
2024/11/08 03:22:36 DEBUG : FILEB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:36 ERROR : /: Dir.Stat error: duplicate filename "FILEB" detected with case/unicode normalization settings
2024/11/08 03:22:36 DEBUG : FILEB: >OpenFile: fd=<nil>, err=duplicate filename "FILEB" detected with case/unicode normalization settings
2024/11/08 03:22:36 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:36 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/08 03:22:36 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:36 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/08 03:22:36 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:37 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:37 DEBUG : fileA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:37 DEBUG : fileA: >OpenFile: fd=<nil>, err=file does not exist
2024/11/08 03:22:37 DEBUG : filea: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:37 DEBUG : filea: >OpenFile: fd=<nil>, err=file does not exist
2024/11/08 03:22:37 DEBUG : FILEA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:37 DEBUG : FILEA: >OpenFile: fd=<nil>, err=file does not exist
2024/11/08 03:22:37 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:37 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/08 03:22:37 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:37 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/08 03:22:37 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:37 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:37 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:37 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/08 03:22:37 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/08 03:22:37 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/08 03:22:37 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/08 03:22:38 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/08 03:22:38 DEBUG : fileb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:38 DEBUG : fileb: >OpenFile: fd=<nil>, err=file does not exist
2024/11/08 03:22:38 DEBUG : FILEB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/08 03:22:38 DEBUG : FILEB: >OpenFile: fd=<nil>, err=file does not exist
2024/11/08 03:22:38 DEBUG : WaitForWriters: timeout=30s
2024/11/08 03:22:38 DEBUG : : Looking for writers
2024/11/08 03:22:38 DEBUG : FiLeB: reading active writers
2024/11/08 03:22:38 DEBUG : FilEb: reading active writers
2024/11/08 03:22:38 DEBUG : FiLeA: reading active writers
2024/11/08 03:22:38 DEBUG : >WaitForWriters: 
2024/11/08 03:22:38 DEBUG : WaitForWriters: timeout=30s
2024/11/08 03:22:38 DEBUG : : Looking for writers
2024/11/08 03:22:38 DEBUG : FilEb: reading active writers
2024/11/08 03:22:38 DEBUG : FiLeA: reading active writers
2024/11/08 03:22:38 DEBUG : FiLeB: reading active writers
2024/11/08 03:22:38 DEBUG : >WaitForWriters: 
--- PASS: TestCaseSensitivity (30.16s)
PASS
2024/11/08 03:22:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wexover8wipa': Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCaseSensitivity|TestDirSetModTime)$'" - Finished OK in 42.66529301s (try 2/5)