"./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavInfiniteScale: -verbose -test.run '^(TestBase64|TestCopyRedownload|TestManualTransformFile|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncAfterChangingModtimeOnly|TestSyncCopyDest)$'" - Starting (try 3/5)
2026/04/22 01:25:51 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-rulaqem0hife"
2026/04/22 01:25:51 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/22 01:25:51 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:25:51 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:25:51 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:25:51 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:25:51 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:25:51 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:25:51 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:25:51 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:25:51 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:25:51 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:25:51 DEBUG : found headers: 
2026/04/22 01:25:51 DEBUG : Creating backend with remote "/tmp/rclone3596579007"
=== RUN   TestServerSideCopy
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:25:51 DEBUG : sub dir/hello world: Update will use the tus protocol to upload
2026/04/22 01:25:51 INFO  : sub dir/hello world: Failed to read metadata: object not found
2026/04/22 01:25:51 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:25:51 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:25:51 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:25:52 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-nevazov9sufe"
2026/04/22 01:25:52 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:25:52 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:25:52 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:25:52 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:25:52 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:25:52 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:25:52 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:25:52 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:25:52 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:25:52 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:25:52 DEBUG : found headers: 
    sync_test.go:620: Server side copy (if possible) webdav root 'rclone-test-rulaqem0hife' -> webdav root 'rclone-test-nevazov9sufe'
2026/04/22 01:25:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/04/22 01:25:52 DEBUG : webdav root 'rclone-test-nevazov9sufe': Waiting for checks to finish
2026/04/22 01:25:52 DEBUG : webdav root 'rclone-test-nevazov9sufe': Waiting for transfers to finish
2026/04/22 01:25:52 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/22 01:25:52 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/04/22 01:25:52 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/04/22 01:25:52 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/04/22 01:25:52 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/04/22 01:25:52 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:25:52 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/04/22 01:25:53 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:25:53 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/04/22 01:25:53 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:25:53 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/04/22 01:25:55 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:25:57 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:25:57 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 0/10
2026/04/22 01:25:59 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:26:01 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:26:03 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:26:05 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:26:07 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:26:09 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:26:11 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:26:13 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:26:15 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:26:17 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:26:17 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 1/10
2026/04/22 01:26:19 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:26:21 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:26:23 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:26:25 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:26:27 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:26:29 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:26:31 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:26:33 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:26:35 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:26:37 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:26:37 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 2/10
2026/04/22 01:26:39 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:26:41 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:26:43 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:26:45 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:26:47 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:26:49 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:26:51 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:26:53 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:26:55 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:26:57 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:26:57 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 3/10
2026/04/22 01:26:59 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:27:01 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:27:03 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:27:05 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:27:07 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:27:09 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:27:11 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:27:13 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:27:15 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:27:17 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:27:17 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 4/10
2026/04/22 01:27:19 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:27:21 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:27:23 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:27:25 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:27:27 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:27:29 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:27:31 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:27:33 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:27:35 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:27:37 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:27:37 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 5/10
2026/04/22 01:27:39 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:27:41 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:27:43 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:27:45 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:27:47 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:27:49 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:27:51 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:27:53 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:27:55 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:27:57 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:27:57 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 6/10
2026/04/22 01:27:59 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:28:01 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:28:03 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:28:05 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:28:07 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:28:09 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:28:11 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:28:13 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:28:15 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:28:17 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:28:17 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 7/10
2026/04/22 01:28:19 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:28:21 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:28:23 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:28:25 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:28:27 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:28:29 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:28:31 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:28:33 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:28:35 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:28:37 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:28:37 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 8/10
2026/04/22 01:28:39 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:28:41 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:28:43 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:28:45 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:28:47 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:28:49 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:28:51 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:28:53 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:28:55 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:28:57 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:28:57 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 9/10
2026/04/22 01:28:57 ERROR : sub dir/hello world: Failed to copy: copy call failed: 500 Internal Server Error
    sync_test.go:624: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:624
        	Error:      	Received unexpected error:
        	            	copy call failed: 500 Internal Server Error
        	Test:       	TestServerSideCopy
