"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^TestBisyncLocalRemote$/^(basic|ext_paths)$|^TestBisyncRemoteRemote$/^(changes|ignorelistingchecksum|resync_modes)$'" - Starting (try 3/5)
2025/09/12 03:33:41 DEBUG : Creating backend with remote "TestPcloud:rclone-test-wixuxid1gaho"
2025/09/12 03:33:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/12 03:33:42 DEBUG : Creating backend with remote "/tmp/rclone1425784617"
=== RUN   TestBisyncLocalRemote
2025/09/12 03:33:42 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo"
2025/09/12 03:33:42 NOTICE: remote: TestPcloud:rclone-test-xihuzey2xuvo
=== RUN   TestBisyncLocalRemote/basic
2025/09/12 03:33:42 DEBUG : Creating backend with remote "/tmp/033342bo"
2025/09/12 03:33:42 DEBUG : Creating backend with remote "/tmp/033342bo/basic/path1"
2025/09/12 03:33:42 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo"
2025/09/12 03:33:43 INFO  : path2: Making directory
2025/09/12 03:33:43 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2"
2025/09/12 03:33:44 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/initial"
2025/09/12 03:33:44 DEBUG : Creating backend with remote "/tmp/033342bo/initdir/test_basic-wigajum8"
2025/09/12 03:33:44 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : subdir: Making directory with metadata
2025/09/12 03:33:44 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/09/12 03:33:44 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/09/12 03:33:44 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/initdir/test_basic-wigajum8: Waiting for checks to finish
2025/09/12 03:33:44 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/initdir/test_basic-wigajum8: Waiting for transfers to finish
2025/09/12 03:33:44 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:33:44 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:33:44 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:33:44 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:33:44 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:33:44 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:33:44 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:33:44 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:33:44 INFO  : file1.txt: Copied (new)
2025/09/12 03:33:44 INFO  : subdir: Set directory modification time (using SetModTime)
2025/09/12 03:33:44 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/modfiles"
2025/09/12 03:33:44 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_basic-letekum7"
2025/09/12 03:33:44 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/datadir/test_basic-letekum7: Waiting for checks to finish
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/datadir/test_basic-letekum7: Waiting for transfers to finish
2025/09/12 03:33:44 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:33:44 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:33:44 INFO  : file1.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : Waiting for deletions to finish
2025/09/12 03:33:44 ERROR : error listing: directory not found
2025/09/12 03:33:44 ERROR : Local file system at /tmp/033342bo/basic/path1: Failed to list "": directory not found
2025/09/12 03:33:44 DEBUG : removing 1 level 0 directories
2025/09/12 03:33:44 INFO  : Local file system at /tmp/033342bo/basic/path1: Removing directory
2025/09/12 03:33:44 ERROR : Failed to rmdir: stat /tmp/033342bo/basic/path1: no such file or directory
2025/09/12 03:33:44 ERROR : error listing: directory not found
2025/09/12 03:33:44 NOTICE: checking initFs Local file system at /tmp/033342bo/initdir/test_basic-wigajum8
2025/09/12 03:33:44 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : subdir: Making directory with metadata
2025/09/12 03:33:44 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/09/12 03:33:44 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/09/12 03:33:44 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:44 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/basic/path1: Waiting for checks to finish
2025/09/12 03:33:44 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:33:44 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:33:44 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : Local file system at /tmp/033342bo/basic/path1: Waiting for transfers to finish
2025/09/12 03:33:44 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:33:44 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:33:44 INFO  : file1.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:33:44 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:33:44 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:33:44 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:33:44 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:33:44 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:33:44 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:33:44 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:33:44 INFO  : subdir: Set directory modification time (using SetModTime)
2025/09/12 03:33:44 NOTICE: checking Path1 Local file system at /tmp/033342bo/basic/path1
2025/09/12 03:33:45 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 INFO  : subdir: Making directory
2025/09/12 03:33:45 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:33:45 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2': Waiting for checks to finish
2025/09/12 03:33:45 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2': Waiting for transfers to finish
2025/09/12 03:33:45 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:33:45 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:33:45 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:33:45 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:33:45 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:33:45 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:33:45 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:33:45 INFO  : file1.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:33:45 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:33:45 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:33:45 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:33:45 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:33:45 NOTICE: checking path2 pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2'
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
2025/09/12 03:33:54 NOTICE: (01)  : test basic
2025/09/12 03:33:54 NOTICE: (02)  : test initial bisync
2025/09/12 03:33:54 NOTICE: (03)  : bisync resync
2025/09/12 03:33:56 INFO  : subdir: Set directory modification time (using SetModTime)
2025/09/12 03:33:56 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:33:56 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:33:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:33:56 INFO  : Synching Path1 "/tmp/033342bo/basic/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/"
2025/09/12 03:33:56 INFO  : Copying Path2 files to Path1
2025/09/12 03:33:56 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:33:56 INFO  : There was nothing to transfer
2025/09/12 03:33:56 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:33:56 INFO  : There was nothing to transfer
2025/09/12 03:33:56 INFO  : Resync updating listings
2025/09/12 03:33:56 INFO  : Validating listings for Path1 "/tmp/033342bo/basic/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/"
2025/09/12 03:33:56 INFO  : Bisync successful
2025/09/12 03:33:56 NOTICE: (04)  : test place newer files on both paths
2025/09/12 03:33:56 NOTICE: (05)  : touch-copy 2001-01-02 /tmp/033342bo/datadir/test_basic-letekum7/file1.txt TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/
2025/09/12 03:33:56 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_basic-letekum7/"
2025/09/12 03:33:56 DEBUG : fs cache: renaming cache item "/tmp/033342bo/datadir/test_basic-letekum7/" to be canonical "/tmp/033342bo/datadir/test_basic-letekum7"
2025/09/12 03:33:56 DEBUG : file1.txt: Set modification time 2001-01-02
2025/09/12 03:33:56 DEBUG : copyFile "/tmp/033342bo/datadir/test_basic-letekum7/file1.txt" to "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/" as ""
2025/09/12 03:33:56 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_basic-letekum7/file1.txt"
2025/09/12 03:33:56 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/"
2025/09/12 03:33:57 DEBUG : operations.CopyFile "file1.txt" to "pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2'" as "file1.txt"
2025/09/12 03:33:57 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:33:57 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:33:57 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:33:57 INFO  : file1.txt: Copied (replaced existing)
2025/09/12 03:33:57 NOTICE: (06)  : copy-as /tmp/033342bo/datadir/test_basic-letekum7/file1.txt /tmp/033342bo/basic/path1/subdir file20.txt
2025/09/12 03:33:57 DEBUG : copyFile "/tmp/033342bo/datadir/test_basic-letekum7/file1.txt" to "/tmp/033342bo/basic/path1/subdir" as "file20.txt"
2025/09/12 03:33:57 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_basic-letekum7/file1.txt"
2025/09/12 03:33:57 DEBUG : Creating backend with remote "/tmp/033342bo/basic/path1/subdir"
2025/09/12 03:33:57 DEBUG : operations.CopyFile "file1.txt" to "Local file system at /tmp/033342bo/basic/path1/subdir" as "file20.txt"
2025/09/12 03:33:57 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:33:57 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:33:57 DEBUG : file20.txt.8dcf80ac.partial: renamed to: file20.txt
2025/09/12 03:33:57 INFO  : file1.txt: Copied (replaced existing) to: file20.txt
2025/09/12 03:33:57 NOTICE: (07)  : test bisync run
2025/09/12 03:33:57 NOTICE: (08)  : bisync
2025/09/12 03:33:59 INFO  : subdir: Set directory modification time (using SetModTime)
2025/09/12 03:33:59 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/basic/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:33:59 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:33:59 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:33:59 INFO  : Synching Path1 "/tmp/033342bo/basic/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/"
2025/09/12 03:33:59 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:00 INFO  : Path1 checking for diffs
2025/09/12 03:34:00 INFO  : - Path1    File changed: size (larger), time (newer) - subdir/file20.txt
2025/09/12 03:34:00 INFO  : Path1:    1 changes:    0 new,    1 modified,    0 deleted
2025/09/12 03:34:00 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/09/12 03:34:00 INFO  : Path2 checking for diffs
2025/09/12 03:34:00 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/09/12 03:34:00 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/09/12 03:34:00 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/09/12 03:34:00 INFO  : Applying changes
2025/09/12 03:34:00 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/subdir/file20.txt
2025/09/12 03:34:00 INFO  : - Path2    Queue copy to Path1       - /tmp/033342bo/basic/path1/file1.txt
2025/09/12 03:34:00 INFO  : - Path2    Do queued copies to                - Path1
2025/09/12 03:34:00 INFO  : file1.txt: Copied (replaced existing)
2025/09/12 03:34:00 INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:34:00 INFO  : subdir/file20.txt: Copied (replaced existing)
2025/09/12 03:34:00 INFO  : Updating listings
2025/09/12 03:34:00 INFO  : Validating listings for Path1 "/tmp/033342bo/basic/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/basic/path2/"
2025/09/12 03:34:00 INFO  : Bisync successful
2025/09/12 03:34:00 DEBUG : Waiting for deletions to finish
2025/09/12 03:34:00 INFO  : RCLONE_TEST: Deleted
2025/09/12 03:34:00 INFO  : file1.copy3.txt: Deleted
2025/09/12 03:34:00 INFO  : file1.copy2.txt: Deleted
2025/09/12 03:34:00 INFO  : file1.copy4.txt: Deleted
2025/09/12 03:34:00 INFO  : file1.copy5.txt: Deleted
2025/09/12 03:34:00 INFO  : file1.copy1.txt: Deleted
2025/09/12 03:34:00 INFO  : file1.txt: Deleted
2025/09/12 03:34:00 INFO  : subdir/file20.txt: Deleted
2025/09/12 03:34:00 DEBUG : removing 1 level 1 directories
2025/09/12 03:34:00 INFO  : subdir: Removing directory
2025/09/12 03:34:00 DEBUG : removing 1 level 0 directories
2025/09/12 03:34:00 INFO  : Local file system at /tmp/033342bo/basic/path1: Removing directory
    bisync_test.go:608: TEST basic PASSED
