"./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Starting (try 1/5)
2026/09/14 01:09:16 DEBUG : Creating backend with remote "TestPcloud:rclone-test-zokeleb0rolu"
2026/09/14 01:09:16 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/14 01:09:26 DEBUG : Creating backend with remote "/tmp/rclone3034821053"
=== RUN   TestDirHandleMethods
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:26 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:27 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:27 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:27 DEBUG : >changeNotify: 
2026/09/14 01:09:27 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:27 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:27 DEBUG : >changeNotify: 
2026/09/14 01:09:27 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:27 DEBUG : dir: Looking for writers
2026/09/14 01:09:27 DEBUG : Looking for writers
2026/09/14 01:09:27 DEBUG : dir: reading active writers
2026/09/14 01:09:27 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleMethods (1.91s)
=== RUN   TestDirHandleReaddir
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:27 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:28 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:28 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:28 DEBUG : >changeNotify: 
2026/09/14 01:09:28 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:28 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:28 DEBUG : >changeNotify: 
2026/09/14 01:09:28 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file2" (type: 1)
2026/09/14 01:09:28 DEBUG : changeNotify: relativePath="dir/file2", type=1
2026/09/14 01:09:28 DEBUG : >changeNotify: 
2026/09/14 01:09:29 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir" (type: 0)
2026/09/14 01:09:29 DEBUG : changeNotify: relativePath="dir/subdir", type=0
2026/09/14 01:09:29 DEBUG : >changeNotify: 
2026/09/14 01:09:29 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir/file3" (type: 1)
2026/09/14 01:09:29 DEBUG : changeNotify: relativePath="dir/subdir/file3", type=1
2026/09/14 01:09:29 DEBUG : >changeNotify: 
2026/09/14 01:09:30 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:30 DEBUG : dir/subdir: Looking for writers
2026/09/14 01:09:30 DEBUG : dir: Looking for writers
2026/09/14 01:09:30 DEBUG : file1: reading active writers
2026/09/14 01:09:30 DEBUG : file2: reading active writers
2026/09/14 01:09:30 DEBUG : subdir: reading active writers
2026/09/14 01:09:30 DEBUG : Looking for writers
2026/09/14 01:09:30 DEBUG : dir: reading active writers
2026/09/14 01:09:30 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddir (3.15s)
=== RUN   TestDirHandleReaddirnames
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:31 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:31 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:31 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:31 DEBUG : >changeNotify: 
2026/09/14 01:09:31 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:31 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:31 DEBUG : >changeNotify: 
2026/09/14 01:09:31 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:31 DEBUG : dir: Looking for writers
2026/09/14 01:09:31 DEBUG : file1: reading active writers
2026/09/14 01:09:31 DEBUG : Looking for writers
2026/09/14 01:09:31 DEBUG : dir: reading active writers
2026/09/14 01:09:31 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddirnames (1.16s)
=== RUN   TestDirMethods
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:32 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:32 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:32 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:32 DEBUG : >changeNotify: 
2026/09/14 01:09:32 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:32 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:32 DEBUG : >changeNotify: 
2026/09/14 01:09:32 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:32 DEBUG : dir: Looking for writers
2026/09/14 01:09:32 DEBUG : Looking for writers
2026/09/14 01:09:32 DEBUG : dir: reading active writers
2026/09/14 01:09:32 DEBUG : >WaitForWriters: 
--- PASS: TestDirMethods (1.13s)
=== RUN   TestDirForgetAll
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:33 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:33 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:33 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:33 DEBUG : >changeNotify: 
2026/09/14 01:09:33 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:33 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:33 DEBUG : >changeNotify: 
2026/09/14 01:09:34 DEBUG : dir: forgetting directory cache
2026/09/14 01:09:34 DEBUG : forgetting directory cache
2026/09/14 01:09:34 DEBUG : dir: forgetting directory cache
2026/09/14 01:09:34 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:34 DEBUG : Looking for writers
2026/09/14 01:09:34 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetAll (1.11s)
=== RUN   TestDirForgetPath
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:34 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:34 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:34 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:34 DEBUG : >changeNotify: 
2026/09/14 01:09:34 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:34 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:34 DEBUG : >changeNotify: 
2026/09/14 01:09:35 DEBUG : ForgetPath: relativePath="dir/notfound", type=1
2026/09/14 01:09:35 DEBUG : dir: invalidating directory cache
2026/09/14 01:09:35 DEBUG : >ForgetPath: 
2026/09/14 01:09:35 DEBUG : ForgetPath: relativePath="dir", type=0
2026/09/14 01:09:35 DEBUG : invalidating directory cache
2026/09/14 01:09:35 DEBUG : dir: forgetting directory cache
2026/09/14 01:09:35 DEBUG : >ForgetPath: 
2026/09/14 01:09:35 DEBUG : ForgetPath: relativePath="not/in/cache", type=0
2026/09/14 01:09:35 DEBUG : >ForgetPath: 
2026/09/14 01:09:35 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:35 DEBUG : dir: Looking for writers
2026/09/14 01:09:35 DEBUG : Looking for writers
2026/09/14 01:09:35 DEBUG : dir: reading active writers
2026/09/14 01:09:35 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetPath (1.72s)
=== RUN   TestDirWalk
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:36 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:36 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:36 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:36 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:37 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:37 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "fil" (type: 0)
2026/09/14 01:09:37 DEBUG : changeNotify: relativePath="fil", type=0
2026/09/14 01:09:37 DEBUG : invalidating directory cache
2026/09/14 01:09:37 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "fil/a" (type: 0)
2026/09/14 01:09:37 DEBUG : changeNotify: relativePath="fil/a", type=0
2026/09/14 01:09:37 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "fil/a/b" (type: 0)
2026/09/14 01:09:37 DEBUG : changeNotify: relativePath="fil/a/b", type=0
2026/09/14 01:09:37 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "fil/a/b/c" (type: 1)
2026/09/14 01:09:37 DEBUG : changeNotify: relativePath="fil/a/b/c", type=1
2026/09/14 01:09:37 DEBUG : >changeNotify: 
2026/09/14 01:09:37 DEBUG : forgetting directory cache
2026/09/14 01:09:37 DEBUG : dir: forgetting directory cache
2026/09/14 01:09:38 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:38 DEBUG : dir: Looking for writers
2026/09/14 01:09:38 DEBUG : fil/a/b: Looking for writers
2026/09/14 01:09:38 DEBUG : fil/a: Looking for writers
2026/09/14 01:09:38 DEBUG : b: reading active writers
2026/09/14 01:09:38 DEBUG : fil: Looking for writers
2026/09/14 01:09:38 DEBUG : a: reading active writers
2026/09/14 01:09:38 DEBUG : Looking for writers
2026/09/14 01:09:38 DEBUG : dir: reading active writers
2026/09/14 01:09:38 DEBUG : fil: reading active writers
2026/09/14 01:09:38 DEBUG : >WaitForWriters: 
--- PASS: TestDirWalk (2.81s)
=== RUN   TestDirSetModTime
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:39 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:39 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:39 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:39 DEBUG : >changeNotify: 
2026/09/14 01:09:39 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:39 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:39 DEBUG : >changeNotify: 
2026/09/14 01:09:39 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:39 DEBUG : dir: Looking for writers
2026/09/14 01:09:39 DEBUG : Looking for writers
2026/09/14 01:09:39 DEBUG : dir: reading active writers
2026/09/14 01:09:39 DEBUG : >WaitForWriters: 
--- PASS: TestDirSetModTime (1.02s)
=== RUN   TestDirStat
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:40 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:41 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:41 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:41 DEBUG : >changeNotify: 
2026/09/14 01:09:41 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:41 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:41 DEBUG : >changeNotify: 
2026/09/14 01:09:42 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:42 DEBUG : dir: Looking for writers
2026/09/14 01:09:42 DEBUG : file1: reading active writers
2026/09/14 01:09:42 DEBUG : Looking for writers
2026/09/14 01:09:42 DEBUG : dir: reading active writers
2026/09/14 01:09:42 DEBUG : >WaitForWriters: 
--- PASS: TestDirStat (2.38s)
=== RUN   TestDirReadDirAll
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:42 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:42 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:42 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:42 DEBUG : >changeNotify: 
2026/09/14 01:09:42 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:42 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:42 DEBUG : >changeNotify: 
2026/09/14 01:09:42 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file2" (type: 1)
2026/09/14 01:09:42 DEBUG : changeNotify: relativePath="dir/file2", type=1
2026/09/14 01:09:42 DEBUG : >changeNotify: 
2026/09/14 01:09:43 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir" (type: 0)
2026/09/14 01:09:43 DEBUG : changeNotify: relativePath="dir/subdir", type=0
2026/09/14 01:09:43 DEBUG : >changeNotify: 
2026/09/14 01:09:43 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir/file3" (type: 1)
2026/09/14 01:09:43 DEBUG : changeNotify: relativePath="dir/subdir/file3", type=1
2026/09/14 01:09:43 DEBUG : >changeNotify: 
=== RUN   TestDirReadDirAll/Virtual
2026/09/14 01:09:43 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2026/09/14 01:09:43 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2026/09/14 01:09:43 DEBUG : dir: Added virtual directory entry vDel: "file2"
2026/09/14 01:09:43 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2026/09/14 01:09:43 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/virtualFile" (type: 1)
2026/09/14 01:09:43 DEBUG : changeNotify: relativePath="dir/virtualFile", type=1
2026/09/14 01:09:43 DEBUG : dir: invalidating directory cache
2026/09/14 01:09:43 DEBUG : >changeNotify: 
2026/09/14 01:09:44 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/virtualDir" (type: 0)
2026/09/14 01:09:44 DEBUG : changeNotify: relativePath="dir/virtualDir", type=0
2026/09/14 01:09:44 DEBUG : >changeNotify: 
2026/09/14 01:09:45 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/virtualDir/testFile" (type: 1)
2026/09/14 01:09:45 DEBUG : changeNotify: relativePath="dir/virtualDir/testFile", type=1
2026/09/14 01:09:45 DEBUG : >changeNotify: 
2026/09/14 01:09:45 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file2" (type: 1)
2026/09/14 01:09:45 DEBUG : changeNotify: relativePath="dir/file2", type=1
2026/09/14 01:09:45 DEBUG : >changeNotify: 
2026/09/14 01:09:45 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir/file3" (type: 1)
2026/09/14 01:09:45 DEBUG : changeNotify: relativePath="dir/subdir/file3", type=1
2026/09/14 01:09:45 DEBUG : >changeNotify: 
2026/09/14 01:09:45 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/subdir" (type: 0)
2026/09/14 01:09:45 DEBUG : changeNotify: relativePath="dir/subdir", type=0
2026/09/14 01:09:45 DEBUG : >changeNotify: 
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2026/09/14 01:09:45 DEBUG : dir/file1: Reset virtual modtime
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2026/09/14 01:09:45 DEBUG : dir/virtualFile: Reset virtual modtime
2026/09/14 01:09:45 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2026/09/14 01:09:45 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2026/09/14 01:09:45 DEBUG : dir: Added virtual directory entry vDel: "file1"
2026/09/14 01:09:45 DEBUG : dir: invalidating directory cache
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2026/09/14 01:09:45 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2026/09/14 01:09:45 DEBUG : dir/virtualFile: Reset virtual modtime
2026/09/14 01:09:45 DEBUG : forgetting directory cache
2026/09/14 01:09:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:09:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:09:45 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:45 DEBUG : dir/virtualDir: Looking for writers
2026/09/14 01:09:45 DEBUG : dir: Looking for writers
2026/09/14 01:09:45 DEBUG : file1: reading active writers
2026/09/14 01:09:45 DEBUG : virtualFile2: reading active writers
2026/09/14 01:09:45 DEBUG : virtualFile: reading active writers
2026/09/14 01:09:45 DEBUG : virtualDir: reading active writers
2026/09/14 01:09:45 DEBUG : Looking for writers
2026/09/14 01:09:45 DEBUG : dir: reading active writers
2026/09/14 01:09:45 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (4.08s)
    --- PASS: TestDirReadDirAll/Virtual (1.97s)