2026/04/22 01:28:57 DEBUG : webdav root 'rclone-test-nevazov9sufe': Purge remote
2026/04/22 01:28:59 DEBUG : pacer: Reducing sleep to 1.5s
2026/04/22 01:29:01 DEBUG : pacer: Reducing sleep to 1.125s
2026/04/22 01:29:02 DEBUG : pacer: Reducing sleep to 843.75ms
2026/04/22 01:29:03 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/04/22 01:29:04 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/04/22 01:29:05 DEBUG : pacer: Reducing sleep to 355.957031ms
--- FAIL: TestServerSideCopy (193.76s)
=== RUN   TestServerSideCopyOverSelf
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:29:05 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/04/22 01:29:05 DEBUG : sub dir/hello world: Update will use the tus protocol to upload
2026/04/22 01:29:06 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/04/22 01:29:06 INFO  : sub dir/hello world: Failed to read metadata: object not found
2026/04/22 01:29:06 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/04/22 01:29:06 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:29:06 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/04/22 01:29:06 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:29:06 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:29:06 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/04/22 01:29:06 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/04/22 01:29:07 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/04/22 01:29:07 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-pojutah3mawe"
2026/04/22 01:29:07 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:29:07 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:29:07 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:29:07 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:29:07 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:29:07 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:29:07 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:29:07 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:29:07 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:29:07 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:29:07 DEBUG : found headers: 
    sync_test.go:656: Server side copy (if possible) webdav root 'rclone-test-rulaqem0hife' -> webdav root 'rclone-test-pojutah3mawe'
2026/04/22 01:29:07 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/04/22 01:29:07 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/04/22 01:29:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/04/22 01:29:07 DEBUG : webdav root 'rclone-test-pojutah3mawe': Waiting for checks to finish
2026/04/22 01:29:07 DEBUG : webdav root 'rclone-test-pojutah3mawe': Waiting for transfers to finish
2026/04/22 01:29:07 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:29:07 DEBUG : pacer: Rate limited, increasing sleep to 53.453842ms
2026/04/22 01:29:07 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:29:07 DEBUG : pacer: Rate limited, increasing sleep to 106.907684ms
2026/04/22 01:29:07 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:29:07 DEBUG : pacer: Rate limited, increasing sleep to 213.815368ms
2026/04/22 01:29:07 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:29:07 DEBUG : pacer: Rate limited, increasing sleep to 427.630736ms
2026/04/22 01:29:07 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:29:07 DEBUG : pacer: Rate limited, increasing sleep to 855.261472ms
2026/04/22 01:29:08 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:29:08 DEBUG : pacer: Rate limited, increasing sleep to 1.710522944s
2026/04/22 01:29:09 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:29:09 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/04/22 01:29:10 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:29:12 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:29:14 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:29:14 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 0/10
2026/04/22 01:29:16 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:29:18 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:29:20 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:29:22 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:29:24 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:29:26 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:29:28 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:29:30 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:29:32 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:29:34 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:29:34 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 1/10
2026/04/22 01:29:36 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:29:38 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:29:40 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:29:42 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:29:44 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:29:46 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:29:48 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:29:50 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:29:52 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:29:54 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:29:54 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 2/10
2026/04/22 01:29:56 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:29:58 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:30:00 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:30:02 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:30:04 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:30:06 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:30:08 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:30:10 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:30:12 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:30:14 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:30:14 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 3/10
2026/04/22 01:30:16 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:30:18 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:30:21 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:30:22 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:30:24 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:30:26 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:30:28 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:30:30 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:30:32 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:30:34 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:30:34 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 4/10
2026/04/22 01:30:36 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:30:38 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:30:40 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:30:42 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:30:45 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:30:46 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:30:48 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:30:50 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:30:53 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:30:54 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:30:54 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 5/10
2026/04/22 01:30:56 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:30:58 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:31:00 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:31:02 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:31:04 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:31:06 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:31:09 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:31:10 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:31:12 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:31:14 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:31:14 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 6/10
2026/04/22 01:31:16 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:31:18 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:31:20 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:31:22 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:31:25 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:31:26 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:31:28 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:31:30 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:31:32 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:31:34 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:31:34 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 7/10
2026/04/22 01:31:37 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:31:39 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:31:41 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:31:43 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:31:45 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:31:47 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:31:49 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:31:51 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:31:53 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:31:55 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:31:55 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 8/10
2026/04/22 01:31:57 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:31:59 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:32:01 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:32:03 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:32:05 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:32:07 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:32:09 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:32:11 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:32:13 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:32:15 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:32:15 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 9/10
2026/04/22 01:32:15 ERROR : sub dir/hello world: Failed to copy: copy call failed: 500 Internal Server Error
    sync_test.go:660: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:660
        	Error:      	Received unexpected error:
        	            	copy call failed: 500 Internal Server Error
        	Test:       	TestServerSideCopyOverSelf
