"./bisync.test -test.v -test.timeout 1h0m0s -remote TestWebdavNextcloud: -verbose -test.run '^TestBisyncRemoteRemote$/^(rclone_args|resolve)$'" - Starting (try 4/5) 2024/09/27 05:49:04 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-miwitud2roce" 2024/09/27 05:49:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/09/27 05:49:04 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:49:04 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:49:04 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:04 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:04 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:04 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:49:04 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:49:04 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:04 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:04 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:04 DEBUG : found headers: 2024/09/27 05:49:04 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:49:05 DEBUG : Creating backend with remote "/tmp/rclone1015921297" === RUN TestBisyncRemoteRemote 2024/09/27 05:49:05 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha" 2024/09/27 05:49:05 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:49: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/09/27 05:49:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:05 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:05 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:49: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/09/27 05:49:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:05 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:05 DEBUG : found headers: 2024/09/27 05:49:05 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:49:05 NOTICE: remote: TestWebdavNextcloud:rclone-test-rucazub9koha === RUN TestBisyncRemoteRemote/rclone_args 2024/09/27 05:49:05 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe" 2024/09/27 05:49:05 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/09/27 05:49:05 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:49: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/09/27 05:49:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:05 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:05 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:49: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/09/27 05:49:05 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:05 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:05 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:05 DEBUG : found headers: 2024/09/27 05:49:05 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:49:06 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe" to be canonical "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe" 2024/09/27 05:49:06 DEBUG : path1: Making directory 2024/09/27 05:49:08 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/rclone_args/path1" 2024/09/27 05:49:08 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:49:08 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:49:08 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:08 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:08 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:08 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:49:08 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:49:08 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:08 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:08 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:08 DEBUG : found headers: 2024/09/27 05:49:08 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:49:08 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/rclone_args/path1" to be canonical "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1" 2024/09/27 05:49:08 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe" for canonical name "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe" 2024/09/27 05:49:08 DEBUG : path2: Making directory 2024/09/27 05:49:09 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/rclone_args/path2" 2024/09/27 05:49:09 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:49: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/09/27 05:49:09 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:09 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:09 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:09 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:49: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/09/27 05:49:09 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:49:09 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:49:09 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:49:09 DEBUG : found headers: 2024/09/27 05:49:09 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:49:09 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/rclone_args/path2" to be canonical "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2" 2024/09/27 05:49:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2024/09/27 05:49:09 DEBUG : Creating backend with remote "/tmp/054905fe/initdir/test_rclone_args-susikos5" 2024/09/27 05:49:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : subdir: Making directory with metadata 2024/09/27 05:49:09 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/09/27 05:49:09 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/09/27 05:49:09 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : Local file system at /tmp/054905fe/initdir/test_rclone_args-susikos5: Waiting for checks to finish 2024/09/27 05:49:09 DEBUG : Local file system at /tmp/054905fe/initdir/test_rclone_args-susikos5: Waiting for transfers to finish 2024/09/27 05:49:09 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:49:09 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:49:09 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2024/09/27 05:49:09 INFO : file2.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2024/09/27 05:49:09 INFO : subdir/file20.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:49:09 DEBUG : subdir/file21.txt.5028a97.partial: renamed to: subdir/file21.txt 2024/09/27 05:49:09 INFO : subdir/file21.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2024/09/27 05:49:09 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/09/27 05:49:09 DEBUG : file1.txt.dae86b42.partial: renamed to: file1.txt 2024/09/27 05:49:09 INFO : file1.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2024/09/27 05:49:09 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:49:09 INFO : subdir: Set directory modification time (using SetModTime) 2024/09/27 05:49:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2024/09/27 05:49:09 DEBUG : Creating backend with remote "/tmp/054905fe/datadir/test_rclone_args-godakaq2" 2024/09/27 05:49:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file20.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file21.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:09 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:49:09 DEBUG : file20.txt.b4075ff1.partial: renamed to: file20.txt 2024/09/27 05:49:09 INFO : file20.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:49:09 DEBUG : Local file system at /tmp/054905fe/datadir/test_rclone_args-godakaq2: Waiting for checks to finish 2024/09/27 05:49:09 DEBUG : Local file system at /tmp/054905fe/datadir/test_rclone_args-godakaq2: Waiting for transfers to finish 2024/09/27 05:49:09 DEBUG : file21.txt.b4075ff1.partial: renamed to: file21.txt 2024/09/27 05:49:09 INFO : file21.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/09/27 05:49:09 DEBUG : file1.txt.6bedbe24.partial: renamed to: file1.txt 2024/09/27 05:49:09 INFO : file1.txt: Copied (new) 2024/09/27 05:49:09 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/09/27 05:49:09 DEBUG : file2.txt.6bedbe24.partial: renamed to: file2.txt 2024/09/27 05:49:09 INFO : file2.txt: Copied (new) 2024/09/27 05:49:10 ERROR : : error listing: directory not found 2024/09/27 05:49:10 ERROR : : error listing: directory not found 2024/09/27 05:49:10 NOTICE: checking initFs Local file system at /tmp/054905fe/initdir/test_rclone_args-susikos5 2024/09/27 05:49:10 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:49:10 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:10 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:10 DEBUG : subdir: Making directory 2024/09/27 05:49:11 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:11 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:11 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:11 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:11 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:11 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path1': Waiting for checks to finish 2024/09/27 05:49:11 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path1': Waiting for transfers to finish 2024/09/27 05:49:12 DEBUG : subdir/file20.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:12 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/09/27 05:49:12 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:49:12 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:12 INFO : file2.txt: Copied (new) 2024/09/27 05:49:12 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2024/09/27 05:49:12 INFO : file1.txt: Copied (new) 2024/09/27 05:49:12 DEBUG : subdir/file21.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:12 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:12 INFO : subdir/file20.txt: Copied (new) 2024/09/27 05:49:13 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:13 INFO : subdir/file21.txt: Copied (new) 2024/09/27 05:49:13 NOTICE: checking Path1 webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path1' 2024/09/27 05:49:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:49:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:14 DEBUG : subdir: Making directory 2024/09/27 05:49:14 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:14 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:14 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:14 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/09/27 05:49:14 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2': Waiting for checks to finish 2024/09/27 05:49:14 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2': Waiting for transfers to finish 2024/09/27 05:49:15 DEBUG : subdir/file20.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:15 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:15 INFO : file2.txt: Copied (new) 2024/09/27 05:49:15 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/09/27 05:49:15 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:49:15 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2024/09/27 05:49:15 INFO : file1.txt: Copied (new) 2024/09/27 05:49:15 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:15 INFO : subdir/file20.txt: Copied (new) 2024/09/27 05:49:15 DEBUG : subdir/file21.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:49:16 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:49:16 INFO : subdir/file21.txt: Copied (new) 2024/09/27 05:49:16 NOTICE: checking path2 webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2' 2024/09/27 05:49:17 NOTICE: (01) : test rclone-args 2024/09/27 05:49:17 NOTICE: (02) : touch-glob 2001-01-02 /tmp/054905fe/datadir/test_rclone_args-godakaq2/ * 2024/09/27 05:49:17 NOTICE: (03) : test initial bisync 2024/09/27 05:49:17 NOTICE: (04) : bisync resync checksum 2024/09/27 05:49: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/09/27 05:49:20 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:20 INFO : Copying Path2 files to Path1 2024/09/27 05:49:20 INFO : - Path2 Resync is copying files to - Path1 2024/09/27 05:49:21 INFO : - Path1 Resync is copying files to - Path2 2024/09/27 05:49:21 INFO : Resync updating listings 2024/09/27 05:49:21 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:21 INFO : Bisync successful 2024/09/27 05:49:21 NOTICE: (05) : test place newer files on both paths 2024/09/27 05:49:21 NOTICE: (06) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file1.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ 2024/09/27 05:49:23 INFO : file1.txt: Copied (replaced existing) 2024/09/27 05:49:23 NOTICE: (07) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file2.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ 2024/09/27 05:49:24 INFO : file2.txt: Copied (replaced existing) 2024/09/27 05:49:24 NOTICE: (08) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file20.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir 2024/09/27 05:49:25 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir': Forced to upload files to set modification times on this backend. 2024/09/27 05:49:25 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:49:26 INFO : file20.txt: Copied (replaced existing) 2024/09/27 05:49:26 NOTICE: (09) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file21.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir 2024/09/27 05:49:27 INFO : file21.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:49:28 INFO : file21.txt: Copied (replaced existing) 2024/09/27 05:49:28 NOTICE: (10) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ file1.txt 2024/09/27 05:49:29 NOTICE: (11) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file2.txt 2024/09/27 05:49:30 NOTICE: (12) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/ file20.txt 2024/09/27 05:49:31 NOTICE: (13) : touch-glob 2001-01-02 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir/ file21.txt 2024/09/27 05:49:32 NOTICE: (14) : test run bisync with custom options 2024/09/27 05:49:32 NOTICE: (15) : bisync checksum 2024/09/27 05:49:35 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/09/27 05:49:35 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:35 INFO : Building Path1 and Path2 listings 2024/09/27 05:49:36 INFO : Path1 checking for diffs 2024/09/27 05:49:36 INFO : - Path1 File changed: hash - file1.txt 2024/09/27 05:49:36 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:49:36 INFO : (Modified:  1 hash differs) 2024/09/27 05:49:36 INFO : Path2 checking for diffs 2024/09/27 05:49:36 INFO : - Path2 File changed: size (larger), hash - file2.txt 2024/09/27 05:49:36 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:49:36 INFO : (Modified:  1 larger,  0 smaller,  1 hash differs) 2024/09/27 05:49:36 INFO : Applying changes 2024/09/27 05:49:36 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/file1.txt 2024/09/27 05:49:36 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/file2.txt 2024/09/27 05:49:36 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:49:37 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:49:37 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:49:39 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:49:39 INFO : Updating listings 2024/09/27 05:49:39 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:39 INFO : Bisync successful 2024/09/27 05:49:39 NOTICE: (16) : touch-glob 2007-07-23 /tmp/054905fe/datadir/test_rclone_args-godakaq2/ * 2024/09/27 05:49:39 NOTICE: (17) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file1.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ 2024/09/27 05:49:40 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:49:41 INFO : file1.txt: Copied (replaced existing) 2024/09/27 05:49:41 NOTICE: (18) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file2.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ 2024/09/27 05:49:42 INFO : file2.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:49:43 INFO : file2.txt: Copied (replaced existing) 2024/09/27 05:49:43 NOTICE: (19) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file20.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir 2024/09/27 05:49:44 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:49:45 INFO : file20.txt: Copied (replaced existing) 2024/09/27 05:49:45 NOTICE: (20) : copy-as /tmp/054905fe/datadir/test_rclone_args-godakaq2/file21.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file1.txt 2024/09/27 05:49:46 INFO : file21.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:49:46 NOTICE: (21) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ file1.txt 2024/09/27 05:49:47 NOTICE: (22) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file2.txt 2024/09/27 05:49:48 NOTICE: (23) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/ file20.txt 2024/09/27 05:49:49 NOTICE: (24) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir/ file21.txt 2024/09/27 05:49:51 NOTICE: (25) : bisync size-only 2024/09/27 05:49:54 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:49:54 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:49:54 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:54 INFO : Building Path1 and Path2 listings 2024/09/27 05:49:55 INFO : Path1 checking for diffs 2024/09/27 05:49:55 INFO : Path2 checking for diffs 2024/09/27 05:49:55 INFO : - Path2 File changed: size (smaller) - file1.txt 2024/09/27 05:49:55 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:49:55 INFO : (Modified:  0 larger,  1 smaller) 2024/09/27 05:49:55 INFO : Applying changes 2024/09/27 05:49:55 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/file1.txt 2024/09/27 05:49:55 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:49:57 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:49:57 INFO : Updating listings 2024/09/27 05:49:57 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:49:57 INFO : Bisync successful 2024/09/27 05:49:57 NOTICE: (26) : bisync resync 2024/09/27 05:50:00 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:50:00 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:50:00 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:00 INFO : Copying Path2 files to Path1 2024/09/27 05:50:00 INFO : - Path2 Resync is copying files to - Path1 2024/09/27 05:50:01 INFO : - Path1 Resync is copying files to - Path2 2024/09/27 05:50:02 INFO : subdir/file20.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:50:02 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:50:03 INFO : subdir/file21.txt: Copied (server-side copy) 2024/09/27 05:50:03 INFO : subdir/file20.txt: Copied (server-side copy) 2024/09/27 05:50:03 INFO : Resync updating listings 2024/09/27 05:50:03 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:03 INFO : Bisync successful 2024/09/27 05:50:03 NOTICE: (27) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file1.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ 2024/09/27 05:50:04 INFO : file1.txt: Copied (replaced existing) 2024/09/27 05:50:04 NOTICE: (28) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file2.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ 2024/09/27 05:50:06 INFO : file2.txt: Copied (replaced existing) 2024/09/27 05:50:06 NOTICE: (29) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file20.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir 2024/09/27 05:50:06 NOTICE: (30) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file21.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir 2024/09/27 05:50:08 INFO : file21.txt: Copied (replaced existing) 2024/09/27 05:50:08 NOTICE: (31) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ file1.txt 2024/09/27 05:50:09 NOTICE: (32) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file2.txt 2024/09/27 05:50:09 NOTICE: (33) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/ file20.txt 2024/09/27 05:50:10 NOTICE: (34) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir/ file21.txt 2024/09/27 05:50:11 NOTICE: (35) : bisync ignore-size 2024/09/27 05:50:14 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:50:14 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": false, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:50:14 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:14 INFO : Building Path1 and Path2 listings 2024/09/27 05:50:15 INFO : Path1 checking for diffs 2024/09/27 05:50:15 INFO : Path2 checking for diffs 2024/09/27 05:50:15 INFO : - Path2 File changed: time (newer) - file2.txt 2024/09/27 05:50:15 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2024/09/27 05:50:15 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2024/09/27 05:50:15 INFO : (Modified:  2 newer,  0 older) 2024/09/27 05:50:15 INFO : Applying changes 2024/09/27 05:50:15 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/file2.txt 2024/09/27 05:50:15 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/file21.txt 2024/09/27 05:50:15 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:50:16 INFO : subdir/file21.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:50:17 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:50:17 INFO : subdir/file21.txt: Copied (server-side copy) 2024/09/27 05:50:17 INFO : Updating listings 2024/09/27 05:50:17 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:17 INFO : Bisync successful 2024/09/27 05:50:17 NOTICE: (36) : bisync resync compare-all 2024/09/27 05:50:21 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/09/27 05:50:21 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:21 INFO : Copying Path2 files to Path1 2024/09/27 05:50:21 INFO : - Path2 Resync is copying files to - Path1 2024/09/27 05:50:21 INFO : TestWebdavNextcloud{zSrAr}: Downloading hashes... 2024/09/27 05:50:22 INFO : - Path1 Resync is copying files to - Path2 2024/09/27 05:50:24 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:50:24 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:50:25 INFO : subdir/file21.txt: Copied (server-side copy) 2024/09/27 05:50:25 INFO : subdir/file20.txt: Copied (server-side copy) 2024/09/27 05:50:25 INFO : Resync updating listings 2024/09/27 05:50:25 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:25 INFO : Bisync successful 2024/09/27 05:50:25 NOTICE: (37) : copy-as /tmp/054905fe/datadir/test_rclone_args-godakaq2/file21.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file2.txt 2024/09/27 05:50:26 INFO : file21.txt: Copied (replaced existing) to: file2.txt 2024/09/27 05:50:26 NOTICE: (38) : touch-glob 2023-08-26 /tmp/054905fe/datadir/test_rclone_args-godakaq2/ * 2024/09/27 05:50:26 NOTICE: (39) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file1.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ 2024/09/27 05:50:27 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:50:28 INFO : file1.txt: Copied (replaced existing) 2024/09/27 05:50:28 NOTICE: (40) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file20.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir 2024/09/27 05:50:29 INFO : file20.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:50:30 INFO : file20.txt: Copied (replaced existing) 2024/09/27 05:50:30 NOTICE: (41) : copy-file /tmp/054905fe/datadir/test_rclone_args-godakaq2/file21.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir 2024/09/27 05:50:32 INFO : file21.txt: Copied (replaced existing) 2024/09/27 05:50:32 NOTICE: (42) : touch-glob 2007-07-23 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/ file2.txt 2024/09/27 05:50:33 NOTICE: (43) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/ file1.txt 2024/09/27 05:50:33 NOTICE: (44) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/ file20.txt 2024/09/27 05:50:34 NOTICE: (45) : touch-glob 2023-08-26 TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir/ file21.txt 2024/09/27 05:50:35 NOTICE: (46) : bisync compare-all 2024/09/27 05:50:38 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2024/09/27 05:50:38 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:38 INFO : Building Path1 and Path2 listings 2024/09/27 05:50:39 INFO : TestWebdavNextcloud{zSrAr}: Downloading hashes... 2024/09/27 05:50:40 INFO : Path1 checking for diffs 2024/09/27 05:50:40 INFO : - Path1 File changed: time (newer) - file1.txt 2024/09/27 05:50:40 INFO : - Path1 File changed: time (newer) - subdir/file20.txt 2024/09/27 05:50:40 INFO : Path1: 2 changes:  0 new,  2 modified,  0 deleted 2024/09/27 05:50:40 INFO : (Modified:  2 newer,  0 older) 2024/09/27 05:50:40 INFO : Path2 checking for diffs 2024/09/27 05:50:40 INFO : - Path2 File changed: hash - file1.txt 2024/09/27 05:50:40 INFO : - Path2 File changed: size (smaller), hash - file2.txt 2024/09/27 05:50:40 INFO : - Path2 File changed: hash - subdir/file20.txt 2024/09/27 05:50:40 INFO : - Path2 File changed: time (newer), hash - subdir/file21.txt 2024/09/27 05:50:40 INFO : Path2: 4 changes:  0 new,  4 modified,  0 deleted 2024/09/27 05:50:40 INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  4 hash differs) 2024/09/27 05:50:40 INFO : Applying changes 2024/09/27 05:50:40 INFO : Checking potential conflicts... 2024/09/27 05:50:41 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2': 0 differences found 2024/09/27 05:50:41 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2': 2 hashes could not be checked 2024/09/27 05:50:41 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/rclone_args/path2': 2 matching files 2024/09/27 05:50:41 INFO : Finished checking the potential conflicts. %!s() 2024/09/27 05:50:41 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:50:41 INFO : file1.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/09/27 05:50:41 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/file1.txt 2024/09/27 05:50:41 NOTICE: - WARNING New or changed in both paths - subdir/file20.txt 2024/09/27 05:50:41 INFO : subdir/file20.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/09/27 05:50:41 INFO : - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/subdir/file20.txt 2024/09/27 05:50:41 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/file2.txt 2024/09/27 05:50:41 INFO : - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/subdir/file21.txt 2024/09/27 05:50:41 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:50:43 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:50:43 INFO : subdir/file21.txt: Copied (server-side copy) 2024/09/27 05:50:43 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:50:45 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:50:46 INFO : subdir/file20.txt: Copied (server-side copy) 2024/09/27 05:50:46 INFO : Updating listings 2024/09/27 05:50:46 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/rclone_args/path2/" 2024/09/27 05:50:46 INFO : Bisync successful 2024/09/27 05:50:46 NOTICE: ---------------------------------------------------------- 2024/09/27 05:50:46 NOTICE: | MISCOMPARE -Golden vs +Results for test.log 2024/09/27 05:50:46 NOTICE: | @@ -187,0 +188 @@ 2024/09/27 05:50:46 NOTICE: | +INFO : - Path2 File changed: hash - file1.txt 2024/09/27 05:50:46 NOTICE: | @@ -189,4 +190,12 @@ 2024/09/27 05:50:46 NOTICE: | -INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2024/09/27 05:50:46 NOTICE: | -INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2024/09/27 05:50:46 NOTICE: | -INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  1 hash differs) 2024/09/27 05:50:46 NOTICE: | -INFO : Applying changes 2024/09/27 05:50:46 NOTICE: | +INFO : - Path2 File changed: hash - subdir/file20.txt 2024/09/27 05:50:46 NOTICE: | +INFO : - Path2 File changed: time (newer), hash - subdir/file21.txt 2024/09/27 05:50:46 NOTICE: | +INFO : Path2: 4 changes:  0 new,  4 modified,  0 deleted 2024/09/27 05:50:46 NOTICE: | +INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  4 hash differs) 2024/09/27 05:50:46 NOTICE: | +INFO : Applying changes 2024/09/27 05:50:46 NOTICE: | +INFO : Checking potential conflicts... 2024/09/27 05:50:46 NOTICE: | +NOTICE: {path2String}: 0 differences found 2024/09/27 05:50:46 NOTICE: | +NOTICE: {path2String}: 2 hashes could not be checked 2024/09/27 05:50:46 NOTICE: | +NOTICE: {path2String}: 2 matching files 2024/09/27 05:50:46 NOTICE: | +INFO : Finished checking the potential conflicts. %!s() 2024/09/27 05:50:46 NOTICE: | +NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:50:46 NOTICE: | +INFO : file1.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/09/27 05:50:46 NOTICE: | @@ -193,0 +203,2 @@ 2024/09/27 05:50:46 NOTICE: | +NOTICE: - WARNING New or changed in both paths - subdir/file20.txt 2024/09/27 05:50:46 NOTICE: | +INFO : subdir/file20.txt: Files are equal but will copy anyway to update modtime (will not rename) 2024/09/27 05:50:46 NOTICE: ---------------------------------------------------------- bisync_test.go:556: TEST rclone_args FAILED - 1 MISCOMPARED FILES === RUN TestBisyncRemoteRemote/resolve 2024/09/27 05:50:46 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe" for canonical name "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe" 2024/09/27 05:50:46 DEBUG : path1: Making directory 2024/09/27 05:50:47 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/resolve/path1" 2024/09/27 05:50:47 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:50:47 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:50:47 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:50:47 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:50:47 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:50:47 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:50:47 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:50:47 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:50:47 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:50:47 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:50:47 DEBUG : found headers: 2024/09/27 05:50:47 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:50:47 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/resolve/path1" to be canonical "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1" 2024/09/27 05:50:47 DEBUG : fs cache: switching user supplied name "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe" for canonical name "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe" 2024/09/27 05:50:47 DEBUG : path2: Making directory 2024/09/27 05:50:47 DEBUG : Creating backend with remote "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/resolve/path2" 2024/09/27 05:50:47 DEBUG : Setting type="webdav" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_TYPE 2024/09/27 05:50:47 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:50:47 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:50:47 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:50:47 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:50:47 DEBUG : TestWebdavNextcloud: detected overridden config - adding "{zSrAr}" suffix to name 2024/09/27 05:50:47 DEBUG : Setting url="http://127.0.0.1:28629/remote.php/dav/files/rclone/" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_URL 2024/09/27 05:50:47 DEBUG : Setting vendor="nextcloud" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_VENDOR 2024/09/27 05:50:47 DEBUG : Setting user="rclone" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_USER 2024/09/27 05:50:47 DEBUG : Setting pass="qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY" for "TestWebdavNextcloud" from environment variable RCLONE_CONFIG_TESTWEBDAVNEXTCLOUD_PASS 2024/09/27 05:50:47 DEBUG : found headers: 2024/09/27 05:50:47 DEBUG : Chunks temporary upload directory: http://127.0.0.1:28629/remote.php/dav/uploads/rclone/ 2024/09/27 05:50:48 DEBUG : fs cache: renaming cache item "TestWebdavNextcloud:rclone-test-rucazub9koha/054905fe/resolve/path2" to be canonical "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2" 2024/09/27 05:50:48 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/initial" 2024/09/27 05:50:48 DEBUG : Creating backend with remote "/tmp/054905fe/initdir/test_resolve-xezudug4" 2024/09/27 05:50:48 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : Local file system at /tmp/054905fe/initdir/test_resolve-xezudug4: Waiting for checks to finish 2024/09/27 05:50:48 DEBUG : Local file system at /tmp/054905fe/initdir/test_resolve-xezudug4: Waiting for transfers to finish 2024/09/27 05:50:48 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:50:48 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2024/09/27 05:50:48 INFO : file2.txt: Copied (new) 2024/09/27 05:50:48 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/09/27 05:50:48 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2024/09/27 05:50:48 INFO : file1.txt: Copied (new) 2024/09/27 05:50:48 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/09/27 05:50:48 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2024/09/27 05:50:48 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:50:48 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/modfiles" 2024/09/27 05:50:48 DEBUG : Creating backend with remote "/tmp/054905fe/datadir/test_resolve-gacofic2" 2024/09/27 05:50:48 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:48 DEBUG : Local file system at /tmp/054905fe/datadir/test_resolve-gacofic2: Waiting for checks to finish 2024/09/27 05:50:48 DEBUG : Local file system at /tmp/054905fe/datadir/test_resolve-gacofic2: Waiting for transfers to finish 2024/09/27 05:50:48 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2024/09/27 05:50:48 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK 2024/09/27 05:50:48 DEBUG : file1R.txt.eafd8cfe.partial: renamed to: file1R.txt 2024/09/27 05:50:48 INFO : file1R.txt: Copied (new) 2024/09/27 05:50:48 DEBUG : file1L.txt.711f2f3a.partial: renamed to: file1L.txt 2024/09/27 05:50:48 INFO : file1L.txt: Copied (new) 2024/09/27 05:50:48 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2024/09/27 05:50:48 DEBUG : file2.txt.cc713425.partial: renamed to: file2.txt 2024/09/27 05:50:48 INFO : file2.txt: Copied (new) 2024/09/27 05:50:49 ERROR : : error listing: directory not found 2024/09/27 05:50:49 ERROR : : error listing: directory not found 2024/09/27 05:50:49 NOTICE: checking initFs Local file system at /tmp/054905fe/initdir/test_resolve-xezudug4 2024/09/27 05:50:49 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:50:49 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:49 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:49 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path1': Waiting for checks to finish 2024/09/27 05:50:49 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path1': Waiting for transfers to finish 2024/09/27 05:50:50 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:50 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:50 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:51 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:50:51 INFO : file2.txt: Copied (new) 2024/09/27 05:50:51 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/09/27 05:50:51 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:50:51 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:50:51 INFO : file1.txt: Copied (new) 2024/09/27 05:50:51 NOTICE: checking Path1 webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path1' 2024/09/27 05:50:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/09/27 05:50:52 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:52 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/09/27 05:50:52 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': Waiting for checks to finish 2024/09/27 05:50:52 DEBUG : webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': Waiting for transfers to finish 2024/09/27 05:50:52 DEBUG : file2.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:52 DEBUG : RCLONE_TEST: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:52 DEBUG : file1.txt: Update will use the normal upload strategy (no chunks) 2024/09/27 05:50:53 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2024/09/27 05:50:53 INFO : RCLONE_TEST: Copied (new) 2024/09/27 05:50:53 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:50:53 INFO : file2.txt: Copied (new) 2024/09/27 05:50:53 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/09/27 05:50:53 INFO : file1.txt: Copied (new) 2024/09/27 05:50:53 NOTICE: checking path2 webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2' 2024/09/27 05:50:53 NOTICE: (01) : test resolve 2024/09/27 05:50:53 NOTICE: (02) : test initial bisync 2024/09/27 05:50:53 NOTICE: (03) : bisync resync 2024/09/27 05:50:56 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:50:56 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:50:56 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:50:56 INFO : Copying Path2 files to Path1 2024/09/27 05:50:56 INFO : - Path2 Resync is copying files to - Path1 2024/09/27 05:50:57 INFO : - Path1 Resync is copying files to - Path2 2024/09/27 05:50:57 INFO : Resync updating listings 2024/09/27 05:50:57 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:50:57 INFO : Bisync successful 2024/09/27 05:50:57 NOTICE: (04) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2024/09/27 05:50:57 NOTICE: (05) : touch-glob 2001-01-02 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:50:57 NOTICE: (06) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:50:58 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:50:58 NOTICE: (07) : touch-glob 2001-03-04 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:50:58 NOTICE: (08) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:50:59 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:50:59 NOTICE: (09) : test bisync run with --conflict-resolve=newer --conflict-loser=delete --conflict-suffix=potato 2024/09/27 05:50:59 NOTICE: (10) : bisync conflict-resolve=newer conflict-loser=delete conflict-suffix=potato 2024/09/27 05:51:03 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:51:03 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:51:03 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:03 INFO : Building Path1 and Path2 listings 2024/09/27 05:51:03 INFO : Path1 checking for diffs 2024/09/27 05:51:03 INFO : - Path1 File changed: size (larger), time (newer) - file1.txt 2024/09/27 05:51:03 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:51:03 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2024/09/27 05:51:03 INFO : Path2 checking for diffs 2024/09/27 05:51:03 INFO : - Path2 File changed: size (larger), time (newer) - file1.txt 2024/09/27 05:51:03 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:51:03 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2024/09/27 05:51:03 INFO : Applying changes 2024/09/27 05:51:03 INFO : Checking potential conflicts... 2024/09/27 05:51:03 ERROR : file1.txt: sha1 differ 2024/09/27 05:51:03 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 differences found 2024/09/27 05:51:03 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 errors while checking 2024/09/27 05:51:03 INFO : Finished checking the potential conflicts. 1 differences found 2024/09/27 05:51:03 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:51:03 INFO : file1.txt: Path1 is newer. Path1: 2001-03-04 00:00:00 +0000 UTC, Path2: 2001-01-02 00:00:00 +0000 UTC, Difference: 1464h0m0s 2024/09/27 05:51:03 INFO : file1.txt: The winner is: Path1 2024/09/27 05:51:03 NOTICE: - Path2 Deleting Path2 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt 2024/09/27 05:51:04 INFO : file1.txt: Deleted 2024/09/27 05:51:04 INFO : - Path1 Queue copy to Path2 - file1.txt 2024/09/27 05:51:04 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:51:06 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:51:06 INFO : Updating listings 2024/09/27 05:51:06 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:06 INFO : Bisync successful 2024/09/27 05:51:06 NOTICE: (11) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2024/09/27 05:51:06 NOTICE: (12) : touch-glob 2001-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:51:06 NOTICE: (13) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:51:07 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:51:07 NOTICE: (14) : touch-glob 2001-08-26 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:51:07 NOTICE: (15) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:51:08 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:51:08 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:51:08 NOTICE: (16) : test bisync run with --conflict-resolve=path2 --conflict-loser=num --conflict-suffix=dinosaur 2024/09/27 05:51:08 NOTICE: (17) : bisync conflict-resolve=path2 conflict-loser=num conflict-suffix=dinosaur 2024/09/27 05:51:12 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:51:12 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:51:12 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:12 INFO : Building Path1 and Path2 listings 2024/09/27 05:51:12 INFO : Path1 checking for diffs 2024/09/27 05:51:12 INFO : - Path1 File changed: time (newer) - file1.txt 2024/09/27 05:51:12 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:51:12 INFO : (Modified:  1 newer,  0 older) 2024/09/27 05:51:12 INFO : Path2 checking for diffs 2024/09/27 05:51:12 INFO : - Path2 File changed: time (newer) - file1.txt 2024/09/27 05:51:12 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2024/09/27 05:51:12 INFO : (Modified:  1 newer,  0 older) 2024/09/27 05:51:12 INFO : Applying changes 2024/09/27 05:51:12 INFO : Checking potential conflicts... 2024/09/27 05:51:12 ERROR : file1.txt: sha1 differ 2024/09/27 05:51:12 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 differences found 2024/09/27 05:51:12 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 errors while checking 2024/09/27 05:51:12 INFO : Finished checking the potential conflicts. 1 differences found 2024/09/27 05:51:12 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:51:12 INFO : file1.txt: The winner is: Path2 2024/09/27 05:51:12 NOTICE: - Path1 Renaming Path1 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt.dinosaur1 2024/09/27 05:51:14 INFO : file1.txt: Moved (server-side) to: file1.txt.dinosaur1 2024/09/27 05:51:14 NOTICE: - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt.dinosaur1 2024/09/27 05:51:14 NOTICE: - Path2 Not renaming Path2 copy, as it was determined the winner - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt 2024/09/27 05:51:14 NOTICE: - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt 2024/09/27 05:51:14 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:51:15 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:51:15 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:51:17 INFO : file1.txt.dinosaur1: Copied (server-side copy) 2024/09/27 05:51:17 INFO : Updating listings 2024/09/27 05:51:17 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:17 INFO : Bisync successful 2024/09/27 05:51:17 NOTICE: (18) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2024/09/27 05:51:17 NOTICE: (19) : touch-glob 2002-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:51:17 NOTICE: (20) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:51:18 INFO : file1.txt: src and dst identical but can't set mod time without re-uploading 2024/09/27 05:51:19 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:51:19 NOTICE: (21) : touch-glob 2002-08-26 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:51:19 NOTICE: (22) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:51:20 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2024/09/27 05:51:20 NOTICE: (23) : test bisync run with --conflict-resolve=larger --conflict-loser=num --conflict-suffix=apple 2024/09/27 05:51:20 NOTICE: (24) : bisync conflict-resolve=larger conflict-loser=num conflict-suffix=apple 2024/09/27 05:51:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:51:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:51:23 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:23 INFO : Building Path1 and Path2 listings 2024/09/27 05:51:23 INFO : Path1 checking for diffs 2024/09/27 05:51:23 INFO : - Path1 File is new - file1.txt 2024/09/27 05:51:23 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:23 INFO : Path2 checking for diffs 2024/09/27 05:51:23 INFO : - Path2 File is new - file1.txt 2024/09/27 05:51:23 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:23 INFO : Applying changes 2024/09/27 05:51:23 INFO : Checking potential conflicts... 2024/09/27 05:51:24 ERROR : file1.txt: sha1 differ 2024/09/27 05:51:24 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 differences found 2024/09/27 05:51:24 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 errors while checking 2024/09/27 05:51:24 INFO : Finished checking the potential conflicts. 1 differences found 2024/09/27 05:51:24 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:51:24 INFO : file1.txt: Winner cannot be determined as sizes are equal. Path1: 33, Path2: 33, Difference: 0 2024/09/27 05:51:24 INFO : file1.txt: A winner could not be determined. 2024/09/27 05:51:24 NOTICE: - Path1 Renaming Path1 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt.apple1 2024/09/27 05:51:25 INFO : file1.txt: Moved (server-side) to: file1.txt.apple1 2024/09/27 05:51:25 NOTICE: - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt.apple1 2024/09/27 05:51:25 NOTICE: - Path2 Renaming Path2 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt.apple2 2024/09/27 05:51:27 INFO : file1.txt: Moved (server-side) to: file1.txt.apple2 2024/09/27 05:51:27 NOTICE: - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt.apple2 2024/09/27 05:51:27 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:51:28 INFO : file1.txt.apple2: Copied (server-side copy) 2024/09/27 05:51:28 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:51:30 INFO : file1.txt.apple1: Copied (server-side copy) 2024/09/27 05:51:30 INFO : Updating listings 2024/09/27 05:51:30 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:30 INFO : Bisync successful 2024/09/27 05:51:30 NOTICE: (25) : test different suffixes 2024/09/27 05:51:30 NOTICE: (26) : touch-glob 2003-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:51:30 NOTICE: (27) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:51:31 INFO : file1R.txt: Copied (new) to: file1.txt 2024/09/27 05:51:31 NOTICE: (28) : touch-glob 2003-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:51:31 NOTICE: (29) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:51:32 INFO : file1L.txt: Copied (new) to: file1.txt 2024/09/27 05:51:32 NOTICE: (30) : test bisync run with --conflict-resolve=older --conflict-loser=num --conflict-suffix=cloud,local 2024/09/27 05:51:32 NOTICE: (31) : bisync conflict-resolve=older conflict-loser=num conflict-suffix=cloud,local 2024/09/27 05:51:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:51:35 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:51:35 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:35 INFO : Building Path1 and Path2 listings 2024/09/27 05:51:36 INFO : Path1 checking for diffs 2024/09/27 05:51:36 INFO : - Path1 File is new - file1.txt 2024/09/27 05:51:36 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:36 INFO : Path2 checking for diffs 2024/09/27 05:51:36 INFO : - Path2 File is new - file1.txt 2024/09/27 05:51:36 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:36 INFO : Applying changes 2024/09/27 05:51:36 INFO : Checking potential conflicts... 2024/09/27 05:51:36 ERROR : file1.txt: sha1 differ 2024/09/27 05:51:36 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 differences found 2024/09/27 05:51:36 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 errors while checking 2024/09/27 05:51:36 INFO : Finished checking the potential conflicts. 1 differences found 2024/09/27 05:51:36 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:51:36 INFO : file1.txt: Winner cannot be determined as times are equal. Path1: 2003-07-23 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 0s 2024/09/27 05:51:36 INFO : file1.txt: A winner could not be determined. 2024/09/27 05:51:36 NOTICE: - Path1 Renaming Path1 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt.cloud1 2024/09/27 05:51:38 INFO : file1.txt: Moved (server-side) to: file1.txt.cloud1 2024/09/27 05:51:38 NOTICE: - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt.cloud1 2024/09/27 05:51:38 NOTICE: - Path2 Renaming Path2 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt.local1 2024/09/27 05:51:39 INFO : file1.txt: Moved (server-side) to: file1.txt.local1 2024/09/27 05:51:39 NOTICE: - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt.local1 2024/09/27 05:51:39 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:51:41 INFO : file1.txt.local1: Copied (server-side copy) 2024/09/27 05:51:41 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:51:42 INFO : file1.txt.cloud1: Copied (server-side copy) 2024/09/27 05:51:42 INFO : Updating listings 2024/09/27 05:51:42 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:42 INFO : Bisync successful 2024/09/27 05:51:42 NOTICE: (32) : test legacy 2024/09/27 05:51:42 NOTICE: (33) : touch-glob 2004-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:51:42 NOTICE: (34) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:51:43 INFO : file1R.txt: Copied (new) to: file1.txt 2024/09/27 05:51:43 NOTICE: (35) : touch-glob 2004-07-23 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:51:43 NOTICE: (36) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:51:45 INFO : file1L.txt: Copied (new) to: file1.txt 2024/09/27 05:51:45 NOTICE: (37) : test bisync run with --conflict-resolve=none --conflict-loser=pathname --conflict-suffix=.path 2024/09/27 05:51:45 NOTICE: (38) : bisync conflict-resolve=none conflict-loser=pathname conflict-suffix=.path 2024/09/27 05:51:48 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:51:48 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:51:48 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:48 INFO : Building Path1 and Path2 listings 2024/09/27 05:51:48 INFO : Path1 checking for diffs 2024/09/27 05:51:48 INFO : - Path1 File is new - file1.txt 2024/09/27 05:51:48 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:48 INFO : Path2 checking for diffs 2024/09/27 05:51:48 INFO : - Path2 File is new - file1.txt 2024/09/27 05:51:48 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2024/09/27 05:51:48 INFO : Applying changes 2024/09/27 05:51:48 INFO : Checking potential conflicts... 2024/09/27 05:51:49 ERROR : file1.txt: sha1 differ 2024/09/27 05:51:49 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 differences found 2024/09/27 05:51:49 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 1 errors while checking 2024/09/27 05:51:49 INFO : Finished checking the potential conflicts. 1 differences found 2024/09/27 05:51:49 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:51:49 NOTICE: - Path1 Renaming Path1 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt..path1 2024/09/27 05:51:50 INFO : file1.txt: Moved (server-side) to: file1.txt..path1 2024/09/27 05:51:50 NOTICE: - Path1 Queue copy to Path2 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt..path1 2024/09/27 05:51:50 NOTICE: - Path2 Renaming Path2 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt..path2 2024/09/27 05:51:51 INFO : file1.txt: Moved (server-side) to: file1.txt..path2 2024/09/27 05:51:51 NOTICE: - Path2 Queue copy to Path1 - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file1.txt..path2 2024/09/27 05:51:51 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:51:53 INFO : file1.txt..path2: Copied (server-side copy) 2024/09/27 05:51:53 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:51:55 INFO : file1.txt..path1: Copied (server-side copy) 2024/09/27 05:51:55 INFO : Updating listings 2024/09/27 05:51:55 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:51:55 INFO : Bisync successful 2024/09/27 05:51:55 NOTICE: (39) : test deletes on both sides with default suffix 2024/09/27 05:51:55 NOTICE: (40) : touch-glob 2005-01-02 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1R.txt 2024/09/27 05:51:55 NOTICE: (41) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file1.txt 2024/09/27 05:51:56 INFO : file1R.txt: Copied (new) to: file1.txt 2024/09/27 05:51:56 NOTICE: (42) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1R.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file2.txt 2024/09/27 05:51:57 INFO : file1R.txt: Copied (replaced existing) to: file2.txt 2024/09/27 05:51:57 NOTICE: (43) : touch-glob 2006-03-04 /tmp/054905fe/datadir/test_resolve-gacofic2/ file1L.txt 2024/09/27 05:51:57 NOTICE: (44) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path1/ file1.txt 2024/09/27 05:51:58 INFO : file1L.txt: Copied (new) to: file1.txt 2024/09/27 05:51:58 NOTICE: (45) : copy-as /tmp/054905fe/datadir/test_resolve-gacofic2/file1L.txt TestWebdavNextcloud,pass='qi8RNmnGYS-xiM_RGQhVflx9MypfFBSWVDg_FICY',url='http://127.0.0.1:28629/remote.php/dav/files/rclone/',user='rclone',vendor='nextcloud':rclone-test-rucazub9koha/054905fe/resolve/path2/ file2.txt 2024/09/27 05:52:00 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2024/09/27 05:52:00 NOTICE: (46) : test bisync run with --conflict-resolve=newer --conflict-loser=delete 2024/09/27 05:52:00 NOTICE: (47) : bisync conflict-resolve=newer conflict-loser=delete 2024/09/27 05:52:03 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/09/27 05:52:03 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/09/27 05:52:03 INFO : Synching Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" with Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:52:03 INFO : Building Path1 and Path2 listings 2024/09/27 05:52:03 INFO : Path1 checking for diffs 2024/09/27 05:52:03 INFO : - Path1 File changed: size (larger), time (newer) - file2.txt 2024/09/27 05:52:03 INFO : - Path1 File is new - file1.txt 2024/09/27 05:52:03 INFO : Path1: 2 changes:  1 new,  1 modified,  0 deleted 2024/09/27 05:52:03 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2024/09/27 05:52:03 INFO : Path2 checking for diffs 2024/09/27 05:52:03 INFO : - Path2 File changed: size (larger), time (newer) - file2.txt 2024/09/27 05:52:03 INFO : - Path2 File is new - file1.txt 2024/09/27 05:52:03 INFO : Path2: 2 changes:  1 new,  1 modified,  0 deleted 2024/09/27 05:52:03 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2024/09/27 05:52:03 INFO : Applying changes 2024/09/27 05:52:03 INFO : Checking potential conflicts... 2024/09/27 05:52:04 ERROR : file2.txt: sha1 differ 2024/09/27 05:52:04 ERROR : file1.txt: sha1 differ 2024/09/27 05:52:04 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 2 differences found 2024/09/27 05:52:04 NOTICE: webdav root 'rclone-test-rucazub9koha/054905fe/resolve/path2': 2 errors while checking 2024/09/27 05:52:04 INFO : Finished checking the potential conflicts. 2 differences found 2024/09/27 05:52:04 NOTICE: - WARNING New or changed in both paths - file1.txt 2024/09/27 05:52:04 INFO : file1.txt: Path1 is newer. Path1: 2006-03-04 00:00:00 +0000 UTC, Path2: 2005-01-02 00:00:00 +0000 UTC, Difference: 10224h0m0s 2024/09/27 05:52:04 INFO : file1.txt: The winner is: Path1 2024/09/27 05:52:04 NOTICE: - Path2 Deleting Path2 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/file1.txt 2024/09/27 05:52:04 INFO : file1.txt: Deleted 2024/09/27 05:52:04 INFO : - Path1 Queue copy to Path2 - file1.txt 2024/09/27 05:52:04 NOTICE: - WARNING New or changed in both paths - file2.txt 2024/09/27 05:52:04 INFO : file2.txt: Path2 is newer. Path1: 2005-01-02 00:00:00 +0000 UTC, Path2: 2006-03-04 00:00:00 +0000 UTC, Difference: 10224h0m0s 2024/09/27 05:52:04 INFO : file2.txt: The winner is: Path2 2024/09/27 05:52:04 NOTICE: - Path1 Deleting Path1 copy - TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/file2.txt 2024/09/27 05:52:05 INFO : file2.txt: Deleted 2024/09/27 05:52:05 INFO : - Path2 Queue copy to Path1 - file2.txt 2024/09/27 05:52:05 INFO : - Path2 Do queued copies to - Path1 2024/09/27 05:52:06 INFO : file2.txt: Copied (server-side copy) 2024/09/27 05:52:06 INFO : - Path1 Do queued copies to - Path2 2024/09/27 05:52:08 INFO : file1.txt: Copied (server-side copy) 2024/09/27 05:52:08 INFO : Updating listings 2024/09/27 05:52:09 ERROR : file1.txt: failed to check as hash is missing 2024/09/27 05:52:09 INFO : file1.txt: files not equal on recheck: file1.txt file1.txt 2024/09/27 05:52:09 INFO : Validating listings for Path1 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path1/" vs Path2 "TestWebdavNextcloud{zSrAr}:rclone-test-rucazub9koha/054905fe/resolve/path2/" 2024/09/27 05:52:09 INFO : Bisync successful 2024/09/27 05:52:09 NOTICE: ---------------------------------------------------------- 2024/09/27 05:52:09 NOTICE: | MISCOMPARE -Golden vs +Results for test.log 2024/09/27 05:52:09 NOTICE: | @@ -284,0 +285,2 @@ 2024/09/27 05:52:09 NOTICE: | +ERROR : file1.txt: failed to check as hash is missing 2024/09/27 05:52:09 NOTICE: | +INFO : file1.txt: files not equal on recheck: file1.txt file1.txt 2024/09/27 05:52:09 NOTICE: ---------------------------------------------------------- bisync_test.go:556: TEST resolve FAILED - 1 MISCOMPARED FILES 2024/09/27 05:52:09 DEBUG : webdav root 'rclone-test-rucazub9koha': Purge remote --- FAIL: TestBisyncRemoteRemote (184.60s) --- FAIL: TestBisyncRemoteRemote/rclone_args (100.99s) --- FAIL: TestBisyncRemoteRemote/resolve (82.97s) FAIL 2024/09/27 05:52:10 DEBUG : webdav root 'rclone-test-miwitud2roce': Purge remote 2024/09/27 05:52:10 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|resolve)$'" - Finished ERROR in 3m5.709888315s (try 4/5): exit status 1: Failed [TestBisyncRemoteRemote/rclone_args TestBisyncRemoteRemote/resolve]