=== RUN   TestBisyncLocalRemote/ext_paths
2025/09/12 03:34:00 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1"
2025/09/12 03:34:00 INFO  : path2: Making directory
2025/09/12 03:34:00 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2"
2025/09/12 03:34:01 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/initial"
2025/09/12 03:34:01 DEBUG : Creating backend with remote "/tmp/033342bo/initdir/test_ext_paths-judokuc5"
2025/09/12 03:34:01 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ: Making directory with metadata
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ: Made directory with metadata (mtime=2024-04-17T01:00:03.064427195Z)
2025/09/12 03:34:01 DEBUG : Added delayed dir = "測試Русский  ěáñ", newDst=測試Русский  ěáñ
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt.87bb9e28.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/09/12 03:34:01 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:01 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/initdir/test_ext_paths-judokuc5: Waiting for checks to finish
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/initdir/test_ext_paths-judokuc5: Waiting for transfers to finish
2025/09/12 03:34:01 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : Русский.txt.81414200.partial: renamed to: Русский.txt
2025/09/12 03:34:01 INFO  : Русский.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:34:01 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:01 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt.873dd986.partial: renamed to: filename_contains_ě_.txt
2025/09/12 03:34:01 INFO  : filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試_check file.a1a409eb.partial: renamed to: 測試_check file
2025/09/12 03:34:01 INFO  : 測試_check file: Copied (new)
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt.fbe64d45.partial: renamed to: filename_contains_ࢺ_.txt
2025/09/12 03:34:01 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file.1e4608b8.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.ee6ef038.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.d5adeddb.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:01 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/modfiles"
2025/09/12 03:34:01 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4"
2025/09/12 03:34:01 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/datadir/test_ext_paths-gemovaj4: Waiting for checks to finish
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/datadir/test_ext_paths-gemovaj4: Waiting for transfers to finish
2025/09/12 03:34:01 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK
2025/09/12 03:34:01 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:01 DEBUG : 測試_filtersfile.txt.ce49fba4.partial: renamed to: 測試_filtersfile.txt
2025/09/12 03:34:01 INFO  : 測試_filtersfile.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : file1.txt.817ca4fb.partial: renamed to: file1.txt
2025/09/12 03:34:01 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : Waiting for deletions to finish
2025/09/12 03:34:01 ERROR : error listing: directory not found
2025/09/12 03:34:01 ERROR : Local file system at /tmp/033342bo/ext_paths/path1: Failed to list "": directory not found
2025/09/12 03:34:01 DEBUG : removing 1 level 0 directories
2025/09/12 03:34:01 INFO  : Local file system at /tmp/033342bo/ext_paths/path1: Removing directory
2025/09/12 03:34:01 ERROR : Failed to rmdir: stat /tmp/033342bo/ext_paths/path1: no such file or directory
2025/09/12 03:34:01 ERROR : error listing: directory not found
2025/09/12 03:34:01 NOTICE: checking initFs Local file system at /tmp/033342bo/initdir/test_ext_paths-judokuc5
2025/09/12 03:34:01 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ: Making directory with metadata
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ: Made directory with metadata (mtime=2024-04-17T01:00:03.064427195Z)
2025/09/12 03:34:01 DEBUG : Added delayed dir = "測試Русский  ěáñ", newDst=測試Русский  ěáñ
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1: Waiting for checks to finish
2025/09/12 03:34:01 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1: Waiting for transfers to finish
2025/09/12 03:34:01 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : file_enconde_mañana_funcionará.txt.87bb9e28.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/09/12 03:34:01 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:01 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/09/12 03:34:01 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:01 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:01 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : Русский.txt.81414200.partial: renamed to: Русский.txt
2025/09/12 03:34:01 INFO  : Русский.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試_check file.a1a409eb.partial: renamed to: 測試_check file
2025/09/12 03:34:01 INFO  : 測試_check file: Copied (new)
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : filename_contains_ě_.txt.873dd986.partial: renamed to: filename_contains_ě_.txt
2025/09/12 03:34:01 INFO  : filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/測試_check file.1e4608b8.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : filename_contains_ࢺ_.txt.fbe64d45.partial: renamed to: filename_contains_ࢺ_.txt
2025/09/12 03:34:01 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.d5adeddb.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:01 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.ee6ef038.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:01 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:01 NOTICE: checking Path1 Local file system at /tmp/033342bo/ext_paths/path1
2025/09/12 03:34:02 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:02 INFO  : 測試Русский  ěáñ: Making directory
2025/09/12 03:34:02 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/09/12 03:34:02 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Waiting for checks to finish
2025/09/12 03:34:02 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Waiting for transfers to finish
2025/09/12 03:34:02 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:34:02 DEBUG : file_enconde_mañana_funcionará.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:02 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:02 DEBUG : filename_contains_ě_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK
2025/09/12 03:34:02 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:02 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:02 DEBUG : file_enconde_mañana_funcionará.txt.87bb9e28.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/09/12 03:34:02 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/09/12 03:34:02 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:02 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:02 DEBUG : filename_contains_ě_.txt.873dd986.partial: renamed to: filename_contains_ě_.txt
2025/09/12 03:34:02 INFO  : filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:02 DEBUG : 測試_check file: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:02 DEBUG : filename_contains_ࢺ_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK
2025/09/12 03:34:02 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK
2025/09/12 03:34:02 DEBUG : Русский.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:02 DEBUG : 測試_check file.a1a409eb.partial: renamed to: 測試_check file
2025/09/12 03:34:02 INFO  : 測試_check file: Copied (new)
2025/09/12 03:34:02 DEBUG : filename_contains_ࢺ_.txt.fbe64d45.partial: renamed to: filename_contains_ࢺ_.txt
2025/09/12 03:34:02 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:02 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.d5adeddb.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/09/12 03:34:02 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/09/12 03:34:02 DEBUG : Русский.txt.81414200.partial: renamed to: Русский.txt
2025/09/12 03:34:02 INFO  : Русский.txt: Copied (new)
2025/09/12 03:34:03 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK
2025/09/12 03:34:03 DEBUG : 測試Русский  ěáñ/測試_check file: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:03 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.ee6ef038.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/09/12 03:34:03 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/09/12 03:34:03 DEBUG : 測試Русский  ěáñ/測試_check file.1e4608b8.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/09/12 03:34:03 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/09/12 03:34:03 NOTICE: checking path2 pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2'
2025/09/12 03:34:04 NOTICE: (01)  : test extended-char-paths
2025/09/12 03:34:04 NOTICE: (02)  : fix-names /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ/
2025/09/12 03:34:04 DEBUG : Creating backend with remote "/"
2025/09/12 03:34:04 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/: is NFC: true
2025/09/12 03:34:04 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/: is NFD: false
2025/09/12 03:34:04 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/: is valid UTF8: true
2025/09/12 03:34:04 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/: attempting to fix directory
2025/09/12 03:34:04 DEBUG : old and new are equal. Skipping. /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/ (0e66ea221dedba0e8f7c226241dc6da9) /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/ (0e66ea221dedba0e8f7c226241dc6da9)
2025/09/12 03:34:04 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/"
2025/09/12 03:34:04 DEBUG : fs cache: renaming cache item "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" to be canonical "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ"
2025/09/12 03:34:04 DEBUG : Attempting to move /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ to /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/
2025/09/12 03:34:04 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7"
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: Using server-side directory move
2025/09/12 03:34:04 ERROR : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: Server side directory move failed: rename /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: no such file or directory
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: error attempting to move folder: rename /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: no such file or directory
2025/09/12 03:34:04 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/"
2025/09/12 03:34:04 DEBUG : fs cache: renaming cache item "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" to be canonical "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ"
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: Using server-side directory move
2025/09/12 03:34:04 INFO  : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/09/12 03:34:04 ERROR : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: error reading source root directory: directory not found
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: Waiting for checks to finish
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: Waiting for transfers to finish
2025/09/12 03:34:04 DEBUG : Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ-rclone-move-zaciyom7: error attempting to move folder to /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ: directory not found
2025/09/12 03:34:04 NOTICE: (03)  : fix-names TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский{spc}{spc}ěáñ/
2025/09/12 03:34:04 DEBUG : Creating backend with remote "TestPcloud:"
2025/09/12 03:34:04 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/: is NFC: true
2025/09/12 03:34:04 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/: is NFD: false
2025/09/12 03:34:04 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/: is valid UTF8: true
2025/09/12 03:34:04 DEBUG : TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/: attempting to fix directory
2025/09/12 03:34:04 DEBUG : old and new are equal. Skipping. TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/ (8d171b8c0edf84b929b142ecbb1e2f93) TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/ (8d171b8c0edf84b929b142ecbb1e2f93)
2025/09/12 03:34:04 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:05 DEBUG : fs cache: renaming cache item "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/" to be canonical "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ"
2025/09/12 03:34:05 DEBUG : Attempting to move rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ to TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/
2025/09/12 03:34:05 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ-rclone-move-famasup1"
2025/09/12 03:34:06 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ-rclone-move-famasup1': Using server-side directory move
2025/09/12 03:34:06 ERROR : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ-rclone-move-famasup1': Server side directory move failed: directory not found
2025/09/12 03:34:06 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': error attempting to move folder: directory not found
2025/09/12 03:34:06 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:07 DEBUG : fs cache: renaming cache item "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/" to be canonical "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ"
2025/09/12 03:34:07 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Using server-side directory move
2025/09/12 03:34:07 INFO  : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/09/12 03:34:07 ERROR : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ-rclone-move-famasup1': error reading source root directory: directory not found
2025/09/12 03:34:07 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Waiting for checks to finish
2025/09/12 03:34:07 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Waiting for transfers to finish
2025/09/12 03:34:07 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ-rclone-move-famasup1': error attempting to move folder to rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ: directory not found
2025/09/12 03:34:07 NOTICE: (04)  : fix-names /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is NFC: true
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is NFD: false
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is valid UTF8: true
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: true 56685de295805449ca363e93ffd4c7f5
2025/09/12 03:34:07 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:07 DEBUG : HASH old: 56685de295805449ca363e93ffd4c7f5 new: 56685de295805449ca363e93ffd4c7f5 equal: true
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: false d82d09ffc7a9703af61ff473717cc5ea
2025/09/12 03:34:07 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:07 DEBUG : HASH old: d82d09ffc7a9703af61ff473717cc5ea new: 56685de295805449ca363e93ffd4c7f5 equal: false
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: false d82d09ffc7a9703af61ff473717cc5ea
2025/09/12 03:34:07 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:07 DEBUG : HASH old: d82d09ffc7a9703af61ff473717cc5ea new: 56685de295805449ca363e93ffd4c7f5 equal: false
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: true 56685de295805449ca363e93ffd4c7f5
2025/09/12 03:34:07 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:07 DEBUG : HASH old: 56685de295805449ca363e93ffd4c7f5 new: 56685de295805449ca363e93ffd4c7f5 equal: true
2025/09/12 03:34:07 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:07 NOTICE: (05)  : fix-names TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/09/12 03:34:07 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is NFC: true
2025/09/12 03:34:07 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is NFD: false
2025/09/12 03:34:07 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is valid UTF8: true
2025/09/12 03:34:07 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: true bb8419282c10576e2bb9e6827fe90df2
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: bb8419282c10576e2bb9e6827fe90df2 new: bb8419282c10576e2bb9e6827fe90df2 equal: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: false 6c51c9054cfabc2e4db227efcd31cfca
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 6c51c9054cfabc2e4db227efcd31cfca new: bb8419282c10576e2bb9e6827fe90df2 equal: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: false 6c51c9054cfabc2e4db227efcd31cfca
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 6c51c9054cfabc2e4db227efcd31cfca new: bb8419282c10576e2bb9e6827fe90df2 equal: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: true bb8419282c10576e2bb9e6827fe90df2
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: bb8419282c10576e2bb9e6827fe90df2 new: bb8419282c10576e2bb9e6827fe90df2 equal: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:08 NOTICE: (06)  : fix-names /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: is NFC: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: is NFD: false
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: is valid UTF8: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: attempting to fix file -- filename hash: 35b54c7614f01a99539c6b3f1c231f93
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: true 98490c9df406788b611926b2b9b232c4
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 98490c9df406788b611926b2b9b232c4 new: 98490c9df406788b611926b2b9b232c4 equal: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false e10cda9e952e9796e17d69abce5cc182
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: e10cda9e952e9796e17d69abce5cc182 new: 98490c9df406788b611926b2b9b232c4 equal: false
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false 5ab3182299b6085e5cc2acbc5b6e6816
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 5ab3182299b6085e5cc2acbc5b6e6816 new: 98490c9df406788b611926b2b9b232c4 equal: false
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false 774e5c52935d95e1c1cc0d5238355f84
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 774e5c52935d95e1c1cc0d5238355f84 new: 98490c9df406788b611926b2b9b232c4 equal: false
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/filename_contains_ě_.txt: verified file exists at correct path. filename hash: 35b54c7614f01a99539c6b3f1c231f93
2025/09/12 03:34:08 NOTICE: (07)  : fix-names TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: is NFC: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: is NFD: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: is valid UTF8: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: attempting to fix file -- filename hash: 35b54c7614f01a99539c6b3f1c231f93
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: true 38cec836ae10c6618155124a51fd8a2e
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 38cec836ae10c6618155124a51fd8a2e new: 38cec836ae10c6618155124a51fd8a2e equal: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false a221307e301662967b8720223e63887c
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: a221307e301662967b8720223e63887c new: 38cec836ae10c6618155124a51fd8a2e equal: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false 7822d7cf76eb538f13e2136541695b9a
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 7822d7cf76eb538f13e2136541695b9a new: 38cec836ae10c6618155124a51fd8a2e equal: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: file exists: false 532eebb52c4855e277873ad0ecd0232e
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt equal: false
2025/09/12 03:34:08 DEBUG : HASH old: 532eebb52c4855e277873ad0ecd0232e new: 38cec836ae10c6618155124a51fd8a2e equal: false
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/filename_contains_ě_.txt: verified file exists at correct path. filename hash: 35b54c7614f01a99539c6b3f1c231f93
2025/09/12 03:34:08 NOTICE: (08)  : fix-names /tmp/033342bo/ext_paths/path1/測試_check{spc}file
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: is NFC: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: is NFD: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: is valid UTF8: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: file exists: true 42223a3163cb176a06b38d2fb00e6f54
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試_check file new: /tmp/033342bo/ext_paths/path1/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 42223a3163cb176a06b38d2fb00e6f54 new: 42223a3163cb176a06b38d2fb00e6f54 equal: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: file exists: true 42223a3163cb176a06b38d2fb00e6f54
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試_check file new: /tmp/033342bo/ext_paths/path1/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 42223a3163cb176a06b38d2fb00e6f54 new: 42223a3163cb176a06b38d2fb00e6f54 equal: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: file exists: true 42223a3163cb176a06b38d2fb00e6f54
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試_check file new: /tmp/033342bo/ext_paths/path1/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 42223a3163cb176a06b38d2fb00e6f54 new: 42223a3163cb176a06b38d2fb00e6f54 equal: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: file exists: true 42223a3163cb176a06b38d2fb00e6f54
2025/09/12 03:34:08 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試_check file new: /tmp/033342bo/ext_paths/path1/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 42223a3163cb176a06b38d2fb00e6f54 new: 42223a3163cb176a06b38d2fb00e6f54 equal: true
2025/09/12 03:34:08 DEBUG : /tmp/033342bo/ext_paths/path1/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:08 NOTICE: (09)  : fix-names TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check{spc}file
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: is NFC: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: is NFD: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: is valid UTF8: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: file exists: true 432ad39662ebc5310797a4160885fb9b
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 432ad39662ebc5310797a4160885fb9b new: 432ad39662ebc5310797a4160885fb9b equal: true
2025/09/12 03:34:08 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: file exists: true 432ad39662ebc5310797a4160885fb9b
2025/09/12 03:34:08 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file equal: true
2025/09/12 03:34:08 DEBUG : HASH old: 432ad39662ebc5310797a4160885fb9b new: 432ad39662ebc5310797a4160885fb9b equal: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: file exists: true 432ad39662ebc5310797a4160885fb9b
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: 432ad39662ebc5310797a4160885fb9b new: 432ad39662ebc5310797a4160885fb9b equal: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: file exists: true 432ad39662ebc5310797a4160885fb9b
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: 432ad39662ebc5310797a4160885fb9b new: 432ad39662ebc5310797a4160885fb9b equal: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:09 NOTICE: (10)  : fix-names /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is NFC: true
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is NFD: false
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: is valid UTF8: true
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: true 56685de295805449ca363e93ffd4c7f5
2025/09/12 03:34:09 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: 56685de295805449ca363e93ffd4c7f5 new: 56685de295805449ca363e93ffd4c7f5 equal: true
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: false d82d09ffc7a9703af61ff473717cc5ea
2025/09/12 03:34:09 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:09 DEBUG : HASH old: d82d09ffc7a9703af61ff473717cc5ea new: 56685de295805449ca363e93ffd4c7f5 equal: false
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: false d82d09ffc7a9703af61ff473717cc5ea
2025/09/12 03:34:09 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:09 DEBUG : HASH old: d82d09ffc7a9703af61ff473717cc5ea new: 56685de295805449ca363e93ffd4c7f5 equal: false
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: file exists: true 56685de295805449ca363e93ffd4c7f5
2025/09/12 03:34:09 DEBUG : FILE old: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file new: /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: 56685de295805449ca363e93ffd4c7f5 new: 56685de295805449ca363e93ffd4c7f5 equal: true
2025/09/12 03:34:09 DEBUG : /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:09 NOTICE: (11)  : fix-names TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is NFC: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is NFD: false
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: is valid UTF8: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: attempting to fix file -- filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: true bb8419282c10576e2bb9e6827fe90df2
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: bb8419282c10576e2bb9e6827fe90df2 new: bb8419282c10576e2bb9e6827fe90df2 equal: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: false 6c51c9054cfabc2e4db227efcd31cfca
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:09 DEBUG : HASH old: 6c51c9054cfabc2e4db227efcd31cfca new: bb8419282c10576e2bb9e6827fe90df2 equal: false
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: false 6c51c9054cfabc2e4db227efcd31cfca
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: false
2025/09/12 03:34:09 DEBUG : HASH old: 6c51c9054cfabc2e4db227efcd31cfca new: bb8419282c10576e2bb9e6827fe90df2 equal: false
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: file exists: true bb8419282c10576e2bb9e6827fe90df2
2025/09/12 03:34:09 DEBUG : FILE old: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file new: rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file equal: true
2025/09/12 03:34:09 DEBUG : HASH old: bb8419282c10576e2bb9e6827fe90df2 new: bb8419282c10576e2bb9e6827fe90df2 equal: true
2025/09/12 03:34:09 DEBUG : rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_check file: verified file exists at correct path. filename hash: b8b5a45ae30d02ead1e2872b8b2241a5
2025/09/12 03:34:09 NOTICE: (12)  : test resync subdirs with extended chars
2025/09/12 03:34:09 NOTICE: (13)  : bisync subdir=測試Русский{spc}{spc}ěáñ resync
2025/09/12 03:34:11 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:11 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:11 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:11 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:11 INFO  : Copying Path2 files to Path1
2025/09/12 03:34:11 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:34:12 INFO  : There was nothing to transfer
2025/09/12 03:34:12 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:34:12 INFO  : There was nothing to transfer
2025/09/12 03:34:12 INFO  : Resync updating listings
2025/09/12 03:34:12 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:12 INFO  : Bisync successful
2025/09/12 03:34:12 NOTICE: (14)  : copy-listings resync
2025/09/12 03:34:12 NOTICE: (15)  : test place new files with extended chars on each side
2025/09/12 03:34:12 NOTICE: (16)  : touch-glob 2001-01-02 /tmp/033342bo/datadir/test_ext_paths-gemovaj4/ file1.txt
2025/09/12 03:34:12 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/"
2025/09/12 03:34:12 DEBUG : fs cache: renaming cache item "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/" to be canonical "/tmp/033342bo/datadir/test_ext_paths-gemovaj4"
2025/09/12 03:34:12 DEBUG : file1.txt: Set modification time 2001-01-02
2025/09/12 03:34:12 NOTICE: (17)  : copy-as /tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ 測試_file1p1
2025/09/12 03:34:12 DEBUG : copyFile "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt" to "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ" as "測試_file1p1"
2025/09/12 03:34:12 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt"
2025/09/12 03:34:12 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ"
2025/09/12 03:34:12 DEBUG : operations.CopyFile "file1.txt" to "Local file system at /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ" as "測試_file1p1"
2025/09/12 03:34:12 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:12 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:12 DEBUG : 測試_file1p1.44ea53d8.partial: renamed to: 測試_file1p1
2025/09/12 03:34:12 INFO  : file1.txt: Copied (new) to: 測試_file1p1
2025/09/12 03:34:12 NOTICE: (18)  : copy-as /tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский{spc}{spc}ěáñ 測試_file1p2
2025/09/12 03:34:12 DEBUG : copyFile "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt" to "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ" as "測試_file1p2"
2025/09/12 03:34:12 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt"
2025/09/12 03:34:12 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ"
2025/09/12 03:34:12 DEBUG : operations.CopyFile "file1.txt" to "pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ'" as "測試_file1p2"
2025/09/12 03:34:12 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:12 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:13 DEBUG : 測試_file1p2.1ffde2cd.partial: renamed to: 測試_file1p2
2025/09/12 03:34:13 INFO  : file1.txt: Copied (new) to: 測試_file1p2
2025/09/12 03:34:13 NOTICE: (19)  : test normal sync of subdirs with extended chars
2025/09/12 03:34:13 NOTICE: (20)  : bisync subdir=測試Русский{spc}{spc}ěáñ
2025/09/12 03:34:15 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:15 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:15 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:15 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:15 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:15 INFO  : Path1 checking for diffs
2025/09/12 03:34:15 INFO  : - Path1    File is new               - 測試_file1p1
2025/09/12 03:34:15 INFO  : Path1:    1 changes:    1 new,    0 modified,    0 deleted
2025/09/12 03:34:15 INFO  : Path2 checking for diffs
2025/09/12 03:34:15 INFO  : - Path2    File is new               - 測試_file1p2
2025/09/12 03:34:15 INFO  : Path2:    1 changes:    1 new,    0 modified,    0 deleted
2025/09/12 03:34:15 INFO  : Applying changes
2025/09/12 03:34:15 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/測試_file1p1
2025/09/12 03:34:15 INFO  : - Path2    Queue copy to Path1       - /tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/測試_file1p2
2025/09/12 03:34:15 INFO  : - Path2    Do queued copies to                - Path1
2025/09/12 03:34:15 INFO  : 測試_file1p2: Copied (new)
2025/09/12 03:34:15 INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:34:15 INFO  : 測試_file1p1: Copied (new)
2025/09/12 03:34:15 INFO  : Updating listings
2025/09/12 03:34:15 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/測試Русский  ěáñ/"
2025/09/12 03:34:15 INFO  : Bisync successful
2025/09/12 03:34:15 NOTICE: (21)  : move-listings normal-sync
2025/09/12 03:34:15 NOTICE: (22)  : test check-filename with extended chars. check should fail.
2025/09/12 03:34:15 NOTICE: (23)  : bisync resync
2025/09/12 03:34:18 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:18 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:18 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:18 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:18 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:18 INFO  : Copying Path2 files to Path1
2025/09/12 03:34:18 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:34:18 INFO  : There was nothing to transfer
2025/09/12 03:34:18 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:34:18 INFO  : There was nothing to transfer
2025/09/12 03:34:18 INFO  : Resync updating listings
2025/09/12 03:34:18 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:18 INFO  : Bisync successful
2025/09/12 03:34:18 NOTICE: (24)  : delete-file /tmp/033342bo/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/09/12 03:34:18 DEBUG : fs cache: switching user supplied name "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ/" for canonical name "/tmp/033342bo/ext_paths/path1/測試Русский  ěáñ"
2025/09/12 03:34:18 INFO  : 測試_check file: Deleted
2025/09/12 03:34:18 NOTICE: (25)  : bisync check-access check-filename=測試_check{spc}file
2025/09/12 03:34:20 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:20 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:20 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:20 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:20 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:20 INFO  : Path1 checking for diffs
2025/09/12 03:34:20 INFO  : - Path1    File was deleted          - 測試Русский  ěáñ/測試_check file
2025/09/12 03:34:20 INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/09/12 03:34:20 INFO  : Path2 checking for diffs
2025/09/12 03:34:20 INFO  : Checking access health
2025/09/12 03:34:20 ERROR : Access test failed: Path1 count 1, Path2 count 2 - 測試_check file
2025/09/12 03:34:20 ERROR : -          Access test failed: Path2 file not found in Path1 - 測試Русский  ěáñ/測試_check file
2025/09/12 03:34:20 ERROR : Bisync critical error: check file check failed
2025/09/12 03:34:20 ERROR : Bisync aborted. Must run --resync to recover.
2025/09/12 03:34:20 NOTICE: Bisync error: bisync aborted
2025/09/12 03:34:20 NOTICE: (26)  : copy-listings check-access-fail
2025/09/12 03:34:20 NOTICE: (27)  : test check-filename with extended chars. check should pass.
2025/09/12 03:34:20 NOTICE: (28)  : bisync resync
2025/09/12 03:34:23 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:23 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:23 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:23 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:23 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:23 INFO  : Copying Path2 files to Path1
2025/09/12 03:34:23 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:34:23 INFO  : modtime_write_test: Copied (new)
2025/09/12 03:34:23 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/09/12 03:34:23 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:23 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:34:23 INFO  : modtime_write_test: Copied (new)
2025/09/12 03:34:23 INFO  : Resync updating listings
2025/09/12 03:34:23 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:23 INFO  : Bisync successful
2025/09/12 03:34:23 NOTICE: (29)  : bisync check-access check-filename=測試_check{spc}file
2025/09/12 03:34:26 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:26 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:26 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:26 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:26 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:26 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:26 INFO  : Path1 checking for diffs
2025/09/12 03:34:26 INFO  : - Path1    File was deleted          - modtime_write_test
2025/09/12 03:34:26 INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/09/12 03:34:26 INFO  : Path2 checking for diffs
2025/09/12 03:34:26 INFO  : Checking access health
2025/09/12 03:34:26 INFO  : Found 2 matching "測試_check file" files on both paths
2025/09/12 03:34:26 INFO  : Applying changes
2025/09/12 03:34:26 INFO  : - Path2    Queue delete              - TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/modtime_write_test
2025/09/12 03:34:26 INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:34:26 INFO  : modtime_write_test: Deleted
2025/09/12 03:34:26 INFO  : There was nothing to transfer
2025/09/12 03:34:26 INFO  : Updating listings
2025/09/12 03:34:26 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:26 INFO  : Bisync successful
2025/09/12 03:34:26 NOTICE: (30)  : move-listings check-access-pass
2025/09/12 03:34:26 NOTICE: (31)  : test filters-file path with extended chars - masks /fileZ.txt
2025/09/12 03:34:26 NOTICE: (32)  : copy-file /tmp/033342bo/datadir/test_ext_paths-gemovaj4/測試_filtersfile.txt /tmp/033342bo/workdir/
2025/09/12 03:34:26 DEBUG : copyFile "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/測試_filtersfile.txt" to "/tmp/033342bo/workdir/" as ""
2025/09/12 03:34:26 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/測試_filtersfile.txt"
2025/09/12 03:34:26 DEBUG : Creating backend with remote "/tmp/033342bo/workdir/"
2025/09/12 03:34:26 DEBUG : operations.CopyFile "測試_filtersfile.txt" to "Local file system at /tmp/033342bo/workdir" as "測試_filtersfile.txt"
2025/09/12 03:34:26 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:26 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK
2025/09/12 03:34:26 DEBUG : 測試_filtersfile.txt.ce49fba4.partial: renamed to: 測試_filtersfile.txt
2025/09/12 03:34:26 INFO  : 測試_filtersfile.txt: Copied (new)
2025/09/12 03:34:26 NOTICE: (33)  : bisync filters-file=/tmp/033342bo/workdir/測試_filtersfile.txt resync
2025/09/12 03:34:28 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:28 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:28 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:28 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:28 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:28 INFO  : Using filters file /tmp/033342bo/workdir/測試_filtersfile.txt
2025/09/12 03:34:28 INFO  : Storing filters file hash to /tmp/033342bo/workdir/測試_filtersfile.txt.md5
2025/09/12 03:34:28 INFO  : Copying Path2 files to Path1
2025/09/12 03:34:28 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:34:28 INFO  : There was nothing to transfer
2025/09/12 03:34:28 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:34:29 INFO  : There was nothing to transfer
2025/09/12 03:34:29 INFO  : Resync updating listings
2025/09/12 03:34:29 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:29 INFO  : Bisync successful
2025/09/12 03:34:29 NOTICE: (34)  : copy-as /tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt /tmp/033342bo/ext_paths/path1/ fileZ.txt
2025/09/12 03:34:29 DEBUG : copyFile "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt" to "/tmp/033342bo/ext_paths/path1/" as "fileZ.txt"
2025/09/12 03:34:29 DEBUG : Creating backend with remote "/tmp/033342bo/datadir/test_ext_paths-gemovaj4/file1.txt"
2025/09/12 03:34:29 DEBUG : Creating backend with remote "/tmp/033342bo/ext_paths/path1/"
2025/09/12 03:34:29 DEBUG : operations.CopyFile "file1.txt" to "Local file system at /tmp/033342bo/ext_paths/path1" as "fileZ.txt"
2025/09/12 03:34:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:29 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:29 DEBUG : fileZ.txt.64882095.partial: renamed to: fileZ.txt
2025/09/12 03:34:29 INFO  : file1.txt: Copied (new) to: fileZ.txt
2025/09/12 03:34:29 NOTICE: (35)  : bisync filters-file=/tmp/033342bo/workdir/測試_filtersfile.txt
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/09/12 03:34:31 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:31 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:31 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/09/12 03:34:31 INFO  : Synching Path1 "/tmp/033342bo/ext_paths/path1/" with Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:31 INFO  : Using filters file /tmp/033342bo/workdir/測試_filtersfile.txt
2025/09/12 03:34:31 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:31 INFO  : Path1 checking for diffs
2025/09/12 03:34:31 INFO  : Path2 checking for diffs
2025/09/12 03:34:31 INFO  : No changes found
2025/09/12 03:34:31 INFO  : Updating listings
2025/09/12 03:34:31 INFO  : Validating listings for Path1 "/tmp/033342bo/ext_paths/path1/" vs Path2 "TestPcloud:rclone-test-xihuzey2xuvo/033342bo/ext_paths/path2/"
2025/09/12 03:34:31 INFO  : Bisync successful
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 NOTICE: MISCOMPARE - Number of Golden and Results files do not match:
2025/09/12 03:34:31 NOTICE:   Golden count: 33
2025/09/12 03:34:31 NOTICE:   Result count: 35
2025/09/12 03:34:31 NOTICE:   Golden files: _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, check-access-fail._testdir_path1.._testdir_path2.path1.lst-err, check-access-fail._testdir_path1.._testdir_path2.path1.lst-new, check-access-fail._testdir_path1.._testdir_path2.path2.lst-err, check-access-fail._testdir_path1.._testdir_path2.path2.lst-new, check-access-pass._testdir_path1.._testdir_path2.path1.lst, check-access-pass._testdir_path1.._testdir_path2.path1.lst-err, check-access-pass._testdir_path1.._testdir_path2.path1.lst-new, check-access-pass._testdir_path1.._testdir_path2.path1.lst-old, check-access-pass._testdir_path1.._testdir_path2.path2.lst, check-access-pass._testdir_path1.._testdir_path2.path2.lst-err, check-access-pass._testdir_path1.._testdir_path2.path2.lst-new, check-access-pass._testdir_path1.._testdir_path2.path2.lst-old, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.copy1to2.que, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.copy2to1.que, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-new, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-old, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-new, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-old, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-new, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-new, test.log, 測試_filtersfile.txt, 測試_filtersfile.txt.md5
2025/09/12 03:34:31 NOTICE:   Result files: _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, check-access-fail._testdir_path1.._testdir_path2.path1.lst-err, check-access-fail._testdir_path1.._testdir_path2.path1.lst-new, check-access-fail._testdir_path1.._testdir_path2.path2.lst-err, check-access-fail._testdir_path1.._testdir_path2.path2.lst-new, check-access-pass._testdir_path1.._testdir_path2.copy1to2.que, check-access-pass._testdir_path1.._testdir_path2.delete2.que, check-access-pass._testdir_path1.._testdir_path2.path1.lst, check-access-pass._testdir_path1.._testdir_path2.path1.lst-err, check-access-pass._testdir_path1.._testdir_path2.path1.lst-new, check-access-pass._testdir_path1.._testdir_path2.path1.lst-old, check-access-pass._testdir_path1.._testdir_path2.path2.lst, check-access-pass._testdir_path1.._testdir_path2.path2.lst-err, check-access-pass._testdir_path1.._testdir_path2.path2.lst-new, check-access-pass._testdir_path1.._testdir_path2.path2.lst-old, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.copy1to2.que, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.copy2to1.que, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-new, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-old, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-new, normal-sync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-old, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path1.lst-new, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst, resync._testdir_path1_測試Русский__ěáñ.._testdir_path2_測試Русский__ěáñ.path2.lst-new, test.log, 測試_filtersfile.txt, 測試_filtersfile.txt.md5
2025/09/12 03:34:31 NOTICE:   File found in Results but not in Golden:  check-access-pass._testdir_path1.._testdir_path2.copy1to2.que
2025/09/12 03:34:31 NOTICE:   File found in Results but not in Golden:  check-access-pass._testdir_path1.._testdir_path2.delete2.que
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 NOTICE: | MISCOMPARE  -Golden vs +Results for  check-access-pass._testdir_path1.._testdir_path2.path1.lst-old
2025/09/12 03:34:31 NOTICE: | @@ -9,0 +10,2 @@
2025/09/12 03:34:31 NOTICE: | +
2025/09/12 03:34:31 NOTICE: | +-       18 - - 2000-01-01 00:00:00 +0000 UTC "\"modtime_write_test\""
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 NOTICE: | MISCOMPARE  -Golden vs +Results for  check-access-pass._testdir_path1.._testdir_path2.path2.lst-new
2025/09/12 03:34:31 NOTICE: | @@ -9,0 +10,2 @@
2025/09/12 03:34:31 NOTICE: | +
2025/09/12 03:34:31 NOTICE: | +-       18 - - 2000-01-01 00:00:00 +0000 UTC "\"modtime_write_test\""
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 NOTICE: | MISCOMPARE  -Golden vs +Results for  check-access-pass._testdir_path1.._testdir_path2.path2.lst-old
2025/09/12 03:34:31 NOTICE: | @@ -9,0 +10,2 @@
2025/09/12 03:34:31 NOTICE: | +
2025/09/12 03:34:31 NOTICE: | +-       18 - - 2000-01-01 00:00:00 +0000 UTC "\"modtime_write_test\""
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 NOTICE: | MISCOMPARE  -Golden vs +Results for  test.log
2025/09/12 03:34:31 NOTICE: | @@ -141,0 +142,2 @@
2025/09/12 03:34:31 NOTICE: | +INFO  : - Path1    File was deleted          - modtime_write_test
2025/09/12 03:34:31 NOTICE: | +INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/09/12 03:34:31 NOTICE: | @@ -145 +147,3 @@
2025/09/12 03:34:31 NOTICE: | -INFO  : No changes found
2025/09/12 03:34:31 NOTICE: | +INFO  : Applying changes
2025/09/12 03:34:31 NOTICE: | +INFO  : - Path2    Queue delete              - {path2/}modtime_write_test
2025/09/12 03:34:31 NOTICE: | +INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:34:31 NOTICE: ----------------------------------------------------------
2025/09/12 03:34:31 DEBUG : Waiting for deletions to finish
2025/09/12 03:34:31 INFO  : RCLONE_TEST: Deleted
2025/09/12 03:34:31 INFO  : file_enconde_mañana_funcionará.txt: Deleted
2025/09/12 03:34:31 INFO  : file1.txt: Deleted
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Deleted
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ/測試_check file: Deleted
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ/測試_file1p1: Deleted
2025/09/12 03:34:31 INFO  : filename_contains_ě_.txt: Deleted
2025/09/12 03:34:31 INFO  : filename_contains_ࢺ_.txt: Deleted
2025/09/12 03:34:31 INFO  : 測試_check file: Deleted
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Deleted
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ/測試_file1p2: Deleted
2025/09/12 03:34:31 INFO  : Русский.txt: Deleted
2025/09/12 03:34:31 INFO  : fileZ.txt: Deleted
2025/09/12 03:34:31 DEBUG : removing 1 level 1 directories
2025/09/12 03:34:31 INFO  : 測試Русский  ěáñ: Removing directory
2025/09/12 03:34:31 DEBUG : removing 1 level 0 directories
2025/09/12 03:34:31 INFO  : Local file system at /tmp/033342bo/ext_paths/path1: Removing directory
    bisync_test.go:608: TEST ext_paths FAILED - 6 MISCOMPARED FILES