2026/04/22 01:32:15 DEBUG : webdav root 'rclone-test-pojutah3mawe': Purge remote
2026/04/22 01:32:17 DEBUG : pacer: Reducing sleep to 1.5s
2026/04/22 01:32:19 DEBUG : pacer: Reducing sleep to 1.125s
2026/04/22 01:32:20 DEBUG : pacer: Reducing sleep to 843.75ms
2026/04/22 01:32:21 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/04/22 01:32:22 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/04/22 01:32:23 DEBUG : pacer: Reducing sleep to 355.957031ms
--- FAIL: TestServerSideCopyOverSelf (197.68s)
=== RUN   TestServerSideMoveOverSelf
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:32:23 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/04/22 01:32:23 DEBUG : sub dir/hello world: Update will use the tus protocol to upload
2026/04/22 01:32:23 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/04/22 01:32:23 INFO  : sub dir/hello world: Failed to read metadata: object not found
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/04/22 01:32:24 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/04/22 01:32:24 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:32:24 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/04/22 01:32:24 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-huzeyuz7tani"
2026/04/22 01:32:24 DEBUG : Config file has changed externally - reloading
2026/04/22 01:32:24 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:32:24 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:32:24 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:32:24 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:32:24 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:32:24 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:32:24 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:32:24 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:32:24 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:32:24 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:32:24 DEBUG : found headers: 
    sync_test.go:701: Server side copy (if possible) webdav root 'rclone-test-rulaqem0hife' -> webdav root 'rclone-test-huzeyuz7tani'
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/04/22 01:32:24 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/04/22 01:32:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/04/22 01:32:24 DEBUG : webdav root 'rclone-test-huzeyuz7tani': Waiting for checks to finish
2026/04/22 01:32:24 DEBUG : webdav root 'rclone-test-huzeyuz7tani': Waiting for transfers to finish
2026/04/22 01:32:25 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:32:25 DEBUG : pacer: Rate limited, increasing sleep to 53.453842ms
2026/04/22 01:32:25 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:32:25 DEBUG : pacer: Rate limited, increasing sleep to 106.907684ms
2026/04/22 01:32:25 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:32:25 DEBUG : pacer: Rate limited, increasing sleep to 213.815368ms
2026/04/22 01:32:25 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:32:25 DEBUG : pacer: Rate limited, increasing sleep to 427.630736ms
2026/04/22 01:32:25 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:32:25 DEBUG : pacer: Rate limited, increasing sleep to 855.261472ms
2026/04/22 01:32:26 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:32:26 DEBUG : pacer: Rate limited, increasing sleep to 1.710522944s
2026/04/22 01:32:27 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:32:27 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/04/22 01:32:28 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:32:30 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:32:32 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:32:32 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 0/10
2026/04/22 01:32:34 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:32:36 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:32:38 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:32:40 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:32:42 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:32:44 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:32:46 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:32:48 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:32:50 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:32:52 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:32:52 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 1/10
2026/04/22 01:32:54 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:32:56 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:32:58 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:33:00 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:33:02 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:33:04 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:33:06 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:33:08 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:33:10 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:33:12 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:33:12 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 2/10
2026/04/22 01:33:14 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:33:16 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:33:18 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:33:20 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:33:22 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:33:24 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:33:26 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:33:28 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:33:30 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:33:32 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:33:32 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 3/10
2026/04/22 01:33:34 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:33:36 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:33:38 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:33:40 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:33:42 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:33:44 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:33:46 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:33:48 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:33:50 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:33:52 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:33:52 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 4/10
2026/04/22 01:33:54 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:33:56 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:33:58 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:34:00 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:34:02 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:34:04 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:34:06 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:34:08 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:34:10 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:34:12 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:34:12 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 5/10
2026/04/22 01:34:14 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:34:16 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:34:18 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:34:20 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:34:22 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:34:24 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:34:26 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:34:28 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:34:30 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:34:32 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:34:32 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 6/10
2026/04/22 01:34:34 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:34:36 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:34:38 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:34:40 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:34:42 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:34:44 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:34:46 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:34:48 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:34:50 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:34:52 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:34:52 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 7/10
2026/04/22 01:34:54 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:34:56 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:34:58 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:35:00 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:35:02 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:35:04 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:35:06 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:35:08 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:35:10 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:35:12 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:35:12 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 8/10
2026/04/22 01:35:14 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:35:16 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:35:18 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:35:20 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:35:22 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:35:24 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:35:26 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:35:28 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:35:30 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:35:32 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:35:32 DEBUG : sub dir/hello world: Received error: copy call failed: 500 Internal Server Error - low level retry 9/10
2026/04/22 01:35:32 ERROR : sub dir/hello world: Failed to copy: copy call failed: 500 Internal Server Error
    sync_test.go:705: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:705
        	Error:      	Received unexpected error:
        	            	copy call failed: 500 Internal Server Error
        	Test:       	TestServerSideMoveOverSelf
