"./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose -test.run '^(TestFixCase|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncOverlapWithFilter|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Starting (try 2/5)
2026/07/26 03:38:02 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu"
2026/07/26 03:38:02 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/07/26 03:38:02 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:02 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:02 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:02 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:02 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:02 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:02 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:02 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:02 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:02 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:02 DEBUG : found headers: 
2026/07/26 03:38:04 DEBUG : Creating backend with remote "/tmp/rclone1196733485"
=== RUN   TestSyncOverlapWithFilter
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:04 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/rclone-sync-test"
2026/07/26 03:38:04 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:04 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:04 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:04 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:04 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:04 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:04 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:04 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:04 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:04 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:04 DEBUG : found headers: 
2026/07/26 03:38:04 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/rclone-sync-test-include/layer2"
2026/07/26 03:38:04 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:04 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:04 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:04 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:04 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:04 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:04 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:04 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:04 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:04 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:04 DEBUG : found headers: 
2026/07/26 03:38:05 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/rclone-sync-test-ignore-file"
2026/07/26 03:38:05 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:05 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:05 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:05 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:05 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:05 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:05 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:05 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:05 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:05 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:05 DEBUG : found headers: 
2026/07/26 03:38:06 DEBUG : rclone-sync-test-ignore-file/.ignore: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:06 DEBUG : rclone-sync-test: Excluded
2026/07/26 03:38:06 DEBUG : rclone-sync-test-ignore-file: Excluded
2026/07/26 03:38:07 DEBUG : rclone-sync-test-include/layer2: Excluded
2026/07/26 03:38:07 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test': Waiting for checks to finish
2026/07/26 03:38:07 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test': Waiting for transfers to finish
2026/07/26 03:38:07 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:07 INFO  : There was nothing to transfer
2026/07/26 03:38:07 DEBUG : rclone-sync-test: Excluded
2026/07/26 03:38:07 DEBUG : rclone-sync-test-ignore-file: Excluded
2026/07/26 03:38:08 DEBUG : rclone-sync-test-include/layer2: Excluded
2026/07/26 03:38:08 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:38:08 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:38:08 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:08 INFO  : rclone-sync-test-include: Removing directory
2026/07/26 03:38:08 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty
2026/07/26 03:38:08 DEBUG : webdav root 'rclone-test-vopumuq8fidu': failed to delete 1 directories
2026/07/26 03:38:08 INFO  : There was nothing to transfer
2026/07/26 03:38:08 DEBUG : rclone-sync-test: Excluded
2026/07/26 03:38:08 DEBUG : rclone-sync-test-ignore-file: Excluded
2026/07/26 03:38:09 DEBUG : rclone-sync-test-include/layer2: Excluded
2026/07/26 03:38:09 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test-include/layer2': Waiting for checks to finish
2026/07/26 03:38:09 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test-include/layer2': Waiting for transfers to finish
2026/07/26 03:38:09 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:09 INFO  : There was nothing to transfer
2026/07/26 03:38:09 DEBUG : rclone-sync-test: Excluded
2026/07/26 03:38:09 DEBUG : rclone-sync-test-ignore-file: Excluded
2026/07/26 03:38:09 DEBUG : rclone-sync-test-include/layer2: Excluded
2026/07/26 03:38:09 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:38:09 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:38:09 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:09 INFO  : rclone-sync-test-include: Removing directory
2026/07/26 03:38:09 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty
2026/07/26 03:38:09 DEBUG : webdav root 'rclone-test-vopumuq8fidu': failed to delete 1 directories
2026/07/26 03:38:09 INFO  : There was nothing to transfer
2026/07/26 03:38:10 DEBUG : Excluded
2026/07/26 03:38:10 DEBUG : rclone-sync-test: Excluded
2026/07/26 03:38:10 DEBUG : rclone-sync-test-ignore-file: Excluded
2026/07/26 03:38:10 DEBUG : rclone-sync-test-include/layer2: Excluded
2026/07/26 03:38:10 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test-ignore-file': Waiting for checks to finish
2026/07/26 03:38:10 DEBUG : webdav root 'rclone-test-vopumuq8fidu/rclone-sync-test-ignore-file': Waiting for transfers to finish
2026/07/26 03:38:10 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:10 INFO  : There was nothing to transfer
--- PASS: TestSyncOverlapWithFilter (8.22s)
=== RUN   TestSyncCompareDest
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:12 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:38:12 DEBUG : Config file has changed externally - reloading
2026/07/26 03:38:12 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:12 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:12 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:12 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:12 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:12 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:12 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:12 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:12 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:12 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:12 DEBUG : found headers: 
2026/07/26 03:38:12 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:12 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:12 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:12 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:12 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:12 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:12 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:12 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:12 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:12 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:12 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:12 DEBUG : found headers: 
2026/07/26 03:38:12 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:12 DEBUG : one: Need to transfer - File not found at Destination
2026/07/26 03:38:12 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:12 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:13 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:13 DEBUG : one: size = 3 OK
2026/07/26 03:38:13 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2026/07/26 03:38:13 INFO  : one: Copied (new)
2026/07/26 03:38:13 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:13 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:13 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:13 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:13 DEBUG : one: Sizes differ
2026/07/26 03:38:13 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:14 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:14 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:14 DEBUG : one: size = 5 OK
2026/07/26 03:38:14 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2026/07/26 03:38:14 INFO  : one: Copied (replaced existing)
2026/07/26 03:38:14 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:14 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:15 DEBUG : CompareDest/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:15 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:15 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:15 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:15 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:15 DEBUG : one: Sizes differ
2026/07/26 03:38:16 DEBUG : one: size = 5 OK
2026/07/26 03:38:16 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:16 DEBUG : one: Destination found in --compare-dest, skipping
2026/07/26 03:38:16 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:16 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:16 INFO  : There was nothing to transfer
2026/07/26 03:38:16 DEBUG : CompareDest/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:16 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:16 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:16 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:16 DEBUG : one: Sizes differ
2026/07/26 03:38:17 DEBUG : two: size = 3 OK
2026/07/26 03:38:17 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:17 DEBUG : two: Destination found in --compare-dest, skipping
2026/07/26 03:38:17 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:17 DEBUG : one: size = 5 OK
2026/07/26 03:38:17 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:17 DEBUG : one: Destination found in --compare-dest, skipping
2026/07/26 03:38:17 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:17 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:17 INFO  : There was nothing to transfer
2026/07/26 03:38:17 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:17 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:17 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:17 DEBUG : one: Sizes differ
2026/07/26 03:38:17 DEBUG : two: size = 3 OK
2026/07/26 03:38:17 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:17 DEBUG : two: Destination found in --compare-dest, skipping
2026/07/26 03:38:17 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:17 DEBUG : one: size = 5 OK
2026/07/26 03:38:17 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:17 DEBUG : one: Destination found in --compare-dest, skipping
2026/07/26 03:38:17 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:17 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:17 INFO  : There was nothing to transfer
2026/07/26 03:38:17 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:18 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:18 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:18 DEBUG : one: Sizes differ
2026/07/26 03:38:18 DEBUG : two: size = 3 OK
2026/07/26 03:38:18 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 GMT
2026/07/26 03:38:18 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2026/07/26 03:38:18 DEBUG : two: Destination found in --compare-dest, skipping
2026/07/26 03:38:18 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:18 DEBUG : one: size = 5 OK
2026/07/26 03:38:18 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:18 DEBUG : one: Destination found in --compare-dest, skipping
2026/07/26 03:38:18 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:18 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:18 INFO  : There was nothing to transfer
2026/07/26 03:38:18 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CompareDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CompareDest"
2026/07/26 03:38:18 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:18 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:18 DEBUG : one: Sizes differ
2026/07/26 03:38:18 DEBUG : one: size = 5 OK
2026/07/26 03:38:18 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:18 DEBUG : one: Destination found in --compare-dest, skipping
2026/07/26 03:38:18 DEBUG : two: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:18 DEBUG : two: size = 3 (webdav root 'rclone-test-vopumuq8fidu/CompareDest')
2026/07/26 03:38:18 DEBUG : two: Sizes differ
2026/07/26 03:38:18 DEBUG : two: Need to transfer - File not found at Destination
2026/07/26 03:38:18 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:18 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:19 DEBUG : two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:19 DEBUG : two: size = 5 OK
2026/07/26 03:38:19 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2026/07/26 03:38:19 INFO  : two: Copied (new)
2026/07/26 03:38:19 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (8.75s)
=== RUN   TestSyncMultipleCompareDest
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:21 DEBUG : pre-dest1/1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:21 DEBUG : pre-dest2/2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:22 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dest"
2026/07/26 03:38:22 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : found headers: 
2026/07/26 03:38:22 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/pre-dest1"
2026/07/26 03:38:22 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : found headers: 
2026/07/26 03:38:22 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/pre-dest1" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/pre-dest1"
2026/07/26 03:38:22 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/pre-dest2"
2026/07/26 03:38:22 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:22 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:22 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:22 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:22 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:22 DEBUG : found headers: 
2026/07/26 03:38:22 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/pre-dest2" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/pre-dest2"
2026/07/26 03:38:22 DEBUG : 1: size = 1 OK
2026/07/26 03:38:22 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:22 DEBUG : 1: Destination found in --compare-dest, skipping
2026/07/26 03:38:23 DEBUG : 2: size = 1 OK
2026/07/26 03:38:23 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:23 DEBUG : 2: Destination found in --compare-dest, skipping
2026/07/26 03:38:23 DEBUG : 3: Need to transfer - File not found at Destination
2026/07/26 03:38:23 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dest': Waiting for checks to finish
2026/07/26 03:38:23 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dest': Waiting for transfers to finish
2026/07/26 03:38:23 DEBUG : 3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:23 DEBUG : 3: size = 1 OK
2026/07/26 03:38:23 DEBUG : 3: md5 = eccbc87e4b5ce2fe28308fd9f2a7baf3 OK
2026/07/26 03:38:23 INFO  : 3: Copied (new)
2026/07/26 03:38:23 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (4.68s)
=== RUN   TestSyncCopyDest
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:25 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:38:25 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:25 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:25 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:25 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:25 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:25 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:25 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:25 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:25 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:25 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:25 DEBUG : found headers: 
2026/07/26 03:38:25 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:25 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:25 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:25 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:25 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:25 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:25 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:25 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:25 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:25 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:25 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:25 DEBUG : found headers: 
2026/07/26 03:38:26 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:26 DEBUG : one: Need to transfer - File not found at Destination
2026/07/26 03:38:26 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:26 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:26 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:26 DEBUG : one: size = 3 OK
2026/07/26 03:38:26 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2026/07/26 03:38:26 INFO  : one: Copied (new)
2026/07/26 03:38:26 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:27 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:27 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:27 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:27 DEBUG : one: Sizes differ
2026/07/26 03:38:27 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:27 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:27 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:27 DEBUG : one: size = 5 OK
2026/07/26 03:38:27 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2026/07/26 03:38:27 INFO  : one: Copied (replaced existing)
2026/07/26 03:38:27 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:28 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:28 DEBUG : CopyDest/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:28 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/BackupDir"
2026/07/26 03:38:28 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:28 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:28 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:28 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:28 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:28 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:28 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:28 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:28 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:28 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:28 DEBUG : found headers: 
2026/07/26 03:38:29 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/BackupDir" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/BackupDir"
2026/07/26 03:38:29 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:29 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:29 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:29 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:29 DEBUG : one: Sizes differ
2026/07/26 03:38:29 DEBUG : one: size = 5 OK
2026/07/26 03:38:29 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:29 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:29 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:29 DEBUG : one: Sizes differ
2026/07/26 03:38:29 INFO  : one: Moved (server-side)
2026/07/26 03:38:30 DEBUG : one: Setting modtime after copy to 2011-12-25 12:59:59 +0000 GMT
2026/07/26 03:38:30 DEBUG : one: size = 5 OK
2026/07/26 03:38:30 DEBUG : one: Dst hash empty - aborting Src hash check
2026/07/26 03:38:30 INFO  : one: Copied (server-side copy)
2026/07/26 03:38:30 DEBUG : one: Destination found in --copy-dest, using server-side copy
2026/07/26 03:38:30 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:30 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:30 DEBUG : CopyDest/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:31 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:31 DEBUG : one: size = 5 OK
2026/07/26 03:38:31 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:31 DEBUG : one: Unchanged skipping
2026/07/26 03:38:31 DEBUG : two: size = 3 OK
2026/07/26 03:38:31 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:31 DEBUG : two: Setting modtime after copy to 2011-12-25 12:59:59 +0000 GMT
2026/07/26 03:38:31 DEBUG : two: size = 3 OK
2026/07/26 03:38:31 DEBUG : two: Dst hash empty - aborting Src hash check
2026/07/26 03:38:31 INFO  : two: Copied (server-side copy)
2026/07/26 03:38:31 DEBUG : two: Destination found in --copy-dest, using server-side copy
2026/07/26 03:38:31 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:31 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:31 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:32 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:32 DEBUG : one: size = 5 OK
2026/07/26 03:38:32 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:32 DEBUG : one: Unchanged skipping
2026/07/26 03:38:32 DEBUG : two: size = 3 OK
2026/07/26 03:38:32 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:32 DEBUG : two: Unchanged skipping
2026/07/26 03:38:32 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:32 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:32 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:32 INFO  : There was nothing to transfer
2026/07/26 03:38:32 DEBUG : CopyDest/three: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:33 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/CopyDest" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/CopyDest"
2026/07/26 03:38:33 DEBUG : one: size = 5 OK
2026/07/26 03:38:33 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:33 DEBUG : one: Unchanged skipping
2026/07/26 03:38:33 DEBUG : three: size = 7 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:33 DEBUG : three: size = 5 (webdav root 'rclone-test-vopumuq8fidu/CopyDest')
2026/07/26 03:38:33 DEBUG : three: Sizes differ
2026/07/26 03:38:33 DEBUG : three: Destination not found in --copy-dest
2026/07/26 03:38:33 DEBUG : three: Need to transfer - File not found at Destination
2026/07/26 03:38:33 DEBUG : two: size = 3 OK
2026/07/26 03:38:33 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/07/26 03:38:33 DEBUG : two: Unchanged skipping
2026/07/26 03:38:33 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:33 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:33 DEBUG : three: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:33 DEBUG : three: size = 7 OK
2026/07/26 03:38:33 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK
2026/07/26 03:38:33 INFO  : three: Copied (new)
2026/07/26 03:38:33 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (10.50s)
=== RUN   TestSyncBackupDir
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:36 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:36 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:37 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:37 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:38:37 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:37 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:37 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:37 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:37 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:37 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:37 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:37 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:37 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:37 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:37 DEBUG : found headers: 
2026/07/26 03:38:37 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:37 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:37 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:37 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:37 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:37 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:37 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:37 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:37 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:37 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:37 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:37 DEBUG : found headers: 
2026/07/26 03:38:37 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:38 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:38 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:38 DEBUG : one: Sizes differ
2026/07/26 03:38:38 DEBUG : two: size = 3 OK
2026/07/26 03:38:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:38 DEBUG : two: Unchanged skipping
2026/07/26 03:38:38 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:38 INFO  : one: Moved (server-side)
2026/07/26 03:38:38 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:38 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:39 DEBUG : one: size = 4 OK
2026/07/26 03:38:39 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:38:39 INFO  : one: Copied (new)
2026/07/26 03:38:39 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:39 INFO  : three.txt: Moved (server-side)
2026/07/26 03:38:39 INFO  : three.txt: Moved into backup dir
2026/07/26 03:38:39 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:40 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:40 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:40 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:40 DEBUG : one: Sizes differ
2026/07/26 03:38:40 DEBUG : two: size = 3 OK
2026/07/26 03:38:40 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:40 DEBUG : two: Unchanged skipping
2026/07/26 03:38:40 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:40 INFO  : one: Deleted
2026/07/26 03:38:41 INFO  : one: Moved (server-side)
2026/07/26 03:38:41 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:41 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:41 DEBUG : one: size = 5 OK
2026/07/26 03:38:41 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:38:41 INFO  : one: Copied (new)
2026/07/26 03:38:41 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:41 INFO  : three.txt: Deleted
2026/07/26 03:38:42 INFO  : three.txt: Moved (server-side)
2026/07/26 03:38:42 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (7.53s)
=== RUN   TestSyncBackupDirWithSuffix
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:44 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:44 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:44 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:45 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:38:45 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:45 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:45 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:45 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:45 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:45 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:45 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:45 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:45 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:45 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:45 DEBUG : found headers: 
2026/07/26 03:38:45 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:45 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:45 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:45 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:45 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:45 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:45 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:45 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:45 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:45 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:45 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:45 DEBUG : found headers: 
2026/07/26 03:38:45 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:45 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:45 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:45 DEBUG : one: Sizes differ
2026/07/26 03:38:45 DEBUG : two: size = 3 OK
2026/07/26 03:38:45 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:45 DEBUG : two: Unchanged skipping
2026/07/26 03:38:45 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:46 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:38:46 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:46 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:46 DEBUG : one: size = 4 OK
2026/07/26 03:38:46 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:38:46 INFO  : one: Copied (new)
2026/07/26 03:38:46 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:47 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:38:47 INFO  : three.txt: Moved into backup dir
2026/07/26 03:38:47 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:48 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:48 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:48 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:48 DEBUG : one: Sizes differ
2026/07/26 03:38:48 DEBUG : two: size = 3 OK
2026/07/26 03:38:48 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:48 DEBUG : two: Unchanged skipping
2026/07/26 03:38:48 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:48 INFO  : one.bak: Deleted
2026/07/26 03:38:48 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:38:48 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:48 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:49 DEBUG : one: size = 5 OK
2026/07/26 03:38:49 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:38:49 INFO  : one: Copied (new)
2026/07/26 03:38:49 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:49 INFO  : three.txt.bak: Deleted
2026/07/26 03:38:49 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:38:49 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (7.69s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:51 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:52 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:52 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:53 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:38:53 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:53 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:53 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:53 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:53 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:53 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:53 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:53 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:53 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:53 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:53 DEBUG : found headers: 
2026/07/26 03:38:53 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:53 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:38:53 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:53 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:53 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:53 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:53 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:38:53 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:38:53 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:38:53 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:38:53 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:38:53 DEBUG : found headers: 
2026/07/26 03:38:53 DEBUG : fs cache: renaming cache item "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" to be canonical "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:53 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:53 DEBUG : two: size = 3 OK
2026/07/26 03:38:53 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:53 DEBUG : two: Unchanged skipping
2026/07/26 03:38:53 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:53 DEBUG : one: Sizes differ
2026/07/26 03:38:53 INFO  : one: Moved (server-side) to: one-2019-01-01
2026/07/26 03:38:53 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:54 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:54 DEBUG : one: size = 4 OK
2026/07/26 03:38:54 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:38:54 INFO  : one: Copied (new)
2026/07/26 03:38:54 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:54 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2026/07/26 03:38:54 INFO  : three.txt: Moved into backup dir
2026/07/26 03:38:55 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:55 DEBUG : fs cache: switching user supplied name "TestWebdavOwncloud:rclone-test-vopumuq8fidu/backup" for canonical name "TestWebdavOwncloud{5eUVF}:rclone-test-vopumuq8fidu/backup"
2026/07/26 03:38:55 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:38:55 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:38:55 DEBUG : one: Sizes differ
2026/07/26 03:38:55 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:38:55 DEBUG : two: size = 3 OK
2026/07/26 03:38:55 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:38:55 DEBUG : two: Unchanged skipping
2026/07/26 03:38:56 INFO  : one-2019-01-01: Deleted
2026/07/26 03:38:56 INFO  : one: Moved (server-side) to: one-2019-01-01
2026/07/26 03:38:56 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:38:56 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:56 DEBUG : one: size = 5 OK
2026/07/26 03:38:56 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:38:56 INFO  : one: Copied (new)
2026/07/26 03:38:56 DEBUG : Waiting for deletions to finish
2026/07/26 03:38:57 INFO  : three-2019-01-01.txt: Deleted
2026/07/26 03:38:57 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2026/07/26 03:38:57 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (7.63s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:38:59 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:38:59 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:00 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:00 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:39:00 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:39:00 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:00 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:00 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:00 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:00 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:39:00 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:00 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:00 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:00 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:00 DEBUG : found headers: 
2026/07/26 03:39:00 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:00 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:00 DEBUG : one: Sizes differ
2026/07/26 03:39:00 DEBUG : two: size = 3 OK
2026/07/26 03:39:00 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:00 DEBUG : two: Unchanged skipping
2026/07/26 03:39:00 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:39:01 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:39:01 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:39:01 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:01 DEBUG : one: size = 4 OK
2026/07/26 03:39:01 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:39:01 INFO  : one: Copied (new)
2026/07/26 03:39:01 DEBUG : Waiting for deletions to finish
2026/07/26 03:39:02 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:39:02 INFO  : three.txt: Moved into backup dir
2026/07/26 03:39:02 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:02 DEBUG : one.bak: Excluded (Path Filter)
2026/07/26 03:39:02 DEBUG : one.bak: Excluded
2026/07/26 03:39:02 DEBUG : three.txt.bak: Excluded (Path Filter)
2026/07/26 03:39:02 DEBUG : three.txt.bak: Excluded
2026/07/26 03:39:02 DEBUG : two: size = 3 OK
2026/07/26 03:39:02 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:02 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:02 DEBUG : one: Sizes differ
2026/07/26 03:39:02 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for checks to finish
2026/07/26 03:39:02 DEBUG : two: Unchanged skipping
2026/07/26 03:39:03 INFO  : one.bak: Deleted
2026/07/26 03:39:03 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:39:03 DEBUG : webdav root 'rclone-test-vopumuq8fidu/dst': Waiting for transfers to finish
2026/07/26 03:39:03 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:03 DEBUG : one: size = 5 OK
2026/07/26 03:39:03 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:39:03 INFO  : one: Copied (new)
2026/07/26 03:39:03 DEBUG : Waiting for deletions to finish
2026/07/26 03:39:04 INFO  : three.txt.bak: Deleted
2026/07/26 03:39:04 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:39:04 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirSuffixOnly (6.83s)
=== RUN   TestSyncSuffix
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:06 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:06 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:06 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:07 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:39:07 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:39:07 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:07 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:07 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:07 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:07 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:39:07 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:07 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:07 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:07 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:07 DEBUG : found headers: 
2026/07/26 03:39:07 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:07 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:07 DEBUG : one: Sizes differ
2026/07/26 03:39:08 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:39:08 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:08 DEBUG : one: size = 4 OK
2026/07/26 03:39:08 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:39:08 INFO  : one: Copied (new)
2026/07/26 03:39:08 DEBUG : two: size = 3 OK
2026/07/26 03:39:08 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:08 DEBUG : two: Unchanged skipping
2026/07/26 03:39:08 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:08 DEBUG : three.txt: size = 5 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:08 DEBUG : three.txt: Sizes differ
2026/07/26 03:39:09 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:39:09 DEBUG : three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:09 DEBUG : three.txt: size = 6 OK
2026/07/26 03:39:09 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2026/07/26 03:39:09 INFO  : three.txt: Copied (new)
2026/07/26 03:39:10 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:10 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:10 DEBUG : one: Sizes differ
2026/07/26 03:39:10 INFO  : one.bak: Deleted
2026/07/26 03:39:10 INFO  : one: Moved (server-side) to: one.bak
2026/07/26 03:39:10 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:11 DEBUG : one: size = 5 OK
2026/07/26 03:39:11 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:39:11 INFO  : one: Copied (new)
2026/07/26 03:39:11 DEBUG : two: size = 3 OK
2026/07/26 03:39:11 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:11 DEBUG : two: Unchanged skipping
2026/07/26 03:39:11 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:11 DEBUG : three.txt: size = 6 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:11 DEBUG : three.txt: Sizes differ
2026/07/26 03:39:11 INFO  : three.txt.bak: Deleted
2026/07/26 03:39:12 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/07/26 03:39:12 DEBUG : three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:12 DEBUG : three.txt: size = 19 OK
2026/07/26 03:39:12 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2026/07/26 03:39:12 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (7.84s)
=== RUN   TestSyncSuffixKeepExtension
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:14 DEBUG : dst/one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:14 DEBUG : dst/two: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:14 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:15 DEBUG : Creating backend with remote "TestWebdavOwncloud:rclone-test-vopumuq8fidu/dst"
2026/07/26 03:39:15 DEBUG : Setting type="webdav" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_TYPE
2026/07/26 03:39:15 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:15 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:15 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:15 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:15 DEBUG : TestWebdavOwncloud: detected overridden config - adding "{5eUVF}" suffix to name
2026/07/26 03:39:15 DEBUG : Setting url="http://127.0.0.1:38081/remote.php/webdav/" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_URL
2026/07/26 03:39:15 DEBUG : Setting vendor="owncloud" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_VENDOR
2026/07/26 03:39:15 DEBUG : Setting user="rclone" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_USER
2026/07/26 03:39:15 DEBUG : Setting pass="sy5UOAPu6my1vBLhskf0IFZn2VXrT99MlbW1esXqjWeHAAo" for "TestWebdavOwncloud" from environment variable RCLONE_CONFIG_TESTWEBDAVOWNCLOUD_PASS
2026/07/26 03:39:15 DEBUG : found headers: 
2026/07/26 03:39:15 DEBUG : one: size = 4 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:15 DEBUG : one: size = 3 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:15 DEBUG : one: Sizes differ
2026/07/26 03:39:16 INFO  : one: Moved (server-side) to: one-2019-01-01
2026/07/26 03:39:16 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:16 DEBUG : one: size = 4 OK
2026/07/26 03:39:16 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/07/26 03:39:16 INFO  : one: Copied (new)
2026/07/26 03:39:16 DEBUG : two: size = 3 OK
2026/07/26 03:39:16 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:16 DEBUG : two: Unchanged skipping
2026/07/26 03:39:16 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:16 DEBUG : three.txt: size = 5 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:16 DEBUG : three.txt: Sizes differ
2026/07/26 03:39:17 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2026/07/26 03:39:17 DEBUG : three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:17 DEBUG : three.txt: size = 6 OK
2026/07/26 03:39:17 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2026/07/26 03:39:17 INFO  : three.txt: Copied (new)
2026/07/26 03:39:18 DEBUG : one: size = 5 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:18 DEBUG : one: size = 4 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:18 DEBUG : one: Sizes differ
2026/07/26 03:39:18 INFO  : one-2019-01-01: Deleted
2026/07/26 03:39:18 INFO  : one: Moved (server-side) to: one-2019-01-01
2026/07/26 03:39:18 DEBUG : one: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:19 DEBUG : one: size = 5 OK
2026/07/26 03:39:19 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/07/26 03:39:19 INFO  : one: Copied (new)
2026/07/26 03:39:19 DEBUG : two: size = 3 OK
2026/07/26 03:39:19 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:19 DEBUG : two: Unchanged skipping
2026/07/26 03:39:19 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:19 DEBUG : three.txt: size = 6 (webdav root 'rclone-test-vopumuq8fidu/dst')
2026/07/26 03:39:19 DEBUG : three.txt: Sizes differ
2026/07/26 03:39:19 INFO  : three-2019-01-01.txt: Deleted
2026/07/26 03:39:19 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2026/07/26 03:39:20 DEBUG : three.txt: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:20 DEBUG : three.txt: size = 19 OK
2026/07/26 03:39:20 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2026/07/26 03:39:20 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffixKeepExtension (7.88s)
=== RUN   TestSyncUTFNorm
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:21 DEBUG : Testêé: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:22 DEBUG : Testêé: size = 14 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:22 DEBUG : Testêé: size = 18 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:39:22 DEBUG : Testêé: Sizes differ
2026/07/26 03:39:22 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:39:22 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:39:22 DEBUG : Testêé: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:22 DEBUG : Testêé: size = 14 OK
2026/07/26 03:39:22 DEBUG : Testêé: md5 = ce114e4501d2f4e2dcea3e17b546f339 OK
2026/07/26 03:39:22 INFO  : Testêé: Copied (replaced existing) to: Testêé
2026/07/26 03:39:22 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncUTFNorm (1.45s)
=== RUN   TestSyncImmutable
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:23 DEBUG : existing: Need to transfer - File not found at Destination
2026/07/26 03:39:23 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:39:23 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:39:23 DEBUG : existing: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:23 DEBUG : existing: size = 6 OK
2026/07/26 03:39:23 DEBUG : existing: md5 = 8ee2027983915ec78acc45027d874316 OK
2026/07/26 03:39:23 INFO  : existing: Copied (new)
2026/07/26 03:39:23 DEBUG : Waiting for deletions to finish
2026/07/26 03:39:24 DEBUG : existing: size = 8 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:39:24 DEBUG : existing: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:39:24 DEBUG : existing: Sizes differ
2026/07/26 03:39:24 ERROR : existing: Source and destination exist but do not match: immutable file modified
2026/07/26 03:39:24 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:39:24 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:39:24 ERROR : webdav root 'rclone-test-vopumuq8fidu': not deleting files as there were IO errors
2026/07/26 03:39:24 ERROR : webdav root 'rclone-test-vopumuq8fidu': not deleting directories as there were IO errors
--- PASS: TestSyncImmutable (1.31s)
=== RUN   TestSyncIgnoreCase
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:24 DEBUG : EXISTING: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:25 DEBUG : EXISTING: size = 6 OK
2026/07/26 03:39:25 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:25 DEBUG : existing: Unchanged skipping
2026/07/26 03:39:25 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:39:25 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:39:25 DEBUG : Waiting for deletions to finish
2026/07/26 03:39:25 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreCase (1.04s)
=== RUN   TestFixCase
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
    sync_test.go:2666: Skipping test as local or remote are case-sensitive
--- SKIP: TestFixCase (0.21s)
=== RUN   TestMaxTransfer
=== RUN   TestMaxTransfer/Hard
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
    sync_test.go:2705: This test only runs on local
=== RUN   TestMaxTransfer/Soft
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
    sync_test.go:2705: This test only runs on local
=== RUN   TestMaxTransfer/Cautious
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
    sync_test.go:2705: This test only runs on local
--- PASS: TestMaxTransfer (0.66s)
    --- SKIP: TestMaxTransfer/Hard (0.22s)
    --- SKIP: TestMaxTransfer/Soft (0.23s)
    --- SKIP: TestMaxTransfer/Cautious (0.21s)
=== RUN   TestSyncConcurrentDelete
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:26 DEBUG : both0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:26 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:27 DEBUG : both1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:27 DEBUG : only1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:28 DEBUG : both2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:28 DEBUG : only2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:28 DEBUG : both3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:29 DEBUG : only3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:29 DEBUG : both4: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:29 DEBUG : only4: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:30 DEBUG : both5: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:30 DEBUG : only5: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:30 DEBUG : both6: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:31 DEBUG : only6: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:31 DEBUG : both7: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:31 DEBUG : only7: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:32 DEBUG : both8: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:32 DEBUG : only8: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:32 DEBUG : both9: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:33 DEBUG : only9: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:33 DEBUG : both10: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:34 DEBUG : only10: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:34 DEBUG : both11: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:34 DEBUG : only11: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:35 DEBUG : both12: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:35 DEBUG : only12: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:35 DEBUG : both13: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:36 DEBUG : only13: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:36 DEBUG : both14: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:37 DEBUG : only14: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:37 DEBUG : both15: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:37 DEBUG : only15: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:38 DEBUG : both16: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:38 DEBUG : only16: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:38 DEBUG : both17: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:39 DEBUG : only17: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:39 DEBUG : both18: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:39 DEBUG : only18: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:40 DEBUG : both19: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:40 DEBUG : only19: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:41 DEBUG : both0: size = 6 OK
2026/07/26 03:39:41 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both12: size = 6 OK
2026/07/26 03:39:41 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both0: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both13: size = 6 OK
2026/07/26 03:39:41 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both10: size = 6 OK
2026/07/26 03:39:41 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both11: size = 6 OK
2026/07/26 03:39:41 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both13: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both14: size = 6 OK
2026/07/26 03:39:41 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both14: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both15: size = 6 OK
2026/07/26 03:39:41 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both10: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both16: size = 6 OK
2026/07/26 03:39:41 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both16: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both17: size = 6 OK
2026/07/26 03:39:41 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both17: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both18: size = 6 OK
2026/07/26 03:39:41 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both18: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both19: size = 6 OK
2026/07/26 03:39:41 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both19: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both1: size = 6 OK
2026/07/26 03:39:41 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both12: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both11: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both2: size = 6 OK
2026/07/26 03:39:41 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both3: size = 6 OK
2026/07/26 03:39:41 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both2: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both4: size = 6 OK
2026/07/26 03:39:41 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both4: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both5: size = 6 OK
2026/07/26 03:39:41 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both5: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both6: size = 6 OK
2026/07/26 03:39:41 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both6: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both7: size = 6 OK
2026/07/26 03:39:41 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both3: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both8: size = 6 OK
2026/07/26 03:39:41 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both1: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both9: size = 6 OK
2026/07/26 03:39:41 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:39:41 DEBUG : both8: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both15: Unchanged skipping
2026/07/26 03:39:41 DEBUG : both9: Unchanged skipping
2026/07/26 03:39:41 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:39:41 DEBUG : both7: Unchanged skipping
2026/07/26 03:39:41 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:39:41 DEBUG : Waiting for deletions to finish
2026/07/26 03:39:41 INFO  : only10: Deleted
2026/07/26 03:39:41 INFO  : only6: Deleted
2026/07/26 03:39:41 INFO  : only15: Deleted
2026/07/26 03:39:41 INFO  : only8: Deleted
2026/07/26 03:39:41 INFO  : only4: Deleted
2026/07/26 03:39:41 INFO  : only7: Deleted
2026/07/26 03:39:41 INFO  : only1: Deleted
2026/07/26 03:39:41 INFO  : only11: Deleted
2026/07/26 03:39:41 INFO  : only9: Deleted
2026/07/26 03:39:41 INFO  : only0: Deleted
2026/07/26 03:39:41 INFO  : only12: Deleted
2026/07/26 03:39:42 INFO  : only14: Deleted
2026/07/26 03:39:42 INFO  : only13: Deleted
2026/07/26 03:39:42 INFO  : only16: Deleted
2026/07/26 03:39:42 INFO  : only5: Deleted
2026/07/26 03:39:42 INFO  : only18: Deleted
2026/07/26 03:39:42 INFO  : only17: Deleted
2026/07/26 03:39:42 INFO  : only19: Deleted
2026/07/26 03:39:42 INFO  : only2: Deleted
2026/07/26 03:39:42 INFO  : only3: Deleted
2026/07/26 03:39:42 INFO  : There was nothing to transfer
--- PASS: TestSyncConcurrentDelete (19.57s)
=== RUN   TestSyncConcurrentTruncate
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:39:46 DEBUG : both0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:46 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:46 DEBUG : both1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:47 DEBUG : only1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:47 DEBUG : both2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:48 DEBUG : only2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:48 DEBUG : both3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:48 DEBUG : only3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:49 DEBUG : both4: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:49 DEBUG : only4: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:49 DEBUG : both5: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:50 DEBUG : only5: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:50 DEBUG : both6: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:51 DEBUG : only6: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:51 DEBUG : both7: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:51 DEBUG : only7: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:52 DEBUG : both8: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:52 DEBUG : only8: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:53 DEBUG : both9: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:53 DEBUG : only9: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:53 DEBUG : both10: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:54 DEBUG : only10: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:54 DEBUG : both11: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:54 DEBUG : only11: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:55 DEBUG : both12: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:55 DEBUG : only12: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:56 DEBUG : both13: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:56 DEBUG : only13: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:56 DEBUG : both14: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:57 DEBUG : only14: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:57 DEBUG : both15: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:57 DEBUG : only15: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:58 DEBUG : both16: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:58 DEBUG : only16: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:59 DEBUG : both17: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:59 DEBUG : only17: Update will use the normal upload strategy (no chunks)
2026/07/26 03:39:59 DEBUG : both18: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:00 DEBUG : only18: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:00 DEBUG : both19: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:00 DEBUG : only19: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:01 DEBUG : both0: size = 6 OK
2026/07/26 03:40:01 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both11: size = 6 OK
2026/07/26 03:40:01 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both0: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both12: size = 6 OK
2026/07/26 03:40:01 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both12: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both10: size = 6 OK
2026/07/26 03:40:01 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both14: size = 6 OK
2026/07/26 03:40:01 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both13: size = 6 OK
2026/07/26 03:40:01 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both11: Unchanged skipping
2026/07/26 03:40:01 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for checks to finish
2026/07/26 03:40:01 DEBUG : both15: size = 6 OK
2026/07/26 03:40:01 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both10: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both16: size = 6 OK
2026/07/26 03:40:01 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both15: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both17: size = 6 OK
2026/07/26 03:40:01 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both17: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both18: size = 6 OK
2026/07/26 03:40:01 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both18: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both19: size = 6 OK
2026/07/26 03:40:01 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both19: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both1: size = 6 OK
2026/07/26 03:40:01 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both14: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both2: size = 6 OK
2026/07/26 03:40:01 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both2: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both3: size = 6 OK
2026/07/26 03:40:01 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both13: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both4: size = 6 OK
2026/07/26 03:40:01 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both4: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both5: size = 6 OK
2026/07/26 03:40:01 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both5: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both16: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both7: size = 6 OK
2026/07/26 03:40:01 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both6: size = 6 OK
2026/07/26 03:40:01 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both7: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both8: size = 6 OK
2026/07/26 03:40:01 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both8: Unchanged skipping
2026/07/26 03:40:01 DEBUG : both9: size = 6 OK
2026/07/26 03:40:01 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/07/26 03:40:01 DEBUG : both6: Unchanged skipping
2026/07/26 03:40:01 DEBUG : only0: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only0: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only0: Sizes differ
2026/07/26 03:40:01 DEBUG : only10: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only10: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only10: Sizes differ
2026/07/26 03:40:01 DEBUG : both3: Unchanged skipping
2026/07/26 03:40:01 DEBUG : only11: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only11: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only11: Sizes differ
2026/07/26 03:40:01 DEBUG : only12: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only12: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only12: Sizes differ
2026/07/26 03:40:01 DEBUG : both1: Unchanged skipping
2026/07/26 03:40:01 DEBUG : only13: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only13: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only13: Sizes differ
2026/07/26 03:40:01 DEBUG : only14: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only14: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only14: Sizes differ
2026/07/26 03:40:01 DEBUG : both9: Unchanged skipping
2026/07/26 03:40:01 DEBUG : only15: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only15: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only15: Sizes differ
2026/07/26 03:40:01 DEBUG : only16: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only16: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only16: Sizes differ
2026/07/26 03:40:01 DEBUG : only17: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only17: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only17: Sizes differ
2026/07/26 03:40:01 DEBUG : only18: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only18: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only18: Sizes differ
2026/07/26 03:40:01 DEBUG : only19: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only19: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only19: Sizes differ
2026/07/26 03:40:01 DEBUG : only1: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only1: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only1: Sizes differ
2026/07/26 03:40:01 DEBUG : only2: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only2: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only2: Sizes differ
2026/07/26 03:40:01 DEBUG : only3: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only3: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only3: Sizes differ
2026/07/26 03:40:01 DEBUG : only4: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only4: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only4: Sizes differ
2026/07/26 03:40:01 DEBUG : only5: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only5: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only5: Sizes differ
2026/07/26 03:40:01 DEBUG : only6: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only6: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only6: Sizes differ
2026/07/26 03:40:01 DEBUG : only7: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only7: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only7: Sizes differ
2026/07/26 03:40:01 DEBUG : only8: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only8: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only8: Sizes differ
2026/07/26 03:40:01 DEBUG : only9: size = 0 (Local file system at /tmp/rclone1196733485)
2026/07/26 03:40:01 DEBUG : only9: size = 6 (webdav root 'rclone-test-vopumuq8fidu')
2026/07/26 03:40:01 DEBUG : only9: Sizes differ
2026/07/26 03:40:01 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Waiting for transfers to finish
2026/07/26 03:40:01 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:01 DEBUG : only11: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:01 DEBUG : only13: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:01 DEBUG : only15: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:01 DEBUG : pacer: low level retry 1/1 (error An exception occurred while executing 'UPDATE "oc_file_locks" SET "lock" = -1, "ttl" = ? WHERE "key" = ? AND "lock" = 1' with params [1785040801, "files\/d09af0a48ab4310191109190fcddbb3a"]:

SQLSTATE[HY000]: General error: 5 database is locked: Doctrine\DBAL\Exception\LockWaitTimeoutException: 500 Internal Server Error)
2026/07/26 03:40:01 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:01 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:01 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:01 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:01 DEBUG : only13: size = 0 OK
2026/07/26 03:40:01 DEBUG : only13: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:01 INFO  : only13: Copied (replaced existing)
2026/07/26 03:40:01 DEBUG : only11: size = 0 OK
2026/07/26 03:40:01 DEBUG : only11: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:01 INFO  : only11: Copied (replaced existing)
2026/07/26 03:40:01 DEBUG : only10: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only15: size = 0 OK
2026/07/26 03:40:02 DEBUG : only15: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only15: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only16: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only17: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only10: size = 0 OK
2026/07/26 03:40:02 DEBUG : only10: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only10: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only16: size = 0 OK
2026/07/26 03:40:02 DEBUG : only16: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only16: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only17: size = 0 OK
2026/07/26 03:40:02 DEBUG : only17: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only17: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only18: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only1: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only2: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only18: size = 0 OK
2026/07/26 03:40:02 DEBUG : only18: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only18: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only2: size = 0 OK
2026/07/26 03:40:02 DEBUG : only2: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only2: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only1: size = 0 OK
2026/07/26 03:40:02 DEBUG : only1: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:02 INFO  : only1: Copied (replaced existing)
2026/07/26 03:40:02 DEBUG : only3: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : only4: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:02 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only5: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 22.5ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 16.875ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 12.65625ms
2026/07/26 03:40:03 DEBUG : only3: size = 0 OK
2026/07/26 03:40:03 DEBUG : only3: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only3: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only4: size = 0 OK
2026/07/26 03:40:03 DEBUG : only4: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only4: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : only6: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : only5: size = 0 OK
2026/07/26 03:40:03 DEBUG : only5: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only5: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only7: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : only8: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only6: size = 0 OK
2026/07/26 03:40:03 DEBUG : only6: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only6: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only9: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : only7: size = 0 OK
2026/07/26 03:40:03 DEBUG : only7: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only7: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : only8: size = 0 OK
2026/07/26 03:40:03 DEBUG : only8: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only8: Copied (replaced existing)
2026/07/26 03:40:03 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:03 DEBUG : only14: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:03 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:03 DEBUG : only12: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:03 DEBUG : only9: size = 0 OK
2026/07/26 03:40:03 DEBUG : only9: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:03 INFO  : only9: Copied (replaced existing)
2026/07/26 03:40:04 DEBUG : only19: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:04 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:04 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:04 DEBUG : only12: size = 0 OK
2026/07/26 03:40:04 DEBUG : only12: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:04 INFO  : only12: Copied (replaced existing)
2026/07/26 03:40:04 DEBUG : pacer: Reducing sleep to 11.25ms
2026/07/26 03:40:04 DEBUG : only14: size = 0 OK
2026/07/26 03:40:04 DEBUG : only14: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:04 INFO  : only14: Copied (replaced existing)
2026/07/26 03:40:04 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:40:04 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:40:04 DEBUG : pacer: Reducing sleep to 15ms
2026/07/26 03:40:04 DEBUG : only19: size = 0 OK
2026/07/26 03:40:04 DEBUG : only19: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/07/26 03:40:04 INFO  : only19: Copied (replaced existing)
2026/07/26 03:40:04 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:04 DEBUG : pacer: Rate limited, increasing sleep to 30ms
2026/07/26 03:40:04 DEBUG : only0: Received error: unchunked simple update failed: An exception occurred while executing 'UPDATE "oc_file_locks" SET "lock" = -1, "ttl" = ? WHERE "key" = ? AND "lock" = 1' with params [1785040801, "files\/d09af0a48ab4310191109190fcddbb3a"]:

SQLSTATE[HY000]: General error: 5 database is locked: Doctrine\DBAL\Exception\LockWaitTimeoutException: 500 Internal Server Error - low level retry 0/10
2026/07/26 03:40:04 DEBUG : pacer: Reducing sleep to 22.5ms
2026/07/26 03:40:04 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:04 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:04 DEBUG : pacer: Rate limited, increasing sleep to 45ms
2026/07/26 03:40:05 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:05 DEBUG : pacer: Rate limited, increasing sleep to 90ms
2026/07/26 03:40:05 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:05 DEBUG : pacer: Rate limited, increasing sleep to 180ms
2026/07/26 03:40:05 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:05 DEBUG : pacer: Rate limited, increasing sleep to 360ms
2026/07/26 03:40:06 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:06 DEBUG : pacer: Rate limited, increasing sleep to 720ms
2026/07/26 03:40:06 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:06 DEBUG : pacer: Rate limited, increasing sleep to 1.44s
2026/07/26 03:40:07 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:07 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:40:08 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:10 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:12 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:14 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:14 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 1/10
2026/07/26 03:40:16 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:40:16 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:18 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:18 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:40:20 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:22 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:24 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:26 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:28 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:30 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:32 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:34 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:36 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:38 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:38 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 2/10
2026/07/26 03:40:40 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:40:40 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:40:42 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:42 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:40:43 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:45 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:47 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:49 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:51 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:53 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:55 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:57 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:40:59 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:01 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:01 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 3/10
2026/07/26 03:41:03 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:41:03 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:41:05 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:05 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:41:07 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:09 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:11 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:13 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:15 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:17 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:19 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:21 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:23 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:25 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:25 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 4/10
2026/07/26 03:41:27 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:41:27 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:41:29 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:29 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:41:30 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:32 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:34 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:36 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:38 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:40 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:42 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:44 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:46 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:48 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:48 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 5/10
2026/07/26 03:41:50 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:41:50 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:41:52 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:52 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:41:54 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:56 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:41:58 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:00 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:02 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:04 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:06 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:08 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:10 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:12 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:12 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 6/10
2026/07/26 03:42:14 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:42:14 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:42:16 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:16 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:42:17 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:19 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:21 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:23 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:25 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:27 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:29 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:31 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:33 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:35 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:35 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 7/10
2026/07/26 03:42:37 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:42:37 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:42:39 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:39 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:42:41 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:43 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:45 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:47 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:49 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:51 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:53 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:55 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:57 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:59 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:42:59 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 8/10
2026/07/26 03:43:01 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:43:01 DEBUG : only0: Update will use the normal upload strategy (no chunks)
2026/07/26 03:43:03 DEBUG : pacer: low level retry 1/1 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:03 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:43:04 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:06 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:08 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:10 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:12 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:14 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:16 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:18 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:20 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:22 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:22 DEBUG : only0: Received error: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked - low level retry 9/10
2026/07/26 03:43:22 ERROR : only0: Failed to copy: unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:43:22 ERROR : webdav root 'rclone-test-vopumuq8fidu': not deleting files as there were IO errors
2026/07/26 03:43:22 ERROR : webdav root 'rclone-test-vopumuq8fidu': not deleting directories as there were IO errors
    sync_test.go:2783: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2783
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	Error:      	Received unexpected error:
        	            	unchunked simple update failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	Sync must not return a error
    sync_test.go:2784: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2784
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	Error:      	Should be false
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	Low level errors must not have happened
2026/07/26 03:43:24 DEBUG : pacer: Reducing sleep to 1.5s
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2026/07/26 03:43:26 DEBUG : pacer: Reducing sleep to 1.125s
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2026/07/26 03:43:28 DEBUG : pacer: Reducing sleep to 843.75ms
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	listing wrong, want
        	            	  both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0) got
        	            	  both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0)
    fstest.go:143: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:149
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	webdav root 'rclone-test-vopumuq8fidu'/only0: md5 hash incorrect - expecting "d41d8cd98f00b204e9800998ecf8427e" got "8ee2027983915ec78acc45027d874316"
    fstest.go:143: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:149
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	webdav root 'rclone-test-vopumuq8fidu'/only0: sha1 hash incorrect - expecting "da39a3ee5e6b4b0d3255bfef95601890afd80709" got "3e2e95f5ad970eadfa7e17eaf73da97024aa5359"
    fstest.go:150: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 6
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	only0: size incorrect file=0 vs obj=6
2026/07/26 03:43:32 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:43:33 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:43:34 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:43:34 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:43:35 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:43:35 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:43:35 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:43:35 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/07/26 03:43:36 DEBUG : pacer: Reducing sleep to 15.033892ms
2026/07/26 03:43:37 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/07/26 03:43:37 DEBUG : pacer: Reducing sleep to 10ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:43:38 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:38 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:43:39 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:39 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:43:40 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:42 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 1/3: sleeping 1s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:43:44 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:46 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:48 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:50 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:52 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:54 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:56 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:43:58 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:00 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:02 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 2/3: sleeping 1.5s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:44:04 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:06 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:08 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:10 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:12 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:14 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:16 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:18 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:20 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:22 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:44:24 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:44:27 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/26 03:44:28 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/26 03:44:29 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:44:30 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:44:31 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:44:31 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:44:31 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:44:32 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:44:33 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/07/26 03:44:33 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/07/26 03:44:33 DEBUG : pacer: Reducing sleep to 15.033892ms
2026/07/26 03:44:33 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/07/26 03:44:33 DEBUG : pacer: Reducing sleep to 10ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	listing wrong, want
        	            	   got
        	            	  only0 (6)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentTruncate
        	Messages:   	Unexpected file "only0"