2025/09/12 03:34:31 DEBUG : pcloud root 'rclone-test-xihuzey2xuvo': Purge remote
--- FAIL: TestBisyncLocalRemote (49.89s)
    --- PASS: TestBisyncLocalRemote/basic (18.22s)
    --- FAIL: TestBisyncLocalRemote/ext_paths (30.71s)
=== RUN   TestBisyncRemoteRemote
2025/09/12 03:34:32 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze"
2025/09/12 03:34:32 NOTICE: remote: TestPcloud:rclone-test-walavuw6neze
=== RUN   TestBisyncRemoteRemote/changes
2025/09/12 03:34:32 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so"
2025/09/12 03:34:33 INFO  : path1: Making directory
2025/09/12 03:34:33 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1"
2025/09/12 03:34:34 INFO  : path2: Making directory
2025/09/12 03:34:34 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2"
2025/09/12 03:34:35 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/initial"
2025/09/12 03:34:35 DEBUG : Creating backend with remote "/tmp/033432so/initdir/test_changes-yejopiv3"
2025/09/12 03:34:35 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:34:35 INFO  : file2.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : Local file system at /tmp/033432so/initdir/test_changes-yejopiv3: Waiting for checks to finish
2025/09/12 03:34:35 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : Local file system at /tmp/033432so/initdir/test_changes-yejopiv3: Waiting for transfers to finish
2025/09/12 03:34:35 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:35 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/09/12 03:34:35 INFO  : file4.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/09/12 03:34:35 INFO  : file3.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/09/12 03:34:35 INFO  : file5.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:34:35 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/09/12 03:34:35 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 INFO  : file8.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:34:35 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/09/12 03:34:35 INFO  : file7.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:35 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:35 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/09/12 03:34:35 INFO  : file6.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/modfiles"
2025/09/12 03:34:35 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:35 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:35 DEBUG : Local file system at /tmp/033432so/datadir/test_changes-koxiwaj5: Waiting for checks to finish
2025/09/12 03:34:35 DEBUG : Local file system at /tmp/033432so/datadir/test_changes-koxiwaj5: Waiting for transfers to finish
2025/09/12 03:34:35 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:35 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:35 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:35 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/09/12 03:34:35 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:34:35 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt
2025/09/12 03:34:35 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:35 INFO  : file11.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/09/12 03:34:35 INFO  : file10.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt
2025/09/12 03:34:35 INFO  : file2.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/09/12 03:34:35 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2025/09/12 03:34:35 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/09/12 03:34:35 INFO  : file5R.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:35 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt
2025/09/12 03:34:35 INFO  : file7.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2025/09/12 03:34:35 INFO  : file5L.txt: Copied (new)
2025/09/12 03:34:35 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:34:35 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/09/12 03:34:35 INFO  : file6.txt: Copied (new)
2025/09/12 03:34:35 NOTICE: checking initFs Local file system at /tmp/033432so/initdir/test_changes-yejopiv3
2025/09/12 03:34:36 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:36 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1': Waiting for checks to finish
2025/09/12 03:34:36 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1': Waiting for transfers to finish
2025/09/12 03:34:36 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:34:36 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:36 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:36 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:36 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/09/12 03:34:36 INFO  : file3.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:34:36 INFO  : file2.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:36 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/09/12 03:34:36 INFO  : file4.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/09/12 03:34:36 INFO  : file6.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/09/12 03:34:36 INFO  : file5.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/09/12 03:34:36 INFO  : file7.txt: Copied (new)
2025/09/12 03:34:36 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:37 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/09/12 03:34:37 INFO  : file8.txt: Copied (new)
2025/09/12 03:34:37 NOTICE: checking Path1 pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1'
2025/09/12 03:34:38 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:38 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': Waiting for checks to finish
2025/09/12 03:34:38 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': Waiting for transfers to finish
2025/09/12 03:34:38 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:34:38 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:34:38 INFO  : file1.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:34:38 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:34:38 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:34:38 INFO  : file2.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/09/12 03:34:38 INFO  : file3.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/09/12 03:34:38 INFO  : file4.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/09/12 03:34:38 INFO  : file5.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/09/12 03:34:38 INFO  : file6.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/09/12 03:34:38 INFO  : file7.txt: Copied (new)
2025/09/12 03:34:38 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:34:38 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/09/12 03:34:38 INFO  : file8.txt: Copied (new)
2025/09/12 03:34:38 NOTICE: checking path2 pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2'
2025/09/12 03:34:39 NOTICE: (01)  : test changes
2025/09/12 03:34:39 NOTICE: (02)  : test initial bisync
2025/09/12 03:34:39 NOTICE: (03)  : bisync resync
2025/09/12 03:34:44 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:44 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:44 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:44 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:34:44 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:44 INFO  : Copying Path2 files to Path1
2025/09/12 03:34:44 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:34:44 INFO  : There was nothing to transfer
2025/09/12 03:34:44 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:34:44 INFO  : There was nothing to transfer
2025/09/12 03:34:44 INFO  : Resync updating listings
2025/09/12 03:34:44 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:44 INFO  : Bisync successful
2025/09/12 03:34:44 NOTICE: (04)  : test make modifications on both paths
2025/09/12 03:34:44 NOTICE: (05)  : test new on path2 - file10
2025/09/12 03:34:44 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file10.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/
2025/09/12 03:34:44 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/"
2025/09/12 03:34:44 DEBUG : fs cache: renaming cache item "/tmp/033432so/datadir/test_changes-koxiwaj5/" to be canonical "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:44 DEBUG : file10.txt: Set modification time 2001-01-02
2025/09/12 03:34:44 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file10.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" as ""
2025/09/12 03:34:44 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file10.txt"
2025/09/12 03:34:44 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:44 DEBUG : operations.CopyFile "file10.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2'" as "file10.txt"
2025/09/12 03:34:44 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:44 DEBUG : file10.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:45 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/09/12 03:34:45 INFO  : file10.txt: Copied (new)
2025/09/12 03:34:45 NOTICE: (07)  : test newer on path2 - file1
2025/09/12 03:34:45 NOTICE: (08)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file1.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/
2025/09/12 03:34:45 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:45 DEBUG : file1.txt: Set modification time 2001-01-02
2025/09/12 03:34:45 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file1.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" as ""
2025/09/12 03:34:45 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file1.txt"
2025/09/12 03:34:45 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:45 DEBUG : operations.CopyFile "file1.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2'" as "file1.txt"
2025/09/12 03:34:45 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:34:45 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:45 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:34:45 INFO  : file1.txt: Copied (replaced existing)
2025/09/12 03:34:45 NOTICE: (09)  : test new on path1 - file11
2025/09/12 03:34:45 NOTICE: (10)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file11.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/
2025/09/12 03:34:45 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:45 DEBUG : file11.txt: Set modification time 2001-01-02
2025/09/12 03:34:45 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file11.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" as ""
2025/09/12 03:34:45 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file11.txt"
2025/09/12 03:34:45 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/"
2025/09/12 03:34:46 DEBUG : operations.CopyFile "file11.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1'" as "file11.txt"
2025/09/12 03:34:46 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/09/12 03:34:46 DEBUG : file11.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:46 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt
2025/09/12 03:34:46 INFO  : file11.txt: Copied (new)
2025/09/12 03:34:46 NOTICE: (11)  : test newer on path1 - file2
2025/09/12 03:34:46 NOTICE: (12)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file2.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/
2025/09/12 03:34:46 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:46 DEBUG : file2.txt: Set modification time 2001-01-02
2025/09/12 03:34:46 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file2.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" as ""
2025/09/12 03:34:46 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file2.txt"
2025/09/12 03:34:46 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/"
2025/09/12 03:34:47 DEBUG : operations.CopyFile "file2.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1'" as "file2.txt"
2025/09/12 03:34:47 DEBUG : file2.txt: Sizes differ (src 13 vs dst 0)
2025/09/12 03:34:47 DEBUG : file2.txt: sha1 = ad47b80be37ef407e5ea1c4b11030c928d02972d OK
2025/09/12 03:34:47 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt
2025/09/12 03:34:47 INFO  : file2.txt: Copied (replaced existing)
2025/09/12 03:34:47 NOTICE: (13)  : test deleted on path2 - file3
2025/09/12 03:34:47 NOTICE: (14)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file3.txt
2025/09/12 03:34:47 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:47 DEBUG : fs cache: renaming cache item "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" to be canonical "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2"
2025/09/12 03:34:48 INFO  : file3.txt: Deleted
2025/09/12 03:34:48 NOTICE: (15)  : test deleted on path1 - file4
2025/09/12 03:34:48 NOTICE: (16)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file4.txt
2025/09/12 03:34:48 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/"
2025/09/12 03:34:48 DEBUG : fs cache: renaming cache item "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" to be canonical "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1"
2025/09/12 03:34:48 INFO  : file4.txt: Deleted
2025/09/12 03:34:48 NOTICE: (17)  : test deleted on both paths - file8
2025/09/12 03:34:48 NOTICE: (18)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file8.txt
2025/09/12 03:34:48 DEBUG : fs cache: switching user supplied name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" for canonical name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1"
2025/09/12 03:34:48 INFO  : file8.txt: Deleted
2025/09/12 03:34:48 NOTICE: (19)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file8.txt
2025/09/12 03:34:48 DEBUG : fs cache: switching user supplied name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" for canonical name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2"
2025/09/12 03:34:49 INFO  : file8.txt: Deleted
2025/09/12 03:34:49 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/09/12 03:34:49 NOTICE: (21)  : touch-glob 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/ file5R.txt
2025/09/12 03:34:49 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:49 DEBUG : file5R.txt: Set modification time 2001-01-02
2025/09/12 03:34:49 NOTICE: (22)  : copy-as /tmp/033432so/datadir/test_changes-koxiwaj5/file5R.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/ file5.txt
2025/09/12 03:34:49 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file5R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" as "file5.txt"
2025/09/12 03:34:49 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file5R.txt"
2025/09/12 03:34:49 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:49 DEBUG : operations.CopyFile "file5R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2'" as "file5.txt"
2025/09/12 03:34:49 DEBUG : file5R.txt: Sizes differ (src 39 vs dst 0)
2025/09/12 03:34:49 DEBUG : file5R.txt: sha1 = 95a9e2f00e77e296ff94d0242db00b946657c53f OK
2025/09/12 03:34:49 DEBUG : file5.txt.232124ee.partial: renamed to: file5.txt
2025/09/12 03:34:49 INFO  : file5R.txt: Copied (replaced existing) to: file5.txt
2025/09/12 03:34:49 NOTICE: (23)  : touch-glob 2001-03-04 /tmp/033432so/datadir/test_changes-koxiwaj5/ file5L.txt
2025/09/12 03:34:49 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:49 DEBUG : file5L.txt: Set modification time 2001-03-04
2025/09/12 03:34:49 NOTICE: (24)  : copy-as /tmp/033432so/datadir/test_changes-koxiwaj5/file5L.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/ file5.txt
2025/09/12 03:34:49 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file5L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" as "file5.txt"
2025/09/12 03:34:49 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file5L.txt"
2025/09/12 03:34:49 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/"
2025/09/12 03:34:50 DEBUG : operations.CopyFile "file5L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1'" as "file5.txt"
2025/09/12 03:34:50 DEBUG : file5L.txt: Sizes differ (src 39 vs dst 0)
2025/09/12 03:34:50 DEBUG : file5L.txt: sha1 = ccec2fd408a4b442e0b4902afb6be0bb9863b78c OK
2025/09/12 03:34:50 DEBUG : file5.txt.4a946ad2.partial: renamed to: file5.txt
2025/09/12 03:34:50 INFO  : file5L.txt: Copied (replaced existing) to: file5.txt
2025/09/12 03:34:50 NOTICE: (25)  : test newer on path2 and deleted on path1 - file6
2025/09/12 03:34:50 NOTICE: (26)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file6.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/
2025/09/12 03:34:50 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:50 DEBUG : file6.txt: Set modification time 2001-01-02
2025/09/12 03:34:50 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file6.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" as ""
2025/09/12 03:34:50 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file6.txt"
2025/09/12 03:34:50 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:51 DEBUG : operations.CopyFile "file6.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2'" as "file6.txt"
2025/09/12 03:34:51 DEBUG : file6.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:34:51 DEBUG : file6.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:51 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/09/12 03:34:51 INFO  : file6.txt: Copied (replaced existing)
2025/09/12 03:34:51 NOTICE: (27)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file6.txt
2025/09/12 03:34:51 DEBUG : fs cache: switching user supplied name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" for canonical name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1"
2025/09/12 03:34:51 INFO  : file6.txt: Deleted
2025/09/12 03:34:51 NOTICE: (28)  : test newer on path1 and deleted on path2 - file7
2025/09/12 03:34:51 NOTICE: (29)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_changes-koxiwaj5/file7.txt TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/
2025/09/12 03:34:51 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_changes-koxiwaj5/" for canonical name "/tmp/033432so/datadir/test_changes-koxiwaj5"
2025/09/12 03:34:51 DEBUG : file7.txt: Set modification time 2001-01-02
2025/09/12 03:34:51 DEBUG : copyFile "/tmp/033432so/datadir/test_changes-koxiwaj5/file7.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" as ""
2025/09/12 03:34:51 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_changes-koxiwaj5/file7.txt"
2025/09/12 03:34:51 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/"
2025/09/12 03:34:52 DEBUG : operations.CopyFile "file7.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1'" as "file7.txt"
2025/09/12 03:34:52 DEBUG : file7.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:34:52 DEBUG : file7.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:34:52 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt
2025/09/12 03:34:52 INFO  : file7.txt: Copied (replaced existing)
2025/09/12 03:34:52 NOTICE: (30)  : delete-file TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file7.txt
2025/09/12 03:34:52 DEBUG : fs cache: switching user supplied name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/" for canonical name "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2"
2025/09/12 03:34:52 INFO  : file7.txt: Deleted
2025/09/12 03:34:52 NOTICE: (31)  : test bisync run
2025/09/12 03:34:52 NOTICE: (32)  : bisync
2025/09/12 03:34:57 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:57 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:34:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:34:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:34:57 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:57 INFO  : Building Path1 and Path2 listings
2025/09/12 03:34:57 INFO  : Path1 checking for diffs
2025/09/12 03:34:57 INFO  : - Path1    File changed: size (larger), time (newer) - file2.txt
2025/09/12 03:34:57 INFO  : - Path1    File was deleted          - file4.txt
2025/09/12 03:34:57 INFO  : - Path1    File changed: size (larger), time (newer) - file5.txt
2025/09/12 03:34:57 INFO  : - Path1    File was deleted          - file6.txt
2025/09/12 03:34:57 INFO  : - Path1    File changed: size (larger), time (newer) - file7.txt
2025/09/12 03:34:57 INFO  : - Path1    File was deleted          - file8.txt
2025/09/12 03:34:57 INFO  : - Path1    File is new               - file11.txt
2025/09/12 03:34:57 INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/09/12 03:34:57 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/09/12 03:34:57 INFO  : Path2 checking for diffs
2025/09/12 03:34:57 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/09/12 03:34:57 INFO  : - Path2    File was deleted          - file3.txt
2025/09/12 03:34:57 INFO  : - Path2    File changed: size (larger), time (newer) - file5.txt
2025/09/12 03:34:57 INFO  : - Path2    File changed: size (larger), time (newer) - file6.txt
2025/09/12 03:34:57 INFO  : - Path2    File was deleted          - file7.txt
2025/09/12 03:34:57 INFO  : - Path2    File was deleted          - file8.txt
2025/09/12 03:34:57 INFO  : - Path2    File is new               - file10.txt
2025/09/12 03:34:57 INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/09/12 03:34:57 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/09/12 03:34:57 INFO  : Applying changes
2025/09/12 03:34:57 INFO  : Checking potential conflicts...
2025/09/12 03:34:57 ERROR : file5.txt: sha1 differ
2025/09/12 03:34:57 NOTICE: pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': 1 differences found
2025/09/12 03:34:57 NOTICE: pcloud root 'rclone-test-walavuw6neze/033432so/changes/path2': 1 errors while checking
2025/09/12 03:34:57 INFO  : Finished checking the potential conflicts. 1 differences found
2025/09/12 03:34:57 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file11.txt
2025/09/12 03:34:57 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file2.txt
2025/09/12 03:34:57 INFO  : - Path2    Queue delete              - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file4.txt
2025/09/12 03:34:57 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/09/12 03:34:57 NOTICE: - Path1    Renaming Path1 copy                - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file5.txt.conflict1
2025/09/12 03:34:57 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/09/12 03:34:57 NOTICE: - Path1    Queue copy to Path2       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file5.txt.conflict1
2025/09/12 03:34:57 NOTICE: - Path2    Renaming Path2 copy                - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file5.txt.conflict2
2025/09/12 03:34:57 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/09/12 03:34:57 NOTICE: - Path2    Queue copy to Path1       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file5.txt.conflict2
2025/09/12 03:34:57 INFO  : - Path2    Queue copy to Path1       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file6.txt
2025/09/12 03:34:57 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/file7.txt
2025/09/12 03:34:57 INFO  : - Path2    Queue copy to Path1       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file1.txt
2025/09/12 03:34:57 INFO  : - Path2    Queue copy to Path1       - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file10.txt
2025/09/12 03:34:57 INFO  : - Path1    Queue delete              - TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/file3.txt
2025/09/12 03:34:57 INFO  : - Path2    Do queued copies to                - Path1
2025/09/12 03:34:58 INFO  : file10.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file5.txt.conflict2: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file6.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file3.txt: Deleted
2025/09/12 03:34:58 INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:34:58 INFO  : file11.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file5.txt.conflict1: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file7.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file2.txt: Copied (server-side copy)
2025/09/12 03:34:58 INFO  : file4.txt: Deleted
2025/09/12 03:34:58 INFO  : Updating listings
2025/09/12 03:34:58 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/changes/path2/"
2025/09/12 03:34:58 INFO  : Bisync successful
    bisync_test.go:608: TEST changes PASSED
