"./vfs.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose" - Starting (try 1/5) 2025/11/20 12:43:57 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-qowiniy3deqa" 2025/11/20 12:43:57 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/20 12:43:57 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE 2025/11/20 12:43:57 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2025/11/20 12:43:57 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2025/11/20 12:43:57 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2025/11/20 12:43:57 DEBUG : Setting pass="AJUEzQ2wi27QYzm5-phezLRkxJs2FLofsmPILxm4YJnzvJQ" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2025/11/20 12:43:57 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{ICNkY}" suffix to name 2025/11/20 12:43:57 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2025/11/20 12:43:57 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2025/11/20 12:43:57 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2025/11/20 12:43:57 DEBUG : Setting pass="AJUEzQ2wi27QYzm5-phezLRkxJs2FLofsmPILxm4YJnzvJQ" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2025/11/20 12:43:57 DEBUG : found headers: 2025/11/20 12:43:58 DEBUG : Creating backend with remote "/tmp/rclone285404664" === RUN TestDirHandleMethods run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:43:58 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:43:58 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:43:59 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:43:59 DEBUG : dir: Looking for writers 2025/11/20 12:43:59 DEBUG : Looking for writers 2025/11/20 12:43:59 DEBUG : dir: reading active writers 2025/11/20 12:43:59 DEBUG : >WaitForWriters: --- PASS: TestDirHandleMethods (1.49s) === RUN TestDirHandleReaddir run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:43:59 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:43:59 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:44:00 DEBUG : dir/file2: Update will use the normal upload strategy (no chunks) 2025/11/20 12:44:00 DEBUG : dir/subdir/file3: Update will use the normal upload strategy (no chunks) 2025/11/20 12:44:01 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:44:01 DEBUG : dir/subdir: Looking for writers 2025/11/20 12:44:01 DEBUG : dir: Looking for writers 2025/11/20 12:44:01 DEBUG : file1: reading active writers 2025/11/20 12:44:01 DEBUG : file2: reading active writers 2025/11/20 12:44:01 DEBUG : subdir: reading active writers 2025/11/20 12:44:01 DEBUG : Looking for writers 2025/11/20 12:44:01 DEBUG : dir: reading active writers 2025/11/20 12:44:01 DEBUG : >WaitForWriters: 2025/11/20 12:44:02 DEBUG : pacer: low level retry 1/10 (error An exception occurred while executing 'UPDATE "oc_file_locks" SET "lock" = 0 WHERE "key" = ? AND "lock" = -1' with params ["files\/c63345ad31e254516bf8f3cd5e0df4ef"]: SQLSTATE[HY000]: General error: 5 database is locked: Doctrine\DBAL\Exception\LockWaitTimeoutException: 500 Internal Server Error) 2025/11/20 12:44:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 12:44:02 DEBUG : pacer: Reducing sleep to 15ms run.go:130: removing dir "dir/subdir" failed - try 1/3: rmdir failed: Sabre\DAV\Exception\Forbidden: 403 Forbidden 2025/11/20 12:44:03 DEBUG : pacer: Reducing sleep to 11.25ms run.go:130: removing dir "dir/subdir" failed - try 2/3: directory not found 2025/11/20 12:44:04 DEBUG : pacer: Reducing sleep to 10ms run.go:130: removing dir "dir/subdir" failed - try 3/3: directory not found run.go:133: removing dir "dir/subdir" failed: directory not found 2025/11/20 12:44:05 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 12:44:05 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:05 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 12:44:05 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:05 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 12:44:05 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:05 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 12:44:06 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:06 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 12:44:06 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:06 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 12:44:06 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:06 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 12:44:07 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:44:08 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:10 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:44:12 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:44:14 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:44:15 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:17 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:19 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:21 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:25 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:27 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:29 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:31 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:44:33 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:44:35 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:44:37 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:41 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:43 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:45 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:47 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:49 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:51 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:44:53 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:44:55 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:44:57 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:44:58 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:45:00 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:45:02 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:45:02 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirHandleReaddir Messages: directories --- FAIL: TestDirHandleReaddir (66.92s) === RUN TestDirHandleReaddirnames run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:45:06 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:45:06 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:45:06 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:45:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:45:07 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:45:07 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:45:07 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:45:07 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:45:08 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:45:08 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:45:08 DEBUG : dir: Looking for writers 2025/11/20 12:45:08 DEBUG : file1: reading active writers 2025/11/20 12:45:08 DEBUG : Looking for writers 2025/11/20 12:45:08 DEBUG : dir: reading active writers 2025/11/20 12:45:08 DEBUG : >WaitForWriters: 2025/11/20 12:45:08 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:45:08 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:45:08 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:45:08 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:45:08 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:08 DEBUG : pacer: Rate limited, increasing sleep to 30.067784ms 2025/11/20 12:45:08 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:08 DEBUG : pacer: Rate limited, increasing sleep to 60.135568ms 2025/11/20 12:45:08 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:08 DEBUG : pacer: Rate limited, increasing sleep to 120.271136ms 2025/11/20 12:45:08 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:08 DEBUG : pacer: Rate limited, increasing sleep to 240.542272ms 2025/11/20 12:45:09 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:09 DEBUG : pacer: Rate limited, increasing sleep to 481.084544ms 2025/11/20 12:45:09 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:09 DEBUG : pacer: Rate limited, increasing sleep to 962.169088ms 2025/11/20 12:45:09 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:09 DEBUG : pacer: Rate limited, increasing sleep to 1.924338176s 2025/11/20 12:45:10 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:10 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:45:12 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:14 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:45:16 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:45:18 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:45:20 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:22 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:24 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:26 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:28 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:30 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:32 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:34 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:36 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:45:38 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:45:40 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:40 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:45:41 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:43 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:45 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:47 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:49 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:51 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:53 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:55 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:45:57 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:45:59 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:46:01 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:46:03 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:46:04 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:46:06 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:46:07 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirHandleReaddirnames Messages: directories --- FAIL: TestDirHandleReaddirnames (64.27s) === RUN TestDirMethods run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:46:11 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:46:11 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:46:11 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:46:11 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:46:11 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:46:11 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:46:12 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:46:12 DEBUG : dir: Looking for writers 2025/11/20 12:46:12 DEBUG : Looking for writers 2025/11/20 12:46:12 DEBUG : dir: reading active writers 2025/11/20 12:46:12 DEBUG : >WaitForWriters: 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:46:12 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:46:12 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:12 DEBUG : pacer: Rate limited, increasing sleep to 40.09038ms 2025/11/20 12:46:12 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:12 DEBUG : pacer: Rate limited, increasing sleep to 80.18076ms 2025/11/20 12:46:13 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:13 DEBUG : pacer: Rate limited, increasing sleep to 160.36152ms 2025/11/20 12:46:13 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:13 DEBUG : pacer: Rate limited, increasing sleep to 320.72304ms 2025/11/20 12:46:13 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:13 DEBUG : pacer: Rate limited, increasing sleep to 641.44608ms 2025/11/20 12:46:13 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:13 DEBUG : pacer: Rate limited, increasing sleep to 1.28289216s 2025/11/20 12:46:14 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:46:15 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:17 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:19 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:46:21 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:46:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:23 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:46:25 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:27 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:31 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:33 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:35 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:37 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:39 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:41 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:46:43 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:46:45 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:46:46 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:48 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:50 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:52 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:54 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:56 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:46:58 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:00 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:02 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:47:04 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:47:06 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:47:08 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:47:09 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:47:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:47:11 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirMethods Messages: directories --- FAIL: TestDirMethods (64.93s) === RUN TestDirForgetAll run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:47:15 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:47:16 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:47:16 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:47:16 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:47:16 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:47:16 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:47:17 DEBUG : dir: forgetting directory cache 2025/11/20 12:47:17 DEBUG : forgetting directory cache 2025/11/20 12:47:17 DEBUG : dir: forgetting directory cache 2025/11/20 12:47:17 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:47:17 DEBUG : Looking for writers 2025/11/20 12:47:17 DEBUG : >WaitForWriters: 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:47:17 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:47:17 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:17 DEBUG : pacer: Rate limited, increasing sleep to 30.067784ms 2025/11/20 12:47:17 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:17 DEBUG : pacer: Rate limited, increasing sleep to 60.135568ms 2025/11/20 12:47:18 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:18 DEBUG : pacer: Rate limited, increasing sleep to 120.271136ms 2025/11/20 12:47:18 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:18 DEBUG : pacer: Rate limited, increasing sleep to 240.542272ms 2025/11/20 12:47:18 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:18 DEBUG : pacer: Rate limited, increasing sleep to 481.084544ms 2025/11/20 12:47:18 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:18 DEBUG : pacer: Rate limited, increasing sleep to 962.169088ms 2025/11/20 12:47:19 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:19 DEBUG : pacer: Rate limited, increasing sleep to 1.924338176s 2025/11/20 12:47:20 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:20 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:47:21 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:23 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:47:25 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:47:27 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:27 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:47:29 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:31 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:33 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:35 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:37 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:39 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:41 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:43 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:45 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:47:47 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:47:49 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:49 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:47:50 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:52 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:54 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:56 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:47:58 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:00 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:02 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:04 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:06 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:48:08 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:48:10 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:48:12 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:48:13 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:48:15 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:48:16 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirForgetAll Messages: directories --- FAIL: TestDirForgetAll (64.34s) === RUN TestDirForgetPath run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:48:20 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:48:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:48:20 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:48:20 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:48:21 DEBUG : ForgetPath: relativePath="dir/notfound", type=1 2025/11/20 12:48:21 DEBUG : dir: invalidating directory cache 2025/11/20 12:48:21 DEBUG : >ForgetPath: 2025/11/20 12:48:21 DEBUG : ForgetPath: relativePath="dir", type=0 2025/11/20 12:48:21 DEBUG : invalidating directory cache 2025/11/20 12:48:21 DEBUG : dir: forgetting directory cache 2025/11/20 12:48:21 DEBUG : >ForgetPath: 2025/11/20 12:48:21 DEBUG : ForgetPath: relativePath="not/in/cache", type=0 2025/11/20 12:48:21 DEBUG : >ForgetPath: 2025/11/20 12:48:21 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:48:21 DEBUG : dir: Looking for writers 2025/11/20 12:48:21 DEBUG : Looking for writers 2025/11/20 12:48:21 DEBUG : dir: reading active writers 2025/11/20 12:48:21 DEBUG : >WaitForWriters: 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:48:21 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 30.067784ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 60.135568ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 120.271136ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 240.542272ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 481.084544ms 2025/11/20 12:48:22 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:22 DEBUG : pacer: Rate limited, increasing sleep to 962.169088ms 2025/11/20 12:48:23 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:23 DEBUG : pacer: Rate limited, increasing sleep to 1.924338176s 2025/11/20 12:48:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:48:26 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:28 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:48:30 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:48:32 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:48:33 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:35 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:37 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:39 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:41 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:43 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:45 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:47 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:49 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:48:51 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:48:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:53 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:48:55 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:57 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:48:59 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:01 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:03 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:05 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:07 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:09 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:11 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:49:13 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:49:15 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:49:16 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:49:17 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:49:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:49:20 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirForgetPath Messages: directories --- FAIL: TestDirForgetPath (64.26s) === RUN TestDirWalk run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:49:24 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:49:24 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:49:24 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:49:25 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:49:26 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:49:26 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:49:26 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:49:26 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 12:49:26 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 12:49:26 DEBUG : fil/a/b/c: Update will use the normal upload strategy (no chunks) 2025/11/20 12:49:27 DEBUG : forgetting directory cache 2025/11/20 12:49:27 DEBUG : dir: forgetting directory cache 2025/11/20 12:49:27 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:49:27 DEBUG : dir: Looking for writers 2025/11/20 12:49:27 DEBUG : fil/a/b: Looking for writers 2025/11/20 12:49:27 DEBUG : fil/a: Looking for writers 2025/11/20 12:49:27 DEBUG : b: reading active writers 2025/11/20 12:49:27 DEBUG : fil: Looking for writers 2025/11/20 12:49:27 DEBUG : a: reading active writers 2025/11/20 12:49:27 DEBUG : Looking for writers 2025/11/20 12:49:27 DEBUG : dir: reading active writers 2025/11/20 12:49:27 DEBUG : fil: reading active writers 2025/11/20 12:49:27 DEBUG : >WaitForWriters: 2025/11/20 12:49:28 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 12:49:29 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:29 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 12:49:30 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:30 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:49:31 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:33 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:49:35 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:49:37 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:49:39 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:41 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:43 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:45 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:47 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:49 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:51 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:53 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:55 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:49:57 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:49:59 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:49:59 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:50:00 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:02 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:04 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:06 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:08 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:10 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:12 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:14 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:16 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:50:18 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:50:20 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:50:22 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:50:23 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:50:25 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:50:26 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirWalk Messages: directories --- FAIL: TestDirWalk (65.64s) === RUN TestDirSetModTime run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:50:30 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:50:30 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:50:30 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:50:30 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:50:30 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:50:31 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:50:31 DEBUG : dir: Looking for writers 2025/11/20 12:50:31 DEBUG : Looking for writers 2025/11/20 12:50:31 DEBUG : dir: reading active writers 2025/11/20 12:50:31 DEBUG : >WaitForWriters: 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:50:31 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:50:31 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:31 DEBUG : pacer: Rate limited, increasing sleep to 40.09038ms 2025/11/20 12:50:32 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:32 DEBUG : pacer: Rate limited, increasing sleep to 80.18076ms 2025/11/20 12:50:32 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:32 DEBUG : pacer: Rate limited, increasing sleep to 160.36152ms 2025/11/20 12:50:32 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:32 DEBUG : pacer: Rate limited, increasing sleep to 320.72304ms 2025/11/20 12:50:32 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:32 DEBUG : pacer: Rate limited, increasing sleep to 641.44608ms 2025/11/20 12:50:32 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:32 DEBUG : pacer: Rate limited, increasing sleep to 1.28289216s 2025/11/20 12:50:33 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:50:34 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:36 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:38 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:50:40 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:50:42 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:42 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:50:44 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:46 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:48 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:50 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:52 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:54 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:56 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:50:58 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:00 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:51:02 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:51:04 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:04 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:51:05 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:07 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:09 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:11 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:13 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:15 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:17 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:19 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:21 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:51:23 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:51:25 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:51:27 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:51:28 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:51:30 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:51:31 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirSetModTime Messages: directories --- FAIL: TestDirSetModTime (64.88s) === RUN TestDirStat run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:51:35 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:51:35 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:51:35 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:51:35 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:51:35 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:51:36 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:51:36 DEBUG : dir: Looking for writers 2025/11/20 12:51:36 DEBUG : file1: reading active writers 2025/11/20 12:51:36 DEBUG : Looking for writers 2025/11/20 12:51:36 DEBUG : dir: reading active writers 2025/11/20 12:51:36 DEBUG : >WaitForWriters: 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:51:36 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:51:36 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:36 DEBUG : pacer: Rate limited, increasing sleep to 30.067784ms 2025/11/20 12:51:36 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:36 DEBUG : pacer: Rate limited, increasing sleep to 60.135568ms 2025/11/20 12:51:37 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:37 DEBUG : pacer: Rate limited, increasing sleep to 120.271136ms 2025/11/20 12:51:37 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:37 DEBUG : pacer: Rate limited, increasing sleep to 240.542272ms 2025/11/20 12:51:37 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:37 DEBUG : pacer: Rate limited, increasing sleep to 481.084544ms 2025/11/20 12:51:37 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:37 DEBUG : pacer: Rate limited, increasing sleep to 962.169088ms 2025/11/20 12:51:38 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:38 DEBUG : pacer: Rate limited, increasing sleep to 1.924338176s 2025/11/20 12:51:39 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:39 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:51:40 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:42 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:51:44 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:51:46 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:51:48 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:50 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:52 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:54 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:56 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:51:58 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:00 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:02 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:04 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:52:06 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:52:08 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:08 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:52:09 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:11 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:13 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:15 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:17 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:19 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:21 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:23 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:25 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:52:27 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:52:29 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:52:31 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:52:32 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:52:34 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:52:35 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirStat Messages: directories --- FAIL: TestDirStat (64.19s) === RUN TestDirReadDirAll run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:52:39 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:52:39 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:52:39 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:52:39 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:52:40 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:52:40 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:52:40 DEBUG : dir/file2: Update will use the normal upload strategy (no chunks) 2025/11/20 12:52:40 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:52:40 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:52:40 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:40 DEBUG : pacer: Rate limited, increasing sleep to 126.705406ms 2025/11/20 12:52:40 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:40 DEBUG : pacer: Rate limited, increasing sleep to 253.410812ms 2025/11/20 12:52:40 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:40 DEBUG : pacer: Rate limited, increasing sleep to 506.821624ms 2025/11/20 12:52:41 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:41 DEBUG : pacer: Rate limited, increasing sleep to 1.013643248s 2025/11/20 12:52:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:52:42 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:44 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:46 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:48 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:50 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 1/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:52 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:54 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:56 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:52:58 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:00 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:02 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:06 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:08 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:10 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 2/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:12 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:14 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:16 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:18 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:20 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:22 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:24 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:26 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:28 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:30 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 3/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:33 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:35 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:36 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:43 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:45 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:47 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:48 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:50 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 4/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:55 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:57 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:59 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:53:59 DEBUG : dir: forgetting directory cache 2025/11/20 12:53:59 DEBUG : forgetting directory cache 2025/11/20 12:53:59 DEBUG : dir: forgetting directory cache 2025/11/20 12:54:01 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:01 DEBUG : forgetting directory cache 2025/11/20 12:54:01 DEBUG : dir: forgetting directory cache 2025/11/20 12:54:01 DEBUG : dir/subdir: forgetting directory cache 2025/11/20 12:54:03 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:05 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:07 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:09 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:11 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 5/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:13 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:15 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:17 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:19 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:21 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:25 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:27 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:29 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:31 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 6/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:33 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:35 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:37 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:43 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:45 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:47 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:49 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:51 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 7/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:55 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:57 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:54:59 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:01 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:03 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:05 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:07 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:07 DEBUG : forgetting directory cache 2025/11/20 12:55:07 DEBUG : dir: forgetting directory cache 2025/11/20 12:55:09 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:11 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 8/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:13 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:15 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:17 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:19 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:21 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:25 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:27 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:29 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:31 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:286: Retry Put of "dir/subdir/file3" to webdav root 'rclone-test-qowiniy3deqa': 9/10 (Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:33 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:35 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:37 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:43 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:45 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:47 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:49 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:51 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:290: Failed to put "dir/subdir/file3" to "webdav root 'rclone-test-qowiniy3deqa'": Update mkParentDir failed: "rclone-test-qowiniy3deqa/dir/subdir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:55:51 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:55:51 DEBUG : Looking for writers 2025/11/20 12:55:51 DEBUG : >WaitForWriters: 2025/11/20 12:55:53 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:55:55 DEBUG : pacer: Reducing sleep to 1.125s 2025/11/20 12:55:57 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:55:58 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/11/20 12:55:59 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:55:59 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:55:59 DEBUG : pacer: Rate limited, increasing sleep to 949.21875ms 2025/11/20 12:56:00 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:00 DEBUG : pacer: Rate limited, increasing sleep to 1.8984375s 2025/11/20 12:56:01 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:01 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:56:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:05 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:07 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:09 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:11 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:12 DEBUG : dir: forgetting directory cache 2025/11/20 12:56:12 DEBUG : forgetting directory cache 2025/11/20 12:56:12 DEBUG : dir: forgetting directory cache 2025/11/20 12:56:13 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:15 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:56:17 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:56:19 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:19 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:56:20 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:22 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:24 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:26 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:28 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:30 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:32 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:34 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:36 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:56:38 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:56:40 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:40 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:56:42 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:44 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:46 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:48 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:50 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:52 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:54 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:56 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:56:58 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:57:00 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:57:02 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:57:03 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:57:04 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:57:06 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:57:07 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /usr/local/go/src/testing/testing.go:1125 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:290 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:297 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:258 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirReadDirAll Messages: directories --- FAIL: TestDirReadDirAll (272.19s) === RUN TestDirOpen run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:57:11 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:57:11 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:57:11 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:57:12 ERROR : dir/: Can only open directories read only 2025/11/20 12:57:12 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:57:12 DEBUG : dir: Looking for writers 2025/11/20 12:57:12 DEBUG : Looking for writers 2025/11/20 12:57:12 DEBUG : dir: reading active writers 2025/11/20 12:57:12 DEBUG : >WaitForWriters: 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:57:12 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:57:13 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:57:13 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:13 DEBUG : pacer: Rate limited, increasing sleep to 40.09038ms 2025/11/20 12:57:13 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:13 DEBUG : pacer: Rate limited, increasing sleep to 80.18076ms 2025/11/20 12:57:13 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:13 DEBUG : pacer: Rate limited, increasing sleep to 160.36152ms 2025/11/20 12:57:13 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:13 DEBUG : pacer: Rate limited, increasing sleep to 320.72304ms 2025/11/20 12:57:13 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:13 DEBUG : pacer: Rate limited, increasing sleep to 641.44608ms 2025/11/20 12:57:14 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:14 DEBUG : pacer: Rate limited, increasing sleep to 1.28289216s 2025/11/20 12:57:14 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:57:15 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:17 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:19 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:57:21 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:57:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:23 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:57:25 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:27 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:31 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:33 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:35 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:37 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:39 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:41 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:57:43 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:57:45 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:57:46 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:48 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:50 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:52 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:54 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:56 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:57:58 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:00 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:02 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:58:04 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:58:06 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:58:08 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:58:09 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:58:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:58:12 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirOpen Messages: directories --- FAIL: TestDirOpen (64.81s) === RUN TestDirCreate run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:58:16 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:58:16 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:58:16 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:58:16 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:58:17 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE 2025/11/20 12:58:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2025/11/20 12:58:17 DEBUG : dir/potato: >Open: fd=dir/potato (w), err= 2025/11/20 12:58:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2025/11/20 12:58:17 DEBUG : webdav root 'rclone-test-qowiniy3deqa': File to upload is small (5 bytes), uploading instead of streaming 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:58:17 DEBUG : dir/potato: Update will use the normal upload strategy (no chunks) 2025/11/20 12:58:17 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:58:18 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:58:18 DEBUG : dir/potato: size = 5 OK 2025/11/20 12:58:18 DEBUG : dir/potato: md5 = 5d41402abc4b2a76b9719d911017c592 OK 2025/11/20 12:58:18 DEBUG : dir/potato: Size and md5 of src and dst objects identical 2025/11/20 12:58:18 DEBUG : dir: Added virtual directory entry vAddFile: "potato" 2025/11/20 12:58:18 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:58:18 DEBUG : dir: Looking for writers 2025/11/20 12:58:18 DEBUG : file1: reading active writers 2025/11/20 12:58:18 DEBUG : potato: reading active writers 2025/11/20 12:58:18 DEBUG : Looking for writers 2025/11/20 12:58:18 DEBUG : dir: reading active writers 2025/11/20 12:58:18 DEBUG : >WaitForWriters: 2025/11/20 12:58:18 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:58:18 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 12:58:18 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 12:58:18 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:18 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 12:58:18 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:18 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 12:58:19 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:19 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 12:58:19 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:19 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 12:58:19 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:19 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 12:58:19 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:19 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 12:58:19 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:19 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 12:58:20 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:20 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:58:21 DEBUG : forgetting directory cache 2025/11/20 12:58:21 DEBUG : dir: forgetting directory cache 2025/11/20 12:58:21 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:23 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:58:25 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:58:27 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:27 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:58:29 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:31 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:33 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:35 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:37 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:39 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:41 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:43 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:45 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:58:47 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:58:49 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:49 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:58:50 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:52 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:54 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:56 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:58:58 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:00 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:02 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:04 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:06 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:59:08 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:59:10 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 12:59:12 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 12:59:13 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 12:59:15 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 12:59:16 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirCreate Messages: directories --- FAIL: TestDirCreate (63.81s) === RUN TestDirMkdir run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 12:59:20 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 12:59:20 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 12:59:20 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 12:59:20 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 12:59:20 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 12:59:21 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 12:59:21 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 12:59:21 DEBUG : WaitForWriters: timeout=30s 2025/11/20 12:59:21 DEBUG : dir/sub: Looking for writers 2025/11/20 12:59:21 DEBUG : dir: Looking for writers 2025/11/20 12:59:21 DEBUG : file1: reading active writers 2025/11/20 12:59:21 DEBUG : sub: reading active writers 2025/11/20 12:59:21 DEBUG : Looking for writers 2025/11/20 12:59:21 DEBUG : dir: reading active writers 2025/11/20 12:59:21 DEBUG : >WaitForWriters: 2025/11/20 12:59:22 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 12:59:22 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 12:59:22 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:22 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 12:59:22 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:22 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 12:59:22 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:22 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 12:59:23 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:23 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 12:59:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:23 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 12:59:23 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:23 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 12:59:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:59:25 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:27 DEBUG : dir: forgetting directory cache 2025/11/20 12:59:27 DEBUG : forgetting directory cache 2025/11/20 12:59:27 DEBUG : dir: forgetting directory cache 2025/11/20 12:59:27 DEBUG : fil: forgetting directory cache 2025/11/20 12:59:27 DEBUG : fil/a: forgetting directory cache 2025/11/20 12:59:27 DEBUG : fil/a/b: forgetting directory cache 2025/11/20 12:59:27 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:59:29 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:59:31 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:31 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:59:33 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:35 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:37 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:39 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:41 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:43 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:45 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:47 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:48 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 12:59:51 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 12:59:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:53 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 12:59:54 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:56 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 12:59:58 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:00 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:02 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:06 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:08 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:10 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:00:12 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:00:14 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:00:16 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:00:17 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:00:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:00:19 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirMkdir Messages: directories --- FAIL: TestDirMkdir (63.79s) === RUN TestDirMkdirSub run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 13:00:23 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 13:00:24 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:00:24 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 13:00:24 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:00:24 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:00:24 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:00:24 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 13:00:25 DEBUG : dir: Added virtual directory entry vAddDir: "sub" 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 13:00:25 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub" 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 13:00:25 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 13:00:25 DEBUG : WaitForWriters: timeout=30s 2025/11/20 13:00:25 DEBUG : dir/sub/subsub: Looking for writers 2025/11/20 13:00:25 DEBUG : dir/sub: Looking for writers 2025/11/20 13:00:25 DEBUG : subsub: reading active writers 2025/11/20 13:00:25 DEBUG : dir: Looking for writers 2025/11/20 13:00:25 DEBUG : file1: reading active writers 2025/11/20 13:00:25 DEBUG : sub: reading active writers 2025/11/20 13:00:25 DEBUG : Looking for writers 2025/11/20 13:00:25 DEBUG : dir: reading active writers 2025/11/20 13:00:25 DEBUG : >WaitForWriters: 2025/11/20 13:00:27 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 13:00:27 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 13:00:27 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 13:00:27 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 13:00:27 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 13:00:27 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:27 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 13:00:28 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:28 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 13:00:28 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:28 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:00:30 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:31 DEBUG : dir: forgetting directory cache 2025/11/20 13:00:31 DEBUG : forgetting directory cache 2025/11/20 13:00:31 DEBUG : dir: forgetting directory cache 2025/11/20 13:00:32 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:00:34 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:00:36 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:36 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:00:37 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:41 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:43 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:45 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:47 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:49 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:51 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:53 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:00:55 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:00:57 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:00:57 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:00:59 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:01 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:05 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:07 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:09 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:11 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:13 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:15 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:01:17 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:01:19 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:01:20 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:01:21 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:01:23 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:01:24 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirMkdirSub Messages: directories --- FAIL: TestDirMkdirSub (64.55s) === RUN TestDirRemove run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 13:01:28 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 13:01:28 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:01:28 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 13:01:29 ERROR : dir/: Dir.Remove not empty 2025/11/20 13:01:29 DEBUG : dir/file1: Remove: 2025/11/20 13:01:29 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 13:01:29 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/11/20 13:01:29 DEBUG : dir/file1: >Remove: err= 2025/11/20 13:01:30 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 13:01:30 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:30 DEBUG : pacer: Rate limited, increasing sleep to 53.453842ms 2025/11/20 13:01:30 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:30 DEBUG : pacer: Rate limited, increasing sleep to 106.907684ms 2025/11/20 13:01:30 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:30 DEBUG : pacer: Rate limited, increasing sleep to 213.815368ms 2025/11/20 13:01:30 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:30 DEBUG : pacer: Rate limited, increasing sleep to 427.630736ms 2025/11/20 13:01:30 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:30 DEBUG : pacer: Rate limited, increasing sleep to 855.261472ms 2025/11/20 13:01:31 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:31 DEBUG : pacer: Rate limited, increasing sleep to 1.710522944s 2025/11/20 13:01:32 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:01:33 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:35 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:36 DEBUG : forgetting directory cache 2025/11/20 13:01:36 DEBUG : dir: forgetting directory cache 2025/11/20 13:01:37 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:37 ERROR : dir/: Dir.Remove failed to remove directory: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked dir_test.go:456: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:456 Error: Received unexpected error: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked Test: TestDirRemove 2025/11/20 13:01:37 DEBUG : WaitForWriters: timeout=30s 2025/11/20 13:01:37 DEBUG : dir: Looking for writers 2025/11/20 13:01:37 DEBUG : Looking for writers 2025/11/20 13:01:37 DEBUG : dir: reading active writers 2025/11/20 13:01:37 DEBUG : >WaitForWriters: 2025/11/20 13:01:39 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:01:41 DEBUG : pacer: Reducing sleep to 1.125s 2025/11/20 13:01:43 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:01:44 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6875s 2025/11/20 13:01:45 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:01:46 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:48 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:50 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:52 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:54 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:56 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:01:58 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:00 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:02:02 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:02:04 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:04 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:02:06 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:08 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:10 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:12 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:14 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:16 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:18 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:20 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:22 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:02:24 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:02:26 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:26 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:02:27 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:29 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:31 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:33 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:35 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:37 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:39 DEBUG : forgetting directory cache 2025/11/20 13:02:39 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:41 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:43 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:02:45 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:02:47 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:02:49 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:02:50 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:02:52 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:02:53 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:456 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirRemove Messages: directories --- FAIL: TestDirRemove (88.80s) === RUN TestDirRemoveAll run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 13:02:57 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 13:02:57 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:02:57 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 13:02:57 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:02:57 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 13:02:58 DEBUG : dir/file1: Remove: 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 13:02:58 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/11/20 13:02:58 DEBUG : dir/file1: >Remove: err= 2025/11/20 13:02:58 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 13:02:58 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:58 DEBUG : pacer: Rate limited, increasing sleep to 53.453842ms 2025/11/20 13:02:58 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:58 DEBUG : pacer: Rate limited, increasing sleep to 106.907684ms 2025/11/20 13:02:59 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:59 DEBUG : pacer: Rate limited, increasing sleep to 213.815368ms 2025/11/20 13:02:59 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:59 DEBUG : pacer: Rate limited, increasing sleep to 427.630736ms 2025/11/20 13:02:59 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:59 DEBUG : pacer: Rate limited, increasing sleep to 855.261472ms 2025/11/20 13:02:59 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:02:59 DEBUG : pacer: Rate limited, increasing sleep to 1.710522944s 2025/11/20 13:03:00 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:00 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:03:02 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:04 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:06 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:06 ERROR : dir/: Dir.Remove failed to remove directory: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked dir_test.go:481: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:481 Error: Received unexpected error: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked Test: TestDirRemoveAll 2025/11/20 13:03:06 DEBUG : WaitForWriters: timeout=30s 2025/11/20 13:03:06 DEBUG : dir: Looking for writers 2025/11/20 13:03:06 DEBUG : Looking for writers 2025/11/20 13:03:06 DEBUG : dir: reading active writers 2025/11/20 13:03:06 DEBUG : >WaitForWriters: 2025/11/20 13:03:08 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:03:10 DEBUG : pacer: Reducing sleep to 1.125s 2025/11/20 13:03:11 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:03:13 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:13 DEBUG : pacer: Rate limited, increasing sleep to 1.6875s 2025/11/20 13:03:13 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:13 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:03:15 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:17 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:19 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:21 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:23 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:25 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:27 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:29 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:03:31 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:03:33 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:03:35 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:37 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:43 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:45 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:47 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:49 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:51 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:03:53 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:03:55 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:55 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:03:56 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:03:58 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:00 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:02 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:04 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:06 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:08 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:10 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:12 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:04:14 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:04:16 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:04:18 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:04:19 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:04:21 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:04:21 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:481 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirRemoveAll Messages: directories --- FAIL: TestDirRemoveAll (88.69s) === RUN TestDirRemoveName run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 13:04:25 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 13:04:26 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:04:26 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 13:04:26 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:04:26 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:04:26 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 13:04:27 DEBUG : dir/file1: Remove: 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 13:04:27 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/11/20 13:04:27 DEBUG : dir/file1: >Remove: err= 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 13:04:27 DEBUG : WaitForWriters: timeout=30s 2025/11/20 13:04:27 DEBUG : dir: Looking for writers 2025/11/20 13:04:27 DEBUG : Looking for writers 2025/11/20 13:04:27 DEBUG : dir: reading active writers 2025/11/20 13:04:27 DEBUG : >WaitForWriters: 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 13:04:27 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 13:04:28 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:28 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 13:04:29 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:04:30 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:32 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:04:34 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:04:36 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:36 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:04:38 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:40 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:42 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:44 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:46 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:48 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:50 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:52 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:54 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:04:56 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:04:58 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:04:58 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:04:59 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:01 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:05 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:07 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:09 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:11 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:13 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:15 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:05:17 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:05:19 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:05:21 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:05:22 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:05:24 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:05:25 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirRemoveName Messages: directories --- FAIL: TestDirRemoveName (63.31s) === RUN TestDirRename run.go:185: Remote "webdav root 'rclone-test-qowiniy3deqa'", Local "Local file system at /tmp/rclone285404664", Modify Window "1s" 2025/11/20 13:05:29 INFO : webdav root 'rclone-test-qowiniy3deqa': poll-interval is not supported by this remote 2025/11/20 13:05:29 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:05:29 DEBUG : dir/file1: Update will use the normal upload strategy (no chunks) 2025/11/20 13:05:29 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:05:29 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 63.352703ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 47.514527ms 2025/11/20 13:05:30 DEBUG : dir/file3: Update will use the normal upload strategy (no chunks) 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 35.635895ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 26.726921ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 20.04519ms 2025/11/20 13:05:30 DEBUG : pacer: Reducing sleep to 15.033892ms 2025/11/20 13:05:31 DEBUG : pacer: Reducing sleep to 11.275419ms 2025/11/20 13:05:31 ERROR : dir/not found: Dir.Rename error: file does not exist 2025/11/20 13:05:31 DEBUG : pacer: Reducing sleep to 10ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2025/11/20 13:05:31 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:31 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2025/11/20 13:05:32 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:32 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2025/11/20 13:05:32 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:05:34 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:36 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error) 2025/11/20 13:05:36 ERROR : dir: Dir.Rename error: DirMove MOVE call failed: "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error dir_test.go:538: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:538 Error: Received unexpected error: DirMove MOVE call failed: "rclone-test-qowiniy3deqa/dir" is locked: OCP\Lock\LockedException: 500 Internal Server Error Test: TestDirRename 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:539 Error: Not equal: expected: []string{"dir2,0,true"} actual : []string{"dir,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,3 @@ ([]string) (len=1) { - (string) (len=11) "dir2,0,true" + (string) (len=10) "dir,0,true" } Test: TestDirRename 2025/11/20 13:05:38 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:05:40 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:05:41 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:05:42 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:05:44 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:05:45 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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/vfs/dir_test.go:545 Error: Should be true Test: TestDirRename Messages: listing wrong, want dir2/file1 (14), dir2/file3 (15) got dir/file1 (14), dir/file3 (15) 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/vfs/dir_test.go:545 Error: Should be true Test: TestDirRename Messages: Unexpected file "dir/file1" 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/vfs/dir_test.go:545 Error: Should be true Test: TestDirRename Messages: Unexpected file "dir/file3" fstest.go:203: Not found "dir2/file1" fstest.go:203: Not found "dir2/file3" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:545 Error: Not equal: expected: 0 actual : 2 Test: TestDirRename Messages: 2 objects not found 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/vfs/dir_test.go:545 Error: Not equal: expected: []string{"dir2"} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,3 +1,3 @@ ([]string) (len=1) { - (string) (len=4) "dir2" + (string) (len=3) "dir" } Test: TestDirRename Messages: directories dir_test.go:549: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:549 Error: Received unexpected error: file does not exist Test: TestDirRename 2025/11/20 13:05:49 DEBUG : WaitForWriters: timeout=30s 2025/11/20 13:05:49 DEBUG : dir: Looking for writers 2025/11/20 13:05:49 DEBUG : file1: reading active writers 2025/11/20 13:05:49 DEBUG : file3: reading active writers 2025/11/20 13:05:49 DEBUG : Looking for writers 2025/11/20 13:05:49 DEBUG : dir: reading active writers 2025/11/20 13:05:49 DEBUG : >WaitForWriters: 2025/11/20 13:05:49 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/11/20 13:05:50 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/11/20 13:05:50 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/11/20 13:05:50 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/11/20 13:05:50 DEBUG : pacer: Reducing sleep to 84.470271ms 2025/11/20 13:05:50 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:50 DEBUG : pacer: Rate limited, increasing sleep to 168.940542ms 2025/11/20 13:05:50 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:50 DEBUG : pacer: Rate limited, increasing sleep to 337.881084ms 2025/11/20 13:05:51 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:51 DEBUG : pacer: Rate limited, increasing sleep to 675.762168ms 2025/11/20 13:05:51 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:51 DEBUG : pacer: Rate limited, increasing sleep to 1.351524336s 2025/11/20 13:05:52 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:52 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:05:53 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:55 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:57 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:05:59 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:01 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 1/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:06:03 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:06:05 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:05 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:06:06 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:09 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:10 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:13 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:14 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:17 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:18 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:20 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:22 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 2/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:06:24 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:06:26 DEBUG : pacer: low level retry 1/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:26 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/20 13:06:28 DEBUG : pacer: low level retry 2/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:30 DEBUG : pacer: low level retry 3/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:32 DEBUG : pacer: low level retry 4/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:34 DEBUG : pacer: low level retry 5/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:36 DEBUG : pacer: low level retry 6/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:38 DEBUG : pacer: low level retry 7/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:40 DEBUG : pacer: low level retry 8/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:42 DEBUG : pacer: low level retry 9/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2025/11/20 13:06:44 DEBUG : pacer: low level retry 10/10 (error "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:130: removing dir "dir" failed - try 3/3: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:133: removing dir "dir" failed: rmdir failed: "rclone-test-qowiniy3deqa/dir" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2025/11/20 13:06:46 DEBUG : pacer: Reducing sleep to 1.5s 2025/11/20 13:06:48 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 2025/11/20 13:06:49 DEBUG : pacer: Reducing sleep to 843.75ms 2025/11/20 13:06:51 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 2025/11/20 13:06:53 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/11/20 13:06:53 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 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:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:792 /usr/local/go/src/runtime/iface.go:275 /usr/local/go/src/runtime/iface.go:285 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:550 Error: Not equal: expected: []string{} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=3) "dir" } Test: TestDirRename Messages: directories --- FAIL: TestDirRename (88.60s) panic: interface conversion: vfs.Node is nil, not *vfs.Dir [recovered] panic: interface conversion: vfs.Node is nil, not *vfs.Dir goroutine 1882 [running]: testing.tRunner.func1.2({0x240f380, 0xc00003a420}) /usr/local/go/src/testing/testing.go:1734 +0x21c testing.tRunner.func1() /usr/local/go/src/testing/testing.go:1737 +0x35e panic({0x240f380?, 0xc00003a420?}) /usr/local/go/src/runtime/panic.go:792 +0x132 github.com/rclone/rclone/vfs.TestDirRename(0xc0007f9180) /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:550 +0x108f testing.tRunner(0xc0007f9180, 0x2a17ed0) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 "./vfs.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose" - Finished ERROR in 23m0.66360122s (try 1/5): exit status 2: Failed [TestDirHandleReaddir TestDirHandleReaddirnames TestDirMethods TestDirForgetAll TestDirForgetPath TestDirWalk TestDirSetModTime TestDirStat TestDirReadDirAll TestDirOpen TestDirCreate TestDirMkdir TestDirMkdirSub TestDirRemove TestDirRemoveAll TestDirRemoveName TestDirRename]