"./bisync.test -test.v -test.timeout 1h0m0s -remote TestWebdavNextcloud: -verbose -test.run '^TestBisyncRemoteRemote$/^rclone_args$'" - Starting (try 3/5) 2024/11/05 05:35:53 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-xucezup7xuxo" 2024/11/05 05:35:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/05 05:35:53 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/05 05:35:53 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/05 05:35:53 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:53 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:53 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:53 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{jrEHa}" suffix to name 2024/11/05 05:35:53 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/05 05:35:53 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:53 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:53 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:53 DEBUG : found headers: 2024/11/05 05:35:53 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/05 05:35:54 DEBUG : Creating backend with remote "/tmp/rclone3378433805" === RUN TestBisyncRemoteRemote 2024/11/05 05:35:54 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rabudew8qedi" 2024/11/05 05:35:54 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/05 05:35: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/05 05:35:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:54 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:54 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{jrEHa}" suffix to name 2024/11/05 05:35: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/05 05:35:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:54 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:54 DEBUG : found headers: 2024/11/05 05:35:54 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/05 05:35:54 NOTICE: remote: TestWebdavNextcloud:rclone-test-rabudew8qedi === RUN TestBisyncRemoteRemote/rclone_args 2024/11/05 05:35:54 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo" 2024/11/05 05:35:54 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/05 05:35:54 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/05 05:35: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/05 05:35:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:54 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:54 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{jrEHa}" suffix to name 2024/11/05 05:35: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/05 05:35:54 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:54 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:54 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:54 DEBUG : found headers: 2024/11/05 05:35:54 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/05 05:35:54 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo" to be canonical "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo" 2024/11/05 05:35:54 DEBUG : path1: Making directory 2024/11/05 05:35:56 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo/rclone_args/path1" 2024/11/05 05:35:56 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/05 05:35: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/05 05:35:56 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:56 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:56 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:56 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{jrEHa}" suffix to name 2024/11/05 05:35: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/05 05:35:56 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:56 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:56 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:56 DEBUG : found headers: 2024/11/05 05:35:56 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/05 05:35:56 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo/rclone_args/path1" to be canonical "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1" 2024/11/05 05:35:56 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo" for canonical name "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo" 2024/11/05 05:35:56 DEBUG : path2: Making directory 2024/11/05 05:35:57 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo/rclone_args/path2" 2024/11/05 05:35:57 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/11/05 05:35:57 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/05 05:35:57 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:57 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:57 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:57 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{jrEHa}" suffix to name 2024/11/05 05:35:57 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/05 05:35:57 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/11/05 05:35:57 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/11/05 05:35:57 DEBUG : Setting pass="ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/11/05 05:35:57 DEBUG : found headers: 2024/11/05 05:35:57 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/11/05 05:35:57 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rabudew8qedi/053554mo/rclone_args/path2" to be canonical "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2" 2024/11/05 05:35:57 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2024/11/05 05:35:57 DEBUG : Creating backend with remote "/tmp/053554mo/initdir/test_rclone_args-cedozuk3" 2024/11/05 05:35:57 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : subdir: Making directory with metadata 2024/11/05 05:35:57 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/11/05 05:35:57 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/11/05 05:35:57 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : Local file system at /tmp/053554mo/initdir/test_rclone_args-cedozuk3: Waiting for checks to finish 2024/11/05 05:35:57 DEBUG : Local file system at /tmp/053554mo/initdir/test_rclone_args-cedozuk3: Waiting for transfers to finish 2024/11/05 05:35:57 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/11/05 05:35:57 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2024/11/05 05:35:57 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2024/11/05 05:35:57 INFO : file2.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : file1.txt.dae86b42.partial: renamed to: file1.txt 2024/11/05 05:35:57 INFO : file1.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/11/05 05:35:57 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/11/05 05:35:57 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2024/11/05 05:35:57 INFO : RCLONE_TEST: Copied (new) 2024/11/05 05:35:57 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2024/11/05 05:35:57 INFO : subdir/file20.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/11/05 05:35:57 DEBUG : subdir/file21.txt.5028a97.partial: renamed to: subdir/file21.txt 2024/11/05 05:35:57 INFO : subdir/file21.txt: Copied (new) 2024/11/05 05:35:57 INFO : subdir: Set directory modification time (using SetModTime) 2024/11/05 05:35:57 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2024/11/05 05:35:57 DEBUG : Creating backend with remote "/tmp/053554mo/datadir/test_rclone_args-fohokop5" 2024/11/05 05:35:57 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file20.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file21.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:57 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/11/05 05:35:57 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/11/05 05:35:57 DEBUG : Local file system at /tmp/053554mo/datadir/test_rclone_args-fohokop5: Waiting for checks to finish 2024/11/05 05:35:57 DEBUG : Local file system at /tmp/053554mo/datadir/test_rclone_args-fohokop5: Waiting for transfers to finish 2024/11/05 05:35:57 DEBUG : file21.txt.b4075ff1.partial: renamed to: file21.txt 2024/11/05 05:35:57 INFO : file21.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : file20.txt.b4075ff1.partial: renamed to: file20.txt 2024/11/05 05:35:57 INFO : file20.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/11/05 05:35:57 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/11/05 05:35:57 DEBUG : file2.txt.6bedbe24.partial: renamed to: file2.txt 2024/11/05 05:35:57 INFO : file2.txt: Copied (new) 2024/11/05 05:35:57 DEBUG : file1.txt.6bedbe24.partial: renamed to: file1.txt 2024/11/05 05:35:57 INFO : file1.txt: Copied (new) 2024/11/05 05:35:58 ERROR : : error listing: directory not found 2024/11/05 05:35:58 ERROR : : error listing: directory not found 2024/11/05 05:35:58 NOTICE: checking initFs Local file system at /tmp/053554mo/initdir/test_rclone_args-cedozuk3 2024/11/05 05:35:58 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/11/05 05:35:58 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:58 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/11/05 05:35:58 DEBUG : subdir: Making directory 2024/11/05 05:35:59 DEBUG : pacer: low level retry 1/10 (error 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: 423 Locked) 2024/11/05 05:35:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/11/05 05:35:59 DEBUG : pacer: Reducing sleep to 15ms 2024/11/05 05:35:59 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:00 DEBUG : pacer: Reducing sleep to 11.25ms 2024/11/05 05:36:00 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:00 DEBUG : pacer: Reducing sleep to 10ms 2024/11/05 05:36:00 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:00 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:00 INFO : file2.txt: Copied (new) 2024/11/05 05:36:00 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2024/11/05 05:36:00 INFO : file1.txt: Copied (new) 2024/11/05 05:36:00 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:00 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:00 DEBUG : webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path1': Waiting for checks to finish 2024/11/05 05:36:00 DEBUG : webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path1': Waiting for transfers to finish 2024/11/05 05:36:00 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/11/05 05:36:00 INFO : RCLONE_TEST: Copied (new) 2024/11/05 05:36:00 DEBUG : subdir/file20.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:00 DEBUG : subdir/file21.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:01 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:01 INFO : subdir/file21.txt: Copied (new) 2024/11/05 05:36:01 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:01 INFO : subdir/file20.txt: Copied (new) 2024/11/05 05:36:01 NOTICE: checking Path1 webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path1' 2024/11/05 05:36:02 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/11/05 05:36:02 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:02 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:02 DEBUG : subdir: Making directory 2024/11/05 05:36:02 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:02 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:02 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:03 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:03 INFO : file2.txt: Copied (new) 2024/11/05 05:36:03 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/11/05 05:36:03 INFO : RCLONE_TEST: Copied (new) 2024/11/05 05:36:03 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:03 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/11/05 05:36:03 DEBUG : webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2': Waiting for checks to finish 2024/11/05 05:36:03 DEBUG : webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2': Waiting for transfers to finish 2024/11/05 05:36:03 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2024/11/05 05:36:03 INFO : file1.txt: Copied (new) 2024/11/05 05:36:03 DEBUG : subdir/file21.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:03 DEBUG : subdir/file20.txt: Update will use the normal upload strategy (no chunks) 2024/11/05 05:36:04 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:04 INFO : subdir/file20.txt: Copied (new) 2024/11/05 05:36:04 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/05 05:36:04 INFO : subdir/file21.txt: Copied (new) 2024/11/05 05:36:04 NOTICE: checking path2 webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2' 2024/11/05 05:36:04 NOTICE: (01) : test rclone-args 2024/11/05 05:36:04 NOTICE: (02) : touch-glob 2001-01-02 /tmp/053554mo/datadir/test_rclone_args-fohokop5/ * 2024/11/05 05:36:04 NOTICE: (03) : test initial bisync 2024/11/05 05:36:04 NOTICE: (04) : bisync resync checksum 2024/11/05 05:36:07 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/11/05 05:36:07 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:07 INFO : Copying Path2 files to Path1 2024/11/05 05:36:07 INFO : - Path2 Resync is copying files to - Path1 2024/11/05 05:36:08 INFO : - Path1 Resync is copying files to - Path2 2024/11/05 05:36:08 INFO : Resync updating listings 2024/11/05 05:36:08 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:08 INFO : Bisync successful 2024/11/05 05:36:08 NOTICE: (05) : test place newer files on both paths 2024/11/05 05:36:08 NOTICE: (06) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file1.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ 2024/11/05 05:36:09 INFO : file1.txt: Copied (replaced existing) 2024/11/05 05:36:09 NOTICE: (07) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file2.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ 2024/11/05 05:36:10 INFO : file2.txt: Copied (replaced existing) 2024/11/05 05:36:10 NOTICE: (08) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file20.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir 2024/11/05 05:36:11 NOTICE: webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir': Forced to upload files to set modification times on this backend. 2024/11/05 05:36:11 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:12 INFO : file20.txt: Copied (replaced existing) 2024/11/05 05:36:12 NOTICE: (09) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file21.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir 2024/11/05 05:36:13 INFO : file21.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:14 INFO : file21.txt: Copied (replaced existing) 2024/11/05 05:36:14 NOTICE: (10) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ file1.txt 2024/11/05 05:36:15 NOTICE: (11) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file2.txt 2024/11/05 05:36:16 NOTICE: (12) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/ file20.txt 2024/11/05 05:36:16 NOTICE: (13) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir/ file21.txt 2024/11/05 05:36:17 NOTICE: (14) : test run bisync with custom options 2024/11/05 05:36:17 NOTICE: (15) : bisync checksum 2024/11/05 05:36:20 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/11/05 05:36:20 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:20 INFO : Building Path1 and Path2 listings 2024/11/05 05:36:21 INFO : Path1 checking for diffs 2024/11/05 05:36:21 INFO : - Path1 File changed: hash - file1.txt 2024/11/05 05:36:21 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2024/11/05 05:36:21 INFO : (Modified:  1 hash differs) 2024/11/05 05:36:21 INFO : Path2 checking for diffs 2024/11/05 05:36:21 INFO : - Path2 File changed: size (larger), hash - file2.txt 2024/11/05 05:36:21 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/11/05 05:36:21 INFO : (Modified:  1 larger,  0 smaller,  1 hash differs) 2024/11/05 05:36:21 INFO : Applying changes 2024/11/05 05:36:21 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/file1.txt 2024/11/05 05:36:21 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/file2.txt 2024/11/05 05:36:21 INFO : - Path2 Do queued copies to - Path1 2024/11/05 05:36:22 INFO : file2.txt: Copied (server-side copy) 2024/11/05 05:36:22 INFO : - Path1 Do queued copies to - Path2 2024/11/05 05:36:23 INFO : file1.txt: Copied (server-side copy) 2024/11/05 05:36:23 INFO : Updating listings 2024/11/05 05:36:23 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:23 INFO : Bisync successful 2024/11/05 05:36:23 NOTICE: (16) : touch-glob 2007-07-23 /tmp/053554mo/datadir/test_rclone_args-fohokop5/ * 2024/11/05 05:36:23 NOTICE: (17) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file1.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ 2024/11/05 05:36:24 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:25 INFO : file1.txt: Copied (replaced existing) 2024/11/05 05:36:25 NOTICE: (18) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file2.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ 2024/11/05 05:36:26 INFO : file2.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:27 INFO : file2.txt: Copied (replaced existing) 2024/11/05 05:36:27 NOTICE: (19) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file20.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir 2024/11/05 05:36:28 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:28 INFO : file20.txt: Copied (replaced existing) 2024/11/05 05:36:28 NOTICE: (20) : copy-as /tmp/053554mo/datadir/test_rclone_args-fohokop5/file21.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file1.txt 2024/11/05 05:36:30 INFO : file21.txt: Copied (replaced existing) to: file1.txt 2024/11/05 05:36:30 NOTICE: (21) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ file1.txt 2024/11/05 05:36:30 NOTICE: (22) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file2.txt 2024/11/05 05:36:31 NOTICE: (23) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/ file20.txt 2024/11/05 05:36:32 NOTICE: (24) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir/ file21.txt 2024/11/05 05:36:34 NOTICE: (25) : bisync size-only 2024/11/05 05:36:37 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/11/05 05:36:37 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/11/05 05:36:37 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:37 INFO : Building Path1 and Path2 listings 2024/11/05 05:36:37 INFO : Path1 checking for diffs 2024/11/05 05:36:37 INFO : Path2 checking for diffs 2024/11/05 05:36:37 INFO : - Path2 File changed: size (smaller) - file1.txt 2024/11/05 05:36:37 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/11/05 05:36:37 INFO : (Modified:  0 larger,  1 smaller) 2024/11/05 05:36:37 INFO : Applying changes 2024/11/05 05:36:37 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/file1.txt 2024/11/05 05:36:37 INFO : - Path2 Do queued copies to - Path1 2024/11/05 05:36:39 INFO : file1.txt: Copied (server-side copy) 2024/11/05 05:36:39 INFO : Updating listings 2024/11/05 05:36:39 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:39 INFO : Bisync successful 2024/11/05 05:36:39 NOTICE: (26) : bisync resync 2024/11/05 05:36:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/11/05 05:36:41 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/11/05 05:36:41 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:41 INFO : Copying Path2 files to Path1 2024/11/05 05:36:41 INFO : - Path2 Resync is copying files to - Path1 2024/11/05 05:36:42 INFO : - Path1 Resync is copying files to - Path2 2024/11/05 05:36:43 INFO : subdir/file20.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:43 INFO : file2.txt: Copied (server-side copy) 2024/11/05 05:36:44 INFO : subdir/file21.txt: Copied (server-side copy) 2024/11/05 05:36:44 INFO : subdir/file20.txt: Copied (server-side copy) 2024/11/05 05:36:44 INFO : Resync updating listings 2024/11/05 05:36:44 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:44 INFO : Bisync successful 2024/11/05 05:36:44 NOTICE: (27) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file1.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ 2024/11/05 05:36:45 INFO : file1.txt: Copied (replaced existing) 2024/11/05 05:36:45 NOTICE: (28) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file2.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ 2024/11/05 05:36:46 INFO : file2.txt: Copied (replaced existing) 2024/11/05 05:36:46 NOTICE: (29) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file20.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir 2024/11/05 05:36:47 NOTICE: (30) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file21.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir 2024/11/05 05:36:48 INFO : file21.txt: Copied (replaced existing) 2024/11/05 05:36:48 NOTICE: (31) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ file1.txt 2024/11/05 05:36:49 NOTICE: (32) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file2.txt 2024/11/05 05:36:50 NOTICE: (33) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/ file20.txt 2024/11/05 05:36:50 NOTICE: (34) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir/ file21.txt 2024/11/05 05:36:51 NOTICE: (35) : bisync ignore-size 2024/11/05 05:36:54 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/11/05 05:36:54 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": false, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/11/05 05:36:54 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:54 INFO : Building Path1 and Path2 listings 2024/11/05 05:36:55 INFO : Path1 checking for diffs 2024/11/05 05:36:55 INFO : Path2 checking for diffs 2024/11/05 05:36:55 INFO : - Path2 File changed: time (newer) - file2.txt 2024/11/05 05:36:55 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2024/11/05 05:36:55 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2024/11/05 05:36:55 INFO : (Modified:  2 newer,  0 older) 2024/11/05 05:36:55 INFO : Applying changes 2024/11/05 05:36:55 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/file2.txt 2024/11/05 05:36:55 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/file21.txt 2024/11/05 05:36:55 INFO : - Path2 Do queued copies to - Path1 2024/11/05 05:36:56 INFO : subdir/file21.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:36:56 INFO : file2.txt: Copied (server-side copy) 2024/11/05 05:36:57 INFO : subdir/file21.txt: Copied (server-side copy) 2024/11/05 05:36:57 INFO : Updating listings 2024/11/05 05:36:57 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:36:57 INFO : Bisync successful 2024/11/05 05:36:57 NOTICE: (36) : bisync resync compare-all 2024/11/05 05:37:00 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/11/05 05:37:00 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:37:00 INFO : Copying Path2 files to Path1 2024/11/05 05:37:00 INFO : - Path2 Resync is copying files to - Path1 2024/11/05 05:37:00 INFO : TestWebdavNextcloud{jrEHa}: Downloading hashes... 2024/11/05 05:37:01 INFO : - Path1 Resync is copying files to - Path2 2024/11/05 05:37:03 INFO : file1.txt: Copied (server-side copy) 2024/11/05 05:37:03 INFO : file2.txt: Copied (server-side copy) 2024/11/05 05:37:03 INFO : subdir/file20.txt: Copied (server-side copy) 2024/11/05 05:37:04 INFO : subdir/file21.txt: Copied (server-side copy) 2024/11/05 05:37:04 INFO : Resync updating listings 2024/11/05 05:37:04 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:37:04 INFO : Bisync successful 2024/11/05 05:37:04 NOTICE: (37) : copy-as /tmp/053554mo/datadir/test_rclone_args-fohokop5/file21.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file2.txt 2024/11/05 05:37:05 INFO : file21.txt: Copied (replaced existing) to: file2.txt 2024/11/05 05:37:05 NOTICE: (38) : touch-glob 2023-08-26 /tmp/053554mo/datadir/test_rclone_args-fohokop5/ * 2024/11/05 05:37:05 NOTICE: (39) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file1.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ 2024/11/05 05:37:06 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:37:07 INFO : file1.txt: Copied (replaced existing) 2024/11/05 05:37:07 NOTICE: (40) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file20.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir 2024/11/05 05:37:08 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/11/05 05:37:08 INFO : file20.txt: Copied (replaced existing) 2024/11/05 05:37:08 NOTICE: (41) : copy-file /tmp/053554mo/datadir/test_rclone_args-fohokop5/file21.txt TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir 2024/11/05 05:37:10 INFO : file21.txt: Copied (replaced existing) 2024/11/05 05:37:10 NOTICE: (42) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/ file2.txt 2024/11/05 05:37:11 NOTICE: (43) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/ file1.txt 2024/11/05 05:37:11 NOTICE: (44) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/ file20.txt 2024/11/05 05:37:12 NOTICE: (45) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='ba1MXO5OSbHV4Mm2g6AdtkrFQ95taGNUyC82qpjU',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir/ file21.txt 2024/11/05 05:37:13 NOTICE: (46) : bisync compare-all 2024/11/05 05:37:16 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/11/05 05:37:16 INFO : Synching Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" with Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:37:16 INFO : Building Path1 and Path2 listings 2024/11/05 05:37:16 INFO : TestWebdavNextcloud{jrEHa}: Downloading hashes... 2024/11/05 05:37:17 INFO : Path1 checking for diffs 2024/11/05 05:37:17 INFO : - Path1 File changed: time (newer) - file1.txt 2024/11/05 05:37:17 INFO : - Path1 File changed: time (newer) - subdir/file20.txt 2024/11/05 05:37:17 INFO : Path1: 2 changes:  0 new,  2 modified,  0 deleted 2024/11/05 05:37:17 INFO : (Modified:  2 newer,  0 older) 2024/11/05 05:37:17 INFO : Path2 checking for diffs 2024/11/05 05:37:17 INFO : - Path2 File changed: hash - file1.txt 2024/11/05 05:37:17 INFO : - Path2 File changed: size (smaller), hash - file2.txt 2024/11/05 05:37:17 INFO : - Path2 File changed: hash - subdir/file20.txt 2024/11/05 05:37:17 INFO : - Path2 File changed: time (newer), hash - subdir/file21.txt 2024/11/05 05:37:17 INFO : Path2: 4 changes:  0 new,  4 modified,  0 deleted 2024/11/05 05:37:17 INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  4 hash differs) 2024/11/05 05:37:17 INFO : Applying changes 2024/11/05 05:37:17 INFO : Checking potential conflicts... 2024/11/05 05:37:18 NOTICE: webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2': 0 differences found 2024/11/05 05:37:18 NOTICE: webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2': 2 hashes could not be checked 2024/11/05 05:37:18 NOTICE: webdav root 'rclone-test-rabudew8qedi/053554mo/rclone_args/path2': 2 matching files 2024/11/05 05:37:18 INFO : Finished checking the potential conflicts. %!s() 2024/11/05 05:37:18 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/11/05 05:37:18 INFO : file1.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/11/05 05:37:18 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/file1.txt 2024/11/05 05:37:18 NOTICE: - WARNING New or changed in both paths - subdir/file20.txt 2024/11/05 05:37:18 INFO : subdir/file20.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/11/05 05:37:18 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/subdir/file20.txt 2024/11/05 05:37:18 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/file2.txt 2024/11/05 05:37:18 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/subdir/file21.txt 2024/11/05 05:37:18 INFO : - Path2 Do queued copies to - Path1 2024/11/05 05:37:20 INFO : file2.txt: Copied (server-side copy) 2024/11/05 05:37:20 INFO : subdir/file21.txt: Copied (server-side copy) 2024/11/05 05:37:20 INFO : - Path1 Do queued copies to - Path2 2024/11/05 05:37:22 INFO : file1.txt: Copied (server-side copy) 2024/11/05 05:37:22 INFO : subdir/file20.txt: Copied (server-side copy) 2024/11/05 05:37:22 INFO : Updating listings 2024/11/05 05:37:22 INFO : Validating listings for Path1 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{jrEHa}:rclone-test-rabudew8qedi/053554mo/rclone_args/path2/" 2024/11/05 05:37:22 INFO : Bisync successful 2024/11/05 05:37:22 NOTICE: ---------------------------------------------------------- 2024/11/05 05:37:22 NOTICE: | MISCOMPARE -Golden vs +Results for test.log 2024/11/05 05:37:22 NOTICE: | @@ -187,0 +188 @@ 2024/11/05 05:37:22 NOTICE: | +INFO : - Path2 File changed: hash - file1.txt 2024/11/05 05:37:22 NOTICE: | @@ -189,4 +190,12 @@ 2024/11/05 05:37:22 NOTICE: | -INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2024/11/05 05:37:22 NOTICE: | -INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2024/11/05 05:37:22 NOTICE: | -INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  1 hash differs) 2024/11/05 05:37:22 NOTICE: | -INFO : Applying changes 2024/11/05 05:37:22 NOTICE: | +INFO : - Path2 File changed: hash - subdir/file20.txt 2024/11/05 05:37:22 NOTICE: | +INFO : - Path2 File changed: time (newer), hash - subdir/file21.txt 2024/11/05 05:37:22 NOTICE: | +INFO : Path2: 4 changes:  0 new,  4 modified,  0 deleted 2024/11/05 05:37:22 NOTICE: | +INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  4 hash differs) 2024/11/05 05:37:22 NOTICE: | +INFO : Applying changes 2024/11/05 05:37:22 NOTICE: | +INFO : Checking potential conflicts... 2024/11/05 05:37:22 NOTICE: | +NOTICE: {path2String}: 0 differences found 2024/11/05 05:37:22 NOTICE: | +NOTICE: {path2String}: 2 hashes could not be checked 2024/11/05 05:37:22 NOTICE: | +NOTICE: {path2String}: 2 matching files 2024/11/05 05:37:22 NOTICE: | +INFO : Finished checking the potential conflicts. %!s() 2024/11/05 05:37:22 NOTICE: | +NOTICE: - WARNING New or changed in both paths - file1.txt 2024/11/05 05:37:22 NOTICE: | +INFO : file1.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/11/05 05:37:22 NOTICE: | @@ -193,0 +203,2 @@ 2024/11/05 05:37:22 NOTICE: | +NOTICE: - WARNING New or changed in both paths - subdir/file20.txt 2024/11/05 05:37:22 NOTICE: | +INFO : subdir/file20.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/11/05 05:37:22 NOTICE: ---------------------------------------------------------- bisync_test.go:558: TEST rclone_args FAILED - 1 MISCOMPARED FILES 2024/11/05 05:37:23 DEBUG : webdav root 'rclone-test-rabudew8qedi': Purge remote --- FAIL: TestBisyncRemoteRemote (89.30s) --- FAIL: TestBisyncRemoteRemote/rclone_args (88.72s) FAIL 2024/11/05 05:37:23 DEBUG : webdav root 'rclone-test-xucezup7xuxo': Purge remote 2024/11/05 05:37:23 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 "./bisync.test -test.v -test.timeout 1h0m0s -remote TestWebdavNextcloud: -verbose -test.run '^TestBisyncRemoteRemote$/^rclone_args$'" - Finished ERROR in 1m30.346595922s (try 3/5): exit status 1: Failed [TestBisyncRemoteRemote/rclone_args]