--- FAIL: TestSyncConcurrentTruncate (295.03s)
=== RUN   TestSyncReplaceDirModTime
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:44:41 DEBUG : empty_dir: Making directory with metadata
2026/07/26 03:44:41 INFO  : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/26 03:44:41 DEBUG : empty_on_remote: Making directory with metadata
2026/07/26 03:44:41 INFO  : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/26 03:44:41 INFO  : empty_on_remote: Making directory
2026/07/26 03:44:41 INFO  : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/26 03:44:42 INFO  : test_dir1: Set directory modification time (using DirSetModTime)
2026/07/26 03:44:42 INFO  : test_dir2: Set directory modification time (using DirSetModTime)
2026/07/26 03:44:42 INFO  : test_dir2/sub_dir: Set directory modification time (using DirSetModTime)
2026/07/26 03:44:42 INFO  : empty_on_remote: Set directory modification time (using DirSetModTime)
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2857
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2864
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTime
        	Messages:   	listing wrong, want
        	            	  file1 (5), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) got
        	            	  file1 (5), only0 (6), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2857
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2864
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTime
        	Messages:   	Unexpected file "only0"
2026/07/26 03:44:51 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:44:51 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:44:51 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:44:51 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:44:51 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:44:51 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:51 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:44:52 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:52 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:44:52 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:52 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:44:53 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:55 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 1/3: sleeping 1s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:44:57 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:44:59 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:01 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:05 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:07 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:09 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:11 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:13 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:15 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 2/3: sleeping 1.5s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:45:17 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:19 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:21 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:23 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:25 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:27 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:29 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:31 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:33 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:45:35 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:45:37 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:45:39 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/26 03:45:41 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/26 03:45:42 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:45:43 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:45:44 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:45:44 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:45:44 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:45:45 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:45:46 DEBUG : pacer: Reducing sleep to 26.726921ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2026/07/26 03:45:47 DEBUG : pacer: Reducing sleep to 20.04519ms
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
2026/07/26 03:45:49 DEBUG : pacer: Reducing sleep to 15.033892ms
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTime
        	Messages:   	listing wrong, want
        	            	   got
        	            	  only0 (6)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTime
        	Messages:   	Unexpected file "only0"
