"./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavNextcloud: -verbose" - Starting (try 1/5) 2024/11/22 03:56:35 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe" 2024/11/22 03:56:35 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/22 03:56:35 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 03:56:35 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:56:35 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:56:35 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:56:35 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:56:35 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 03:56:35 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:56:35 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:56:35 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:56:35 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:56:35 DEBUG : found headers: 2024/11/22 03:56:35 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 03:56:35 DEBUG : Creating backend with remote "/tmp/rclone2847720371" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.01s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:56:35 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2024/11/22 03:56:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyWithDryRun (1.86s) === RUN TestCopy run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/22 03:56:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:56:37 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:37 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:37 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:56:38 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:38 DEBUG : webdav root 'rclone-test-higozel4yohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (3.73s) === RUN TestCopyMetadata run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.58s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.56s) === RUN TestCopyMissingDirectory run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:42 DEBUG : Creating backend with remote "/non-existing" 2024/11/22 03:56:42 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/11/22 03:56:42 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:42 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyMissingDirectory (1.29s) === RUN TestCopyNoTraverse run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:56:43 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:43 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:43 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:56:44 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyNoTraverse (3.89s) === RUN TestCopyCheckFirst run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:47 INFO : webdav root 'rclone-test-higozel4yohe': Running all checks before starting transfers 2024/11/22 03:56:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:56:47 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:47 INFO : webdav root 'rclone-test-higozel4yohe': Checks finished, now starting transfers 2024/11/22 03:56:47 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:47 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:56:48 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyCheckFirst (3.77s) === RUN TestSyncNoTraverse run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:51 ERROR : Ignoring --no-traverse with sync 2024/11/22 03:56:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:56:51 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:51 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:51 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:52 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:56:52 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:56:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncNoTraverse (3.81s) === RUN TestCopyWithDepth run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:55 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/11/22 03:56:55 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:55 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:55 DEBUG : hello world2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:56 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2024/11/22 03:56:56 INFO : hello world2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyWithDepth (2.71s) === RUN TestCopyWithFilesFrom run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:56:57 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:56:57 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:56:57 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:56:58 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:56:58 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:56:58 INFO : potato2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyWithFilesFrom (2.67s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:00 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:57:00 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:00 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:00 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:01 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:01 INFO : potato2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyWithFilesFromAndNoTraverse (2.67s) === RUN TestCopyEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:02 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/22 03:57:02 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/22 03:57:02 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2024/11/22 03:57:02 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/22 03:57:03 DEBUG : sub dir: Making directory 2024/11/22 03:57:03 DEBUG : sub dir2: Making directory 2024/11/22 03:57:03 DEBUG : sub dir2/sub sub dir2: Making directory 2024/11/22 03:57:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:04 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:04 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:04 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:04 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:04 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:05 DEBUG : webdav root 'rclone-test-higozel4yohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (5.97s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:08 DEBUG : sub dir2: Making directory 2024/11/22 03:57:08 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/22 03:57:08 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/22 03:57:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:09 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:09 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:09 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:10 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:10 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (3.31s) === RUN TestMoveEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:12 DEBUG : sub dir2: Making directory with metadata 2024/11/22 03:57:12 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/22 03:57:12 DEBUG : sub dir: Making directory 2024/11/22 03:57:12 DEBUG : sub dir2: Making directory 2024/11/22 03:57:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:13 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:13 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:13 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:13 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:13 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:57:13 INFO : sub dir/hello world: Deleted run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:14 DEBUG : webdav root 'rclone-test-higozel4yohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/11/22 03:57:14 DEBUG : webdav root 'rclone-test-higozel4yohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (5.12s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.48s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:17 DEBUG : sub dir2: Making directory 2024/11/22 03:57:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:18 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:18 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:18 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:18 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:18 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:57:18 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (3.17s) === RUN TestSyncEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:20 DEBUG : sub dir2: Making directory with metadata 2024/11/22 03:57:20 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/22 03:57:20 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/22 03:57:21 DEBUG : sub dir: Making directory 2024/11/22 03:57:21 DEBUG : sub dir2: Making directory 2024/11/22 03:57:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:21 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:21 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:22 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:22 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:57:22 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:23 DEBUG : webdav root 'rclone-test-higozel4yohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (4.94s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.51s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:26 DEBUG : sub dir2: Making directory 2024/11/22 03:57:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:26 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:26 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:26 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:57:27 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:57:27 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (3.17s) === RUN TestServerSideCopy run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:29 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:30 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-xozotub0miga" 2024/11/22 03:57:30 DEBUG : Config file has changed externally - reloading 2024/11/22 03:57:30 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 03:57:30 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:30 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:30 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:30 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:30 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 03:57:30 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:30 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:30 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:30 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:30 DEBUG : found headers: 2024/11/22 03:57:30 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ sync_test.go:590: Server side copy (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-xozotub0miga' 2024/11/22 03:57:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:31 DEBUG : webdav root 'rclone-test-xozotub0miga': Waiting for checks to finish 2024/11/22 03:57:31 DEBUG : webdav root 'rclone-test-xozotub0miga': Waiting for transfers to finish 2024/11/22 03:57:33 DEBUG : sub dir/hello world: Setting modtime after copy to 2001-02-03 04:05:06 +0000 GMT 2024/11/22 03:57:33 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2024/11/22 03:57:33 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:34 DEBUG : webdav root 'rclone-test-xozotub0miga': Purge remote --- PASS: TestServerSideCopy (6.91s) === RUN TestCopyOverSelf run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:36 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:38 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/22 03:57:38 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:38 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:38 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:39 DEBUG : sub dir/hello world: sha1 = b84a9b2362aee3556081792f3b7abd3958da8deb OK 2024/11/22 03:57:39 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyOverSelf (5.36s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:42 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:43 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-seyowuv1dari" 2024/11/22 03:57:43 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 03:57:43 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:43 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:43 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:43 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:43 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 03:57:43 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:43 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:43 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:43 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:43 DEBUG : found headers: 2024/11/22 03:57:43 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ sync_test.go:626: Server side copy (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-seyowuv1dari' 2024/11/22 03:57:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:57:43 DEBUG : webdav root 'rclone-test-seyowuv1dari': Waiting for checks to finish 2024/11/22 03:57:43 DEBUG : webdav root 'rclone-test-seyowuv1dari': Waiting for transfers to finish 2024/11/22 03:57:45 DEBUG : sub dir/hello world: Setting modtime after copy to 2001-02-03 04:05:06 +0000 GMT 2024/11/22 03:57:45 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2024/11/22 03:57:45 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:46 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:48 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/22 03:57:48 DEBUG : webdav root 'rclone-test-seyowuv1dari': Waiting for checks to finish 2024/11/22 03:57:48 DEBUG : webdav root 'rclone-test-seyowuv1dari': Waiting for transfers to finish 2024/11/22 03:57:49 DEBUG : sub dir/hello world: Setting modtime after copy to 2011-12-25 12:59:59 +0000 GMT 2024/11/22 03:57:49 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2024/11/22 03:57:49 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:49 DEBUG : webdav root 'rclone-test-seyowuv1dari': Purge remote --- PASS: TestServerSideCopyOverSelf (10.97s) === RUN TestMoveOverSelf run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:53 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:54 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:57:54 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/22 03:57:54 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:57:54 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:55 DEBUG : sub dir/hello world: sha1 = b84a9b2362aee3556081792f3b7abd3958da8deb OK 2024/11/22 03:57:55 INFO : sub dir/hello world: Copied (replaced existing) 2024/11/22 03:57:55 INFO : sub dir/hello world: Deleted run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestMoveOverSelf (5.38s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:57:58 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:57:59 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-yisokun7wiha" 2024/11/22 03:57:59 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 03:57:59 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:59 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:59 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:59 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:59 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 03:57:59 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 03:57:59 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 03:57:59 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 03:57:59 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 03:57:59 DEBUG : found headers: 2024/11/22 03:57:59 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ sync_test.go:671: Server side copy (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-yisokun7wiha' 2024/11/22 03:58:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:58:00 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for checks to finish 2024/11/22 03:58:00 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for transfers to finish 2024/11/22 03:58:02 DEBUG : sub dir/hello world: Setting modtime after copy to 2001-02-03 04:05:06 +0000 GMT 2024/11/22 03:58:02 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2024/11/22 03:58:02 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:03 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:04 DEBUG : webdav root 'rclone-test-yisokun7wiha': Using server-side directory move 2024/11/22 03:58:04 INFO : webdav root 'rclone-test-yisokun7wiha': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/22 03:58:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/22 03:58:05 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for checks to finish 2024/11/22 03:58:05 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for transfers to finish 2024/11/22 03:58:05 INFO : sub dir/hello world: Deleted 2024/11/22 03:58:06 INFO : sub dir/hello world: Moved (server-side) 2024/11/22 03:58:07 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:08 DEBUG : testing file moves 2024/11/22 03:58:09 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2024/11/22 03:58:09 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for checks to finish 2024/11/22 03:58:09 DEBUG : webdav root 'rclone-test-yisokun7wiha': Waiting for transfers to finish 2024/11/22 03:58:09 INFO : sub dir/hello world: Deleted 2024/11/22 03:58:10 INFO : sub dir/hello world: Moved (server-side) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:11 DEBUG : webdav root 'rclone-test-yisokun7wiha': Purge remote --- PASS: TestServerSideMoveOverSelf (15.71s) === RUN TestCopyAfterDelete run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:14 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:14 ERROR : : error listing: directory not found 2024/11/22 03:58:15 DEBUG : Local file system at /tmp/rclone2847720371: Making directory 2024/11/22 03:58:15 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:15 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyAfterDelete (4.35s) === RUN TestCopyRedownload run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:18 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:19 DEBUG : Added delayed dir = "sub dir", newDst= 2024/11/22 03:58:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 03:58:20 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for checks to finish 2024/11/22 03:58:20 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for transfers to finish 2024/11/22 03:58:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 03:58:20 DEBUG : sub dir/hello world.e0e42c92.partial: renamed to: sub dir/hello world 2024/11/22 03:58:20 INFO : sub dir/hello world: Copied (new) 2024/11/22 03:58:20 INFO : sub dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyRedownload (4.14s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:22 DEBUG : check sum: Need to transfer - File not found at Destination 2024/11/22 03:58:22 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:22 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:22 DEBUG : check sum: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:23 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:23 INFO : check sum: Copied (new) 2024/11/22 03:58:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:23 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:23 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:23 DEBUG : check sum: Size and sha1 of src and dst objects identical 2024/11/22 03:58:23 DEBUG : check sum: Unchanged skipping 2024/11/22 03:58:23 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:23 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:23 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncBasedOnCheckSum (3.56s) === RUN TestSyncSizeOnly run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:26 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/11/22 03:58:26 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:26 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:26 DEBUG : sizeonly: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:27 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/22 03:58:27 INFO : sizeonly: Copied (new) 2024/11/22 03:58:27 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:27 DEBUG : sizeonly: Sizes identical 2024/11/22 03:58:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:27 DEBUG : sizeonly: Unchanged skipping 2024/11/22 03:58:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:27 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:27 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncSizeOnly (3.67s) === RUN TestSyncIgnoreSize run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:29 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/11/22 03:58:29 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:29 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:30 DEBUG : ignore-size: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:30 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2024/11/22 03:58:30 INFO : ignore-size: Copied (new) 2024/11/22 03:58:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:31 DEBUG : ignore-size: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 03:58:31 DEBUG : ignore-size: Unchanged skipping 2024/11/22 03:58:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:31 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:31 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncIgnoreSize (3.65s) === RUN TestSyncIgnoreTimes run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:33 DEBUG : existing: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:34 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 03:58:34 DEBUG : existing: Unchanged skipping 2024/11/22 03:58:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:34 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:34 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:34 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/11/22 03:58:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:35 DEBUG : existing: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:35 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/22 03:58:35 INFO : existing: Copied (replaced existing) 2024/11/22 03:58:35 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncIgnoreTimes (4.51s) === RUN TestSyncIgnoreExisting run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:38 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/22 03:58:38 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:38 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:38 DEBUG : existing: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:38 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/22 03:58:38 INFO : existing: Copied (new) 2024/11/22 03:58:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:39 DEBUG : existing: Destination exists, skipping 2024/11/22 03:58:39 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:39 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:39 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:39 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncIgnoreExisting (3.60s) === RUN TestSyncIgnoreErrors run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:41 DEBUG : b/potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:42 DEBUG : c/non empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:43 DEBUG : d: Making directory 2024/11/22 03:58:44 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/22 03:58:44 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:58:44 DEBUG : c/non empty space: Unchanged skipping 2024/11/22 03:58:44 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:44 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:44 DEBUG : a/potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:45 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:58:45 INFO : a/potato2: Copied (new) 2024/11/22 03:58:45 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:45 INFO : b/potato: Deleted 2024/11/22 03:58:45 INFO : d: Removing directory 2024/11/22 03:58:46 INFO : b: Removing directory 2024/11/22 03:58:46 DEBUG : webdav root 'rclone-test-higozel4yohe': deleted 2 directories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncIgnoreErrors (8.91s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:50 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:51 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 2024/11/22 03:58:51 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:51 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:51 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/11/22 03:58:51 DEBUG : empty space: Unchanged skipping 2024/11/22 03:58:51 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:51 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:51 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:52 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 2024/11/22 03:58:52 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:52 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:52 NOTICE: webdav root 'rclone-test-higozel4yohe': Forced to upload files to set modification times on this backend. 2024/11/22 03:58:52 INFO : empty space: src and dst identical but can't set mod time without re-uploading 2024/11/22 03:58:52 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:53 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:53 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:53 INFO : empty space: Copied (replaced existing) 2024/11/22 03:58:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterChangingModtimeOnly (5.54s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:56 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:58:57 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:58:57 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 2024/11/22 03:58:57 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/22 03:58:57 DEBUG : empty space: Unchanged skipping 2024/11/22 03:58:57 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:58:57 DEBUG : Waiting for deletions to finish 2024/11/22 03:58:57 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.95s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:58:59 DEBUG : foo: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:00 DEBUG : foo: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 GMT 2024/11/22 03:59:00 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:00 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone2847720371) 2024/11/22 03:59:00 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (webdav root 'rclone-test-higozel4yohe') 2024/11/22 03:59:00 DEBUG : foo: sha1 differ 2024/11/22 03:59:00 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:00 DEBUG : foo: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:00 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/11/22 03:59:00 INFO : foo: Copied (replaced existing) 2024/11/22 03:59:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncDoesntUpdateModtime (3.75s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:02 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:03 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/22 03:59:03 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:03 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:03 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:03 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:04 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:04 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:04 INFO : potato: Copied (new) 2024/11/22 03:59:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterAddingAFile (4.01s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:06 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:07 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/11/22 03:59:07 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:07 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:08 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:08 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2024/11/22 03:59:08 INFO : potato: Copied (replaced existing) 2024/11/22 03:59:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterChangingFilesSizeOnly (3.69s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:10 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:11 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 GMT 2024/11/22 03:59:11 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:11 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone2847720371) 2024/11/22 03:59:11 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (webdav root 'rclone-test-higozel4yohe') 2024/11/22 03:59:11 DEBUG : potato: sha1 differ 2024/11/22 03:59:11 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:11 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:12 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2024/11/22 03:59:12 INFO : potato: Copied (replaced existing) 2024/11/22 03:59:12 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterChangingContentsOnly (3.85s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:14 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:15 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:16 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:16 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:16 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:16 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:16 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:16 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/11/22 03:59:16 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:16 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (3.88s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:18 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:19 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:20 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:20 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:20 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:20 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:20 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:20 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:20 INFO : potato2: Copied (new) 2024/11/22 03:59:20 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:21 INFO : potato: Deleted run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (5.11s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:23 DEBUG : b/potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:24 DEBUG : c/non empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:24 DEBUG : d: Making directory 2024/11/22 03:59:25 DEBUG : d/e: Making directory 2024/11/22 03:59:26 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:26 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:26 DEBUG : c/non empty space: Unchanged skipping 2024/11/22 03:59:26 DEBUG : a/potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:27 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:27 INFO : a/potato2: Copied (new) 2024/11/22 03:59:27 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:27 INFO : b/potato: Deleted 2024/11/22 03:59:27 INFO : d/e: Removing directory 2024/11/22 03:59:28 INFO : d: Removing directory 2024/11/22 03:59:28 INFO : b: Removing directory 2024/11/22 03:59:29 DEBUG : webdav root 'rclone-test-higozel4yohe': deleted 3 directories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (9.67s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:33 DEBUG : b/potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:33 DEBUG : c/non empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:34 DEBUG : d: Making directory 2024/11/22 03:59:35 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:35 DEBUG : a/potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:35 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:35 DEBUG : c/non empty space: Unchanged skipping 2024/11/22 03:59:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:36 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:36 INFO : a/potato2: Copied (new) 2024/11/22 03:59:36 ERROR : webdav root 'rclone-test-higozel4yohe': not deleting files as there were IO errors 2024/11/22 03:59:36 ERROR : webdav root 'rclone-test-higozel4yohe': not deleting directories as there were IO errors run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (8.85s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:41 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:42 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:43 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:43 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:43 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:43 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:43 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:43 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:44 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:44 INFO : potato: Deleted 2024/11/22 03:59:44 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:44 INFO : potato2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncDeleteDuring (4.80s) === RUN TestSyncDeleteBefore run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:46 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:47 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:48 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:48 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:48 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:48 INFO : potato: Deleted 2024/11/22 03:59:49 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:49 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:49 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:49 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:49 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:49 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:50 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/22 03:59:50 INFO : potato2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncDeleteBefore (5.56s) === RUN TestCopyDeleteBefore run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:52 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:53 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 03:59:53 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:53 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:53 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:54 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2024/11/22 03:59:54 INFO : potato2: Copied (new) run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestCopyDeleteBefore (4.02s) === RUN TestSyncWithExclude run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:56 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:57 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 03:59:57 DEBUG : enormous: Excluded (Size Filter) 2024/11/22 03:59:57 DEBUG : enormous: Excluded 2024/11/22 03:59:57 DEBUG : potato2: Excluded (Size Filter) 2024/11/22 03:59:57 DEBUG : potato2: Excluded 2024/11/22 03:59:58 DEBUG : potato2: Excluded (Size Filter) 2024/11/22 03:59:58 DEBUG : potato2: Excluded 2024/11/22 03:59:58 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 03:59:58 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 03:59:58 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:58 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 03:59:58 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:58 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 03:59:58 DEBUG : enormous: Excluded (Size Filter) 2024/11/22 03:59:58 DEBUG : enormous: Excluded 2024/11/22 03:59:58 DEBUG : potato2: Excluded (Size Filter) 2024/11/22 03:59:58 DEBUG : potato2: Excluded 2024/11/22 03:59:58 DEBUG : potato2: Excluded (Size Filter) 2024/11/22 03:59:58 DEBUG : potato2: Excluded 2024/11/22 03:59:58 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for checks to finish 2024/11/22 03:59:58 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s) 2024/11/22 03:59:58 DEBUG : empty space: Unchanged skipping 2024/11/22 03:59:58 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for transfers to finish 2024/11/22 03:59:58 DEBUG : Waiting for deletions to finish 2024/11/22 03:59:58 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncWithExclude (4.82s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:01 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:01 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:02 DEBUG : enormous: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:03 DEBUG : enormous: Excluded (Size Filter) 2024/11/22 04:00:03 DEBUG : enormous: Excluded 2024/11/22 04:00:03 DEBUG : potato2: Excluded (Size Filter) 2024/11/22 04:00:03 DEBUG : potato2: Excluded 2024/11/22 04:00:03 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:00:03 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:03 DEBUG : empty space: Unchanged skipping 2024/11/22 04:00:03 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:03 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:04 INFO : enormous: Deleted 2024/11/22 04:00:04 INFO : potato2: Deleted 2024/11/22 04:00:04 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:04 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s) 2024/11/22 04:00:04 DEBUG : empty space: Unchanged skipping 2024/11/22 04:00:04 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for checks to finish 2024/11/22 04:00:04 DEBUG : Local file system at /tmp/rclone2847720371: Waiting for transfers to finish 2024/11/22 04:00:04 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:04 INFO : enormous: Deleted 2024/11/22 04:00:04 INFO : potato2: Deleted 2024/11/22 04:00:04 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncWithExcludeAndDeleteExcluded (5.66s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:06 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:07 DEBUG : two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:08 DEBUG : three: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:09 DEBUG : four: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:10 DEBUG : five: Need to transfer - File not found at Destination 2024/11/22 04:00:10 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/11/22 04:00:10 DEBUG : one: Destination is newer than source, skipping 2024/11/22 04:00:10 DEBUG : three: Sizes identical 2024/11/22 04:00:10 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:10 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/11/22 04:00:10 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone2847720371) 2024/11/22 04:00:10 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (webdav root 'rclone-test-higozel4yohe') 2024/11/22 04:00:10 DEBUG : two: sha1 differ 2024/11/22 04:00:10 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/11/22 04:00:10 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:10 DEBUG : five: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:10 DEBUG : four: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:10 DEBUG : two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:11 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/11/22 04:00:11 INFO : five: Copied (new) 2024/11/22 04:00:11 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/22 04:00:11 INFO : two: Copied (replaced existing) 2024/11/22 04:00:11 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/11/22 04:00:11 INFO : four: Copied (replaced existing) 2024/11/22 04:00:11 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:11 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:11 DEBUG : one: Destination is newer than source, skipping 2024/11/22 04:00:11 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/11/22 04:00:11 DEBUG : five: Size and sha1 of src and dst objects identical 2024/11/22 04:00:11 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2024/11/22 04:00:11 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone2847720371) 2024/11/22 04:00:11 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (webdav root 'rclone-test-higozel4yohe') 2024/11/22 04:00:11 DEBUG : three: sha1 differ 2024/11/22 04:00:11 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/22 04:00:11 DEBUG : two: Size and sha1 of src and dst objects identical 2024/11/22 04:00:11 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/11/22 04:00:11 DEBUG : four: Size and sha1 of src and dst objects identical 2024/11/22 04:00:11 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2024/11/22 04:00:11 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2024/11/22 04:00:11 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2024/11/22 04:00:11 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:12 DEBUG : three: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:12 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/22 04:00:12 INFO : three: Copied (replaced existing) 2024/11/22 04:00:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (8.53s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1466: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1466: Skipping test on non local remote --- PASS: TestSyncWithMaxDuration (0.00s) --- SKIP: TestSyncWithMaxDuration/Hard (0.00s) --- SKIP: TestSyncWithMaxDuration/Soft (0.00s) === RUN TestSyncWithTrackRenames run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:1538: Can track renames: true 2024/11/22 04:00:15 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:15 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:15 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:15 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/22 04:00:15 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/22 04:00:15 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:15 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:15 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:15 DEBUG : yam: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:16 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/22 04:00:16 INFO : potato: Copied (new) 2024/11/22 04:00:16 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/22 04:00:16 INFO : yam: Copied (new) 2024/11/22 04:00:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:16 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:00:16 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:16 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:16 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:16 DEBUG : potato: Unchanged skipping 2024/11/22 04:00:16 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:17 INFO : yam: Moved (server-side) to: yaml 2024/11/22 04:00:17 INFO : yaml: Renamed from "yam" 2024/11/22 04:00:17 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:17 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:17 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncWithTrackRenames (5.09s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:1610: Can track renames: true 2024/11/22 04:00:20 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:20 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:20 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/22 04:00:20 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/22 04:00:20 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:20 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:20 DEBUG : yam: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:20 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/22 04:00:21 INFO : yam: Copied (new) 2024/11/22 04:00:21 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/22 04:00:21 INFO : potato: Copied (new) 2024/11/22 04:00:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:21 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:21 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:00:21 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:21 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:21 DEBUG : potato: Unchanged skipping 2024/11/22 04:00:21 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:22 INFO : yam: Moved (server-side) to: yaml 2024/11/22 04:00:22 INFO : yaml: Renamed from "yam" 2024/11/22 04:00:22 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:22 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:22 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncWithTrackRenamesStrategyModtime (5.08s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:1649: Can track renames: true 2024/11/22 04:00:25 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:25 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:25 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:25 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/22 04:00:25 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/11/22 04:00:25 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:25 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:25 DEBUG : potato: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:25 DEBUG : sub/yam: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:26 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/22 04:00:26 INFO : potato: Copied (new) 2024/11/22 04:00:26 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/22 04:00:26 INFO : sub/yam: Copied (new) 2024/11/22 04:00:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:27 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:00:27 DEBUG : potato: Unchanged skipping 2024/11/22 04:00:27 INFO : webdav root 'rclone-test-higozel4yohe': Making map for --track-renames 2024/11/22 04:00:27 INFO : webdav root 'rclone-test-higozel4yohe': Finished making map for --track-renames 2024/11/22 04:00:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for renames to finish 2024/11/22 04:00:28 INFO : sub/yam: Moved (server-side) to: yam 2024/11/22 04:00:28 INFO : yam: Renamed from "sub/yam" 2024/11/22 04:00:28 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:28 DEBUG : Waiting for deletions to finish 2024/11/22 04:00:28 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (6.74s) === RUN TestServerSideMoveLocal run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:31 DEBUG : Creating backend with remote "/tmp/rclone2847720371/dir1" 2024/11/22 04:00:31 DEBUG : Creating backend with remote "/tmp/rclone2847720371/dir2" 2024/11/22 04:00:31 DEBUG : Local file system at /tmp/rclone2847720371/dir2: Using server-side directory move 2024/11/22 04:00:31 INFO : Local file system at /tmp/rclone2847720371/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/22 04:00:31 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/22 04:00:31 DEBUG : Local file system at /tmp/rclone2847720371/dir2: Waiting for checks to finish 2024/11/22 04:00:31 DEBUG : Local file system at /tmp/rclone2847720371/dir2: Waiting for transfers to finish 2024/11/22 04:00:31 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.54s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 04:00:32 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/22 04:00:32 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:32 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:33 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 04:00:33 INFO : sub dir/hello world: Copied (new) 2024/11/22 04:00:33 INFO : sub dir/hello world: Deleted 2024/11/22 04:00:33 DEBUG : nested/sub dir/file: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:34 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/11/22 04:00:34 INFO : nested/sub dir/file: Copied (new) 2024/11/22 04:00:34 INFO : nested/sub dir/file: Deleted 2024/11/22 04:00:34 INFO : sub dir: Removing directory 2024/11/22 04:00:34 INFO : nested/sub dir: Removing directory 2024/11/22 04:00:34 INFO : nested: Removing directory 2024/11/22 04:00:34 DEBUG : Local file system at /tmp/rclone2847720371: deleted 3 directories run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestMoveWithDeleteEmptySrcDirs (6.55s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/22 04:00:39 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/22 04:00:39 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:39 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:39 DEBUG : sub dir/hello world: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/22 04:00:40 INFO : sub dir/hello world: Copied (new) 2024/11/22 04:00:40 INFO : sub dir/hello world: Deleted 2024/11/22 04:00:40 DEBUG : nested/sub dir/file: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:40 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/11/22 04:00:40 INFO : nested/sub dir/file: Copied (new) 2024/11/22 04:00:40 INFO : nested/sub dir/file: Deleted run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (6.54s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:45 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/22 04:00:45 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/11/22 04:00:45 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:45 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:46 DEBUG : existing: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:46 DEBUG : existing-b: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:46 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/22 04:00:46 INFO : existing: Copied (new) 2024/11/22 04:00:46 INFO : existing: Deleted 2024/11/22 04:00:46 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2024/11/22 04:00:46 INFO : existing-b: Copied (new) 2024/11/22 04:00:46 INFO : existing-b: Deleted 2024/11/22 04:00:47 DEBUG : existing: Destination exists, skipping 2024/11/22 04:00:47 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/11/22 04:00:47 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:00:47 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:00:47 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestMoveWithIgnoreExisting (3.48s) === RUN TestServerSideMove run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:49 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-capodif6qeci" 2024/11/22 04:00:49 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:00:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:49 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:00:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:49 DEBUG : found headers: 2024/11/22 04:00:49 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:00:49 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:50 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:51 DEBUG : potato3: Update will use the normal upload strategy (no chunks) sync_test.go:1705: Server side move (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-capodif6qeci' 2024/11/22 04:00:52 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:53 DEBUG : potato3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:00:54 DEBUG : webdav root 'rclone-test-capodif6qeci': Using server-side directory move 2024/11/22 04:00:54 INFO : webdav root 'rclone-test-capodif6qeci': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/22 04:00:54 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 04:00:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/11/22 04:00:54 DEBUG : empty space: Unchanged skipping 2024/11/22 04:00:54 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/22 04:00:54 DEBUG : webdav root 'rclone-test-capodif6qeci': Waiting for checks to finish 2024/11/22 04:00:55 INFO : potato3: Deleted 2024/11/22 04:00:55 INFO : empty space: Deleted 2024/11/22 04:00:55 DEBUG : webdav root 'rclone-test-capodif6qeci': Waiting for transfers to finish 2024/11/22 04:00:55 INFO : potato2: Moved (server-side) 2024/11/22 04:00:55 INFO : potato3: Moved (server-side) 2024/11/22 04:00:56 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-buhuqox9budi" 2024/11/22 04:00:56 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:00:56 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:56 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:56 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:56 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:56 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:00:56 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:56 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:56 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:56 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:56 DEBUG : found headers: 2024/11/22 04:00:56 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:00:56 DEBUG : webdav root 'rclone-test-buhuqox9budi': Using server-side directory move 2024/11/22 04:00:57 INFO : webdav root 'rclone-test-buhuqox9budi': Server side directory move succeeded 2024/11/22 04:00:57 ERROR : : error listing: directory not found 2024/11/22 04:00:57 DEBUG : webdav root 'rclone-test-buhuqox9budi': Purge remote 2024/11/22 04:00:57 DEBUG : webdav root 'rclone-test-capodif6qeci': Purge remote 2024/11/22 04:00:58 NOTICE: purge failed: rmdir failed: The server was unable to complete your request. If this happens again, please send the technical details below to the server administrator. More details can be found in the server log. : Internal Server Error: 404 Not Found --- PASS: TestServerSideMove (9.66s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:00:58 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-lizuzij9siwa" 2024/11/22 04:00:58 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:00:58 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:58 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:58 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:58 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:58 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:00:58 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:00:58 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:00:58 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:00:58 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:00:58 DEBUG : found headers: 2024/11/22 04:00:58 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:00:59 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:00 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:00 DEBUG : potato3: Update will use the normal upload strategy (no chunks) sync_test.go:1705: Server side move (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-lizuzij9siwa' 2024/11/22 04:01:02 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:03 DEBUG : potato3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:04 DEBUG : empty space: Excluded (Size Filter) 2024/11/22 04:01:04 DEBUG : empty space: Excluded 2024/11/22 04:01:04 DEBUG : empty space: Excluded (Size Filter) 2024/11/22 04:01:04 DEBUG : empty space: Excluded 2024/11/22 04:01:04 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 04:01:04 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/22 04:01:04 DEBUG : webdav root 'rclone-test-lizuzij9siwa': Waiting for checks to finish 2024/11/22 04:01:04 DEBUG : webdav root 'rclone-test-lizuzij9siwa': Waiting for transfers to finish 2024/11/22 04:01:04 INFO : potato3: Deleted 2024/11/22 04:01:05 INFO : potato2: Moved (server-side) 2024/11/22 04:01:05 INFO : potato3: Moved (server-side) 2024/11/22 04:01:05 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-mihinic3kaja" 2024/11/22 04:01:05 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:05 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:05 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:05 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:05 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:05 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:05 DEBUG : found headers: 2024/11/22 04:01:05 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:06 DEBUG : empty space: Excluded (Size Filter) 2024/11/22 04:01:06 DEBUG : empty space: Excluded 2024/11/22 04:01:06 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 04:01:06 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/22 04:01:06 DEBUG : webdav root 'rclone-test-mihinic3kaja': Waiting for checks to finish 2024/11/22 04:01:06 DEBUG : webdav root 'rclone-test-mihinic3kaja': Waiting for transfers to finish 2024/11/22 04:01:07 INFO : potato2: Moved (server-side) 2024/11/22 04:01:07 INFO : potato3: Moved (server-side) 2024/11/22 04:01:07 DEBUG : webdav root 'rclone-test-mihinic3kaja': Purge remote 2024/11/22 04:01:08 DEBUG : webdav root 'rclone-test-lizuzij9siwa': Purge remote --- PASS: TestServerSideMoveWithFilter (10.58s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:09 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-piroviw3yinu" 2024/11/22 04:01:09 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:09 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:09 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:09 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:09 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:09 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:09 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:09 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:09 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:09 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:09 DEBUG : found headers: 2024/11/22 04:01:09 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:09 DEBUG : potato2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:10 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:11 DEBUG : potato3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:12 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) webdav root 'rclone-test-higozel4yohe' -> webdav root 'rclone-test-piroviw3yinu' 2024/11/22 04:01:13 DEBUG : empty space: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:14 DEBUG : potato3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:15 DEBUG : webdav root 'rclone-test-piroviw3yinu': Using server-side directory move 2024/11/22 04:01:15 INFO : webdav root 'rclone-test-piroviw3yinu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/22 04:01:15 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/22 04:01:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2024/11/22 04:01:15 DEBUG : empty space: Unchanged skipping 2024/11/22 04:01:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/22 04:01:15 DEBUG : webdav root 'rclone-test-piroviw3yinu': Waiting for checks to finish 2024/11/22 04:01:15 INFO : empty space: Deleted 2024/11/22 04:01:15 DEBUG : webdav root 'rclone-test-piroviw3yinu': Waiting for transfers to finish 2024/11/22 04:01:15 INFO : potato3: Deleted 2024/11/22 04:01:16 INFO : potato2: Moved (server-side) 2024/11/22 04:01:16 INFO : potato3: Moved (server-side) 2024/11/22 04:01:16 INFO : tomatoDir: Removing directory 2024/11/22 04:01:17 DEBUG : webdav root 'rclone-test-higozel4yohe': deleted 1 directories 2024/11/22 04:01:18 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-cudeqeb2jihu" 2024/11/22 04:01:18 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:18 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:18 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:18 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:18 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:18 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:18 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:18 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:18 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:18 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:18 DEBUG : found headers: 2024/11/22 04:01:18 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:18 DEBUG : tomatoDir: Making directory 2024/11/22 04:01:18 DEBUG : webdav root 'rclone-test-cudeqeb2jihu': Using server-side directory move 2024/11/22 04:01:19 INFO : webdav root 'rclone-test-cudeqeb2jihu': Server side directory move succeeded 2024/11/22 04:01:19 ERROR : : error listing: directory not found 2024/11/22 04:01:20 ERROR : : error listing: directory not found 2024/11/22 04:01:20 DEBUG : webdav root 'rclone-test-cudeqeb2jihu': Purge remote 2024/11/22 04:01:20 DEBUG : webdav root 'rclone-test-piroviw3yinu': Purge remote 2024/11/22 04:01:20 NOTICE: purge failed: rmdir failed: The server was unable to complete your request. If this happens again, please send the technical details below to the server administrator. More details can be found in the server log. : Internal Server Error: 404 Not Found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (11.93s) === RUN TestServerSideMoveOverlap run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:1910: Skipping test as remote supports DirMove --- SKIP: TestServerSideMoveOverlap (0.53s) === RUN TestSyncOverlap run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:21 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/rclone-sync-test" 2024/11/22 04:01:21 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:21 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:21 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:21 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:21 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:21 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:21 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:21 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:21 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:21 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:21 DEBUG : found headers: 2024/11/22 04:01:21 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncOverlap (2.76s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:24 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/rclone-sync-test" 2024/11/22 04:01:24 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:24 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:24 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:24 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:24 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:24 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:24 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:24 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:24 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:24 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:24 DEBUG : found headers: 2024/11/22 04:01:24 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:25 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/rclone-sync-test-include/layer2" 2024/11/22 04:01:25 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:25 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:25 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:25 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:25 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:25 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:25 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:25 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:25 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:25 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:25 DEBUG : found headers: 2024/11/22 04:01:25 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:26 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/rclone-sync-test-ignore-file" 2024/11/22 04:01:26 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:26 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:26 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:26 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:26 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:26 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:26 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:26 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:26 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:26 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:26 DEBUG : found headers: 2024/11/22 04:01:26 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:27 DEBUG : rclone-sync-test-ignore-file/.ignore: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:28 DEBUG : rclone-sync-test: Excluded 2024/11/22 04:01:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/22 04:01:29 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/11/22 04:01:29 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test': Waiting for checks to finish 2024/11/22 04:01:29 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test': Waiting for transfers to finish 2024/11/22 04:01:29 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:29 INFO : There was nothing to transfer 2024/11/22 04:01:30 DEBUG : rclone-sync-test: Excluded 2024/11/22 04:01:30 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/22 04:01:31 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/11/22 04:01:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:01:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:01:31 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:31 INFO : rclone-sync-test-include: Removing directory 2024/11/22 04:01:31 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2024/11/22 04:01:31 DEBUG : webdav root 'rclone-test-higozel4yohe': failed to delete 1 directories 2024/11/22 04:01:31 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:32 DEBUG : rclone-sync-test: Excluded 2024/11/22 04:01:32 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/22 04:01:33 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/11/22 04:01:33 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test-include/layer2': Waiting for checks to finish 2024/11/22 04:01:33 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test-include/layer2': Waiting for transfers to finish 2024/11/22 04:01:33 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:33 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:34 DEBUG : rclone-sync-test: Excluded 2024/11/22 04:01:34 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/22 04:01:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/11/22 04:01:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:01:35 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:01:35 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:35 INFO : rclone-sync-test-include: Removing directory 2024/11/22 04:01:35 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2024/11/22 04:01:35 DEBUG : webdav root 'rclone-test-higozel4yohe': failed to delete 1 directories 2024/11/22 04:01:35 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:35 DEBUG : : Excluded 2024/11/22 04:01:35 DEBUG : rclone-sync-test: Excluded 2024/11/22 04:01:36 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/22 04:01:36 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/11/22 04:01:36 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test-ignore-file': Waiting for checks to finish 2024/11/22 04:01:36 DEBUG : webdav root 'rclone-test-higozel4yohe/rclone-sync-test-ignore-file': Waiting for transfers to finish 2024/11/22 04:01:36 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:36 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncOverlapWithFilter (24.33s) === RUN TestSyncCompareDest run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:01:48 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:01:48 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:48 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:48 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:48 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:48 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:48 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:48 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:48 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:48 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:48 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:48 DEBUG : found headers: 2024/11/22 04:01:48 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:49 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:01:49 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:01:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:49 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:01:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:01:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:01:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:01:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:01:49 DEBUG : found headers: 2024/11/22 04:01:49 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:01:49 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:01:50 DEBUG : one: Need to transfer - File not found at Destination 2024/11/22 04:01:50 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:01:50 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:01:50 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:50 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/22 04:01:50 INFO : one: Copied (new) 2024/11/22 04:01:50 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:52 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:01:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:01:52 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:01:52 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:01:53 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:53 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/11/22 04:01:53 INFO : one: Copied (replaced existing) 2024/11/22 04:01:53 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:54 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:55 DEBUG : CompareDest/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:56 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:01:56 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:01:56 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:01:57 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:01:57 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/22 04:01:57 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:01:57 DEBUG : Waiting for deletions to finish 2024/11/22 04:01:57 INFO : There was nothing to transfer 2024/11/22 04:01:58 DEBUG : CompareDest/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:01:59 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:02:00 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:00 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/22 04:02:00 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:00 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:00 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:00 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/22 04:02:00 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:00 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:00 INFO : There was nothing to transfer 2024/11/22 04:02:01 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:02:01 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:01 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/22 04:02:01 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:01 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:02 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:02 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/22 04:02:02 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:02 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:02 INFO : There was nothing to transfer 2024/11/22 04:02:03 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:02:03 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 GMT 2024/11/22 04:02:03 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/22 04:02:03 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/22 04:02:03 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:03 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:04 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:04 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/22 04:02:04 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:04 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:04 INFO : There was nothing to transfer 2024/11/22 04:02:05 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CompareDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CompareDest" 2024/11/22 04:02:06 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:06 DEBUG : two: Need to transfer - File not found at Destination 2024/11/22 04:02:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:06 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:06 DEBUG : two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:06 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:06 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/22 04:02:06 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:07 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2024/11/22 04:02:07 INFO : two: Copied (new) 2024/11/22 04:02:07 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (22.55s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:02:11 DEBUG : pre-dest1/1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:12 DEBUG : pre-dest2/2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:13 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dest" 2024/11/22 04:02:13 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:13 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:13 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:13 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:13 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:13 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:13 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:13 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:13 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:13 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:13 DEBUG : found headers: 2024/11/22 04:02:13 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:13 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/pre-dest1" 2024/11/22 04:02:13 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:13 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:13 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:13 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:13 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:13 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:13 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:13 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:13 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:13 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:13 DEBUG : found headers: 2024/11/22 04:02:13 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:14 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/pre-dest1" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/pre-dest1" 2024/11/22 04:02:14 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/pre-dest2" 2024/11/22 04:02:14 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:14 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:14 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:14 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:14 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:14 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:14 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:14 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:14 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:14 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:14 DEBUG : found headers: 2024/11/22 04:02:14 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:14 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/pre-dest2" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/pre-dest2" 2024/11/22 04:02:15 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:02:15 DEBUG : 1: Destination found in --compare-dest, skipping 2024/11/22 04:02:15 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:02:15 DEBUG : 2: Destination found in --compare-dest, skipping 2024/11/22 04:02:16 DEBUG : 3: Need to transfer - File not found at Destination 2024/11/22 04:02:16 DEBUG : webdav root 'rclone-test-higozel4yohe/dest': Waiting for checks to finish 2024/11/22 04:02:16 DEBUG : webdav root 'rclone-test-higozel4yohe/dest': Waiting for transfers to finish 2024/11/22 04:02:16 DEBUG : 3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:17 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/11/22 04:02:17 INFO : 3: Copied (new) 2024/11/22 04:02:17 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (10.46s) === RUN TestSyncCopyDest run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:02:21 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:02:21 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:21 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:21 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:21 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:21 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:21 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:21 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:21 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:21 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:21 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:21 DEBUG : found headers: 2024/11/22 04:02:21 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:22 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:22 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:22 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:22 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:22 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:22 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:22 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:22 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:22 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:22 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:22 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:22 DEBUG : found headers: 2024/11/22 04:02:22 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:22 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:22 DEBUG : one: Need to transfer - File not found at Destination 2024/11/22 04:02:22 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:22 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:23 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:23 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/22 04:02:23 INFO : one: Copied (new) 2024/11/22 04:02:23 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:24 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:25 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:25 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:25 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:25 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:26 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/11/22 04:02:26 INFO : one: Copied (replaced existing) 2024/11/22 04:02:26 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:26 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:27 DEBUG : CopyDest/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:28 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/BackupDir" 2024/11/22 04:02:28 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:28 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:28 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:28 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:28 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:28 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:28 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:28 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:28 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:28 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:28 DEBUG : found headers: 2024/11/22 04:02:28 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:29 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/BackupDir" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/BackupDir" 2024/11/22 04:02:29 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:29 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:29 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:29 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:29 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/22 04:02:31 INFO : one: Moved (server-side) 2024/11/22 04:02:32 DEBUG : one: Setting modtime after copy to 2011-12-25 12:59:59 +0000 GMT 2024/11/22 04:02:32 DEBUG : one: Dst hash empty - aborting Src hash check 2024/11/22 04:02:32 INFO : one: Copied (server-side copy) 2024/11/22 04:02:32 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/22 04:02:32 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:32 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:33 DEBUG : CopyDest/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:34 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:35 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:36 DEBUG : two: Setting modtime after copy to 2011-12-25 12:59:59 +0000 GMT 2024/11/22 04:02:36 DEBUG : two: Dst hash empty - aborting Src hash check 2024/11/22 04:02:36 INFO : two: Copied (server-side copy) 2024/11/22 04:02:36 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/22 04:02:36 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:36 DEBUG : one: Unchanged skipping 2024/11/22 04:02:36 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:36 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:36 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:37 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:37 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:37 DEBUG : one: Unchanged skipping 2024/11/22 04:02:37 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:37 DEBUG : two: Unchanged skipping 2024/11/22 04:02:37 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:37 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:37 INFO : There was nothing to transfer 2024/11/22 04:02:38 DEBUG : CopyDest/three: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:39 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/CopyDest" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/CopyDest" 2024/11/22 04:02:40 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/22 04:02:40 DEBUG : three: Destination not found in --copy-dest 2024/11/22 04:02:40 DEBUG : three: Need to transfer - File not found at Destination 2024/11/22 04:02:40 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:40 DEBUG : one: Unchanged skipping 2024/11/22 04:02:40 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/22 04:02:40 DEBUG : two: Unchanged skipping 2024/11/22 04:02:40 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:40 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:40 DEBUG : three: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:40 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2024/11/22 04:02:40 INFO : three: Copied (new) 2024/11/22 04:02:40 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (24.64s) === RUN TestSyncBackupDir run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:02:46 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:47 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:48 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:49 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:02:49 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:49 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:49 DEBUG : found headers: 2024/11/22 04:02:49 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:49 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" 2024/11/22 04:02:49 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:02:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:49 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:02:49 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:02:49 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:02:49 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:02:49 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:02:49 DEBUG : found headers: 2024/11/22 04:02:49 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:02:50 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:02:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:02:50 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:02:50 DEBUG : two: Unchanged skipping 2024/11/22 04:02:50 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:51 INFO : one: Moved (server-side) 2024/11/22 04:02:51 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:51 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:52 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:02:52 INFO : one: Copied (new) 2024/11/22 04:02:52 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:53 INFO : three.txt: Moved (server-side) 2024/11/22 04:02:53 INFO : three.txt: Moved into backup dir 2024/11/22 04:02:54 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:55 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:02:55 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:02:55 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:02:55 DEBUG : two: Unchanged skipping 2024/11/22 04:02:55 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:02:56 INFO : one: Deleted 2024/11/22 04:02:57 INFO : one: Moved (server-side) 2024/11/22 04:02:57 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:02:57 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:02:58 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:02:58 INFO : one: Copied (new) 2024/11/22 04:02:58 DEBUG : Waiting for deletions to finish 2024/11/22 04:02:58 INFO : three.txt: Deleted 2024/11/22 04:02:59 INFO : three.txt: Moved (server-side) 2024/11/22 04:02:59 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (16.96s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:03:03 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:04 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:05 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:06 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:03:06 DEBUG : Config file has changed externally - reloading 2024/11/22 04:03:06 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:06 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:06 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:06 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:06 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:06 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:06 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:06 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:06 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:06 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:06 DEBUG : found headers: 2024/11/22 04:03:06 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:06 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:06 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:06 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:06 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:06 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:06 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:06 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:06 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:06 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:06 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:06 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:06 DEBUG : found headers: 2024/11/22 04:03:06 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:06 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:03:07 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:07 DEBUG : two: Unchanged skipping 2024/11/22 04:03:07 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:08 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:03:08 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:08 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:09 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:03:09 INFO : one: Copied (new) 2024/11/22 04:03:09 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:10 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:03:10 INFO : three.txt: Moved into backup dir 2024/11/22 04:03:11 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:12 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:12 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:03:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:12 DEBUG : two: Unchanged skipping 2024/11/22 04:03:12 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:13 INFO : one.bak: Deleted 2024/11/22 04:03:14 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:03:14 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:14 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:15 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:03:15 INFO : one: Copied (new) 2024/11/22 04:03:15 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:15 INFO : three.txt.bak: Deleted 2024/11/22 04:03:16 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:03:16 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (16.73s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:03:20 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:21 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:22 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:23 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:03:23 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:23 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:23 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:23 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:23 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:23 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:23 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:23 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:23 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:23 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:23 DEBUG : found headers: 2024/11/22 04:03:23 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:23 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:23 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:23 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:23 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:23 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:23 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:23 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:23 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:23 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:23 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:23 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:23 DEBUG : found headers: 2024/11/22 04:03:23 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:23 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" to be canonical "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:03:23 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:23 DEBUG : two: Unchanged skipping 2024/11/22 04:03:23 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:25 INFO : one: Moved (server-side) to: one-2019-01-01 2024/11/22 04:03:25 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:25 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:25 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:03:25 INFO : one: Copied (new) 2024/11/22 04:03:25 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:26 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/11/22 04:03:26 INFO : three.txt: Moved into backup dir 2024/11/22 04:03:27 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:28 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-higozel4yohe/backup" for canonical name "TestWebdavNextcloud{D9r3Z}:rclone-test-higozel4yohe/backup" 2024/11/22 04:03:29 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:03:29 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:29 DEBUG : two: Unchanged skipping 2024/11/22 04:03:29 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:29 INFO : one-2019-01-01: Deleted 2024/11/22 04:03:30 INFO : one: Moved (server-side) to: one-2019-01-01 2024/11/22 04:03:30 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:30 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:31 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:03:31 INFO : one: Copied (new) 2024/11/22 04:03:31 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:31 INFO : three-2019-01-01.txt: Deleted 2024/11/22 04:03:32 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/11/22 04:03:32 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (16.14s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:03:36 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:37 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:38 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:39 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:03:39 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:39 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:39 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:39 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:39 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:39 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:39 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:39 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:39 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:39 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:39 DEBUG : found headers: 2024/11/22 04:03:39 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:03:39 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:39 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:39 DEBUG : two: Unchanged skipping 2024/11/22 04:03:40 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:03:40 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:41 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:41 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:03:41 INFO : one: Copied (new) 2024/11/22 04:03:41 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:42 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:03:42 INFO : three.txt: Moved into backup dir 2024/11/22 04:03:43 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:44 DEBUG : one.bak: Excluded (Path Filter) 2024/11/22 04:03:44 DEBUG : one.bak: Excluded 2024/11/22 04:03:44 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/11/22 04:03:44 DEBUG : three.txt.bak: Excluded 2024/11/22 04:03:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:03:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:44 DEBUG : two: Unchanged skipping 2024/11/22 04:03:44 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for checks to finish 2024/11/22 04:03:45 INFO : one.bak: Deleted 2024/11/22 04:03:46 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:03:46 DEBUG : webdav root 'rclone-test-higozel4yohe/dst': Waiting for transfers to finish 2024/11/22 04:03:46 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:46 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:03:46 INFO : one: Copied (new) 2024/11/22 04:03:46 DEBUG : Waiting for deletions to finish 2024/11/22 04:03:47 INFO : three.txt.bak: Deleted 2024/11/22 04:03:48 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:03:48 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (15.05s) === RUN TestSyncSuffix run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:03:51 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:52 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:53 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:54 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:03:54 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:03:54 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:54 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:54 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:03:54 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:03:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:03:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:03:54 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:03:54 DEBUG : found headers: 2024/11/22 04:03:54 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:03:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:03:55 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:03:56 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:56 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:03:56 INFO : one: Copied (new) 2024/11/22 04:03:57 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:03:57 DEBUG : two: Unchanged skipping 2024/11/22 04:03:57 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/22 04:03:58 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:03:58 DEBUG : three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:03:59 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/22 04:03:59 INFO : three.txt: Copied (new) 2024/11/22 04:04:00 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:04:00 INFO : one.bak: Deleted 2024/11/22 04:04:01 INFO : one: Moved (server-side) to: one.bak 2024/11/22 04:04:02 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:02 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:04:02 INFO : one: Copied (new) 2024/11/22 04:04:02 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:04:02 DEBUG : two: Unchanged skipping 2024/11/22 04:04:03 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/22 04:04:03 INFO : three.txt.bak: Deleted 2024/11/22 04:04:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2024/11/22 04:04:04 DEBUG : three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:05 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/11/22 04:04:05 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (17.50s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:09 DEBUG : dst/one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:09 DEBUG : dst/two: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:10 DEBUG : dst/three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:11 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-higozel4yohe/dst" 2024/11/22 04:04:11 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/22 04:04:11 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:04:11 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:04:11 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:04:11 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:04:11 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{D9r3Z}" suffix to name 2024/11/22 04:04:11 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/11/22 04:04:11 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/22 04:04:11 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/22 04:04:11 DEBUG : Setting pass="Aau6tqUsWt0eR0pF4KRD0nhzrCSSkunRyz5ZqMKy" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/22 04:04:11 DEBUG : found headers: 2024/11/22 04:04:11 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/22 04:04:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/22 04:04:13 INFO : one: Moved (server-side) to: one-2019-01-01 2024/11/22 04:04:13 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:14 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/22 04:04:14 INFO : one: Copied (new) 2024/11/22 04:04:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:04:14 DEBUG : two: Unchanged skipping 2024/11/22 04:04:14 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/22 04:04:15 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/11/22 04:04:16 DEBUG : three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:16 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/22 04:04:16 INFO : three.txt: Copied (new) 2024/11/22 04:04:17 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/22 04:04:18 INFO : one-2019-01-01: Deleted 2024/11/22 04:04:19 INFO : one: Moved (server-side) to: one-2019-01-01 2024/11/22 04:04:19 DEBUG : one: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:20 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/22 04:04:20 INFO : one: Copied (new) 2024/11/22 04:04:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:04:20 DEBUG : two: Unchanged skipping 2024/11/22 04:04:20 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/22 04:04:21 INFO : three-2019-01-01.txt: Deleted 2024/11/22 04:04:22 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/11/22 04:04:22 DEBUG : three.txt: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:22 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/11/22 04:04:22 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (17.22s) === RUN TestSyncUTFNorm run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:26 DEBUG : Testêé: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:27 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/11/22 04:04:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:04:27 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:04:27 DEBUG : Testêé: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:28 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/11/22 04:04:28 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/11/22 04:04:28 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.17s) === RUN TestSyncImmutable run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:29 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/22 04:04:29 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:04:29 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:04:30 DEBUG : existing: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:30 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/22 04:04:30 INFO : existing: Copied (new) 2024/11/22 04:04:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:31 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/11/22 04:04:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:04:31 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/11/22 04:04:31 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:04:31 ERROR : webdav root 'rclone-test-higozel4yohe': not deleting files as there were IO errors 2024/11/22 04:04:31 ERROR : webdav root 'rclone-test-higozel4yohe': not deleting directories as there were IO errors run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncImmutable (4.19s) === RUN TestSyncIgnoreCase run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:33 DEBUG : EXISTING: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:34 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:04:34 DEBUG : existing: Unchanged skipping 2024/11/22 04:04:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:04:34 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:04:34 DEBUG : Waiting for deletions to finish 2024/11/22 04:04:34 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.31s) === RUN TestFixCase run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.53s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (1.51s) --- SKIP: TestMaxTransfer/Hard (0.50s) --- SKIP: TestMaxTransfer/Soft (0.50s) --- SKIP: TestMaxTransfer/Cautious (0.50s) === RUN TestSyncConcurrentDelete run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:04:38 DEBUG : both0: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:38 DEBUG : only0: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:39 DEBUG : both1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:40 DEBUG : only1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:41 DEBUG : both2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:42 DEBUG : only2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:42 DEBUG : both3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:43 DEBUG : only3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:44 DEBUG : both4: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:45 DEBUG : only4: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:46 DEBUG : both5: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:46 DEBUG : only5: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:47 DEBUG : both6: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:48 DEBUG : only6: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:49 DEBUG : both7: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:50 DEBUG : only7: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:50 DEBUG : both8: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:51 DEBUG : only8: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:52 DEBUG : both9: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:53 DEBUG : only9: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:54 DEBUG : both10: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:55 DEBUG : only10: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:55 DEBUG : both11: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:56 DEBUG : only11: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:57 DEBUG : both12: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:58 DEBUG : only12: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:58 DEBUG : both13: Update will use the normal upload strategy (no chunks) 2024/11/22 04:04:59 DEBUG : only13: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:00 DEBUG : both14: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:01 DEBUG : only14: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:02 DEBUG : both15: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:02 DEBUG : only15: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:03 DEBUG : both16: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:04 DEBUG : only16: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:05 DEBUG : both17: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:06 DEBUG : only17: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:07 DEBUG : both18: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:07 DEBUG : only18: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:08 DEBUG : both19: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:09 DEBUG : only19: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:10 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:05:10 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both0: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both12: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both13: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both14: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both15: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both16: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both17: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both18: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both19: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both2: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both3: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both4: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both5: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both6: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both7: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both8: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:10 DEBUG : both9: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both1: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both10: Unchanged skipping 2024/11/22 04:05:10 DEBUG : both11: Unchanged skipping 2024/11/22 04:05:10 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:05:10 DEBUG : Waiting for deletions to finish 2024/11/22 04:05:10 INFO : only1: Deleted 2024/11/22 04:05:10 INFO : only14: Deleted 2024/11/22 04:05:10 INFO : only2: Deleted 2024/11/22 04:05:10 INFO : only16: Deleted 2024/11/22 04:05:11 INFO : only13: Deleted 2024/11/22 04:05:11 INFO : only3: Deleted 2024/11/22 04:05:11 INFO : only10: Deleted 2024/11/22 04:05:11 INFO : only5: Deleted 2024/11/22 04:05:11 INFO : only18: Deleted 2024/11/22 04:05:11 INFO : only7: Deleted 2024/11/22 04:05:11 INFO : only4: Deleted 2024/11/22 04:05:11 INFO : only8: Deleted 2024/11/22 04:05:11 INFO : only12: Deleted 2024/11/22 04:05:12 INFO : only17: Deleted 2024/11/22 04:05:12 INFO : only15: Deleted 2024/11/22 04:05:12 INFO : only19: Deleted 2024/11/22 04:05:12 INFO : only6: Deleted 2024/11/22 04:05:12 INFO : only11: Deleted 2024/11/22 04:05:12 INFO : only0: Deleted 2024/11/22 04:05:12 INFO : only9: Deleted 2024/11/22 04:05:12 INFO : There was nothing to transfer run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncConcurrentDelete (41.93s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:05:19 DEBUG : both0: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:20 DEBUG : only0: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:21 DEBUG : both1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:22 DEBUG : only1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:23 DEBUG : both2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:23 DEBUG : only2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:24 DEBUG : both3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:25 DEBUG : only3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:26 DEBUG : both4: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:27 DEBUG : only4: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:27 DEBUG : both5: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:28 DEBUG : only5: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:29 DEBUG : both6: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:30 DEBUG : only6: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:31 DEBUG : both7: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:32 DEBUG : only7: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:32 DEBUG : both8: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:33 DEBUG : only8: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:34 DEBUG : both9: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:35 DEBUG : only9: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:36 DEBUG : both10: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:36 DEBUG : only10: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:37 DEBUG : both11: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:38 DEBUG : only11: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:39 DEBUG : both12: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:40 DEBUG : only12: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:40 DEBUG : both13: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:41 DEBUG : only13: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:42 DEBUG : both14: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:43 DEBUG : only14: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:44 DEBUG : both15: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:44 DEBUG : only15: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:45 DEBUG : both16: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:46 DEBUG : only16: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:47 DEBUG : both17: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:48 DEBUG : only17: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:49 DEBUG : both18: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:49 DEBUG : only18: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:50 DEBUG : both19: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:51 DEBUG : only19: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:52 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for checks to finish 2024/11/22 04:05:52 DEBUG : both0: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both12: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both13: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both10: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both1: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both16: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both17: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both18: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both19: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both2: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both3: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both4: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both5: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both6: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both7: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both8: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/11/22 04:05:52 DEBUG : both9: Unchanged skipping 2024/11/22 04:05:52 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/11/22 04:05:52 DEBUG : both11: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both14: Unchanged skipping 2024/11/22 04:05:52 DEBUG : both15: Unchanged skipping 2024/11/22 04:05:52 DEBUG : webdav root 'rclone-test-higozel4yohe': Waiting for transfers to finish 2024/11/22 04:05:52 DEBUG : only0: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:52 DEBUG : only1: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:52 DEBUG : only10: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:52 DEBUG : only11: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:53 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:53 INFO : only0: Copied (replaced existing) 2024/11/22 04:05:53 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:53 INFO : only1: Copied (replaced existing) 2024/11/22 04:05:53 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:53 INFO : only10: Copied (replaced existing) 2024/11/22 04:05:53 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:53 INFO : only11: Copied (replaced existing) 2024/11/22 04:05:53 DEBUG : only13: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:53 DEBUG : only12: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:53 DEBUG : only15: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:53 DEBUG : only14: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:54 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:54 INFO : only13: Copied (replaced existing) 2024/11/22 04:05:54 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:54 INFO : only12: Copied (replaced existing) 2024/11/22 04:05:54 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:54 INFO : only15: Copied (replaced existing) 2024/11/22 04:05:54 DEBUG : only16: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:54 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:54 INFO : only14: Copied (replaced existing) 2024/11/22 04:05:54 DEBUG : only17: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:54 DEBUG : only18: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:54 DEBUG : only19: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:55 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:55 INFO : only16: Copied (replaced existing) 2024/11/22 04:05:55 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:55 INFO : only17: Copied (replaced existing) 2024/11/22 04:05:55 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:55 INFO : only19: Copied (replaced existing) 2024/11/22 04:05:55 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:55 INFO : only18: Copied (replaced existing) 2024/11/22 04:05:55 DEBUG : only2: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:55 DEBUG : only3: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:55 DEBUG : only4: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:55 DEBUG : only5: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:56 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:56 INFO : only2: Copied (replaced existing) 2024/11/22 04:05:56 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:56 INFO : only3: Copied (replaced existing) 2024/11/22 04:05:56 DEBUG : only6: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:56 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:56 INFO : only5: Copied (replaced existing) 2024/11/22 04:05:56 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:56 INFO : only4: Copied (replaced existing) 2024/11/22 04:05:56 DEBUG : only7: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:56 DEBUG : only8: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:56 DEBUG : only9: Update will use the normal upload strategy (no chunks) 2024/11/22 04:05:57 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:57 INFO : only6: Copied (replaced existing) 2024/11/22 04:05:57 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:57 INFO : only7: Copied (replaced existing) 2024/11/22 04:05:57 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:57 INFO : only8: Copied (replaced existing) 2024/11/22 04:05:57 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/22 04:05:57 INFO : only9: Copied (replaced existing) 2024/11/22 04:05:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestSyncConcurrentTruncate (51.70s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:06:11 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/22 04:06:11 DEBUG : sub dir: Making directory 2024/11/22 04:06:11 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestNothingToTransferWithEmptyDirs (19.89s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" 2024/11/22 04:06:31 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/22 04:06:31 DEBUG : sub dir: Making directory 2024/11/22 04:06:31 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" run.go:180: Remote "webdav root 'rclone-test-higozel4yohe'", Local "Local file system at /tmp/rclone2847720371", Modify Window "1s" --- PASS: TestNothingToTransferWithoutEmptyDirs (23.21s) PASS 2024/11/22 04:06:54 DEBUG : webdav root 'rclone-test-higozel4yohe': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestWebdavNextcloud: -verbose" - Finished OK in 10m19.771581811s (try 1/5)