"./vfs.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestDirRename$'" - Starting (try 5/5)
2025/07/12 04:05:58 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-gojahix5falo"
2025/07/12 04:05:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/07/12 04:05:59 DEBUG : Starting OpenDrive session with ID: 9e3e82ac8461233825dc2fb6f1a1b36be8a324c963bdb4ac2c8d8e2fb58b3f27
2025/07/12 04:05:59 DEBUG : Creating backend with remote "/tmp/rclone997667338"
=== RUN   TestDirRename
    run.go:180: Remote "OpenDrive root 'rclone-test-gojahix5falo'", Local "Local file system at /tmp/rclone997667338", Modify Window "1s"
2025/07/12 04:05:59 INFO  : OpenDrive root 'rclone-test-gojahix5falo': poll-interval is not supported by this remote
2025/07/12 04:05:59 NOTICE: OpenDrive root 'rclone-test-gojahix5falo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/07/12 04:06:01 DEBUG : dir/file1: Uploading chunk 0, size=14, remain=0
    fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Flushing the directory cache
    fstest.go:289: Sleeping for 6s just to make sure
2025/07/12 04:06:11 DEBUG : dir/file3: Uploading chunk 0, size=15, remain=0
2025/07/12 04:06:12 ERROR : dir/not found: Dir.Rename error: file does not exist
2025/07/12 04:06:12 DEBUG : dir2: same parent dir (ODFfOTE2ODgxMl9DWjh6NA) - using folder/rename instead of move_copy
2025/07/12 04:06:12 DEBUG : dir: Updating dir with dir2 0xc0009c1110
2025/07/12 04:06:12 DEBUG : dir: forgetting directory cache
2025/07/12 04:06:12 DEBUG : Added virtual directory entry vDel: "dir"
2025/07/12 04:06:12 DEBUG : Added virtual directory entry vAddDir: "dir2"
2025/07/12 04:06:14 INFO  : dir2/file1: Moved (server-side) to: file2
2025/07/12 04:06:14 DEBUG : file2: Updating file with file2 0xc0005ea180
2025/07/12 04:06:14 DEBUG : dir2: Added virtual directory entry vDel: "file1"
2025/07/12 04:06:14 DEBUG : Added virtual directory entry vAddFile: "file2"
2025/07/12 04:06:15 INFO  : dir2/file3: Deleted
2025/07/12 04:06:15 INFO  : file2: Moved (server-side) to: dir2/file3
2025/07/12 04:06:15 DEBUG : dir2/file3: Updating file with dir2/file3 0xc0005ea180
2025/07/12 04:06:15 DEBUG : Added virtual directory entry vDel: "file2"
2025/07/12 04:06:15 DEBUG : dir2: Added virtual directory entry vAddFile: "file3"
2025/07/12 04:06:16 DEBUG : Added virtual directory entry vAddDir: "empty directory"
2025/07/12 04:06:16 DEBUG : renamed empty directory: same parent dir (ODFfOTE2ODgxMl9DWjh6NA) - using folder/rename instead of move_copy
2025/07/12 04:06:16 DEBUG : empty directory: Updating dir with renamed empty directory 0xc00097ac30
2025/07/12 04:06:16 DEBUG : empty directory: forgetting directory cache
2025/07/12 04:06:16 DEBUG : Added virtual directory entry vDel: "empty directory"
2025/07/12 04:06:16 DEBUG : Added virtual directory entry vAddDir: "renamed empty directory"
2025/07/12 04:06:16 DEBUG : dir2: Renaming to "dir3"
2025/07/12 04:06:16 DEBUG : WaitForWriters: timeout=30s
2025/07/12 04:06:16 DEBUG : dir3: Looking for writers
2025/07/12 04:06:16 DEBUG : file3: reading active writers
2025/07/12 04:06:16 DEBUG : renamed empty directory: Looking for writers
2025/07/12 04:06:16 DEBUG : Looking for writers
2025/07/12 04:06:16 DEBUG : dir3: reading active writers
2025/07/12 04:06:16 DEBUG : renamed empty directory: reading active writers
2025/07/12 04:06:16 DEBUG : >WaitForWriters: 
--- PASS: TestDirRename (18.21s)
PASS
2025/07/12 04:06:18 DEBUG : OpenDrive root 'rclone-test-gojahix5falo': Purge remote
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestDirRename$'" - Finished OK in 19.523875478s (try 5/5)