--- FAIL: TestSyncReplaceDirModTime (72.25s)
=== RUN   TestSyncReplaceDirModTimeWithEmptyDirs
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:45:53 DEBUG : empty_dir: Making directory with metadata
2026/07/26 03:45:53 INFO  : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/26 03:45:53 DEBUG : empty_on_remote: Making directory with metadata
2026/07/26 03:45:53 INFO  : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/26 03:45:53 INFO  : empty_on_remote: Making directory
2026/07/26 03:45:53 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/07/26 03:45:53 INFO  : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/26 03:45:54 INFO  : test_dir1: Set directory modification time (using DirSetModTime)
2026/07/26 03:45:54 INFO  : test_dir2: Set directory modification time (using DirSetModTime)
2026/07/26 03:45:54 INFO  : test_dir2/sub_dir: Set directory modification time (using DirSetModTime)
2026/07/26 03:45:54 INFO  : empty_on_remote: Set directory modification time (using DirSetModTime)
2026/07/26 03:45:54 INFO  : empty_dir: Set directory modification time (using DirSetModTime)
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2857
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2868
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTimeWithEmptyDirs
        	Messages:   	listing wrong, want
        	            	  file1 (5), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) got
        	            	  file1 (5), only0 (6), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2857
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2868
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTimeWithEmptyDirs
        	Messages:   	Unexpected file "only0"
