"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestCaseSensitivity|TestDirRemove)$'" - Starting (try 2/5)
2024/11/01 01:50:04 DEBUG : Creating backend with remote "TestYandex:rclone-test-qepaken5tija"
2024/11/01 01:50:04 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/01 01:50:04 DEBUG : Creating backend with remote "/tmp/rclone840421309"
=== RUN   TestDirRemove
    run.go:180: Remote "Yandex rclone-test-qepaken5tija", Local "Local file system at /tmp/rclone840421309", Modify Window "1ns"
2024/11/01 01:50:04 INFO  : Yandex rclone-test-qepaken5tija: poll-interval is not supported by this remote
2024/11/01 01:50:08 ERROR : dir/: Dir.Remove not empty
2024/11/01 01:50:08 DEBUG : dir/file1: Remove: 
2024/11/01 01:50:09 DEBUG : dir: Added virtual directory entry vDel: "file1"
2024/11/01 01:50:09 DEBUG : dir/file1: >Remove: err=<nil>
2024/11/01 01:50:11 DEBUG : : Added virtual directory entry vDel: "dir"
2024/11/01 01:50:11 DEBUG : WaitForWriters: timeout=30s
2024/11/01 01:50:11 DEBUG : : Looking for writers
2024/11/01 01:50:11 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemove (7.37s)
=== RUN   TestCaseSensitivity
    run.go:180: Remote "Yandex rclone-test-qepaken5tija", Local "Local file system at /tmp/rclone840421309", Modify Window "1ns"
2024/11/01 01:50:17 INFO  : Yandex rclone-test-qepaken5tija: poll-interval is not supported by this remote
2024/11/01 01:50:17 INFO  : Yandex rclone-test-qepaken5tija: poll-interval is not supported by this remote
2024/11/01 01:50:17 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:17 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:17 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:17 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:17 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:18 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:18 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:24 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:24 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:24 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:24 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:24 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:24 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:24 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:24 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:24 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:24 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:25 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:25 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:25 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/01 01:50:25 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:25 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:25 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:25 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:25 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:25 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/01 01:50:25 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/01 01:50:25 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/01 01:50:25 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:25 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:26 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:26 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:26 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:26 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:26 DEBUG : fileA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:26 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:26 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : fileA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:26 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:26 DEBUG : filea: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:26 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:26 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : filea: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:26 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:27 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:27 DEBUG : FILEA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:27 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:27 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:27 DEBUG : FILEA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:27 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:27 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:27 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:27 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/01 01:50:27 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:27 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:27 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:28 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:28 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/01 01:50:28 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:28 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:28 DEBUG : fileb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 ERROR : /: Dir.Stat error: duplicate filename "fileb" detected with case/unicode normalization settings
2024/11/01 01:50:28 DEBUG : fileb: >OpenFile: fd=<nil>, err=duplicate filename "fileb" detected with case/unicode normalization settings
2024/11/01 01:50:28 DEBUG : FILEB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 ERROR : /: Dir.Stat error: duplicate filename "FILEB" detected with case/unicode normalization settings
2024/11/01 01:50:28 DEBUG : FILEB: >OpenFile: fd=<nil>, err=duplicate filename "FILEB" detected with case/unicode normalization settings
2024/11/01 01:50:28 DEBUG : FiLeA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : FiLeA: Open: flags=O_RDONLY
2024/11/01 01:50:28 DEBUG : FiLeA: >Open: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FiLeA: >OpenFile: fd=FiLeA (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FiLeA: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:28 DEBUG : FiLeA: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:28 DEBUG : fileA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : fileA: >OpenFile: fd=<nil>, err=file does not exist
2024/11/01 01:50:28 DEBUG : filea: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : filea: >OpenFile: fd=<nil>, err=file does not exist
2024/11/01 01:50:28 DEBUG : FILEA: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : FILEA: >OpenFile: fd=<nil>, err=file does not exist
2024/11/01 01:50:28 DEBUG : FiLeB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:28 DEBUG : FiLeB: Open: flags=O_RDONLY
2024/11/01 01:50:28 DEBUG : FiLeB: >Open: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FiLeB: >OpenFile: fd=FiLeB (r), err=<nil>
2024/11/01 01:50:28 DEBUG : FiLeB: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:29 DEBUG : FiLeB: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:29 DEBUG : FilEb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:29 DEBUG : FilEb: Open: flags=O_RDONLY
2024/11/01 01:50:29 DEBUG : FilEb: >Open: fd=FilEb (r), err=<nil>
2024/11/01 01:50:29 DEBUG : FilEb: >OpenFile: fd=FilEb (r), err=<nil>
2024/11/01 01:50:29 DEBUG : FilEb: ChunkedReader.openRange at 0 length 134217728
2024/11/01 01:50:29 DEBUG : FilEb: ChunkedReader.Read at 0 length 5 chunkOffset 0 chunkSize 134217728
2024/11/01 01:50:29 DEBUG : fileb: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:29 DEBUG : fileb: >OpenFile: fd=<nil>, err=file does not exist
2024/11/01 01:50:29 DEBUG : FILEB: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/11/01 01:50:29 DEBUG : FILEB: >OpenFile: fd=<nil>, err=file does not exist
2024/11/01 01:50:29 DEBUG : WaitForWriters: timeout=30s
2024/11/01 01:50:29 DEBUG : : Looking for writers
2024/11/01 01:50:29 DEBUG : FiLeA: reading active writers
2024/11/01 01:50:29 DEBUG : FiLeB: reading active writers
2024/11/01 01:50:29 DEBUG : FilEb: reading active writers
2024/11/01 01:50:29 DEBUG : >WaitForWriters: 
2024/11/01 01:50:29 DEBUG : WaitForWriters: timeout=30s
2024/11/01 01:50:29 DEBUG : : Looking for writers
2024/11/01 01:50:29 DEBUG : FiLeA: reading active writers
2024/11/01 01:50:29 DEBUG : FiLeB: reading active writers
2024/11/01 01:50:29 DEBUG : FilEb: reading active writers
2024/11/01 01:50:29 DEBUG : >WaitForWriters: 
--- PASS: TestCaseSensitivity (22.31s)
PASS
2024/11/01 01:50:34 DEBUG : Yandex rclone-test-qepaken5tija: Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestCaseSensitivity|TestDirRemove)$'" - Finished OK in 32.161886421s (try 2/5)