"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirMethods|TestDirReadDirAll|TestVFSOpenFile)$'" - Starting (try 2/5)
2024/12/22 03:15:43 DEBUG : Creating backend with remote "TestYandex:rclone-test-wawezud3dege"
2024/12/22 03:15:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/12/22 03:15:43 DEBUG : Creating backend with remote "/tmp/rclone1597484003"
=== RUN   TestDirMethods
    run.go:180: Remote "Yandex rclone-test-wawezud3dege", Local "Local file system at /tmp/rclone1597484003", Modify Window "1ns"
2024/12/22 03:15:43 INFO  : Yandex rclone-test-wawezud3dege: poll-interval is not supported by this remote
2024/12/22 03:15:51 DEBUG : WaitForWriters: timeout=30s
2024/12/22 03:15:51 DEBUG : dir: Looking for writers
2024/12/22 03:15:51 DEBUG : : Looking for writers
2024/12/22 03:15:51 DEBUG : dir: reading active writers
2024/12/22 03:15:51 DEBUG : >WaitForWriters: 
--- PASS: TestDirMethods (16.92s)
=== RUN   TestDirReadDirAll
    run.go:180: Remote "Yandex rclone-test-wawezud3dege", Local "Local file system at /tmp/rclone1597484003", Modify Window "1ns"
2024/12/22 03:16:00 INFO  : Yandex rclone-test-wawezud3dege: poll-interval is not supported by this remote
2024/12/22 03:16:06 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2024/12/22 03:16:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/12/22 03:16:07 DEBUG : pacer: Reducing sleep to 15ms
2024/12/22 03:16:08 DEBUG : pacer: Reducing sleep to 11.25ms
2024/12/22 03:16:08 DEBUG : pacer: Reducing sleep to 10ms
=== RUN   TestDirReadDirAll/Virtual
2024/12/22 03:16:10 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2024/12/22 03:16:10 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2024/12/22 03:16:10 DEBUG : dir: Added virtual directory entry vDel: "file2"
2024/12/22 03:16:10 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2024/12/22 03:16:16 DEBUG : dir: invalidating directory cache
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2024/12/22 03:16:17 DEBUG : dir/file1: Reset virtual modtime
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2024/12/22 03:16:17 DEBUG : dir/virtualFile: Reset virtual modtime
2024/12/22 03:16:17 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2024/12/22 03:16:17 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2024/12/22 03:16:17 DEBUG : dir: Added virtual directory entry vDel: "file1"
2024/12/22 03:16:17 DEBUG : dir: invalidating directory cache
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2024/12/22 03:16:17 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2024/12/22 03:16:17 DEBUG : dir/virtualFile: Reset virtual modtime
2024/12/22 03:16:17 DEBUG : : forgetting directory cache
2024/12/22 03:16:17 DEBUG : dir: forgetting directory cache
2024/12/22 03:16:17 DEBUG : dir/virtualDir: forgetting directory cache
2024/12/22 03:16:17 DEBUG : dir/file1: Reset virtual modtime
2024/12/22 03:16:17 DEBUG : dir/virtualFile: Reset virtual modtime
2024/12/22 03:16:17 DEBUG : WaitForWriters: timeout=30s
2024/12/22 03:16:17 DEBUG : dir/virtualDir: Looking for writers
2024/12/22 03:16:17 DEBUG : dir: Looking for writers
2024/12/22 03:16:17 DEBUG : virtualDir: reading active writers
2024/12/22 03:16:17 DEBUG : file1: reading active writers
2024/12/22 03:16:17 DEBUG : virtualFile2: reading active writers
2024/12/22 03:16:17 DEBUG : virtualFile: reading active writers
2024/12/22 03:16:17 DEBUG : : Looking for writers
2024/12/22 03:16:17 DEBUG : dir: reading active writers
2024/12/22 03:16:17 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (25.92s)
    --- PASS: TestDirReadDirAll/Virtual (7.94s)
=== RUN   TestVFSOpenFile
    run.go:180: Remote "Yandex rclone-test-wawezud3dege", Local "Local file system at /tmp/rclone1597484003", Modify Window "1ns"
2024/12/22 03:16:26 INFO  : Yandex rclone-test-wawezud3dege: poll-interval is not supported by this remote
2024/12/22 03:16:30 DEBUG : file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/12/22 03:16:30 DEBUG : file1: Open: flags=O_RDONLY
2024/12/22 03:16:30 DEBUG : file1: >Open: fd=file1 (r), err=<nil>
2024/12/22 03:16:30 DEBUG : file1: >OpenFile: fd=file1 (r), err=<nil>
2024/12/22 03:16:30 DEBUG : dir: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/12/22 03:16:30 DEBUG : dir: >OpenFile: fd=dir/ (r), err=<nil>
2024/12/22 03:16:30 DEBUG : dir/new_file.txt: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2024/12/22 03:16:31 DEBUG : dir/new_file.txt: >OpenFile: fd=<nil>, err=file does not exist
2024/12/22 03:16:31 DEBUG : dir/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2024/12/22 03:16:31 DEBUG : dir/new_file.txt: Open: flags=O_WRONLY|O_CREATE
2024/12/22 03:16:31 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt"
2024/12/22 03:16:31 DEBUG : dir/new_file.txt: >Open: fd=dir/new_file.txt (w), err=<nil>
2024/12/22 03:16:31 DEBUG : dir/new_file.txt: >OpenFile: fd=dir/new_file.txt (w), err=<nil>
2024/12/22 03:16:31 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt"
2024/12/22 03:16:31 DEBUG : Yandex rclone-test-wawezud3dege: File to upload is small (0 bytes), uploading instead of streaming
2024/12/22 03:16:34 DEBUG : dir/new_file.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/12/22 03:16:34 DEBUG : dir/new_file.txt: Size and md5 of src and dst objects identical
2024/12/22 03:16:34 DEBUG : dir: Added virtual directory entry vAddFile: "new_file.txt"
2024/12/22 03:16:34 DEBUG : not found/new_file.txt: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx
2024/12/22 03:16:34 DEBUG : not found/new_file.txt: >OpenFile: fd=<nil>, err=file does not exist
2024/12/22 03:16:34 DEBUG : WaitForWriters: timeout=30s
2024/12/22 03:16:34 DEBUG : dir: Looking for writers
2024/12/22 03:16:34 DEBUG : file2: reading active writers
2024/12/22 03:16:34 DEBUG : new_file.txt: reading active writers
2024/12/22 03:16:34 DEBUG : : Looking for writers
2024/12/22 03:16:34 DEBUG : dir: reading active writers
2024/12/22 03:16:34 DEBUG : file1: reading active writers
2024/12/22 03:16:34 DEBUG : >WaitForWriters: 
--- PASS: TestVFSOpenFile (14.29s)
PASS
2024/12/22 03:16:40 DEBUG : Yandex rclone-test-wawezud3dege: Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirMethods|TestDirReadDirAll|TestVFSOpenFile)$'" - Finished OK in 58.79908826s (try 2/5)