2026/07/26 03:46:03 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:46:03 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:03 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:46:03 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:03 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:46:03 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:03 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:46:04 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:04 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:46:04 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:04 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:46:04 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:04 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:46:05 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:05 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:46:06 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:08 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 1/3: sleeping 1s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:46:10 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:12 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:14 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:16 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:18 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:20 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:22 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:24 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:26 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:28 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 2/3: sleeping 1.5s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:46:30 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:32 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:34 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:36 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:38 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:40 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:42 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:44 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:46 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:46:48 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:46:50 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:46:52 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/26 03:46:53 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/26 03:46:55 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:46:55 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:46:56 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:46:57 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:46:57 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:46:57 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:46:57 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 15.033892ms
2026/07/26 03:46:58 DEBUG : pacer: Reducing sleep to 11.275419ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
2026/07/26 03:46:59 DEBUG : pacer: Reducing sleep to 10ms
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTimeWithEmptyDirs
        	Messages:   	listing wrong, want
        	            	   got
        	            	  only0 (6)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestSyncReplaceDirModTimeWithEmptyDirs
        	Messages:   	Unexpected file "only0"
--- FAIL: TestSyncReplaceDirModTimeWithEmptyDirs (72.83s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:47:06 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/26 03:47:06 INFO  : sub dir: Making directory
2026/07/26 03:47:06 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2904
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	listing wrong, want
        	            	  sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got
        	            	  only0 (6), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2904
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	Unexpected file "only0"
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2926
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	listing wrong, want
        	            	  sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got
        	            	  only0 (6), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2926
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	Unexpected file "only0"
2026/07/26 03:47:28 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:47:29 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:29 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:47:30 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:30 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:47:31 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:33 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 1/3: sleeping 1s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:47:35 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:37 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:39 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:41 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:43 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:45 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:47 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:49 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:51 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:53 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 2/3: sleeping 1.5s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:47:55 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:57 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:47:59 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:01 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:03 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:05 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:07 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:09 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:11 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:13 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:48:15 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:48:17 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/26 03:48:19 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/26 03:48:20 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:48:21 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:48:21 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:48:22 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:48:22 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:48:23 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:48:24 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/07/26 03:48:24 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/07/26 03:48:24 DEBUG : pacer: Reducing sleep to 15.033892ms
2026/07/26 03:48:24 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/07/26 03:48:24 DEBUG : pacer: Reducing sleep to 10ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	listing wrong, want
        	            	   got
        	            	  only0 (6)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	Unexpected file "only0"
--- FAIL: TestNothingToTransferWithEmptyDirs (87.16s)
=== RUN   TestNothingToTransferWithoutEmptyDirs
    run.go:198: Remote "webdav root 'rclone-test-vopumuq8fidu'", Local "Local file system at /tmp/rclone1196733485", Modify Window "1s"
2026/07/26 03:48:33 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/26 03:48:33 INFO  : sub dir: Making directory
2026/07/26 03:48:33 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2904
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	listing wrong, want
        	            	  sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got
        	            	  only0 (6), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2904
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	Unexpected file "only0"
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2926
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981
        	            				/usr/local/go/src/runtime/asm_amd64.s:1771
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	listing wrong, want
        	            	  sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11) got
        	            	  only0 (6), sub dir/hello world (11), sub dir2/very/very/very/very/very/nested/subdir/hello world (11)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2926
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2981
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	Unexpected file "only0"
2026/07/26 03:48:56 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:56 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:48:56 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:56 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:48:57 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:57 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:48:57 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:57 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:48:57 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:57 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:48:57 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:57 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:48:57 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:57 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:48:58 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:48:58 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:48:59 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:01 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 1/3: sleeping 1s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:49:03 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:05 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:07 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:09 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:11 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:13 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:15 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:17 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:19 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:21 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed - try 2/3: sleeping 1.5s: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:49:23 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:25 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:27 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:29 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:31 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:33 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:35 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:37 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:39 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:49:41 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
    run.go:172: removing file "only0" failed: "rclone-test-vopumuq8fidu/only0" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
