"./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestDirCreate|TestDirMkdir)$|^TestDirReadDirAll$/^Virtual$'" - Starting (try 2/5)
2024/10/05 03:09:13 DEBUG : Creating backend with remote "TestPcloud:rclone-test-zijicey6roya"
2024/10/05 03:09:13 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/10/05 03:09:14 DEBUG : Creating backend with remote "/tmp/rclone840541611"
=== RUN   TestDirReadDirAll
    run.go:180: Remote "pcloud root 'rclone-test-zijicey6roya'", Local "Local file system at /tmp/rclone840541611", Modify Window "1s"
2024/10/05 03:09:14 INFO  : pcloud root 'rclone-test-zijicey6roya': poll-interval is not supported by this remote
2024/10/05 03:09:14 NOTICE: pcloud root 'rclone-test-zijicey6roya': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
=== RUN   TestDirReadDirAll/Virtual
2024/10/05 03:09:15 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2024/10/05 03:09:15 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2024/10/05 03:09:15 DEBUG : dir: Added virtual directory entry vDel: "file2"
2024/10/05 03:09:15 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2024/10/05 03:09:16 DEBUG : dir: invalidating directory cache
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2024/10/05 03:09:16 DEBUG : dir/file1: Reset virtual modtime
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2024/10/05 03:09:16 DEBUG : dir/virtualFile: Reset virtual modtime
2024/10/05 03:09:16 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2024/10/05 03:09:16 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2024/10/05 03:09:16 DEBUG : dir: Added virtual directory entry vDel: "file1"
2024/10/05 03:09:16 DEBUG : dir: invalidating directory cache
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2024/10/05 03:09:16 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2024/10/05 03:09:16 DEBUG : dir/virtualFile: Reset virtual modtime
2024/10/05 03:09:16 DEBUG : : forgetting directory cache
2024/10/05 03:09:16 DEBUG : dir: forgetting directory cache
2024/10/05 03:09:16 DEBUG : dir/virtualDir: forgetting directory cache
2024/10/05 03:09:16 DEBUG : dir/file1: Reset virtual modtime
2024/10/05 03:09:16 DEBUG : dir/virtualFile: Reset virtual modtime
2024/10/05 03:09:16 DEBUG : WaitForWriters: timeout=30s
2024/10/05 03:09:16 DEBUG : dir/virtualDir: Looking for writers
2024/10/05 03:09:16 DEBUG : dir: Looking for writers
2024/10/05 03:09:16 DEBUG : file1: reading active writers
2024/10/05 03:09:16 DEBUG : virtualFile2: reading active writers
2024/10/05 03:09:16 DEBUG : virtualFile: reading active writers
2024/10/05 03:09:16 DEBUG : virtualDir: reading active writers
2024/10/05 03:09:16 DEBUG : : Looking for writers
2024/10/05 03:09:16 DEBUG : dir: reading active writers
2024/10/05 03:09:16 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (3.13s)
    --- PASS: TestDirReadDirAll/Virtual (0.93s)
=== RUN   TestDirCreate
    run.go:180: Remote "pcloud root 'rclone-test-zijicey6roya'", Local "Local file system at /tmp/rclone840541611", Modify Window "1s"
2024/10/05 03:09:17 INFO  : pcloud root 'rclone-test-zijicey6roya': poll-interval is not supported by this remote
2024/10/05 03:09:17 NOTICE: pcloud root 'rclone-test-zijicey6roya': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2024/10/05 03:09:17 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2024/10/05 03:09:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2024/10/05 03:09:17 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2024/10/05 03:09:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2024/10/05 03:09:17 DEBUG : pcloud root 'rclone-test-zijicey6roya': File to upload is small (5 bytes), uploading instead of streaming
2024/10/05 03:09:18 DEBUG : dir/potato: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK
2024/10/05 03:09:18 DEBUG : dir/potato: Size and sha1 of src and dst objects identical
2024/10/05 03:09:18 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2024/10/05 03:09:18 DEBUG : WaitForWriters: timeout=30s
2024/10/05 03:09:18 DEBUG : dir: Looking for writers
2024/10/05 03:09:18 DEBUG : file1: reading active writers
2024/10/05 03:09:18 DEBUG : potato: reading active writers
2024/10/05 03:09:18 DEBUG : : Looking for writers
2024/10/05 03:09:18 DEBUG : dir: reading active writers
2024/10/05 03:09:18 DEBUG : >WaitForWriters: 
--- PASS: TestDirCreate (1.27s)
=== RUN   TestDirMkdir
    run.go:180: Remote "pcloud root 'rclone-test-zijicey6roya'", Local "Local file system at /tmp/rclone840541611", Modify Window "1s"
2024/10/05 03:09:18 INFO  : pcloud root 'rclone-test-zijicey6roya': poll-interval is not supported by this remote
2024/10/05 03:09:18 NOTICE: pcloud root 'rclone-test-zijicey6roya': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2024/10/05 03:09:19 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2024/10/05 03:09:19 DEBUG : WaitForWriters: timeout=30s
2024/10/05 03:09:19 DEBUG : dir/sub: Looking for writers
2024/10/05 03:09:19 DEBUG : dir: Looking for writers
2024/10/05 03:09:19 DEBUG : file1: reading active writers
2024/10/05 03:09:19 DEBUG : sub: reading active writers
2024/10/05 03:09:19 DEBUG : : Looking for writers
2024/10/05 03:09:19 DEBUG : dir: reading active writers
2024/10/05 03:09:19 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdir (1.63s)
PASS
2024/10/05 03:09:20 DEBUG : pcloud root 'rclone-test-zijicey6roya': Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestDirCreate|TestDirMkdir)$|^TestDirReadDirAll$/^Virtual$'" - Finished OK in 6.57505544s (try 2/5)