2026/04/22 01:35:32 DEBUG : webdav root 'rclone-test-huzeyuz7tani': Purge remote
2026/04/22 01:35:34 DEBUG : pacer: Reducing sleep to 1.5s
2026/04/22 01:35:36 DEBUG : pacer: Reducing sleep to 1.125s
2026/04/22 01:35:38 DEBUG : pacer: Reducing sleep to 843.75ms
2026/04/22 01:35:39 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/04/22 01:35:40 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/04/22 01:35:40 DEBUG : pacer: Reducing sleep to 355.957031ms
--- FAIL: TestServerSideMoveOverSelf (197.85s)
=== RUN   TestCopyRedownload
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:35:41 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/04/22 01:35:41 DEBUG : sub dir/hello world: Update will use the tus protocol to upload
2026/04/22 01:35:41 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/04/22 01:35:41 INFO  : sub dir/hello world: Failed to read metadata: object not found
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/04/22 01:35:42 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/04/22 01:35:42 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:35:42 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/04/22 01:35:42 DEBUG : Added delayed dir = "sub dir", newDst=<nil>
2026/04/22 01:35:42 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/04/22 01:35:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/04/22 01:35:42 DEBUG : Local file system at /tmp/rclone3596579007: Waiting for checks to finish
2026/04/22 01:35:42 DEBUG : Local file system at /tmp/rclone3596579007: Waiting for transfers to finish
2026/04/22 01:35:42 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:35:42 DEBUG : pacer: Rate limited, increasing sleep to 53.453842ms
2026/04/22 01:35:42 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:35:42 DEBUG : pacer: Rate limited, increasing sleep to 106.907684ms
2026/04/22 01:35:42 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:35:42 DEBUG : pacer: Rate limited, increasing sleep to 213.815368ms
2026/04/22 01:35:42 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:35:42 DEBUG : pacer: Rate limited, increasing sleep to 427.630736ms
2026/04/22 01:35:43 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:35:43 DEBUG : pacer: Rate limited, increasing sleep to 855.261472ms
2026/04/22 01:35:43 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:35:43 DEBUG : pacer: Rate limited, increasing sleep to 1.710522944s
2026/04/22 01:35:44 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:35:44 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/04/22 01:35:46 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:35:48 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:35:50 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:35:50 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 0/10
2026/04/22 01:35:52 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:35:54 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:35:56 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:35:58 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:36:00 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:36:02 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:36:04 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:36:06 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:36:08 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:36:10 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:36:10 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 1/10
2026/04/22 01:36:12 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:36:14 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:36:16 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:36:18 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:36:20 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:36:22 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:36:24 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:36:26 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:36:28 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:36:30 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:36:30 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 2/10
2026/04/22 01:36:32 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:36:34 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:36:36 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:36:38 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:36:40 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:36:42 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:36:44 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:36:46 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:36:48 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:36:50 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:36:50 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 3/10
2026/04/22 01:36:52 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:36:54 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:36:56 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:36:58 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:37:00 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:37:02 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:37:04 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:37:06 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:37:08 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:37:10 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:37:10 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 4/10
2026/04/22 01:37:12 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:37:14 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:37:16 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:37:18 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:37:20 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:37:22 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:37:24 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:37:26 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:37:28 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:37:30 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:37:30 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 5/10
2026/04/22 01:37:32 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:37:34 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:37:36 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:37:38 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:37:40 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:37:42 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:37:44 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:37:46 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:37:48 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:37:50 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:37:50 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 6/10
2026/04/22 01:37:52 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:37:54 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:37:56 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:37:58 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:38:00 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:38:02 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:38:04 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:38:06 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:38:08 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:38:10 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:38:10 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 7/10
2026/04/22 01:38:12 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:38:14 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:38:16 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:38:18 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:38:20 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:38:22 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:38:24 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:38:26 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:38:28 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:38:30 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:38:30 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 8/10
2026/04/22 01:38:32 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:38:34 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:38:36 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:38:38 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:38:40 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:38:42 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:38:44 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:38:46 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:38:48 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:38:50 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:38:50 DEBUG : sub dir/hello world: Received error: failed to open source object: 500 Internal Server Error - low level retry 9/10
2026/04/22 01:38:50 ERROR : sub dir/hello world: Failed to copy: failed to open source object: 500 Internal Server Error
2026/04/22 01:38:50 ERROR : sub dir: Failed to update directory timestamp or metadata: chtimes /tmp/rclone3596579007/sub dir: no such file or directory
    sync_test.go:762: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:762
        	Error:      	Received unexpected error:
        	            	failed to set directory modtime: chtimes /tmp/rclone3596579007/sub dir: no such file or directory
        	Test:       	TestCopyRedownload