=== RUN   TestBisyncRemoteRemote/ignorelistingchecksum
2025/09/12 03:34:59 INFO  : path1: Making directory
2025/09/12 03:34:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1"
2025/09/12 03:34:59 INFO  : path2: Making directory
2025/09/12 03:34:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2"
2025/09/12 03:35:00 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/initial"
2025/09/12 03:35:00 DEBUG : Creating backend with remote "/tmp/033432so/initdir/test_ignorelistingchecksum-davajer7"
2025/09/12 03:35:00 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : subdir: Making directory with metadata
2025/09/12 03:35:00 INFO  : subdir: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z)
2025/09/12 03:35:00 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/09/12 03:35:00 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : Local file system at /tmp/033432so/initdir/test_ignorelistingchecksum-davajer7: Waiting for checks to finish
2025/09/12 03:35:00 DEBUG : Local file system at /tmp/033432so/initdir/test_ignorelistingchecksum-davajer7: Waiting for transfers to finish
2025/09/12 03:35:00 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:35:00 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:35:00 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:35:00 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:35:00 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:00 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:35:00 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:00 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:35:00 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:35:00 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:00 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:35:00 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:00 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:00 INFO  : subdir: Set directory modification time (using SetModTime)
2025/09/12 03:35:00 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/modfiles"
2025/09/12 03:35:00 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3"
2025/09/12 03:35:00 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:00 DEBUG : Local file system at /tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3: Waiting for checks to finish
2025/09/12 03:35:00 DEBUG : Local file system at /tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3: Waiting for transfers to finish
2025/09/12 03:35:00 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/12 03:35:00 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:35:00 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:01 NOTICE: checking initFs Local file system at /tmp/033432so/initdir/test_ignorelistingchecksum-davajer7
2025/09/12 03:35:01 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 INFO  : subdir: Making directory
2025/09/12 03:35:01 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:01 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1': Waiting for checks to finish
2025/09/12 03:35:01 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1': Waiting for transfers to finish
2025/09/12 03:35:01 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:35:01 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:01 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:01 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:01 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:01 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:01 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:35:01 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:35:02 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:35:02 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:02 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:02 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:02 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:35:02 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:02 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:35:02 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:35:02 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:02 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:35:02 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:35:02 NOTICE: checking Path1 pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1'
2025/09/12 03:35:03 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 INFO  : subdir: Making directory
2025/09/12 03:35:03 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:03 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2': Waiting for checks to finish
2025/09/12 03:35:03 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2': Waiting for transfers to finish
2025/09/12 03:35:03 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:35:03 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:03 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2025/09/12 03:35:03 INFO  : file1.copy1.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2025/09/12 03:35:03 INFO  : file1.copy3.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:03 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2025/09/12 03:35:03 INFO  : file1.copy2.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2025/09/12 03:35:03 INFO  : file1.copy4.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2025/09/12 03:35:03 INFO  : file1.copy5.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:03 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:03 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:04 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2025/09/12 03:35:04 INFO  : subdir/file20.txt: Copied (new)
2025/09/12 03:35:04 NOTICE: checking path2 pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2'
2025/09/12 03:35:04 NOTICE: (01)  : test basic
2025/09/12 03:35:04 NOTICE: (02)  : test initial bisync
2025/09/12 03:35:04 NOTICE: (03)  : bisync resync
2025/09/12 03:35:09 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:09 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:09 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:09 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:09 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:09 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:09 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:09 INFO  : There was nothing to transfer
2025/09/12 03:35:09 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:09 INFO  : There was nothing to transfer
2025/09/12 03:35:09 INFO  : Resync updating listings
2025/09/12 03:35:09 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:09 INFO  : Bisync successful
2025/09/12 03:35:09 NOTICE: (04)  : bisync resync ignore-listing-checksum
2025/09/12 03:35:14 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:14 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:14 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:14 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:14 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:14 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:14 INFO  : There was nothing to transfer
2025/09/12 03:35:14 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:14 INFO  : There was nothing to transfer
2025/09/12 03:35:14 INFO  : Resync updating listings
2025/09/12 03:35:14 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:14 INFO  : Bisync successful
2025/09/12 03:35:14 NOTICE: (05)  : test place newer files on both paths
2025/09/12 03:35:14 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/
2025/09/12 03:35:14 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/"
2025/09/12 03:35:14 DEBUG : fs cache: renaming cache item "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/" to be canonical "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3"
2025/09/12 03:35:14 DEBUG : file1.txt: Set modification time 2001-01-02
2025/09/12 03:35:14 DEBUG : copyFile "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/" as ""
2025/09/12 03:35:14 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt"
2025/09/12 03:35:14 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:14 DEBUG : operations.CopyFile "file1.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2'" as "file1.txt"
2025/09/12 03:35:14 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:35:15 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:35:15 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/12 03:35:15 INFO  : file1.txt: Copied (replaced existing)
2025/09/12 03:35:15 NOTICE: (07)  : copy-as /tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/subdir file20.txt
2025/09/12 03:35:15 DEBUG : copyFile "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/subdir" as "file20.txt"
2025/09/12 03:35:15 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_ignorelistingchecksum-hejazuh3/file1.txt"
2025/09/12 03:35:15 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/subdir"
2025/09/12 03:35:15 DEBUG : operations.CopyFile "file1.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/subdir'" as "file20.txt"
2025/09/12 03:35:15 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/12 03:35:15 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2025/09/12 03:35:16 DEBUG : file20.txt.8dcf80ac.partial: renamed to: file20.txt
2025/09/12 03:35:16 INFO  : file1.txt: Copied (replaced existing) to: file20.txt
2025/09/12 03:35:16 NOTICE: (08)  : test bisync run
2025/09/12 03:35:16 NOTICE: (09)  : bisync ignore-listing-checksum
2025/09/12 03:35:20 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:20 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:20 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:20 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:20 INFO  : Building Path1 and Path2 listings
2025/09/12 03:35:20 INFO  : Path1 checking for diffs
2025/09/12 03:35:20 INFO  : - Path1    File changed: size (larger), time (newer) - subdir/file20.txt
2025/09/12 03:35:20 INFO  : Path1:    1 changes:    0 new,    1 modified,    0 deleted
2025/09/12 03:35:20 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/09/12 03:35:20 INFO  : Path2 checking for diffs
2025/09/12 03:35:20 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/09/12 03:35:20 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/09/12 03:35:20 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/09/12 03:35:20 INFO  : Applying changes
2025/09/12 03:35:20 INFO  : - Path1    Queue copy to Path2       - TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/subdir/file20.txt
2025/09/12 03:35:20 INFO  : - Path2    Queue copy to Path1       - TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/file1.txt
2025/09/12 03:35:20 INFO  : - Path2    Do queued copies to                - Path1
2025/09/12 03:35:21 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:35:21 INFO  : - Path1    Do queued copies to                - Path2
2025/09/12 03:35:21 INFO  : subdir/file20.txt: Copied (server-side copy)
2025/09/12 03:35:21 INFO  : Updating listings
2025/09/12 03:35:21 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/ignorelistingchecksum/path2/"
2025/09/12 03:35:21 INFO  : Bisync successful
    bisync_test.go:608: TEST ignorelistingchecksum PASSED