2026/07/26 03:49:43 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/26 03:49:45 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/26 03:49:47 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/26 03:49:48 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/26 03:49:49 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/26 03:49:49 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/26 03:49:50 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/26 03:49:50 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/26 03:49:50 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/07/26 03:49:51 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/07/26 03:49:52 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/07/26 03:49:52 DEBUG : pacer: Reducing sleep to 15.033892ms
2026/07/26 03:49:52 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/07/26 03:49:52 DEBUG : pacer: Reducing sleep to 10ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	listing wrong, want
        	            	   got
        	            	  only0 (6)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:406
        	            				/usr/local/go/src/testing/testing.go:1317
        	            				/usr/local/go/src/testing/testing.go:1667
        	            				/usr/local/go/src/testing/testing.go:2030
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithoutEmptyDirs
        	Messages:   	Unexpected file "only0"
--- FAIL: TestNothingToTransferWithoutEmptyDirs (87.69s)
FAIL
2026/07/26 03:50:00 DEBUG : webdav root 'rclone-test-vopumuq8fidu': Purge remote
2026/07/26 03:50:01 DEBUG : pacer: low level retry 1/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/07/26 03:50:01 DEBUG : pacer: low level retry 2/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/07/26 03:50:01 DEBUG : pacer: low level retry 3/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/07/26 03:50:01 DEBUG : pacer: low level retry 4/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/07/26 03:50:01 DEBUG : pacer: low level retry 5/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/07/26 03:50:01 DEBUG : pacer: low level retry 6/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:01 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/07/26 03:50:02 DEBUG : pacer: low level retry 7/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:02 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/07/26 03:50:02 DEBUG : pacer: low level retry 8/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:02 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/26 03:50:04 DEBUG : pacer: low level retry 9/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:06 DEBUG : pacer: low level retry 10/10 (error "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked)
2026/07/26 03:50:06 NOTICE: purge failed: rmdir failed: "rclone-test-vopumuq8fidu" is locked: OCA\DAV\Connector\Sabre\Exception\FileLocked: 423 Locked
"./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavOwncloud: -verbose -test.run '^(TestFixCase|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncOverlapWithFilter|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Finished ERROR in 12m3.11558079s (try 2/5): exit status 1: Failed [TestSyncConcurrentTruncate TestSyncReplaceDirModTime TestSyncReplaceDirModTimeWithEmptyDirs TestNothingToTransferWithEmptyDirs TestNothingToTransferWithoutEmptyDirs]