"./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^TestDirFileOpen$'" - Starting (try 4/5) 2026/08/05 02:07:45 DEBUG : Creating backend with remote "TestPcloud:rclone-test-coroxed4ruyu" 2026/08/05 02:07:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/05 02:07:46 DEBUG : Creating backend with remote "/tmp/rclone2120628740" === RUN TestDirFileOpen run.go:198: Remote "pcloud root 'rclone-test-coroxed4ruyu'", Local "Local file system at /tmp/rclone2120628740", Modify Window "1s" 2026/08/05 02:07:46 NOTICE: pcloud root 'rclone-test-coroxed4ruyu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2026/08/05 02:07:47 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': ChangeNotify: detected change in "dir" (type: 0) 2026/08/05 02:07:47 DEBUG : changeNotify: relativePath="dir", type=0 2026/08/05 02:07:47 DEBUG : >changeNotify: 2026/08/05 02:07:48 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': ChangeNotify: detected change in "dir/file1" (type: 1) 2026/08/05 02:07:48 DEBUG : changeNotify: relativePath="dir/file1", type=1 2026/08/05 02:07:48 DEBUG : >changeNotify: 2026/08/05 02:07:48 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2026/08/05 02:07:48 DEBUG : dir/sub/file0: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2026/08/05 02:07:48 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': ChangeNotify: detected change in "dir/sub" (type: 0) 2026/08/05 02:07:48 DEBUG : changeNotify: relativePath="dir/sub", type=0 2026/08/05 02:07:48 DEBUG : dir: invalidating directory cache 2026/08/05 02:07:48 DEBUG : dir/sub: invalidating directory cache 2026/08/05 02:07:48 DEBUG : >changeNotify: 2026/08/05 02:07:48 DEBUG : dir: Removed virtual directory entry vAddDir: "sub" 2026/08/05 02:07:48 DEBUG : dir/file1: Reset virtual modtime 2026/08/05 02:07:49 DEBUG : dir/sub/file0: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2026/08/05 02:07:49 DEBUG : dir/sub/file0: >Open: fd=dir/sub/file0 (w), err= 2026/08/05 02:07:49 DEBUG : dir/sub/file0: >OpenFile: fd=dir/sub/file0 (w), err= 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2026/08/05 02:07:49 DEBUG : dir/sub/file2: OpenFile: flags=O_RDWR|O_CREATE|O_TRUNC, perm=-rw-rw-rw- 2026/08/05 02:07:49 DEBUG : dir/sub/file2: Open: flags=O_RDWR|O_CREATE|O_TRUNC 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2026/08/05 02:07:49 DEBUG : dir/sub/file2: >Open: fd=dir/sub/file2 (w), err= 2026/08/05 02:07:49 DEBUG : dir/sub/file2: >OpenFile: fd=dir/sub/file2 (w), err= 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2026/08/05 02:07:49 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': File to upload is small (12 bytes), uploading instead of streaming 2026/08/05 02:07:49 DEBUG : dir/sub/file2: size = 12 OK 2026/08/05 02:07:49 DEBUG : dir/sub/file2: sha1 = 430ce34d020724ed75a196dfc2ad67c77772d169 OK 2026/08/05 02:07:49 DEBUG : dir/sub/file2: Size and sha1 of src and dst objects identical 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file2" 2026/08/05 02:07:49 DEBUG : forgetting directory cache 2026/08/05 02:07:49 DEBUG : dir: forgetting directory cache 2026/08/05 02:07:49 DEBUG : dir/sub: forgetting directory cache 2026/08/05 02:07:49 DEBUG : dir/sub: Removed virtual directory entry vAddFile: "file2" 2026/08/05 02:07:49 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': File to upload is small (5 bytes), uploading instead of streaming 2026/08/05 02:07:49 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': ChangeNotify: detected change in "dir/sub/file2" (type: 1) 2026/08/05 02:07:49 DEBUG : changeNotify: relativePath="dir/sub/file2", type=1 2026/08/05 02:07:49 DEBUG : dir/sub: invalidating directory cache 2026/08/05 02:07:49 DEBUG : >changeNotify: 2026/08/05 02:07:49 DEBUG : dir/sub/file0: size = 5 OK 2026/08/05 02:07:49 DEBUG : dir/sub/file0: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK 2026/08/05 02:07:49 DEBUG : dir/sub/file0: Size and sha1 of src and dst objects identical 2026/08/05 02:07:49 DEBUG : dir/sub: Added virtual directory entry vAddFile: "file0" 2026/08/05 02:07:49 DEBUG : WaitForWriters: timeout=30s 2026/08/05 02:07:49 DEBUG : dir/sub: Looking for writers 2026/08/05 02:07:49 DEBUG : file0: reading active writers 2026/08/05 02:07:49 DEBUG : file2: reading active writers 2026/08/05 02:07:49 DEBUG : dir: Looking for writers 2026/08/05 02:07:49 DEBUG : file1: reading active writers 2026/08/05 02:07:49 DEBUG : sub: reading active writers 2026/08/05 02:07:49 DEBUG : Looking for writers 2026/08/05 02:07:49 DEBUG : dir: reading active writers 2026/08/05 02:07:49 DEBUG : >WaitForWriters: run.go:186: removing dir "dir/sub" failed - try 1/3: sleeping 1s: rmdir failed: pcloud error: Folder is not empty. (2006) run.go:186: removing dir "dir/sub" failed - try 2/3: sleeping 1.5s: rmdir failed: pcloud error: Folder is not empty. (2006) run.go:186: removing dir "dir/sub" failed: rmdir failed: pcloud error: Folder is not empty. (2006) run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: rmdir failed: pcloud error: Folder is not empty. (2006) run.go:186: removing dir "dir" failed - try 2/3: sleeping 1.5s: rmdir failed: pcloud error: Folder is not empty. (2006) run.go:186: removing dir "dir" failed: rmdir failed: pcloud error: Folder is not empty. (2006) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestDirFileOpen Messages: listing wrong, want got dir/sub/file0 (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestDirFileOpen Messages: Unexpected file "dir/sub/file0" fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Not equal: expected: []string{} actual : []string{"dir", "dir/sub"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) (len=3) "dir", + (string) (len=7) "dir/sub" } Test: TestDirFileOpen Messages: directories --- FAIL: TestDirFileOpen (16.33s) FAIL 2026/08/05 02:08:03 DEBUG : pcloud root 'rclone-test-coroxed4ruyu': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^TestDirFileOpen$'" - Finished ERROR in 18.425466531s (try 4/5): exit status 1: Failed [TestDirFileOpen]