2026/04/22 01:38:52 DEBUG : pacer: Reducing sleep to 1.5s
2026/04/22 01:38:54 DEBUG : pacer: Reducing sleep to 1.125s
2026/04/22 01:38:55 DEBUG : pacer: Reducing sleep to 843.75ms
2026/04/22 01:38:56 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/04/22 01:38:57 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/04/22 01:38:58 DEBUG : pacer: Reducing sleep to 355.957031ms
--- FAIL: TestCopyRedownload (197.39s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:38:58 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/04/22 01:38:58 DEBUG : empty space: Update will use the tus protocol to upload
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/04/22 01:38:59 INFO  : empty space: Failed to read metadata: object not found
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 150.169371ms
2026/04/22 01:38:59 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 112.627028ms
2026/04/22 01:38:59 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 1
2026/04/22 01:38:59 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 84.470271ms
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 63.352703ms
2026/04/22 01:38:59 DEBUG : pacer: Reducing sleep to 47.514527ms
2026/04/22 01:38:59 DEBUG : empty space: size = 1 OK
2026/04/22 01:38:59 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 GMT
2026/04/22 01:38:59 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for checks to finish
2026/04/22 01:38:59 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2026/04/22 01:38:59 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1)
2026/04/22 01:38:59 DEBUG : empty space: Unchanged skipping
2026/04/22 01:38:59 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for transfers to finish
2026/04/22 01:38:59 DEBUG : Waiting for deletions to finish
2026/04/22 01:38:59 INFO  : There was nothing to transfer
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 35.635895ms
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 26.726921ms
2026/04/22 01:39:00 DEBUG : empty space: size = 1 OK
2026/04/22 01:39:00 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 GMT
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for checks to finish
2026/04/22 01:39:00 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 20.04519ms
2026/04/22 01:39:00 INFO  : empty space: Updated modification time in destination
2026/04/22 01:39:00 DEBUG : empty space: Unchanged skipping
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for transfers to finish
2026/04/22 01:39:00 DEBUG : Waiting for deletions to finish
2026/04/22 01:39:00 INFO  : There was nothing to transfer
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 15.033892ms
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:132
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151
        	            				/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:345
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1037
        	Error:      	Should be true
        	Test:       	TestSyncAfterChangingModtimeOnly
        	Messages:   	empty space: Modification time difference too big |95456h54m53.123456789s| > 1s (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2001-02-03 04:05:06 +0000 GMT) (precision 1s)
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 11.275419ms
2026/04/22 01:39:00 DEBUG : pacer: Reducing sleep to 10ms
--- FAIL: TestSyncAfterChangingModtimeOnly (2.07s)
=== RUN   TestSyncCopyDest
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:39:00 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/dst"
2026/04/22 01:39:00 DEBUG : Config file has changed externally - reloading
2026/04/22 01:39:00 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:39:00 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:00 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:00 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:00 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:00 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:39:00 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:00 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:00 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:00 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:00 DEBUG : found headers: 
2026/04/22 01:39:00 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/CopyDest"
2026/04/22 01:39:00 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:39:00 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:00 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:00 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:00 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:00 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:39:00 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:00 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:00 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:00 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:00 DEBUG : found headers: 
2026/04/22 01:39:00 DEBUG : fs cache: renaming cache item "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/CopyDest" to be canonical "TestWebdavInfiniteScale{qIAoV}:rclone-test-rulaqem0hife/CopyDest"
2026/04/22 01:39:00 DEBUG : one: Need to transfer - File not found at Destination
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for checks to finish
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for transfers to finish
2026/04/22 01:39:00 DEBUG : one: Update will use the tus protocol to upload
2026/04/22 01:39:00 INFO  : one: Failed to read metadata: object not found
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Uploaded starts
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Uploaded chunk no 1 ok, range 0 -> 3
2026/04/22 01:39:00 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': -- Uploaded finished
2026/04/22 01:39:00 DEBUG : one: size = 3 OK
2026/04/22 01:39:00 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2026/04/22 01:39:00 INFO  : one: Copied (new)
2026/04/22 01:39:00 DEBUG : Waiting for deletions to finish
2026/04/22 01:39:01 DEBUG : fs cache: switching user supplied name "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/CopyDest" for canonical name "TestWebdavInfiniteScale{qIAoV}:rclone-test-rulaqem0hife/CopyDest"
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for checks to finish
2026/04/22 01:39:01 DEBUG : one: size = 5 (Local file system at /tmp/rclone3596579007)
2026/04/22 01:39:01 DEBUG : one: size = 3 (webdav root 'rclone-test-rulaqem0hife/dst')
2026/04/22 01:39:01 DEBUG : one: Sizes differ
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for transfers to finish
2026/04/22 01:39:01 DEBUG : one: Update will use the tus protocol to upload
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Uploaded starts
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Uploaded chunk no 1 ok, range 0 -> 5
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': -- Uploaded finished
2026/04/22 01:39:01 DEBUG : one: size = 5 OK
2026/04/22 01:39:01 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK
2026/04/22 01:39:01 INFO  : one: Copied (replaced existing)
2026/04/22 01:39:01 DEBUG : Waiting for deletions to finish
2026/04/22 01:39:01 DEBUG : dst/one: Update will use the tus protocol to upload
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 3
2026/04/22 01:39:01 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:39:02 DEBUG : CopyDest/one: Update will use the tus protocol to upload
2026/04/22 01:39:02 INFO  : CopyDest/one: Failed to read metadata: object not found
2026/04/22 01:39:02 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:39:02 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 5
2026/04/22 01:39:02 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:39:02 DEBUG : Creating backend with remote "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/BackupDir"
2026/04/22 01:39:02 DEBUG : Setting type="webdav" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_TYPE
2026/04/22 01:39:02 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:02 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:02 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:02 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:02 DEBUG : TestWebdavInfiniteScale: detected overridden config - adding "{qIAoV}" suffix to name
2026/04/22 01:39:02 DEBUG : Setting url="https://127.0.0.1:28639/dav/spaces/some-admin-user-id-0000-100000000000" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_URL
2026/04/22 01:39:02 DEBUG : Setting vendor="infinitescale" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_VENDOR
2026/04/22 01:39:02 DEBUG : Setting user="admin" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_USER
2026/04/22 01:39:02 DEBUG : Setting pass="g8bGvHWXA3gBJy8YpcjnzH_k6NNr" for "TestWebdavInfiniteScale" from environment variable RCLONE_CONFIG_TESTWEBDAVINFINITESCALE_PASS
2026/04/22 01:39:02 DEBUG : found headers: 
2026/04/22 01:39:02 DEBUG : fs cache: renaming cache item "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/BackupDir" to be canonical "TestWebdavInfiniteScale{qIAoV}:rclone-test-rulaqem0hife/BackupDir"
2026/04/22 01:39:02 DEBUG : fs cache: switching user supplied name "TestWebdavInfiniteScale:rclone-test-rulaqem0hife/CopyDest" for canonical name "TestWebdavInfiniteScale{qIAoV}:rclone-test-rulaqem0hife/CopyDest"
2026/04/22 01:39:02 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for checks to finish
2026/04/22 01:39:02 DEBUG : one: size = 5 (Local file system at /tmp/rclone3596579007)
2026/04/22 01:39:02 DEBUG : one: size = 3 (webdav root 'rclone-test-rulaqem0hife/dst')
2026/04/22 01:39:02 DEBUG : one: Sizes differ
2026/04/22 01:39:02 DEBUG : one: size = 5 OK
2026/04/22 01:39:02 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/04/22 01:39:02 DEBUG : one: size = 5 (Local file system at /tmp/rclone3596579007)
2026/04/22 01:39:02 DEBUG : one: size = 3 (webdav root 'rclone-test-rulaqem0hife/dst')
2026/04/22 01:39:02 DEBUG : one: Sizes differ
2026/04/22 01:39:02 INFO  : one: Moved (server-side)
2026/04/22 01:39:03 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/22 01:39:03 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/04/22 01:39:03 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/04/22 01:39:03 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/04/22 01:39:03 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/04/22 01:39:03 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:39:03 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/04/22 01:39:04 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:39:04 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/04/22 01:39:04 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:39:04 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/04/22 01:39:05 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:39:07 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:39:07 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 0/10
2026/04/22 01:39:09 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:39:11 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:39:13 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:39:15 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:39:17 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:39:19 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:39:21 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:39:23 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:39:25 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:39:27 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:39:27 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 1/10
2026/04/22 01:39:29 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:39:31 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:39:33 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:39:35 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:39:37 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:39:39 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:39:41 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:39:43 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:39:45 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:39:47 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:39:47 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 2/10
2026/04/22 01:39:49 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:39:51 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:39:53 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:39:55 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:39:57 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:39:59 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:40:01 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:40:03 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:40:05 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:40:07 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:40:07 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 3/10
2026/04/22 01:40:09 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:40:11 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:40:13 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:40:15 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:40:17 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:40:19 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:40:21 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:40:23 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:40:26 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:40:27 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:40:27 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 4/10
2026/04/22 01:40:29 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:40:32 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:40:33 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:40:35 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:40:38 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:40:39 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:40:42 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:40:43 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:40:45 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:40:47 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:40:47 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 5/10
2026/04/22 01:40:50 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:40:52 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:40:53 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:40:55 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:40:57 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:40:59 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:41:01 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:41:04 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:41:06 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:41:07 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:41:07 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 6/10
2026/04/22 01:41:09 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:41:12 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:41:13 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:41:16 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:41:17 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:41:20 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:41:22 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:41:24 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:41:26 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:41:28 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:41:28 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 7/10
2026/04/22 01:41:30 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:41:32 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:41:34 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:41:36 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:41:38 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:41:40 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:41:42 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:41:44 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:41:45 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:41:48 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:41:48 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 8/10
2026/04/22 01:41:50 DEBUG : pacer: low level retry 1/10 (error 500 Internal Server Error)
2026/04/22 01:41:52 DEBUG : pacer: low level retry 2/10 (error 500 Internal Server Error)
2026/04/22 01:41:54 DEBUG : pacer: low level retry 3/10 (error 500 Internal Server Error)
2026/04/22 01:41:56 DEBUG : pacer: low level retry 4/10 (error 500 Internal Server Error)
2026/04/22 01:41:58 DEBUG : pacer: low level retry 5/10 (error 500 Internal Server Error)
2026/04/22 01:42:00 DEBUG : pacer: low level retry 6/10 (error 500 Internal Server Error)
2026/04/22 01:42:02 DEBUG : pacer: low level retry 7/10 (error 500 Internal Server Error)
2026/04/22 01:42:04 DEBUG : pacer: low level retry 8/10 (error 500 Internal Server Error)
2026/04/22 01:42:06 DEBUG : pacer: low level retry 9/10 (error 500 Internal Server Error)
2026/04/22 01:42:08 DEBUG : pacer: low level retry 10/10 (error 500 Internal Server Error)
2026/04/22 01:42:08 DEBUG : one: Received error: copy call failed: 500 Internal Server Error - low level retry 9/10
2026/04/22 01:42:08 ERROR : one: Failed to copy: copy call failed: 500 Internal Server Error
2026/04/22 01:42:08 ERROR : one: Destination found in --copy-dest, error copying
2026/04/22 01:42:08 INFO  : one: Deleted
2026/04/22 01:42:08 ERROR : one: Couldn't move: copy call failed: Resource ./rclone-test-rulaqem0hife/dst/one not found: Sabre\DAV\Exception\NotFound: 404 Not Found
2026/04/22 01:42:08 DEBUG : webdav root 'rclone-test-rulaqem0hife/dst': Waiting for transfers to finish
2026/04/22 01:42:08 ERROR : webdav root 'rclone-test-rulaqem0hife/dst': not deleting files as there were IO errors
2026/04/22 01:42:08 ERROR : webdav root 'rclone-test-rulaqem0hife/dst': not deleting directories as there were IO errors
    sync_test.go:2319: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2319
        	Error:      	Received unexpected error:
        	            	copy call failed: Resource ./rclone-test-rulaqem0hife/dst/one not found: Sabre\DAV\Exception\NotFound: 404 Not Found
        	Test:       	TestSyncCopyDest