=== RUN   TestDirOpen
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:46 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:47 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:47 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:47 DEBUG : >changeNotify: 
2026/09/14 01:09:47 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:47 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:47 DEBUG : >changeNotify: 
2026/09/14 01:09:48 ERROR : dir/: Can only open directories read only
2026/09/14 01:09:48 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:48 DEBUG : dir: Looking for writers
2026/09/14 01:09:48 DEBUG : Looking for writers
2026/09/14 01:09:48 DEBUG : dir: reading active writers
2026/09/14 01:09:48 DEBUG : >WaitForWriters: 
--- PASS: TestDirOpen (1.99s)
=== RUN   TestDirCreate
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:48 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:48 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:48 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:48 DEBUG : >changeNotify: 
2026/09/14 01:09:48 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:48 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:48 DEBUG : >changeNotify: 
2026/09/14 01:09:49 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2026/09/14 01:09:49 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/09/14 01:09:49 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2026/09/14 01:09:49 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/09/14 01:09:49 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': File to upload is small (5 bytes), uploading instead of streaming
2026/09/14 01:09:50 DEBUG : dir/potato: size = 5 OK
2026/09/14 01:09:50 DEBUG : dir/potato: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK
2026/09/14 01:09:50 DEBUG : dir/potato: Size and sha1 of src and dst objects identical
2026/09/14 01:09:50 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/09/14 01:09:50 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:50 DEBUG : dir: Looking for writers
2026/09/14 01:09:50 DEBUG : file1: reading active writers
2026/09/14 01:09:50 DEBUG : potato: reading active writers
2026/09/14 01:09:50 DEBUG : Looking for writers
2026/09/14 01:09:50 DEBUG : dir: reading active writers
2026/09/14 01:09:50 DEBUG : >WaitForWriters: 
--- PASS: TestDirCreate (2.36s)
=== RUN   TestDirMkdir
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:50 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:51 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:51 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:51 DEBUG : >changeNotify: 
2026/09/14 01:09:51 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:51 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:51 DEBUG : >changeNotify: 
2026/09/14 01:09:52 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2026/09/14 01:09:52 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/sub" (type: 0)
2026/09/14 01:09:52 DEBUG : changeNotify: relativePath="dir/sub", type=0
2026/09/14 01:09:52 DEBUG : dir: invalidating directory cache
2026/09/14 01:09:52 DEBUG : dir/sub: invalidating directory cache
2026/09/14 01:09:52 DEBUG : >changeNotify: 
2026/09/14 01:09:53 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:53 DEBUG : dir/sub: Looking for writers
2026/09/14 01:09:53 DEBUG : dir: Looking for writers
2026/09/14 01:09:53 DEBUG : file1: reading active writers
2026/09/14 01:09:53 DEBUG : sub: reading active writers
2026/09/14 01:09:53 DEBUG : Looking for writers
2026/09/14 01:09:53 DEBUG : dir: reading active writers
2026/09/14 01:09:53 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdir (4.74s)
=== RUN   TestDirMkdirSub
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:55 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:55 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:55 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:55 DEBUG : >changeNotify: 
2026/09/14 01:09:55 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:55 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:55 DEBUG : >changeNotify: 
2026/09/14 01:09:56 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2026/09/14 01:09:56 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/sub" (type: 0)
2026/09/14 01:09:56 DEBUG : changeNotify: relativePath="dir/sub", type=0
2026/09/14 01:09:56 DEBUG : dir: invalidating directory cache
2026/09/14 01:09:56 DEBUG : dir/sub: invalidating directory cache
2026/09/14 01:09:56 DEBUG : >changeNotify: 
2026/09/14 01:09:56 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub"
2026/09/14 01:09:56 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/sub/subsub" (type: 0)
2026/09/14 01:09:56 DEBUG : changeNotify: relativePath="dir/sub/subsub", type=0
2026/09/14 01:09:56 DEBUG : dir: Removed virtual directory entry vAddDir: "sub"
2026/09/14 01:09:56 DEBUG : dir/file1: Reset virtual modtime
2026/09/14 01:09:57 DEBUG : dir/sub: Removed virtual directory entry vAddDir: "subsub"
2026/09/14 01:09:57 DEBUG : dir/sub: invalidating directory cache
2026/09/14 01:09:57 DEBUG : dir/sub/subsub: invalidating directory cache
2026/09/14 01:09:57 DEBUG : >changeNotify: 
2026/09/14 01:09:57 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:09:57 DEBUG : dir/sub/subsub: Looking for writers
2026/09/14 01:09:57 DEBUG : dir/sub: Looking for writers
2026/09/14 01:09:57 DEBUG : subsub: reading active writers
2026/09/14 01:09:57 DEBUG : dir: Looking for writers
2026/09/14 01:09:57 DEBUG : file1: reading active writers
2026/09/14 01:09:57 DEBUG : sub: reading active writers
2026/09/14 01:09:57 DEBUG : Looking for writers
2026/09/14 01:09:57 DEBUG : dir: reading active writers
2026/09/14 01:09:57 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdirSub (3.36s)
=== RUN   TestDirRemove
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:09:58 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:09:59 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:09:59 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:09:59 DEBUG : >changeNotify: 
2026/09/14 01:09:59 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:09:59 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:09:59 DEBUG : >changeNotify: 
2026/09/14 01:10:00 ERROR : dir/: Dir.Remove not empty
2026/09/14 01:10:00 DEBUG : dir/file1: Remove: 
2026/09/14 01:10:00 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:10:00 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:10:00 DEBUG : dir: invalidating directory cache
2026/09/14 01:10:00 DEBUG : >changeNotify: 
2026/09/14 01:10:00 DEBUG : dir: Added virtual directory entry vDel: "file1"
2026/09/14 01:10:00 DEBUG : dir/file1: >Remove: err=<nil>
2026/09/14 01:10:00 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2026/09/14 01:10:00 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:10:00 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:10:00 DEBUG : invalidating directory cache
2026/09/14 01:10:00 DEBUG : dir: invalidating directory cache
2026/09/14 01:10:00 DEBUG : >changeNotify: 
2026/09/14 01:10:00 DEBUG : Added virtual directory entry vDel: "dir"
2026/09/14 01:10:00 DEBUG : Removed virtual directory entry vDel: "dir"
2026/09/14 01:10:00 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:10:00 DEBUG : Looking for writers
2026/09/14 01:10:00 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemove (2.25s)
=== RUN   TestDirRemoveAll
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:10:01 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:10:01 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:10:01 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:10:01 DEBUG : >changeNotify: 
2026/09/14 01:10:01 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:10:01 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:10:01 DEBUG : >changeNotify: 
2026/09/14 01:10:01 DEBUG : dir/file1: Remove: 
2026/09/14 01:10:02 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir/file1" (type: 1)
2026/09/14 01:10:02 DEBUG : changeNotify: relativePath="dir/file1", type=1
2026/09/14 01:10:02 DEBUG : dir: invalidating directory cache
2026/09/14 01:10:02 DEBUG : >changeNotify: 
2026/09/14 01:10:02 DEBUG : dir: Added virtual directory entry vDel: "file1"
2026/09/14 01:10:02 DEBUG : dir/file1: >Remove: err=<nil>
2026/09/14 01:10:02 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2026/09/14 01:10:02 DEBUG : pcloud root 'rclone-test-zokeleb0rolu': ChangeNotify: detected change in "dir" (type: 0)
2026/09/14 01:10:02 DEBUG : changeNotify: relativePath="dir", type=0
2026/09/14 01:10:02 DEBUG : invalidating directory cache
2026/09/14 01:10:02 DEBUG : dir: invalidating directory cache
2026/09/14 01:10:02 DEBUG : >changeNotify: 
2026/09/14 01:10:02 DEBUG : Added virtual directory entry vDel: "dir"
2026/09/14 01:10:02 DEBUG : Removed virtual directory entry vDel: "dir"
    dir_test.go:250: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:486
        	Error:      	Not equal: 
        	            	expected: []string(nil)
        	            	actual  : []string{"dir,0,true"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,2 +1,4 @@
        	            	-([]string) <nil>
        	            	+([]string) (len=1) {
        	            	+ (string) (len=10) "dir,0,true"
        	            	+}
        	            	 
        	Test:       	TestDirRemoveAll
2026/09/14 01:10:02 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:10:02 DEBUG : dir: Looking for writers
2026/09/14 01:10:02 DEBUG : Looking for writers
2026/09/14 01:10:02 DEBUG : dir: reading active writers
2026/09/14 01:10:02 DEBUG : >WaitForWriters: 
--- FAIL: TestDirRemoveAll (1.47s)
=== RUN   TestDirRemoveName
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:10:02 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:12:02 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:12:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:12:02 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:12:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:12:05 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 1/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:14:10 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:14:10 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:14:10 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:14:11 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:14:12 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 2/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:16:17 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:16:17 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:16:18 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:16:19 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:16:20 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 3/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:18:25 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:18:25 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:18:25 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:18:26 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:18:27 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 4/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:19:27 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:27 DEBUG : forgetting directory cache
2026/09/14 01:19:27 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:30 DEBUG : forgetting directory cache
2026/09/14 01:19:30 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:30 DEBUG : dir/subdir: forgetting directory cache
2026/09/14 01:19:31 DEBUG : forgetting directory cache
2026/09/14 01:19:31 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:32 DEBUG : forgetting directory cache
2026/09/14 01:19:32 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:32 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:35 DEBUG : forgetting directory cache
2026/09/14 01:19:35 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:37 DEBUG : forgetting directory cache
2026/09/14 01:19:37 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:37 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:37 DEBUG : fil: forgetting directory cache
2026/09/14 01:19:37 DEBUG : fil/a: forgetting directory cache
2026/09/14 01:19:37 DEBUG : fil/a/b: forgetting directory cache
2026/09/14 01:19:39 DEBUG : forgetting directory cache
2026/09/14 01:19:39 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:39 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:41 DEBUG : forgetting directory cache
2026/09/14 01:19:41 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:43 DEBUG : dir/subdir: forgetting directory cache
2026/09/14 01:19:45 DEBUG : dir/virtualDir2: forgetting directory cache
2026/09/14 01:19:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:19:45 DEBUG : forgetting directory cache
2026/09/14 01:19:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:19:48 DEBUG : forgetting directory cache
2026/09/14 01:19:48 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:48 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:49 DEBUG : forgetting directory cache
2026/09/14 01:19:49 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:49 DEBUG : dir: Removed virtual directory entry vAddFile: "potato"
2026/09/14 01:19:51 DEBUG : forgetting directory cache
2026/09/14 01:19:51 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:51 DEBUG : dir/sub: forgetting directory cache
2026/09/14 01:19:51 DEBUG : dir: Removed virtual directory entry vAddDir: "sub"
2026/09/14 01:19:56 DEBUG : forgetting directory cache
2026/09/14 01:19:56 DEBUG : dir: forgetting directory cache
2026/09/14 01:19:56 DEBUG : dir/sub: forgetting directory cache
2026/09/14 01:19:56 DEBUG : dir/sub/subsub: forgetting directory cache
2026/09/14 01:20:00 DEBUG : dir: forgetting directory cache
2026/09/14 01:20:00 DEBUG : forgetting directory cache
2026/09/14 01:20:02 DEBUG : dir: forgetting directory cache
2026/09/14 01:20:02 DEBUG : dir: forgetting directory cache
2026/09/14 01:20:02 DEBUG : forgetting directory cache
2026/09/14 01:20:02 DEBUG : dir: forgetting directory cache
2026/09/14 01:20:02 DEBUG : forgetting directory cache
2026/09/14 01:20:33 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:20:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:20:33 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:20:34 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:20:35 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 5/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:22:40 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:22:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:22:40 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:22:41 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:22:43 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 6/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:24:48 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:24:48 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:24:48 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:24:49 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:24:50 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 7/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:26:55 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:26:55 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:26:55 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:26:57 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:26:58 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 8/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:29:03 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:29:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:29:03 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:29:04 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:29:05 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 9/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:29:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:29:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:29:45 DEBUG : forgetting directory cache
2026/09/14 01:29:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:29:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:31:11 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:31:11 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:31:11 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:31:12 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:31:13 DEBUG : pacer: Reducing sleep to 10ms
    run.go:303: Failed to put "dir/file1" to "pcloud root 'rclone-test-zokeleb0rolu'": Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF
2026/09/14 01:31:16 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:31:16 DEBUG : Looking for writers
2026/09/14 01:31:16 DEBUG : >WaitForWriters: 
--- FAIL: TestDirRemoveName (1273.98s)
=== RUN   TestDirRename
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:31:16 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:33:16 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:33:16 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:33:16 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:33:17 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:33:19 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 1/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:35:24 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:35:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:35:24 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:35:25 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:35:26 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 2/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:37:31 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:37:31 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:37:32 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:37:33 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:37:34 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 3/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:39:39 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:39:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:39:39 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:39:40 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:39:41 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 4/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:39:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:39:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:39:45 DEBUG : forgetting directory cache
2026/09/14 01:39:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:39:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:41:16 DEBUG : forgetting directory cache
2026/09/14 01:41:47 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:41:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:41:47 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:41:48 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:41:49 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 5/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:43:54 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:43:54 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:43:54 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:43:55 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:43:57 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 6/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:46:02 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:46:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:46:02 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:46:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:46:04 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 7/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:48:09 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:48:09 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:48:10 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:48:11 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:48:12 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 8/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:49:45 DEBUG : forgetting directory cache
2026/09/14 01:49:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:49:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:49:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:49:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:50:17 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:50:17 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:50:17 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:50:18 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:50:19 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 9/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:52:25 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:52:25 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:52:25 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:52:26 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:52:28 DEBUG : pacer: Reducing sleep to 10ms
    run.go:303: Failed to put "dir/file1" to "pcloud root 'rclone-test-zokeleb0rolu'": Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF
2026/09/14 01:52:31 DEBUG : WaitForWriters: timeout=30s
2026/09/14 01:52:31 DEBUG : Looking for writers
2026/09/14 01:52:31 DEBUG : >WaitForWriters: 
--- FAIL: TestDirRename (1275.20s)
=== RUN   TestDirStructSize
    dir_test.go:611: Dir struct has size 192 bytes
--- PASS: TestDirStructSize (0.00s)
=== RUN   TestDirFileOpen
    run.go:198: Remote "pcloud root 'rclone-test-zokeleb0rolu'", Local "Local file system at /tmp/rclone3034821053", Modify Window "1s"
2026/09/14 01:52:31 NOTICE: pcloud root 'rclone-test-zokeleb0rolu': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/09/14 01:54:31 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:54:31 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:54:32 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:54:33 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:54:34 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 1/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:56:39 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:56:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:56:39 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:56:40 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:56:41 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 2/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:58:47 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:58:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 01:58:47 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 01:58:48 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 01:58:49 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 3/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 01:59:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:59:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 01:59:45 DEBUG : forgetting directory cache
2026/09/14 01:59:45 DEBUG : dir: forgetting directory cache
2026/09/14 01:59:45 DEBUG : dir/virtualDir: forgetting directory cache
2026/09/14 02:00:54 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:00:54 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 02:00:54 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 02:00:55 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 02:00:57 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 4/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:02:31 DEBUG : forgetting directory cache
2026/09/14 02:03:02 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:03:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 02:03:02 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 02:03:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 02:03:04 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 5/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:05:10 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:05:10 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 02:05:10 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 02:05:11 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 02:05:12 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 6/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:07:17 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:07:17 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 02:07:17 DEBUG : pacer: Reducing sleep to 15ms
2026/09/14 02:07:18 DEBUG : pacer: Reducing sleep to 11.25ms
2026/09/14 02:07:19 DEBUG : pacer: Reducing sleep to 10ms
    run.go:299: Retry Put of "dir/file1" to pcloud root 'rclone-test-zokeleb0rolu': 7/10 (Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:09:25 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=file1&folderid=26539177261&mtime=981173106&nopartial=1": EOF)
2026/09/14 02:09:25 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/14 02:09:25 DEBUG : pacer: Reducing sleep to 15ms
panic: test timed out after 1h0m0s
	running tests:
		TestDirFileOpen (16m54s)

goroutine 30787 [running]:
testing.(*M).startAlarm.func1()
	/usr/local/go/src/testing/testing.go:2959 +0x34a
created by time.goFunc
	/usr/local/go/src/time/sleep.go:182 +0x2d

goroutine 1 [chan receive, 16 minutes]:
testing.(*T).Run(0x616769c6488, {0x24feda8?, 0x61676c0fa58?}, 0x490bb00)
	/usr/local/go/src/testing/testing.go:2266 +0x4f2
testing.runTests.func1(0x616769c6488)
	/usr/local/go/src/testing/testing.go:2742 +0x37
testing.tRunner(0x616769c6488, 0x61676c0fb80)
	/usr/local/go/src/testing/testing.go:2193 +0xea
testing.runTests({0x2522022, 0x18}, {0x253362b, 0x1c}, 0x61676f5d980, {0x4be44b0, 0x62, 0x62}, {0xc2a1f3b583182d0a, 0x34882eefbc1, ...})
	/usr/local/go/src/testing/testing.go:2740 +0x510
testing.(*M).Run(0x61676d566e0)
	/usr/local/go/src/testing/testing.go:2600 +0x6af
github.com/rclone/rclone/fstest.TestMain(0x61676d566e0)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:75 +0xa6
github.com/rclone/rclone/vfs.TestMain(...)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/vfs_test.go:36
main.main()
	_testmain.go:244 +0xa6

goroutine 21684 [select, 16 minutes]:
github.com/rclone/rclone/vfs.(*VFS).signalHandler(0x61677097a20, {0x48f1470, 0x61676f9caf0})
	/home/rclone/go/src/github.com/rclone/rclone/vfs/vfs.go:306 +0xc5
created by github.com/rclone/rclone/vfs.New in goroutine 21648
	/home/rclone/go/src/github.com/rclone/rclone/vfs/vfs.go:281 +0x928

goroutine 50 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0x61676957880)
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x85
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xfa

goroutine 14 [syscall, 60 minutes]:
os/signal.signal_recv()
	/usr/local/go/src/runtime/sigqueue.go:152 +0x98
os/signal.loop()
	/usr/local/go/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func2.1 in goroutine 1
	/usr/local/go/src/os/signal/signal.go:164 +0x1f

goroutine 15 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xae

goroutine 21648 [sleep]:
time.Sleep(0x3b9aca00)
	/usr/local/go/src/runtime/time.go:368 +0x165
github.com/rclone/rclone/backend/pcloud.(*Object).Update(0x61676914fc0, {0x48f1390, 0x4c29820}, {0x48c9568, 0x61676da94d0}, {0x48fa918, 0x616769e0a80}, {0x0, 0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:1547 +0xe05
github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x61676918b00, {0x48f1390, 0x4c29820}, {0x48c9568, 0x61676da94d0}, {0x48fa918, 0x616769e0a80}, {0x0, 0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:764 +0x14c
github.com/rclone/rclone/fstest.(*Run).WriteObjectTo(0x61676b06a10, {0x48f1390, 0x4c29820}, {0x4900c00, 0x61676918b00}, {0x24ec0c4, 0x9}, {0x24fbb11, 0xe}, {0x1dcd64ff, ...}, ...)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:293 +0x408
github.com/rclone/rclone/fstest.(*Run).WriteObject(...)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:310
github.com/rclone/rclone/vfs.dirCreate(0x61676d3eb48)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:25 +0xb2
github.com/rclone/rclone/vfs.TestDirFileOpen(0x61676d3eb48)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:616 +0x36
testing.tRunner(0x61676d3eb48, 0x490bb00)
	/usr/local/go/src/testing/testing.go:2193 +0xea
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:2258 +0x4d4

goroutine 30781 [select]:
net/http.(*persistConn).writeLoop(0x61676983cc0)
	/usr/local/go/src/net/http/transport.go:2810 +0xe6
created by net/http.(*Transport).dialConn in goroutine 30775
	/usr/local/go/src/net/http/transport.go:2124 +0x1e05

goroutine 30780 [IO wait]:
internal/poll.runtime_pollWait(0x726ed9a32200, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0x61676916880?, 0x61677102000?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0x61676916880, {0x61677102000, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:170 +0x2a8
net.(*netFD).Read(0x61676916880, {0x61677102000?, 0x61677102005?, 0x6167643e678?})
	/usr/local/go/src/net/fd_posix.go:68 +0x25
net.(*conn).Read(0x6167643e678, {0x61677102000?, 0x61676c2ea18?, 0x1700061676c2ea10?})
	/usr/local/go/src/net/net.go:196 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0x616769db518, {0x61677102000?, 0x726e901d4d30?, 0x726ed9ab8bf0?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*Conn).readFromUntil(0x6167699e808, {0x726e9026f468, 0x616769db518}, 0x61677098ef9?)
	/usr/local/go/src/crypto/tls/conn.go:820 +0xf4
crypto/tls.(*Conn).readRecordOrCCS(0x6167699e808, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:626 +0x3fb
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:588
crypto/tls.(*Conn).Read(0x6167699e808, {0x61676f77000, 0x1000, 0x70?})
	/usr/local/go/src/crypto/tls/conn.go:1392 +0x148
net/http.(*persistConn).Read(0x61676983cc0, {0x61676f77000?, 0x70?, 0x0?})
	/usr/local/go/src/net/http/transport.go:2300 +0x47
bufio.(*Reader).fill(0x61677100fc0)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0x61677100fc0, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x52
net/http.(*persistConn).readLoop(0x61676983cc0)
	/usr/local/go/src/net/http/transport.go:2483 +0x172
created by net/http.(*Transport).dialConn in goroutine 30775
	/usr/local/go/src/net/http/transport.go:2123 +0x1da5

goroutine 21649 [select]:
net/http.(*persistConn).roundTrip(0x61676983cc0, 0x6167691b0e0)
	/usr/local/go/src/net/http/transport.go:3069 +0x84b
net/http.(*Transport).roundTrip(0x616769bcc40, 0x61676983b80)
	/usr/local/go/src/net/http/transport.go:725 +0xada
net/http.(*Transport).RoundTrip(...)
	/usr/local/go/src/net/http/roundtrip.go:33
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0x616764f4b40, 0x61676983b80)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:700 +0x63b
golang.org/x/oauth2.(*Transport).RoundTrip(0x61676522ea0, 0x61676983a40)
	/home/rclone/go/pkg/mod/golang.org/x/oauth2@v0.36.0/transport.go:55 +0x15b
net/http.send(0x61676983a40, {0x48cd1e8, 0x61676522ea0}, {0x616764a5198?, 0x497406?, 0x0?})
	/usr/local/go/src/net/http/client.go:266 +0x654
net/http.(*Client).send(0x61676cef6e0, 0x61676983a40, {0x269c6a0?, 0x1?, 0x0?})
	/usr/local/go/src/net/http/client.go:187 +0x250
net/http.(*Client).do(0x61676cef6e0, 0x61676983a40)
	/usr/local/go/src/net/http/client.go:745 +0x9f7
net/http.(*Client).Do(...)
	/usr/local/go/src/net/http/client.go:604
github.com/rclone/rclone/lib/rest.(*Client).Call(0x616769581e0, {0x48f14e0, 0x616765121c0}, 0x616764a5b40)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:440 +0xe85
github.com/rclone/rclone/lib/rest.(*Client).callCodec(0x616769581e0, {0x48f14e0, 0x616765121c0}, 0x726ed9a32230?, {0x0?, 0x0?}, {0x409f6d0, 0x61676b22d00}, 0x41df540?, 0x490d558, ...)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:686 +0x4e8
github.com/rclone/rclone/lib/rest.(*Client).CallJSON(...)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:623
github.com/rclone/rclone/backend/pcloud.(*Fs).changeNotifyLoop(0x61676918b00, {0x48f1470, 0x61676f9caf0}, 0x616769327b0, 0x616765170a0)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:1192 +0x4ad
created by github.com/rclone/rclone/backend/pcloud.(*Fs).ChangeNotify in goroutine 21648
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:1097 +0xb4
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Finished ERROR in 1h0m9.988167621s (try 1/5): exit status 2: Failed [TestDirRemoveAll TestDirRemoveName TestDirRename]