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