--- FAIL: TestSyncCopyDest (188.76s)
=== RUN   TestManualTransformFile
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:42:09 DEBUG : Reset feature "Copy"
2026/04/22 01:42:09 DEBUG : Reset feature "Move"
2026/04/22 01:42:09 DEBUG : Reset feature "Copy"
2026/04/22 01:42:09 DEBUG : Reset feature "Move"
2026/04/22 01:42:09 DEBUG : empty_dir: Making directory with metadata
2026/04/22 01:42:09 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/04/22 01:42:09 DEBUG : toe: transformed to: tictactoe
2026/04/22 01:42:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2026/04/22 01:42:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2026/04/22 01:42:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2026/04/22 01:42:09 INFO  : tictacempty_dir: Making directory
2026/04/22 01:42:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2026/04/22 01:42:09 DEBUG : toe: transformed to: tictactoe
2026/04/22 01:42:09 DEBUG : toe: transformed to: tictactoe
2026/04/22 01:42:09 INFO  : tictactoe: Making directory
2026/04/22 01:42:09 DEBUG : toe: transformed to: tictactoe
2026/04/22 01:42:09 DEBUG : toe: transformed to: tictactoe
2026/04/22 01:42:09 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2026/04/22 01:42:09 INFO  : tictactoe/tictactoe: Making directory
2026/04/22 01:42:09 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2026/04/22 01:42:09 DEBUG : toe.txt: transformed to: tictactoe.txt
2026/04/22 01:42:09 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2026/04/22 01:42:09 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2026/04/22 01:42:09 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2026/04/22 01:42:09 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2026/04/22 01:42:09 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for checks to finish
2026/04/22 01:42:09 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for transfers to finish
2026/04/22 01:42:09 DEBUG : tictactoe/tictactoe/tictactoe.txt: Update will use the tus protocol to upload
2026/04/22 01:42:09 INFO  : tictactoe/tictactoe/tictactoe.txt: Failed to read metadata: object not found
2026/04/22 01:42:09 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:42:09 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:42:09 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:42:09 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2026/04/22 01:42:09 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2026/04/22 01:42:09 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2026/04/22 01:42:09 INFO  : toe/toe/toe.txt: Deleted
2026/04/22 01:42:09 ERROR : Local file system at /tmp/rclone3596579007: not deleting directories as there were IO errors
    sync_transform_test.go:458: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:458
        	Error:      	Received unexpected error:
        	            	not deleting directories as there were IO errors
        	Test:       	TestManualTransformFile