=== RUN   TestBisyncRemoteRemote/resync_modes
2025/09/12 03:35:21 INFO  : path1: Making directory
2025/09/12 03:35:21 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1"
2025/09/12 03:35:22 INFO  : path2: Making directory
2025/09/12 03:35:22 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2"
2025/09/12 03:35:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial"
2025/09/12 03:35:23 DEBUG : Creating backend with remote "/tmp/033432so/initdir/test_resync_modes-wocusur5"
2025/09/12 03:35:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:23 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:23 DEBUG : Local file system at /tmp/033432so/initdir/test_resync_modes-wocusur5: Waiting for checks to finish
2025/09/12 03:35:23 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:23 DEBUG : Local file system at /tmp/033432so/initdir/test_resync_modes-wocusur5: Waiting for transfers to finish
2025/09/12 03:35:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/12 03:35:23 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:35:23 INFO  : file2.txt: Copied (new)
2025/09/12 03:35:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/12 03:35:23 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:23 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles"
2025/09/12 03:35:23 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:23 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:23 DEBUG : Local file system at /tmp/033432so/datadir/test_resync_modes-rebuvis4: Waiting for checks to finish
2025/09/12 03:35:23 DEBUG : Local file system at /tmp/033432so/datadir/test_resync_modes-rebuvis4: Waiting for transfers to finish
2025/09/12 03:35:23 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2025/09/12 03:35:23 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK
2025/09/12 03:35:23 DEBUG : file2.txt.ac4156f2.partial: renamed to: file2.txt
2025/09/12 03:35:23 INFO  : file2.txt: Copied (new)
2025/09/12 03:35:23 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2025/09/12 03:35:23 DEBUG : file1R.txt.d467e63a.partial: renamed to: file1R.txt
2025/09/12 03:35:23 INFO  : file1R.txt: Copied (new)
2025/09/12 03:35:23 DEBUG : file1L.txt.684d937d.partial: renamed to: file1L.txt
2025/09/12 03:35:23 INFO  : file1L.txt: Copied (new)
2025/09/12 03:35:23 NOTICE: checking initFs Local file system at /tmp/033432so/initdir/test_resync_modes-wocusur5
2025/09/12 03:35:24 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:24 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:24 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:24 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Waiting for checks to finish
2025/09/12 03:35:24 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Waiting for transfers to finish
2025/09/12 03:35:24 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:24 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:35:24 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:24 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:24 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:24 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:24 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:24 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:35:24 INFO  : file2.txt: Copied (new)
2025/09/12 03:35:24 NOTICE: checking Path1 pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'
2025/09/12 03:35:25 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/12 03:35:25 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:25 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/12 03:35:25 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Waiting for checks to finish
2025/09/12 03:35:25 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Waiting for transfers to finish
2025/09/12 03:35:25 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2025/09/12 03:35:25 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:25 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2025/09/12 03:35:25 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/12 03:35:25 INFO  : RCLONE_TEST: Copied (new)
2025/09/12 03:35:25 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/12 03:35:25 INFO  : file2.txt: Copied (new)
2025/09/12 03:35:25 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/12 03:35:25 INFO  : file1.txt: Copied (new)
2025/09/12 03:35:25 NOTICE: checking path2 pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'
2025/09/12 03:35:25 NOTICE: (01)  : test resync-mode
2025/09/12 03:35:25 NOTICE: (02)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:25 NOTICE: (03)  : touch-glob 2001-01-02 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:25 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/"
2025/09/12 03:35:25 DEBUG : fs cache: renaming cache item "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" to be canonical "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:25 DEBUG : file1R.txt: Set modification time 2001-01-02
2025/09/12 03:35:25 NOTICE: (04)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:25 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:25 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:25 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:26 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:26 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 0)
2025/09/12 03:35:26 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:26 DEBUG : file1.txt.91f01f3f.partial: renamed to: file1.txt
2025/09/12 03:35:26 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:26 NOTICE: (05)  : touch-glob 2001-03-04 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:26 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:26 DEBUG : file1L.txt: Set modification time 2001-03-04
2025/09/12 03:35:26 NOTICE: (06)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:26 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:26 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:26 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:27 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:35:27 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 0)
2025/09/12 03:35:27 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:35:27 DEBUG : file1.txt.4e37ab47.partial: renamed to: file1.txt
2025/09/12 03:35:27 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:27 NOTICE: (07)  : test bisync run with --resync-mode=newer
2025/09/12 03:35:27 NOTICE: (08)  : bisync resync resync-mode=newer
2025/09/12 03:35:31 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:31 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:31 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:31 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:31 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:31 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:31 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:31 INFO  : There was nothing to transfer
2025/09/12 03:35:31 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:32 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:35:32 INFO  : Resync updating listings
2025/09/12 03:35:32 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:32 INFO  : Bisync successful
2025/09/12 03:35:32 NOTICE: (09)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:32 NOTICE: (10)  : touch-glob 2001-07-23 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:32 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:32 DEBUG : file1R.txt: Set modification time 2001-07-23
2025/09/12 03:35:32 NOTICE: (11)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:32 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:32 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:32 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:32 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:32 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 33)
2025/09/12 03:35:33 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:33 DEBUG : file1.txt.fd99577e.partial: renamed to: file1.txt
2025/09/12 03:35:33 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:33 NOTICE: (12)  : touch-glob 2001-08-26 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:33 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:33 DEBUG : file1L.txt: Set modification time 2001-08-26
2025/09/12 03:35:33 NOTICE: (13)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:33 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:33 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:33 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:33 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:35:33 DEBUG : file1L.txt: Modification times differ by -4200h0m0s: 2001-08-26 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC
2025/09/12 03:35:33 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:35:33 INFO  : file1L.txt: Updated modification time in destination
2025/09/12 03:35:33 DEBUG : file1L.txt: Unchanged skipping
2025/09/12 03:35:33 NOTICE: (14)  : test bisync run with --resync-mode=path2
2025/09/12 03:35:33 NOTICE: (15)  : bisync resync resync-mode=path2
2025/09/12 03:35:38 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:38 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:38 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:38 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:38 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:38 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:38 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:38 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:35:38 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:38 INFO  : Resync updating listings
2025/09/12 03:35:38 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:38 INFO  : Bisync successful
2025/09/12 03:35:38 NOTICE: (16)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:38 NOTICE: (17)  : touch-glob 2002-07-23 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:38 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:38 DEBUG : file1R.txt: Set modification time 2002-07-23
2025/09/12 03:35:38 NOTICE: (18)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:38 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:38 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:38 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:39 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:39 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2002-07-23 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC
2025/09/12 03:35:39 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:39 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:35:39 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:35:39 NOTICE: (19)  : touch-glob 2002-08-26 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:39 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:39 DEBUG : file1L.txt: Set modification time 2002-08-26
2025/09/12 03:35:39 NOTICE: (20)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:39 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:39 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:40 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:35:40 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42)
2025/09/12 03:35:40 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:35:40 DEBUG : file1.txt.e4364b55.partial: renamed to: file1.txt
2025/09/12 03:35:40 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:40 NOTICE: (21)  : test bisync run with --resync-mode=larger
2025/09/12 03:35:40 NOTICE: (22)  : bisync resync resync-mode=larger
2025/09/12 03:35:44 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:44 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:44 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:44 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:44 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:44 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:44 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:45 INFO  : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9
2025/09/12 03:35:45 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:35:45 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:45 INFO  : Resync updating listings
2025/09/12 03:35:45 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:45 INFO  : Bisync successful
2025/09/12 03:35:45 NOTICE: (23)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:45 NOTICE: (24)  : touch-glob 2003-07-23 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:45 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:45 DEBUG : file1R.txt: Set modification time 2003-07-23
2025/09/12 03:35:45 NOTICE: (25)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:45 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:45 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:45 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:45 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:46 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2003-07-23 00:00:00 +0000 UTC, 2002-07-23 00:00:00 +0000 UTC
2025/09/12 03:35:46 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:46 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:35:46 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:35:46 NOTICE: (26)  : touch-glob 2003-09-04 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:46 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:46 DEBUG : file1L.txt: Set modification time 2003-09-04
2025/09/12 03:35:46 NOTICE: (27)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:46 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:46 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:46 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:46 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:35:46 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42)
2025/09/12 03:35:46 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:35:47 DEBUG : file1.txt.b65270e7.partial: renamed to: file1.txt
2025/09/12 03:35:47 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:47 NOTICE: (28)  : test bisync run with --resync-mode=older
2025/09/12 03:35:47 NOTICE: (29)  : bisync resync resync-mode=older
2025/09/12 03:35:51 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:51 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:51 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:51 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:51 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:51 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:51 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:51 INFO  : file1.txt: Path2 is older. Path1: 2003-09-04 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 1032h0m0s
2025/09/12 03:35:51 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:35:51 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:35:51 INFO  : Resync updating listings
2025/09/12 03:35:51 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:51 INFO  : Bisync successful
2025/09/12 03:35:51 NOTICE: (30)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:51 NOTICE: (31)  : touch-glob 2004-07-23 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:51 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:51 DEBUG : file1R.txt: Set modification time 2004-07-23
2025/09/12 03:35:51 NOTICE: (32)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:51 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:51 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:51 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:52 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:52 DEBUG : file1R.txt: Modification times differ by -8784h0m0s: 2004-07-23 00:00:00 +0000 UTC, 2003-07-23 00:00:00 +0000 UTC
2025/09/12 03:35:52 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:52 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:35:52 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:35:52 NOTICE: (33)  : touch-glob 2004-07-23 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:52 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:52 DEBUG : file1L.txt: Set modification time 2004-07-23
2025/09/12 03:35:52 NOTICE: (34)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:52 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:52 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:52 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:53 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:35:53 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42)
2025/09/12 03:35:53 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:35:53 DEBUG : file1.txt.86629d73.partial: renamed to: file1.txt
2025/09/12 03:35:53 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/09/12 03:35:53 NOTICE: (35)  : test bisync run with --resync-mode=smaller
2025/09/12 03:35:53 NOTICE: (36)  : bisync resync resync-mode=smaller
2025/09/12 03:35:57 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:57 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:35:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:35:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:35:57 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:57 INFO  : Copying Path2 files to Path1
2025/09/12 03:35:57 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:35:58 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2025/09/12 03:35:58 ERROR : modtime_write_test: Failed to copy: pcloud error: File not found. (2009)
2025/09/12 03:35:58 ERROR : Bisync critical error: pcloud error: File not found. (2009)
2025/09/12 03:35:58 ERROR : Bisync aborted. Must run --resync to recover.
2025/09/12 03:35:58 NOTICE: Bisync error: bisync aborted
2025/09/12 03:35:58 NOTICE: (37)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/09/12 03:35:58 NOTICE: (38)  : touch-glob 2005-01-02 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:35:58 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:58 DEBUG : file1R.txt: Set modification time 2005-01-02
2025/09/12 03:35:58 NOTICE: (39)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:35:58 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:35:58 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:58 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:35:58 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:35:58 DEBUG : file1R.txt: Modification times differ by -3912h0m0s: 2005-01-02 00:00:00 +0000 UTC, 2004-07-23 00:00:00 +0000 UTC
2025/09/12 03:35:59 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:59 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:35:59 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:35:59 NOTICE: (40)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file2.txt
2025/09/12 03:35:59 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file2.txt"
2025/09/12 03:35:59 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:35:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:35:59 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file2.txt"
2025/09/12 03:35:59 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 0)
2025/09/12 03:35:59 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:35:59 DEBUG : file2.txt.e105b681.partial: renamed to: file2.txt
2025/09/12 03:35:59 INFO  : file1R.txt: Copied (replaced existing) to: file2.txt
2025/09/12 03:35:59 NOTICE: (41)  : touch-glob 2006-03-04 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:35:59 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:35:59 DEBUG : file1L.txt: Set modification time 2006-03-04
2025/09/12 03:35:59 NOTICE: (42)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:35:59 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:35:59 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:35:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:36:00 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:36:00 DEBUG : file1L.txt: Modification times differ by -14136h0m0s: 2006-03-04 00:00:00 +0000 UTC, 2004-07-23 00:00:00 +0000 UTC
2025/09/12 03:36:00 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:36:00 INFO  : file1L.txt: Updated modification time in destination
2025/09/12 03:36:00 DEBUG : file1L.txt: Unchanged skipping
2025/09/12 03:36:00 NOTICE: (43)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file2.txt
2025/09/12 03:36:00 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file2.txt"
2025/09/12 03:36:00 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:36:00 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:01 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file2.txt"
2025/09/12 03:36:01 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 0)
2025/09/12 03:36:01 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:36:01 DEBUG : file2.txt.cc95ef01.partial: renamed to: file2.txt
2025/09/12 03:36:01 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2025/09/12 03:36:01 NOTICE: (44)  : test bisync run with --resync-mode=path1
2025/09/12 03:36:01 NOTICE: (45)  : bisync resync resync-mode=path1
2025/09/12 03:36:05 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:36:05 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:36:05 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:36:05 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:36:05 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:05 INFO  : Copying Path2 files to Path1
2025/09/12 03:36:05 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:36:06 ERROR : modtime_write_test: Failed to copy: pcloud error: File not found. (2009)
2025/09/12 03:36:06 ERROR : Bisync critical error: pcloud error: File not found. (2009)
2025/09/12 03:36:06 ERROR : Bisync aborted. Must run --resync to recover.
2025/09/12 03:36:06 NOTICE: Bisync error: bisync aborted
2025/09/12 03:36:06 NOTICE: (46)  : test no winner
2025/09/12 03:36:06 NOTICE: (47)  : touch-glob 2022-02-22 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1R.txt
2025/09/12 03:36:06 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:36:06 DEBUG : file1R.txt: Set modification time 2022-02-22
2025/09/12 03:36:06 NOTICE: (48)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file1.txt
2025/09/12 03:36:06 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file1.txt"
2025/09/12 03:36:06 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:36:06 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:06 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file1.txt"
2025/09/12 03:36:06 DEBUG : file1R.txt: Modification times differ by -150240h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2005-01-02 00:00:00 +0000 UTC
2025/09/12 03:36:06 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:36:07 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:36:07 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:36:07 NOTICE: (49)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file2.txt
2025/09/12 03:36:07 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file2.txt"
2025/09/12 03:36:07 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1R.txt"
2025/09/12 03:36:07 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:36:07 DEBUG : operations.CopyFile "file1R.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file2.txt"
2025/09/12 03:36:07 DEBUG : file1R.txt: Modification times differ by -150240h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2005-01-02 00:00:00 +0000 UTC
2025/09/12 03:36:07 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2025/09/12 03:36:07 INFO  : file1R.txt: Updated modification time in destination
2025/09/12 03:36:07 DEBUG : file1R.txt: Unchanged skipping
2025/09/12 03:36:07 NOTICE: (50)  : touch-glob 2022-02-22 /tmp/033432so/datadir/test_resync_modes-rebuvis4/ file1L.txt
2025/09/12 03:36:07 DEBUG : fs cache: switching user supplied name "/tmp/033432so/datadir/test_resync_modes-rebuvis4/" for canonical name "/tmp/033432so/datadir/test_resync_modes-rebuvis4"
2025/09/12 03:36:07 DEBUG : file1L.txt: Set modification time 2022-02-22
2025/09/12 03:36:07 NOTICE: (51)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/ file1.txt
2025/09/12 03:36:07 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" as "file1.txt"
2025/09/12 03:36:07 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:36:07 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/"
2025/09/12 03:36:08 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1'" as "file1.txt"
2025/09/12 03:36:08 DEBUG : file1L.txt: Modification times differ by -140016h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2006-03-04 00:00:00 +0000 UTC
2025/09/12 03:36:08 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:36:08 INFO  : file1L.txt: Updated modification time in destination
2025/09/12 03:36:08 DEBUG : file1L.txt: Unchanged skipping
2025/09/12 03:36:08 NOTICE: (52)  : copy-as /tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/ file2.txt
2025/09/12 03:36:08 DEBUG : copyFile "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt" to "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/" as "file2.txt"
2025/09/12 03:36:08 DEBUG : Creating backend with remote "/tmp/033432so/datadir/test_resync_modes-rebuvis4/file1L.txt"
2025/09/12 03:36:08 DEBUG : Creating backend with remote "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:09 DEBUG : operations.CopyFile "file1L.txt" to "pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2'" as "file2.txt"
2025/09/12 03:36:09 DEBUG : file1L.txt: Modification times differ by -140016h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2006-03-04 00:00:00 +0000 UTC
2025/09/12 03:36:09 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2025/09/12 03:36:09 INFO  : file1L.txt: Updated modification time in destination
2025/09/12 03:36:09 DEBUG : file1L.txt: Unchanged skipping
2025/09/12 03:36:09 NOTICE: (53)  : test bisync run with --resync-mode=newer
2025/09/12 03:36:09 NOTICE: (54)  : bisync resync resync-mode=newer
2025/09/12 03:36:13 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:36:13 DEBUG : pcloud root 'rclone-test-walavuw6neze/033432so/resync_modes/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/12 03:36:13 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/09/12 03:36:13 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/09/12 03:36:13 INFO  : Synching Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" with Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:13 INFO  : Copying Path2 files to Path1
2025/09/12 03:36:13 INFO  : - Path2    Resync is copying files to         - Path1
2025/09/12 03:36:14 INFO  : file1.txt: Copied (server-side copy)
2025/09/12 03:36:14 INFO  : file2.txt: Copied (server-side copy)
2025/09/12 03:36:14 INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:36:14 INFO  : Resync updating listings
2025/09/12 03:36:14 INFO  : Validating listings for Path1 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path1/" vs Path2 "TestPcloud:rclone-test-walavuw6neze/033432so/resync_modes/path2/"
2025/09/12 03:36:14 INFO  : Bisync successful
2025/09/12 03:36:14 NOTICE: ----------------------------------------------------------
2025/09/12 03:36:14 NOTICE: MISCOMPARE - Number of Golden and Results files do not match:
2025/09/12 03:36:14 NOTICE:   Golden count: 7
2025/09/12 03:36:14 NOTICE:   Result count: 9
2025/09/12 03:36:14 NOTICE:   Golden files: _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, test.log
2025/09/12 03:36:14 NOTICE:   Result files: _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-err, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-err, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, test.log
2025/09/12 03:36:14 NOTICE:   File found in Results but not in Golden:  _testdir_path1.._testdir_path2.path1.lst-err
2025/09/12 03:36:14 NOTICE:   File found in Results but not in Golden:  _testdir_path1.._testdir_path2.path2.lst-err
2025/09/12 03:36:14 NOTICE: ----------------------------------------------------------
2025/09/12 03:36:14 NOTICE: | MISCOMPARE  -Golden vs +Results for  _testdir_path1.._testdir_path2.path1.lst-old
2025/09/12 03:36:14 NOTICE: | @@ -3 +3 @@
2025/09/12 03:36:14 NOTICE: | --       33 - - 2006-03-04 00:00:00 +0000 UTC "\"file1.txt\""
2025/09/12 03:36:14 NOTICE: | +-       42 - - 2002-07-23 00:00:00 +0000 UTC "\"file1.txt\""
2025/09/12 03:36:14 NOTICE: | @@ -5 +5 @@
2025/09/12 03:36:14 NOTICE: | --       42 - - 2005-01-02 00:00:00 +0000 UTC "\"file2.txt\""
2025/09/12 03:36:14 NOTICE: | +-        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file2.txt\""
2025/09/12 03:36:14 NOTICE: ----------------------------------------------------------
2025/09/12 03:36:14 NOTICE: | MISCOMPARE  -Golden vs +Results for  _testdir_path1.._testdir_path2.path2.lst-old
2025/09/12 03:36:14 NOTICE: | @@ -3 +3 @@
2025/09/12 03:36:14 NOTICE: | --       33 - - 2006-03-04 00:00:00 +0000 UTC "\"file1.txt\""
2025/09/12 03:36:14 NOTICE: | +-       42 - - 2002-07-23 00:00:00 +0000 UTC "\"file1.txt\""
2025/09/12 03:36:14 NOTICE: | @@ -5 +5 @@
2025/09/12 03:36:14 NOTICE: | --       42 - - 2005-01-02 00:00:00 +0000 UTC "\"file2.txt\""
2025/09/12 03:36:14 NOTICE: | +-        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file2.txt\""
2025/09/12 03:36:14 NOTICE: ----------------------------------------------------------
2025/09/12 03:36:14 NOTICE: | MISCOMPARE  -Golden vs +Results for  test.log
2025/09/12 03:36:14 NOTICE: | @@ -121,5 +121,4 @@
2025/09/12 03:36:14 NOTICE: | -INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:36:14 NOTICE: | -INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2025/09/12 03:36:14 NOTICE: | -INFO  : Resync updating listings
2025/09/12 03:36:14 NOTICE: | -INFO  : Validating listings for Path1 "{path1/}" vs Path2 "{path2/}"
2025/09/12 03:36:14 NOTICE: | -INFO  : Bisync successful
2025/09/12 03:36:14 NOTICE: | +ERROR : modtime_write_test: Failed to copy: pcloud error: File not found. (2009)
2025/09/12 03:36:14 NOTICE: | +ERROR : Bisync critical error: pcloud error: File not found. (2009)
2025/09/12 03:36:14 NOTICE: | +ERROR : Bisync aborted. Must run --resync to recover.
2025/09/12 03:36:14 NOTICE: | +Bisync error: bisync aborted
2025/09/12 03:36:14 NOTICE: | @@ -148,4 +147,4 @@
2025/09/12 03:36:14 NOTICE: | -INFO  : - Path1    Resync is copying files to         - Path2
2025/09/12 03:36:14 NOTICE: | -INFO  : Resync updating listings
2025/09/12 03:36:14 NOTICE: | -INFO  : Validating listings for Path1 "{path1/}" vs Path2 "{path2/}"
2025/09/12 03:36:14 NOTICE: | -INFO  : Bisync successful
2025/09/12 03:36:14 NOTICE: | +ERROR : modtime_write_test: Failed to copy: pcloud error: File not found. (2009)
2025/09/12 03:36:14 NOTICE: | +ERROR : Bisync critical error: pcloud error: File not found. (2009)
2025/09/12 03:36:14 NOTICE: | +ERROR : Bisync aborted. Must run --resync to recover.
2025/09/12 03:36:14 NOTICE: | +Bisync error: bisync aborted
2025/09/12 03:36:14 NOTICE: ----------------------------------------------------------
    bisync_test.go:608: TEST resync_modes FAILED - 5 MISCOMPARED FILES
2025/09/12 03:36:14 DEBUG : pcloud root 'rclone-test-walavuw6neze': Purge remote
--- FAIL: TestBisyncRemoteRemote (102.90s)
    --- PASS: TestBisyncRemoteRemote/changes (26.63s)
    --- PASS: TestBisyncRemoteRemote/ignorelistingchecksum (22.65s)
    --- FAIL: TestBisyncRemoteRemote/resync_modes (52.75s)
FAIL
2025/09/12 03:36:14 DEBUG : pcloud root 'rclone-test-wixuxid1gaho': Purge remote
2025/09/12 03:36:15 NOTICE: purge failed: directory not found
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^TestBisyncLocalRemote$/^(basic|ext_paths)$|^TestBisyncRemoteRemote$/^(changes|ignorelistingchecksum|resync_modes)$'" - Finished ERROR in 2m33.674720593s (try 3/5): exit status 1: Failed [TestBisyncLocalRemote/ext_paths TestBisyncRemoteRemote/resync_modes]