"./operations.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose -test.run '^(TestCopyDirMetadata|TestDirMove|TestDirsEqual|TestGetFsInfo|TestMkdirMetadata|TestMkdirModTime|TestMoveFileBackupDir|TestRcat|TestRcatMetadata|TestRcatSize|TestRcatSizeMetadata|TestRmdirsNoLeaveRoot|TestSetDirModTime|TestTouchDir)$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Starting (try 3/5) 2024/04/12 02:19:39 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-howikor7xiwihoy3bisuqer4" 2024/04/12 02:19:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/12 02:19:39 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE 2024/04/12 02:19:39 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2024/04/12 02:19:39 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2024/04/12 02:19:39 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2024/04/12 02:19:39 DEBUG : Setting pass="biYP-L6xbVVAK6dE1i2uPyuHnbMAgHx_X-zR0K-qZ6PazDY" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2024/04/12 02:19:39 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{i6dyL}" suffix to name 2024/04/12 02:19:39 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2024/04/12 02:19:39 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2024/04/12 02:19:39 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2024/04/12 02:19:39 DEBUG : Setting pass="biYP-L6xbVVAK6dE1i2uPyuHnbMAgHx_X-zR0K-qZ6PazDY" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2024/04/12 02:19:39 DEBUG : found headers: 2024/04/12 02:19:39 DEBUG : Creating backend with remote "/tmp/rclone2289203140" === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:19:40 DEBUG : A1/B1/C1/one: Update will use the normal upload strategy (no chunks) 2024/04/12 02:19:40 DEBUG : A2: Making directory 2024/04/12 02:19:40 DEBUG : A1/B2: Making directory 2024/04/12 02:19:40 DEBUG : A1/B2/C2: Making directory 2024/04/12 02:19:40 DEBUG : A1/B1/C3: Making directory 2024/04/12 02:19:41 DEBUG : A3: Making directory 2024/04/12 02:19:41 DEBUG : A3/B3: Making directory 2024/04/12 02:19:41 DEBUG : A3/B3/C4: Making directory 2024/04/12 02:19:41 DEBUG : A1/two: Update will use the normal upload strategy (no chunks) 2024/04/12 02:19:42 DEBUG : removing 1 level 3 directories 2024/04/12 02:19:42 INFO : A3/B3/C4: Removing directory 2024/04/12 02:19:43 DEBUG : removing 2 level 3 directories 2024/04/12 02:19:43 INFO : A1/B2/C2: Removing directory 2024/04/12 02:19:43 INFO : A1/B1/C3: Removing directory 2024/04/12 02:19:43 DEBUG : removing 2 level 2 directories 2024/04/12 02:19:43 INFO : A3/B3: Removing directory 2024/04/12 02:19:43 INFO : A1/B2: Removing directory 2024/04/12 02:19:43 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\/1e7eda6c94a7a86cb5deae8d35fe2c01"]: SQLSTATE[HY000]: General error: 5 database is locked: Doctrine\DBAL\Exception\LockWaitTimeoutException: 500 Internal Server Error) 2024/04/12 02:19:43 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:19:43 DEBUG : pacer: Reducing sleep to 15ms 2024/04/12 02:19:43 DEBUG : pacer: Reducing sleep to 11.25ms 2024/04/12 02:19:43 ERROR : A3/B3: Failed to rmdir: rmdir failed: Sabre\DAV\Exception\Forbidden: 403 Forbidden 2024/04/12 02:19:43 DEBUG : removing 2 level 1 directories 2024/04/12 02:19:43 INFO : A3: Removing directory 2024/04/12 02:19:43 INFO : A2: Removing directory 2024/04/12 02:19:43 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:19:43 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:43 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:19:43 DEBUG : pacer: Reducing sleep to 15ms 2024/04/12 02:19:43 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:43 DEBUG : pacer: Rate limited, increasing sleep to 30ms 2024/04/12 02:19:44 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:44 DEBUG : pacer: Rate limited, increasing sleep to 60ms 2024/04/12 02:19:44 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:44 DEBUG : pacer: Rate limited, increasing sleep to 120ms 2024/04/12 02:19:44 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:44 DEBUG : pacer: Rate limited, increasing sleep to 240ms 2024/04/12 02:19:44 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:44 DEBUG : pacer: Rate limited, increasing sleep to 480ms 2024/04/12 02:19:44 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:44 DEBUG : pacer: Rate limited, increasing sleep to 960ms 2024/04/12 02:19:45 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:45 DEBUG : pacer: Rate limited, increasing sleep to 1.92s 2024/04/12 02:19:46 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:19:47 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:47 ERROR : A3: Failed to rmdir: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked operations_test.go:687: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:687 Error: Received unexpected error: failed to remove directories: 2 errors: last error: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked Test: TestRmdirsNoLeaveRoot 2024/04/12 02:19:49 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:19:51 DEBUG : pacer: Reducing sleep to 1.125s 2024/04/12 02:19:53 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:19:54 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/04/12 02:19:55 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:19:56 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/04/12 02:19:56 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:19:56 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:19:57 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:57 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2024/04/12 02:19:57 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:57 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2024/04/12 02:19:57 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:57 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2024/04/12 02:19:58 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:19:58 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:20:00 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:02 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:06 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:08 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:10 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:20:12 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:20:14 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:20:15 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:17 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:19 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:21 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:25 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:27 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:29 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:31 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:20:33 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:20:35 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:20:37 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:41 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:43 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:45 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:47 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:49 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:51 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:20:53 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:20:55 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:20:57 DEBUG : pacer: Reducing sleep to 1.125s 2024/04/12 02:20:58 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:20:59 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/04/12 02:21:00 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:21:01 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/04/12 02:21:01 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:21:02 DEBUG : pacer: Reducing sleep to 200.225829ms fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:21:03 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:21:03 DEBUG : pacer: Reducing sleep to 112.627028ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:21:05 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:21:05 DEBUG : pacer: Reducing sleep to 63.352703ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1005 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:687 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRmdirsNoLeaveRoot Messages: directories --- FAIL: TestRmdirsNoLeaveRoot (90.06s) === RUN TestMoveFileBackupDir run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:21:09 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:21:09 DEBUG : dst/file1: Update will use the normal upload strategy (no chunks) 2024/04/12 02:21:09 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:21:10 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:21:10 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:21:10 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:21:10 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:21:10 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:21:10 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-howikor7xiwihoy3bisuqer4/backup" 2024/04/12 02:21:10 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE 2024/04/12 02:21:10 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2024/04/12 02:21:10 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2024/04/12 02:21:10 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2024/04/12 02:21:10 DEBUG : Setting pass="biYP-L6xbVVAK6dE1i2uPyuHnbMAgHx_X-zR0K-qZ6PazDY" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2024/04/12 02:21:10 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{i6dyL}" suffix to name 2024/04/12 02:21:10 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL 2024/04/12 02:21:10 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR 2024/04/12 02:21:10 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER 2024/04/12 02:21:10 DEBUG : Setting pass="biYP-L6xbVVAK6dE1i2uPyuHnbMAgHx_X-zR0K-qZ6PazDY" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS 2024/04/12 02:21:10 DEBUG : found headers: 2024/04/12 02:21:10 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-howikor7xiwihoy3bisuqer4/backup" to be canonical "TestWebdavOwncloud{i6dyL}:rclone-test-howikor7xiwihoy3bisuqer4/backup" 2024/04/12 02:21:10 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2024/04/12 02:21:11 INFO : dst/file1: Moved (server-side) 2024/04/12 02:21:11 DEBUG : dst/file1: Update will use the normal upload strategy (no chunks) 2024/04/12 02:21:11 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2024/04/12 02:21:11 INFO : dst/file1: Copied (new) 2024/04/12 02:21:11 INFO : dst/file1: Deleted 2024/04/12 02:21:12 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:12 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:21:13 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:13 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:21:14 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:21:15 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:17 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:21:19 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:21:21 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:21:23 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:25 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:27 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:29 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:31 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:33 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:35 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:37 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:39 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:21:41 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:21:43 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:43 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:21:44 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:46 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:48 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:50 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:52 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:54 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:56 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:21:58 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:00 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:22:02 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:22:04 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:22:06 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:22:07 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:22:09 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:22:10 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestMoveFileBackupDir Messages: directories --- FAIL: TestMoveFileBackupDir (64.49s) === RUN TestDirMove run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:22:14 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:22:14 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:22:14 DEBUG : A1/one: Update will use the normal upload strategy (no chunks) 2024/04/12 02:22:14 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:22:15 DEBUG : A1/two: Update will use the normal upload strategy (no chunks) 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:22:15 DEBUG : A1/B1/three: Update will use the normal upload strategy (no chunks) 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:22:15 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:22:15 DEBUG : A1/B1/C1/four: Update will use the normal upload strategy (no chunks) 2024/04/12 02:22:16 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:22:16 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:22:16 DEBUG : A1/B1/C2/five: Update will use the normal upload strategy (no chunks) 2024/04/12 02:22:16 DEBUG : A1/B2: Making directory 2024/04/12 02:22:16 DEBUG : A1/B1/C3: Making directory fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1347 Error: Not equal: expected: []string{"A1", "A1/B1", "A1/B1/C1", "A1/B1/C2", "A1/B1/C3", "A1/B2"} actual : []string{"A1", "A1/B1", "A1/B1/C1", "A1/B1/C2", "A1/B1/C3", "A1/B2", "A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A1", @@ -6,3 +6,4 @@ (string) (len=8) "A1/B1/C3", - (string) (len=5) "A1/B2" + (string) (len=5) "A1/B2", + (string) (len=2) "A3" } Test: TestDirMove Messages: directories fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1368 Error: Not equal: expected: []string{"A2", "A2/B1", "A2/B1/C1", "A2/B1/C2", "A2/B1/C3", "A2/B2"} actual : []string{"A2", "A2/B1", "A2/B1/C1", "A2/B1/C2", "A2/B1/C3", "A2/B2", "A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A2", @@ -6,3 +6,4 @@ (string) (len=8) "A2/B1/C3", - (string) (len=5) "A2/B2" + (string) (len=5) "A2/B2", + (string) (len=2) "A3" } Test: TestDirMove Messages: directories 2024/04/12 02:22:35 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2024/04/12 02:22:35 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2024/04/12 02:22:35 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2024/04/12 02:22:35 INFO : A2/one: Moved (server-side) to: A3/one 2024/04/12 02:22:35 INFO : A2/two: Moved (server-side) to: A3/two 2024/04/12 02:22:36 INFO : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2024/04/12 02:22:38 INFO : A3/one: Moved (server-side) to: A4/one 2024/04/12 02:22:38 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2024/04/12 02:22:38 INFO : A3/two: Moved (server-side) to: A4/two 2024/04/12 02:22:38 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2024/04/12 02:22:38 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2024/04/12 02:22:39 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:22:39 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:22:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:22:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:22:39 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:22:39 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:39 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:22:40 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:40 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:22:40 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:40 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:22:42 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:22:44 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) operations_test.go:1415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1415 Error: Received unexpected error: RenameDir rmdir: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked Test: TestDirMove 2024/04/12 02:22:46 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:22:48 DEBUG : pacer: Reducing sleep to 1.125s 2024/04/12 02:22:49 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:22:50 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/04/12 02:22:51 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:22:52 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/04/12 02:22:52 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:22:53 DEBUG : pacer: Reducing sleep to 200.225829ms fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:22:54 DEBUG : pacer: Reducing sleep to 20.04519ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:22:57 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:22:57 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:22:57 DEBUG : pacer: Reducing sleep to 10ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1421 Error: Not equal: expected: []string{"A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2"} actual : []string{"A3", "A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=6) { +([]string) (len=7) { + (string) (len=2) "A3", (string) (len=2) "A4", Test: TestDirMove Messages: directories 2024/04/12 02:23:03 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:23:03 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:03 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:23:03 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:03 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:23:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:03 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:23:04 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:04 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:23:04 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:04 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:23:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:04 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:23:05 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:05 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:23:06 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:08 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:23:10 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:23:12 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:12 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:23:13 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:16 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:17 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:20 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:21 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:23 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:26 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:28 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:30 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:23:32 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:23:34 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:23:35 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:37 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:41 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:43 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:45 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:47 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:49 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:23:51 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:23:53 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:23:55 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:23:57 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:23:58 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:24:00 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:24:00 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestDirMove Messages: directories --- FAIL: TestDirMove (110.78s) === RUN TestGetFsInfo run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:24:05 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:24:05 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:24:05 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:24:05 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:05 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:24:06 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:06 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:24:06 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:06 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:24:06 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:06 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:24:08 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:10 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:12 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:14 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:16 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:18 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:24:20 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:24:22 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:24:23 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:25 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:27 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:29 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:31 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:33 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:35 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:37 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:39 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:24:41 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:24:43 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:43 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:24:45 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:47 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:49 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:51 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:53 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:55 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:57 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:24:59 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:01 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:25:03 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:25:05 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:25:06 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:25:07 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:25:09 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:25:10 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestGetFsInfo Messages: directories --- FAIL: TestGetFsInfo (69.62s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:25:14 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:25:14 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:25:14 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': File to upload is small (34 bytes), uploading instead of streaming 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:25:15 DEBUG : no_checksum_small_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:25:15 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2024/04/12 02:25:15 INFO : no_checksum_small_file_from_pipe: Copied (new) 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:25:15 DEBUG : no_checksum_big_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:25:15 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:25:15 DEBUG : no_checksum_big_file_from_pipe: md5 = fffc7956ba9a7b58a63c01b6ce1ddc45 OK 2024/04/12 02:25:15 DEBUG : no_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical 2024/04/12 02:25:16 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:25:16 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:25:16 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:25:16 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:25:16 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:25:16 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:16 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:25:16 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:16 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:25:16 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:16 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:25:16 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:16 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:25:17 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:17 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:25:17 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:17 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:25:17 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:17 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:25:18 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:25:19 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:21 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:25:23 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:25:25 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:25 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:25:26 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:28 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:30 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:32 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:34 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:36 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:38 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:40 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:42 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:25:44 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:25:46 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:46 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:25:48 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:50 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:52 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:54 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:56 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:25:58 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:00 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:02 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:04 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:26:06 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:26:08 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:26:09 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:26:11 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:26:13 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:26:13 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcat/withChecksum=false,ignoreChecksum=false Messages: directories === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:26:17 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:26:18 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:26:18 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': File to upload is small (34 bytes), uploading instead of streaming 2024/04/12 02:26:18 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:26:18 DEBUG : with_checksum_small_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:26:18 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:26:18 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:26:18 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2024/04/12 02:26:18 INFO : with_checksum_small_file_from_pipe: Copied (new) 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:26:19 DEBUG : with_checksum_big_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:26:19 DEBUG : with_checksum_big_file_from_pipe: md5 = fffc7956ba9a7b58a63c01b6ce1ddc45 OK 2024/04/12 02:26:19 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:26:19 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:26:19 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:26:20 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:20 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:26:21 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:26:22 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:24 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:26:26 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:26:28 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:28 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:26:30 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:32 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:34 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:36 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:38 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:40 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:42 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:44 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:46 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:26:48 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:26:50 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:50 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:26:51 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:53 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:55 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:57 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:26:59 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:01 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:03 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:05 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:07 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:27:09 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:27:11 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:27:13 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:27:14 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:27:16 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:27:17 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcat/withChecksum=true,ignoreChecksum=false Messages: directories === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:27:21 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:27:21 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:27:21 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': File to upload is small (34 bytes), uploading instead of streaming 2024/04/12 02:27:21 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:27:21 DEBUG : ignore_checksum_small_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:27:22 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:27:22 DEBUG : ignore_checksum_big_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:27:22 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:27:22 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:27:23 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:23 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:27:24 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:24 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:27:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:27:25 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:27 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:27:29 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:27:31 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:31 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:27:33 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:35 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:37 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:39 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:41 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:43 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:45 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:47 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:49 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:27:51 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:27:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:53 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:27:54 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:56 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:27:58 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:00 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:02 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:06 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:08 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:10 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:28:12 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:28:14 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:28:16 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:28:17 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:28:19 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:28:20 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcat/withChecksum=false,ignoreChecksum=true Messages: directories === RUN TestRcat/withChecksum=true,ignoreChecksum=true run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:28:24 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:28:24 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:28:24 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': File to upload is small (34 bytes), uploading instead of streaming 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:28:25 DEBUG : ignore_checksum_small_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:28:25 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:28:25 DEBUG : ignore_checksum_big_file_from_pipe: Update will use the normal upload strategy (no chunks) 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:28:25 DEBUG : ignore_checksum_big_file_from_pipe: Src hash empty - aborting Dst hash check 2024/04/12 02:28:25 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:28:25 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:28:26 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:28:26 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:28:26 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:28:26 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:26 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:28:26 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:26 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:28:26 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:26 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:28:26 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:26 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:28:27 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:27 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:28:27 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:27 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:28:27 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:27 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:28:29 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:31 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:28:33 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:28:35 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:28:36 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:38 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:40 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:42 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:44 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:46 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:48 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:50 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:52 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:28:54 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:28:56 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:28:56 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:28:58 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:00 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:02 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:04 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:06 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:08 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:10 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:12 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:14 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:29:16 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:29:18 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:29:19 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:29:20 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:29:22 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:29:23 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcat/withChecksum=true,ignoreChecksum=true Messages: directories --- FAIL: TestRcat (253.07s) --- FAIL: TestRcat/withChecksum=false,ignoreChecksum=false (63.34s) --- FAIL: TestRcat/withChecksum=true,ignoreChecksum=false (63.23s) --- FAIL: TestRcat/withChecksum=false,ignoreChecksum=true (63.24s) --- FAIL: TestRcat/withChecksum=true,ignoreChecksum=true (63.26s) === RUN TestRcatMetadata run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1514: Skipping as destination doesn't support user metadata 2024/04/12 02:29:27 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:29:28 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:29:28 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:29:28 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:28 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:29:28 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:28 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:29:28 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:28 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:29:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:29:30 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:32 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:34 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:36 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:38 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:40 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:29:42 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:29:44 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:44 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:29:46 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:48 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:50 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:52 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:54 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:56 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:29:58 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:00 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:02 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:30:04 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:30:06 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:06 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:30:07 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:09 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:11 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:13 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:15 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:17 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:19 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:21 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:23 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:30:25 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:30:27 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:30:29 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:30:30 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:30:32 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:30:33 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1514 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcatMetadata Messages: directories --- FAIL: TestRcatMetadata (69.60s) === RUN TestRcatSize run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:30:37 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:30:37 DEBUG : potato1: Update will use the normal upload strategy (no chunks) 2024/04/12 02:30:37 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:30:37 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:30:37 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': File to upload is small (60 bytes), uploading instead of streaming 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:30:38 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:30:38 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2024/04/12 02:30:38 INFO : potato2: Copied (new) 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:30:38 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:30:39 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:30:39 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:39 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:30:40 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:40 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:30:41 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:43 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:30:45 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:30:47 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:47 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:30:49 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:51 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:53 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:55 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:57 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:30:59 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:01 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:03 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:05 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:31:07 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:31:09 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:09 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:31:10 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:12 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:14 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:16 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:18 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:20 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:22 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:24 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:26 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:31:28 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:31:30 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:31:32 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:31:33 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:31:35 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:31:36 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcatSize Messages: directories --- FAIL: TestRcatSize (63.05s) === RUN TestRcatSizeMetadata run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1595: Skipping as destination doesn't support user metadata 2024/04/12 02:31:40 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:31:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:31:40 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:31:41 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:41 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:31:41 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:41 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:31:41 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:41 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:31:42 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:42 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:31:43 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:45 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:47 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:49 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:51 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:53 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:31:55 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:31:57 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:31:57 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:31:58 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:00 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:02 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:04 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:06 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:08 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:10 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:12 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:14 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:32:16 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:32:18 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:32:20 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:22 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:24 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:26 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:28 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:30 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:32 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:34 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:36 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:32:38 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:32:40 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:32:41 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:32:43 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:32:45 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:32:45 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1595 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestRcatSizeMetadata Messages: directories --- FAIL: TestRcatSizeMetadata (69.57s) === RUN TestTouchDir run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" 2024/04/12 02:32:49 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:32:49 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/04/12 02:32:50 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:32:50 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:32:50 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/12 02:32:50 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/04/12 02:32:50 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/12 02:32:50 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/12 02:32:51 DEBUG : sub dir/potato3: Update will use the normal upload strategy (no chunks) 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/12 02:32:51 DEBUG : pacer: Reducing sleep to 10ms 2024/04/12 02:32:51 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': Touching "empty space" 2024/04/12 02:32:51 ERROR : empty space: failed to touch: can't set modified time 2024/04/12 02:32:51 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': Touching "potato2" 2024/04/12 02:32:51 ERROR : potato2: failed to touch: can't set modified time 2024/04/12 02:32:52 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': Touching "sub dir/potato3" 2024/04/12 02:32:52 ERROR : sub dir/potato3: failed to touch: can't set modified time 2024/04/12 02:32:53 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/12 02:32:53 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:53 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/12 02:32:54 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:54 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:32:55 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:32:57 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:32:59 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:33:01 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:01 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:33:03 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:05 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:07 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:09 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:11 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:13 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:15 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:17 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:19 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:33:21 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:33:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:23 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:33:24 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:26 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:28 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:30 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:32 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:34 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:36 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:38 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:40 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:33:42 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:33:44 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:33:46 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:33:47 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:33:49 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:33:50 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestTouchDir Messages: directories --- FAIL: TestTouchDir (64.43s) === RUN TestMkdirMetadata run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1685: Skipping test as remote does not support MkdirMetadata 2024/04/12 02:33:54 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:33:54 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:33:54 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:33:55 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:55 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:33:55 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:55 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:33:55 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:55 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:33:56 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:56 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:33:57 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:33:59 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:01 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:03 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:05 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:07 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:34:09 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:34:11 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:11 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:34:12 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:14 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:16 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:18 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:20 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:22 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:26 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:28 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:34:30 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:34:32 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:34:34 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:36 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:38 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:40 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:42 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:44 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:46 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:48 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:34:50 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:34:52 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:34:54 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:34:55 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:34:57 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:34:59 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:34:59 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1685 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestMkdirMetadata Messages: directories --- FAIL: TestMkdirMetadata (69.60s) === RUN TestMkdirModTime run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1704: Skipping test as remote does not support DirSetModTime or MkdirMetadata 2024/04/12 02:35:03 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:35:04 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:35:04 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:35:04 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:04 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:35:04 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:04 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:35:05 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:05 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:35:05 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:05 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:35:07 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:09 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:11 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:13 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:15 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:17 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:35:19 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:35:21 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:35:22 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:24 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:26 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:28 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:30 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:32 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:34 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:36 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:38 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:35:40 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:35:42 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:42 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:35:44 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:46 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:48 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:50 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:52 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:54 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:56 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:35:58 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:00 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:36:02 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:36:04 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:36:05 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:36:06 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:36:08 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:36:09 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1704 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestMkdirModTime Messages: directories --- FAIL: TestMkdirModTime (69.57s) === RUN TestCopyDirMetadata run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1725: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata 2024/04/12 02:36:13 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:36:13 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:36:14 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:36:14 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:14 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:36:14 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:14 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:36:14 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:14 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:36:15 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:15 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:36:16 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:18 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:20 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:22 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:24 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:26 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:36:28 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:36:30 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:30 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:36:32 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:34 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:36 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:38 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:40 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:42 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:44 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:46 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:48 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:36:50 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:36:52 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:52 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:36:53 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:55 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:57 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:36:59 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:01 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:03 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:05 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:07 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:09 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:37:11 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:37:13 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:37:15 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:37:16 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:37:18 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:37:18 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1725 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestCopyDirMetadata Messages: directories --- FAIL: TestCopyDirMetadata (69.54s) === RUN TestSetDirModTime run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1761: Skipping test as remote does not support DirSetModTime or WriteDirSetModTime 2024/04/12 02:37:23 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:37:23 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:37:23 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:37:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:23 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:37:24 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:24 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:37:24 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:24 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:37:24 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:37:26 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:28 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:30 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:32 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:34 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:36 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:37:38 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:37:40 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:40 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:37:41 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:43 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:45 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:47 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:49 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:51 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:53 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:55 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:37:57 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:37:59 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:38:01 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:01 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:38:03 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:05 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:07 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:09 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:11 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:13 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:15 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:17 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:19 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:38:21 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:38:23 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:38:24 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:38:25 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:38:27 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:38:28 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1761 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestSetDirModTime Messages: directories --- FAIL: TestSetDirModTime (69.61s) === RUN TestDirsEqual run.go:180: Remote "webdav root 'rclone-test-howikor7xiwihoy3bisuqer4'", Local "Local file system at /tmp/rclone2289203140", Modify Window "1s" operations_test.go:1805: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata 2024/04/12 02:38:32 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/12 02:38:33 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/12 02:38:33 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/12 02:38:33 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:33 DEBUG : pacer: Rate limited, increasing sleep to 300.338742ms 2024/04/12 02:38:33 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:33 DEBUG : pacer: Rate limited, increasing sleep to 600.677484ms 2024/04/12 02:38:33 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:33 DEBUG : pacer: Rate limited, increasing sleep to 1.201354968s 2024/04/12 02:38:34 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:38:35 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:37 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:39 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:41 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:43 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:45 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 1/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:38:47 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:38:49 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:49 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:38:51 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:53 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:55 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:57 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:38:59 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:01 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:03 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:05 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:07 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 2/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:39:09 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:39:11 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:11 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:39:12 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:14 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:16 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:18 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:20 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:22 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:26 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:28 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) run.go:125: removing dir "A3" failed - try 3/3: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked run.go:128: removing dir "A3" failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4/A3" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked 2024/04/12 02:39:30 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/12 02:39:32 DEBUG : pacer: Reducing sleep to 1.125s fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 2024/04/12 02:39:34 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/12 02:39:35 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 2024/04/12 02:39:37 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/12 02:39:38 DEBUG : pacer: Reducing sleep to 355.957031ms fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /usr/local/go/src/testing/testing.go:1175 /usr/local/go/src/testing/testing.go:1353 /usr/local/go/src/testing/testing.go:1683 /usr/local/go/src/runtime/panic.go:626 /usr/local/go/src/testing/testing.go:1120 /usr/local/go/src/testing/testing.go:1096 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1805 Error: Not equal: expected: []string{} actual : []string{"A3"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A3" } Test: TestDirsEqual Messages: directories --- FAIL: TestDirsEqual (69.55s) FAIL 2024/04/12 02:39:42 DEBUG : webdav root 'rclone-test-howikor7xiwihoy3bisuqer4': Purge remote 2024/04/12 02:39:42 DEBUG : pacer: low level retry 1/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:42 DEBUG : pacer: Rate limited, increasing sleep to 711.914062ms 2024/04/12 02:39:42 DEBUG : pacer: low level retry 2/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:42 DEBUG : pacer: Rate limited, increasing sleep to 1.423828124s 2024/04/12 02:39:43 DEBUG : pacer: low level retry 3/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:43 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/12 02:39:44 DEBUG : pacer: low level retry 4/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:46 DEBUG : pacer: low level retry 5/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:48 DEBUG : pacer: low level retry 6/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:50 DEBUG : pacer: low level retry 7/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:52 DEBUG : pacer: low level retry 8/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:54 DEBUG : pacer: low level retry 9/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:56 DEBUG : pacer: low level retry 10/10 (error "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked) 2024/04/12 02:39:56 purge failed: rmdir failed: "rclone-test-howikor7xiwihoy3bisuqer4" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked "./operations.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose -test.run '^(TestCopyDirMetadata|TestDirMove|TestDirsEqual|TestGetFsInfo|TestMkdirMetadata|TestMkdirModTime|TestMoveFileBackupDir|TestRcat|TestRcatMetadata|TestRcatSize|TestRcatSizeMetadata|TestRmdirsNoLeaveRoot|TestSetDirModTime|TestTouchDir)$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Finished ERROR in 20m17.323222203s (try 3/5): exit status 1: Failed [TestRmdirsNoLeaveRoot TestMoveFileBackupDir TestDirMove TestGetFsInfo TestRcat/withChecksum=false,ignoreChecksum=false TestRcat/withChecksum=true,ignoreChecksum=false TestRcat/withChecksum=false,ignoreChecksum=true TestRcat/withChecksum=true,ignoreChecksum=true TestRcatMetadata TestRcatSize TestRcatSizeMetadata TestTouchDir TestMkdirMetadata TestMkdirModTime TestCopyDirMetadata TestSetDirModTime TestDirsEqual]