--- FAIL: TestManualTransformFile (1.14s)
=== RUN   TestBase64
    run.go:185: Remote "webdav root 'rclone-test-rulaqem0hife'", Local "Local file system at /tmp/rclone3596579007", Modify Window "1s"
2026/04/22 01:42:10 DEBUG : toe: transformed to: dG9l
2026/04/22 01:42:10 DEBUG : toe: transformed to: dG9l
2026/04/22 01:42:10 INFO  : dG9l: Making directory
2026/04/22 01:42:10 DEBUG : toe: transformed to: dG9l
2026/04/22 01:42:10 DEBUG : toe: transformed to: dG9l
2026/04/22 01:42:10 DEBUG : toe/toe: transformed to: dG9l/dG9l
2026/04/22 01:42:10 INFO  : dG9l/dG9l: Making directory
2026/04/22 01:42:10 DEBUG : toe/toe: transformed to: dG9l/dG9l
2026/04/22 01:42:10 DEBUG : toe.txt: transformed to: dG9lLnR4dA==
2026/04/22 01:42:10 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2026/04/22 01:42:10 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2026/04/22 01:42:10 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2026/04/22 01:42:10 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for checks to finish
2026/04/22 01:42:10 DEBUG : webdav root 'rclone-test-rulaqem0hife': Waiting for transfers to finish
2026/04/22 01:42:10 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Update will use the tus protocol to upload
2026/04/22 01:42:10 INFO  : dG9l/dG9l/dG9lLnR4dA==: Failed to read metadata: object not found
2026/04/22 01:42:10 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded starts
2026/04/22 01:42:10 DEBUG : webdav root 'rclone-test-rulaqem0hife': Uploaded chunk no 1 ok, range 0 -> 11
2026/04/22 01:42:10 DEBUG : webdav root 'rclone-test-rulaqem0hife': -- Uploaded finished
2026/04/22 01:42:10 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK
2026/04/22 01:42:10 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2026/04/22 01:42:10 INFO  : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA==
2026/04/22 01:42:10 ERROR : webdav root 'rclone-test-rulaqem0hife': not deleting files as there were IO errors
2026/04/22 01:42:10 ERROR : webdav root 'rclone-test-rulaqem0hife': not deleting directories as there were IO errors
    sync_transform_test.go:482: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:482
        	Error:      	Received unexpected error:
        	            	not deleting files as there were IO errors
        	Test:       	TestBase64
--- FAIL: TestBase64 (1.00s)
FAIL
2026/04/22 01:42:11 DEBUG : webdav root 'rclone-test-rulaqem0hife': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavInfiniteScale: -verbose -test.run '^(TestBase64|TestCopyRedownload|TestManualTransformFile|TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncAfterChangingModtimeOnly|TestSyncCopyDest)$'" - Finished ERROR in 16m20.077171141s (try 3/5): exit status 1: Failed [TestServerSideCopy TestServerSideCopyOverSelf TestServerSideMoveOverSelf TestCopyRedownload TestSyncAfterChangingModtimeOnly TestSyncCopyDest TestManualTransformFile TestBase64]