"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^resync$|^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5)
2026/01/17 04:06:23 DEBUG : Creating backend with remote "TestB2:rclone-test-wimiguf1tebu"
2026/01/17 04:06:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/01/17 04:06:23 DEBUG : Creating backend with remote "/tmp/rclone3001168233"
=== RUN   TestBisyncLocalRemote
2026/01/17 04:06:23 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava"
2026/01/17 04:06:24 NOTICE: remote: TestB2:rclone-test-vixawez7fava
=== RUN   TestBisyncLocalRemote/resync
2026/01/17 04:06:24 DEBUG : Creating backend with remote "/tmp/040624we"
2026/01/17 04:06:24 DEBUG : Creating backend with remote "/tmp/040624we/resync/path1"
2026/01/17 04:06:24 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we"
2026/01/17 04:06:25 INFO  : path2: Making directory
2026/01/17 04:06:26 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2"
2026/01/17 04:06:27 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial"
2026/01/17 04:06:27 DEBUG : Creating backend with remote "/tmp/040624we/initdir/test_resync-pofawog0"
2026/01/17 04:06:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : Local file system at /tmp/040624we/initdir/test_resync-pofawog0: Waiting for checks to finish
2026/01/17 04:06:27 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : Local file system at /tmp/040624we/initdir/test_resync-pofawog0: Waiting for transfers to finish
2026/01/17 04:06:27 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/17 04:06:27 INFO  : file3.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/17 04:06:27 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:06:27 INFO  : file1.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/17 04:06:27 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/17 04:06:27 INFO  : file5.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:06:27 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/17 04:06:27 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:27 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:06:27 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/17 04:06:27 INFO  : file7.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/17 04:06:27 INFO  : file6.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:06:27 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:06:27 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles"
2026/01/17 04:06:27 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4"
2026/01/17 04:06:27 DEBUG : fileA.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : fileB.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:27 DEBUG : Local file system at /tmp/040624we/datadir/test_resync-qakiled4: Waiting for checks to finish
2026/01/17 04:06:27 DEBUG : Local file system at /tmp/040624we/datadir/test_resync-qakiled4: Waiting for transfers to finish
2026/01/17 04:06:27 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK
2026/01/17 04:06:27 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK
2026/01/17 04:06:27 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:06:27 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:06:27 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt
2026/01/17 04:06:27 INFO  : fileA.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt
2026/01/17 04:06:27 INFO  : fileB.txt: Copied (new)
2026/01/17 04:06:27 DEBUG : Waiting for deletions to finish
2026/01/17 04:06:27 ERROR : error listing: directory not found
2026/01/17 04:06:27 ERROR : Local file system at /tmp/040624we/resync/path1: Failed to list "": directory not found
2026/01/17 04:06:27 DEBUG : removing 1 level 0 directories
2026/01/17 04:06:27 INFO  : Local file system at /tmp/040624we/resync/path1: Removing directory
2026/01/17 04:06:27 ERROR : Failed to rmdir: stat /tmp/040624we/resync/path1: no such file or directory
2026/01/17 04:06:27 INFO  : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: cleaning bucket "rclone-test-vixawez7fava" of all files
2026/01/17 04:06:27 ERROR : error listing: directory not found
2026/01/17 04:06:28 NOTICE: checking initFs Local file system at /tmp/040624we/initdir/test_resync-pofawog0
2026/01/17 04:06:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:06:28 DEBUG : Local file system at /tmp/040624we/resync/path1: Waiting for checks to finish
2026/01/17 04:06:28 DEBUG : Local file system at /tmp/040624we/resync/path1: Waiting for transfers to finish
2026/01/17 04:06:28 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/17 04:06:28 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/17 04:06:28 INFO  : file3.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:06:28 INFO  : file1.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/17 04:06:28 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/17 04:06:28 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:06:28 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/17 04:06:28 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:06:28 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/17 04:06:28 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/17 04:06:28 INFO  : file5.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:06:28 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/17 04:06:28 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:06:28 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/17 04:06:28 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/17 04:06:28 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/17 04:06:28 INFO  : file7.txt: Copied (new)
2026/01/17 04:06:28 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:06:28 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/17 04:06:28 INFO  : file6.txt: Copied (new)
2026/01/17 04:06:28 NOTICE: checking Path1 Local file system at /tmp/040624we/resync/path1
2026/01/17 04:06:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:06:28 DEBUG : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: Waiting for checks to finish
2026/01/17 04:06:28 DEBUG : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: Waiting for transfers to finish
2026/01/17 04:06:29 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file1.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : file4.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : file5.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file5.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : file3.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file3.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : file6.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file6.txt: Copied (new)
2026/01/17 04:06:29 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:06:29 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:06:29 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:06:29 DEBUG : file7.txt: size = 0 OK
2026/01/17 04:06:29 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:06:29 INFO  : file7.txt: Copied (new)
2026/01/17 04:06:29 NOTICE: checking path2 B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2
2026/01/17 04:06:30 NOTICE: (01)  : test resync
2026/01/17 04:06:30 NOTICE: (02)  : test 1. resync with empty path1, resulting in copying all content from path2.
2026/01/17 04:06:30 NOTICE: (03)  : purge-children /tmp/040624we/resync/path1/
2026/01/17 04:06:30 DEBUG : file6.txt: Remove file
2026/01/17 04:06:30 DEBUG : file4.txt: Remove file
2026/01/17 04:06:30 DEBUG : file1.txt: Remove file
2026/01/17 04:06:30 DEBUG : file3.txt: Remove file
2026/01/17 04:06:30 DEBUG : RCLONE_TEST: Remove file
2026/01/17 04:06:30 DEBUG : file5.txt: Remove file
2026/01/17 04:06:30 DEBUG : file7.txt: Remove file
2026/01/17 04:06:30 DEBUG : file2.txt: Remove file
2026/01/17 04:06:30 NOTICE: (04)  : bisync resync
2026/01/17 04:06:33 DEBUG : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:06:33 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:06:33 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2026/01/17 04:06:33 INFO  : Synching Path1 "/tmp/040624we/resync/path1/" with Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:33 INFO  : Copying Path2 files to Path1
2026/01/17 04:06:33 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:06:33 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:06:34 INFO  : file1.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file5.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file3.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file6.txt: Copied (new)
2026/01/17 04:06:34 INFO  : file7.txt: Copied (new)
2026/01/17 04:06:34 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:06:34 INFO  : Resync updating listings
2026/01/17 04:06:34 INFO  : Validating listings for Path1 "/tmp/040624we/resync/path1/" vs Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:34 INFO  : Bisync successful
2026/01/17 04:06:34 NOTICE: (05)  : move-listings empty-path1
2026/01/17 04:06:34 NOTICE: (06)  : test 2. resync with empty path2, resulting in syncing all content to path2.
2026/01/17 04:06:34 NOTICE: (07)  : purge-children TestB2:rclone-test-vixawez7fava/040624we/resync/path2/
2026/01/17 04:06:34 DEBUG : RCLONE_TEST: Remove file
2026/01/17 04:06:35 DEBUG : file1.txt: Remove file
2026/01/17 04:06:35 DEBUG : file2.txt: Remove file
2026/01/17 04:06:35 DEBUG : file3.txt: Remove file
2026/01/17 04:06:35 DEBUG : file4.txt: Remove file
2026/01/17 04:06:35 DEBUG : file5.txt: Remove file
2026/01/17 04:06:36 DEBUG : file6.txt: Remove file
2026/01/17 04:06:36 DEBUG : file7.txt: Remove file
2026/01/17 04:06:36 NOTICE: (08)  : bisync resync
2026/01/17 04:06:39 DEBUG : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:06:39 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:06:39 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2026/01/17 04:06:39 INFO  : Synching Path1 "/tmp/040624we/resync/path1/" with Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:39 INFO  : Copying Path2 files to Path1
2026/01/17 04:06:39 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:06:39 INFO  : There was nothing to transfer
2026/01/17 04:06:39 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:06:40 INFO  : file1.txt: Copied (new)
2026/01/17 04:06:40 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:06:40 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:40 INFO  : file3.txt: Copied (new)
2026/01/17 04:06:40 INFO  : file5.txt: Copied (new)
2026/01/17 04:06:40 INFO  : file6.txt: Copied (new)
2026/01/17 04:06:40 INFO  : file7.txt: Copied (new)
2026/01/17 04:06:40 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:40 INFO  : Resync updating listings
2026/01/17 04:06:40 INFO  : Validating listings for Path1 "/tmp/040624we/resync/path1/" vs Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:40 INFO  : Bisync successful
2026/01/17 04:06:40 NOTICE: (09)  : move-listings empty-path2
2026/01/17 04:06:40 NOTICE: (10)  : test 3. exercise all of the various file difference scenarios during a resync.
2026/01/17 04:06:40 NOTICE: (11)  : touch-glob 2002-02-02 /tmp/040624we/datadir/test_resync-qakiled4/ fileA.txt
2026/01/17 04:06:40 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/"
2026/01/17 04:06:40 DEBUG : fs cache: renaming cache item "/tmp/040624we/datadir/test_resync-qakiled4/" to be canonical "/tmp/040624we/datadir/test_resync-qakiled4"
2026/01/17 04:06:40 DEBUG : fileA.txt: Set modification time 2002-02-02
2026/01/17 04:06:40 NOTICE: (12)  : touch-glob 1999-09-09 /tmp/040624we/datadir/test_resync-qakiled4/ fileB.txt
2026/01/17 04:06:40 DEBUG : fs cache: switching user supplied name "/tmp/040624we/datadir/test_resync-qakiled4/" for canonical name "/tmp/040624we/datadir/test_resync-qakiled4"
2026/01/17 04:06:40 DEBUG : fileB.txt: Set modification time 1999-09-09
2026/01/17 04:06:40 NOTICE: (13)  : test = file      - path1      - path2      - expected action    - who wins
2026/01/17 04:06:40 NOTICE: (14)  : test - file1.txt - exists     - missing    - sync path1 > path2 - path1
2026/01/17 04:06:40 NOTICE: (15)  : delete-file TestB2:rclone-test-vixawez7fava/040624we/resync/path2/file1.txt
2026/01/17 04:06:40 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:42 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/" to be canonical "TestB2:rclone-test-vixawez7fava/040624we/resync/path2"
2026/01/17 04:06:42 INFO  : file1.txt: Deleted
2026/01/17 04:06:42 NOTICE: (16)  : test - file2.txt - missing    - exists     - copy path2 > path1 - path2
2026/01/17 04:06:42 NOTICE: (17)  : delete-file /tmp/040624we/resync/path1/file2.txt
2026/01/17 04:06:42 DEBUG : Creating backend with remote "/tmp/040624we/resync/path1/"
2026/01/17 04:06:42 DEBUG : fs cache: renaming cache item "/tmp/040624we/resync/path1/" to be canonical "/tmp/040624we/resync/path1"
2026/01/17 04:06:42 INFO  : file2.txt: Deleted
2026/01/17 04:06:42 NOTICE: (18)  : test - file3.txt - exists     - newer date - sync path1 > path2 - path1
2026/01/17 04:06:42 NOTICE: (19)  : copy-as /tmp/040624we/datadir/test_resync-qakiled4/fileA.txt TestB2:rclone-test-vixawez7fava/040624we/resync/path2/ file3.txt
2026/01/17 04:06:42 DEBUG : copyFile "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt" to "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/" as "file3.txt"
2026/01/17 04:06:42 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt"
2026/01/17 04:06:42 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:43 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2" as "file3.txt"
2026/01/17 04:06:43 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040624we/datadir/test_resync-qakiled4)
2026/01/17 04:06:43 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2)
2026/01/17 04:06:43 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:06:45 DEBUG : file3.txt: size = 19 OK
2026/01/17 04:06:45 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:06:45 INFO  : fileA.txt: Copied (replaced existing) to: file3.txt
2026/01/17 04:06:45 NOTICE: (20)  : test - file4.txt - missing    - newer date - copy path2 > path1 - path2
2026/01/17 04:06:45 NOTICE: (21)  : delete-file /tmp/040624we/resync/path1/file4.txt
2026/01/17 04:06:45 DEBUG : fs cache: switching user supplied name "/tmp/040624we/resync/path1/" for canonical name "/tmp/040624we/resync/path1"
2026/01/17 04:06:45 INFO  : file4.txt: Deleted
2026/01/17 04:06:45 NOTICE: (22)  : copy-as /tmp/040624we/datadir/test_resync-qakiled4/fileA.txt TestB2:rclone-test-vixawez7fava/040624we/resync/path2/ file4.txt
2026/01/17 04:06:45 DEBUG : copyFile "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt" to "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/" as "file4.txt"
2026/01/17 04:06:45 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt"
2026/01/17 04:06:45 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:46 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2" as "file4.txt"
2026/01/17 04:06:47 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040624we/datadir/test_resync-qakiled4)
2026/01/17 04:06:47 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2)
2026/01/17 04:06:47 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:06:48 DEBUG : file4.txt: size = 19 OK
2026/01/17 04:06:48 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:06:48 INFO  : fileA.txt: Copied (replaced existing) to: file4.txt
2026/01/17 04:06:48 NOTICE: (23)  : test - file5.txt - exists     - older date - sync path1 > path2 - path1
2026/01/17 04:06:48 NOTICE: (24)  : copy-as /tmp/040624we/datadir/test_resync-qakiled4/fileB.txt TestB2:rclone-test-vixawez7fava/040624we/resync/path2/ file5.txt
2026/01/17 04:06:48 DEBUG : copyFile "/tmp/040624we/datadir/test_resync-qakiled4/fileB.txt" to "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/" as "file5.txt"
2026/01/17 04:06:48 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/fileB.txt"
2026/01/17 04:06:48 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:50 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2" as "file5.txt"
2026/01/17 04:06:50 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/040624we/datadir/test_resync-qakiled4)
2026/01/17 04:06:50 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2)
2026/01/17 04:06:50 DEBUG : fileB.txt: Sizes differ
2026/01/17 04:06:51 DEBUG : file5.txt: size = 19 OK
2026/01/17 04:06:51 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:06:51 INFO  : fileB.txt: Copied (replaced existing) to: file5.txt
2026/01/17 04:06:51 NOTICE: (25)  : test - file6.txt - older date - newer date - sync path1 > path2	- path1
2026/01/17 04:06:51 NOTICE: (26)  : copy-as /tmp/040624we/datadir/test_resync-qakiled4/fileB.txt /tmp/040624we/resync/path1/ file6.txt
2026/01/17 04:06:51 DEBUG : copyFile "/tmp/040624we/datadir/test_resync-qakiled4/fileB.txt" to "/tmp/040624we/resync/path1/" as "file6.txt"
2026/01/17 04:06:51 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/fileB.txt"
2026/01/17 04:06:51 DEBUG : Creating backend with remote "/tmp/040624we/resync/path1/"
2026/01/17 04:06:51 DEBUG : operations.CopyFile "fileB.txt" to "Local file system at /tmp/040624we/resync/path1" as "file6.txt"
2026/01/17 04:06:51 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/040624we/datadir/test_resync-qakiled4)
2026/01/17 04:06:51 DEBUG : file6.txt: size = 0 (Local file system at /tmp/040624we/resync/path1)
2026/01/17 04:06:51 DEBUG : fileB.txt: Sizes differ
2026/01/17 04:06:51 DEBUG : file6.txt.237b502b.partial: size = 19 OK
2026/01/17 04:06:51 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:06:51 DEBUG : file6.txt.237b502b.partial: renamed to: file6.txt
2026/01/17 04:06:51 INFO  : fileB.txt: Copied (replaced existing) to: file6.txt
2026/01/17 04:06:51 NOTICE: (27)  : copy-as /tmp/040624we/datadir/test_resync-qakiled4/fileA.txt TestB2:rclone-test-vixawez7fava/040624we/resync/path2/ file6.txt
2026/01/17 04:06:51 DEBUG : copyFile "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt" to "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/" as "file6.txt"
2026/01/17 04:06:51 DEBUG : Creating backend with remote "/tmp/040624we/datadir/test_resync-qakiled4/fileA.txt"
2026/01/17 04:06:51 DEBUG : Creating backend with remote "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:53 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2" as "file6.txt"
2026/01/17 04:06:53 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040624we/datadir/test_resync-qakiled4)
2026/01/17 04:06:53 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2)
2026/01/17 04:06:53 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:06:55 DEBUG : file6.txt: size = 19 OK
2026/01/17 04:06:55 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:06:55 INFO  : fileA.txt: Copied (replaced existing) to: file6.txt
2026/01/17 04:06:55 NOTICE: (28)  : test - file7.txt - exists     - exists (same) - none            - same
2026/01/17 04:06:55 NOTICE: (29)  : test run bisync with resync
2026/01/17 04:06:55 NOTICE: (30)  : bisync resync
2026/01/17 04:06:59 DEBUG : B2 bucket rclone-test-vixawez7fava path 040624we/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:06:59 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:06:59 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2026/01/17 04:06:59 INFO  : Synching Path1 "/tmp/040624we/resync/path1/" with Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:06:59 INFO  : Copying Path2 files to Path1
2026/01/17 04:06:59 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:06:59 INFO  : file4.txt: Copied (new)
2026/01/17 04:06:59 INFO  : file2.txt: Copied (new)
2026/01/17 04:06:59 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:07:00 INFO  : file3.txt: Copied (replaced existing)
2026/01/17 04:07:00 INFO  : file1.txt: Copied (new)
2026/01/17 04:07:00 INFO  : file6.txt: Updated modification time in destination
2026/01/17 04:07:00 INFO  : file5.txt: Copied (replaced existing)
2026/01/17 04:07:00 INFO  : Resync updating listings
2026/01/17 04:07:00 INFO  : Validating listings for Path1 "/tmp/040624we/resync/path1/" vs Path2 "TestB2:rclone-test-vixawez7fava/040624we/resync/path2/"
2026/01/17 04:07:00 INFO  : Bisync successful
2026/01/17 04:07:00 NOTICE: (31)  : copy-listings mixed-diffs
2026/01/17 04:07:00 NOTICE: (32)  : test run normal bisync
2026/01/17 04:07:00 NOTICE: (33)  : bisync
2026/01/17 04:07:00 DEBUG : modtime_write_test: Clearing upload URL because of error: Post "https://pod-000-1185-05.backblaze.com/b2api/v1/b2_upload_file/fff20d43202dcbab9fb80e1b/c001_v0001185_t0030": EOF
2026/01/17 04:07:00 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1185-05.backblaze.com/b2api/v1/b2_upload_file/fff20d43202dcbab9fb80e1b/c001_v0001185_t0030": EOF)
2026/01/17 04:07:00 DEBUG : pacer: Rate limited, increasing sleep to 20ms
    bisync_test.go:1025: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1025
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1046
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1111
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:788
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:542
        	            				/usr/local/go/src/strings/iter.go:61
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:525
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405
        	Error:      	Received unexpected error:
        	            	Post "https://pod-000-1185-05.backblaze.com/b2api/v1/b2_upload_file/fff20d43202dcbab9fb80e1b/c001_v0001185_t0030": EOF
        	Test:       	TestBisyncLocalRemote/resync
2026/01/17 04:07:00 DEBUG : B2 bucket rclone-test-vixawez7fava: Purge remote
2026/01/17 04:07:00 INFO  : B2 bucket rclone-test-vixawez7fava: cleaning bucket "rclone-test-vixawez7fava" of all files
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/RCLONE_TEST: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca7667f_d20260117_m040640_c001_v0001185_t0035_u01768622800591")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/RCLONE_TEST: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f1c_d20260117_m040634_c001_v7007000_t0000_u01768622794983")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/RCLONE_TEST: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105019da08042dc5_d20260117_m040629_c001_v0001183_t0040_u01768622789620")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file1.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79519_d20260117_m040700_c001_v0001185_t0053_u01768622820134")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file1.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f58_d20260117_m040642_c001_v7007000_t0000_u01768622802330")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file1.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e7917c_d20260117_m040640_c001_v0001185_t0047_u01768622800230")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file1.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f1e_d20260117_m040635_c001_v7007000_t0000_u01768622795168")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file1.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79028_d20260117_m040629_c001_v0001185_t0029_u01768622789001")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file2.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f111bd18e09dbac9d_d20260117_m040640_c001_v0001167_t0004_u01768622800609")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file2.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f20_d20260117_m040635_c001_v7007000_t0000_u01768622795353")
2026/01/17 04:07:01 DEBUG : 040624we/resync/path2/file2.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca764ec_d20260117_m040629_c001_v0001185_t0054_u01768622789213")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file3.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105019da08042e19_d20260117_m040700_c001_v0001183_t0045_u01768622820175")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file3.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f119ed60f4c17389e_d20260117_m040645_c001_v0001037_t0002_u01768622805192")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file3.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105019da08042de2_d20260117_m040640_c001_v0001183_t0007_u01768622800616")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file3.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f23_d20260117_m040635_c001_v7007000_t0000_u01768622795538")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file3.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f111bd18e09dbab85_d20260117_m040629_c001_v0001167_t0014_u01768622789412")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file4.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f107a86d6ae5f2b84_d20260117_m040648_c001_v0001104_t0057_u01768622808532")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file4.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79188_d20260117_m040640_c001_v0001185_t0049_u01768622800616")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file4.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f25_d20260117_m040635_c001_v7007000_t0000_u01768622795731")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file4.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79034_d20260117_m040629_c001_v0001185_t0051_u01768622789327")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file5.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f111bd18e09dbaee1_d20260117_m040700_c001_v0001167_t0038_u01768622820144")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file5.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f106f3577c417fd36_d20260117_m040651_c001_v0001101_t0011_u01768622811715")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file5.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca76687_d20260117_m040640_c001_v0001185_t0017_u01768622800784")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file5.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f28_d20260117_m040635_c001_v7007000_t0000_u01768622795915")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file5.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca764f8_d20260117_m040629_c001_v0001185_t0046_u01768622789457")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file6.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f116485bbae35edad_d20260117_m040700_c001_v0001092_t0039_u01768622820003")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file6.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f10571f75896bbf1f_d20260117_m040654_c001_v0001154_t0008_u01768622814711")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file6.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79195_d20260117_m040640_c001_v0001185_t0050_u01768622800812")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file6.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f2a_d20260117_m040636_c001_v7007000_t0000_u01768622796099")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file6.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e7903c_d20260117_m040629_c001_v0001185_t0023_u01768622789618")
2026/01/17 04:07:02 DEBUG : 040624we/resync/path2/file7.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105019da08042de4_d20260117_m040640_c001_v0001183_t0035_u01768622800828")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/file7.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f2c_d20260117_m040636_c001_v7007000_t0000_u01768622796283")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/file7.txt: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca764fb_d20260117_m040629_c001_v0001185_t0000_u01768622789645")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4025740bd6a61d9f_d20260117_m040658_c001_v7007000_t0000_u01768622818966")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f10477f579d062bc4_d20260117_m040657_c001_v0001173_t0027_u01768622817278")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f105e11d48ca768f0_d20260117_m040655_c001_v0001185_t0054_u01768622815501")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f45_d20260117_m040639_c001_v7007000_t0000_u01768622799648")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f1003496a68117bb6_d20260117_m040638_c001_v0001137_t0036_u01768622798257")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f11072d0921e79112_d20260117_m040636_c001_v0001185_t0042_u01768622796853")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f4068695031cb7f12_d20260117_m040633_c001_v7007000_t0000_u01768622793459")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f1071b92b04a65c5b_d20260117_m040631_c001_v0001043_t0012_u01768622791998")
2026/01/17 04:07:03 DEBUG : 040624we/resync/path2/modtime_write_test: Deleting (id "4_zfff20d43202dcbab9fb80e1b_f111bd18e09dbab94_d20260117_m040630_c001_v0001167_t0052_u01768622790132")
--- FAIL: TestBisyncLocalRemote (40.74s)
    --- FAIL: TestBisyncLocalRemote/resync (36.41s)
=== RUN   TestBisyncRemoteRemote
2026/01/17 04:07:04 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu"
2026/01/17 04:07:04 NOTICE: remote: TestB2:rclone-test-cudexuk6qoqu
=== RUN   TestBisyncRemoteRemote/resync
2026/01/17 04:07:04 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he"
2026/01/17 04:07:06 INFO  : path1: Making directory
2026/01/17 04:07:06 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1"
2026/01/17 04:07:08 INFO  : path2: Making directory
2026/01/17 04:07:08 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2"
2026/01/17 04:07:09 DEBUG : Creating backend with remote "/tmp/040704he/initdir/test_resync-fudazof3"
2026/01/17 04:07:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : Local file system at /tmp/040704he/initdir/test_resync-fudazof3: Waiting for checks to finish
2026/01/17 04:07:09 DEBUG : Local file system at /tmp/040704he/initdir/test_resync-fudazof3: Waiting for transfers to finish
2026/01/17 04:07:09 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/17 04:07:09 INFO  : file2.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/17 04:07:09 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:07:09 INFO  : file3.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/17 04:07:09 INFO  : file4.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:07:09 INFO  : file1.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/17 04:07:09 INFO  : file5.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/17 04:07:09 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/17 04:07:09 INFO  : file6.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:07:09 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:07:09 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/17 04:07:09 INFO  : file7.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:07:09 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:07:09 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:07:09 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4"
2026/01/17 04:07:09 DEBUG : fileA.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : fileB.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:09 DEBUG : Local file system at /tmp/040704he/datadir/test_resync-litetuc4: Waiting for checks to finish
2026/01/17 04:07:09 DEBUG : Local file system at /tmp/040704he/datadir/test_resync-litetuc4: Waiting for transfers to finish
2026/01/17 04:07:09 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK
2026/01/17 04:07:09 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:07:09 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt
2026/01/17 04:07:09 INFO  : fileA.txt: Copied (new)
2026/01/17 04:07:09 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK
2026/01/17 04:07:09 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:07:09 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt
2026/01/17 04:07:09 INFO  : fileB.txt: Copied (new)
2026/01/17 04:07:09 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:07:09 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:07:10 NOTICE: checking initFs Local file system at /tmp/040704he/initdir/test_resync-fudazof3
2026/01/17 04:07:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:11 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Waiting for checks to finish
2026/01/17 04:07:11 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Waiting for transfers to finish
2026/01/17 04:07:11 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:07:11 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:11 INFO  : file2.txt: Copied (new)
2026/01/17 04:07:12 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:07:12 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:07:12 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:07:12 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:07:12 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:12 INFO  : file1.txt: Copied (new)
2026/01/17 04:07:12 DEBUG : file4.txt: size = 0 OK
2026/01/17 04:07:12 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:12 INFO  : file4.txt: Copied (new)
2026/01/17 04:07:12 DEBUG : file5.txt: size = 0 OK
2026/01/17 04:07:12 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:12 INFO  : file5.txt: Copied (new)
2026/01/17 04:07:12 DEBUG : file7.txt: size = 0 OK
2026/01/17 04:07:12 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:12 INFO  : file7.txt: Copied (new)
2026/01/17 04:07:13 DEBUG : file3.txt: size = 0 OK
2026/01/17 04:07:13 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:13 INFO  : file3.txt: Copied (new)
2026/01/17 04:07:13 DEBUG : file6.txt: size = 0 OK
2026/01/17 04:07:13 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:13 INFO  : file6.txt: Copied (new)
2026/01/17 04:07:13 NOTICE: checking Path1 B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1
2026/01/17 04:07:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:07:13 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Waiting for checks to finish
2026/01/17 04:07:13 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Waiting for transfers to finish
2026/01/17 04:07:14 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:07:14 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:14 INFO  : file2.txt: Copied (new)
2026/01/17 04:07:14 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:07:14 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:14 INFO  : file1.txt: Copied (new)
2026/01/17 04:07:14 DEBUG : file3.txt: size = 0 OK
2026/01/17 04:07:14 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:14 INFO  : file3.txt: Copied (new)
2026/01/17 04:07:14 DEBUG : file4.txt: size = 0 OK
2026/01/17 04:07:14 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:14 INFO  : file4.txt: Copied (new)
2026/01/17 04:07:14 DEBUG : file7.txt: size = 0 OK
2026/01/17 04:07:14 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:14 INFO  : file7.txt: Copied (new)
2026/01/17 04:07:15 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:07:15 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:07:15 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:07:15 DEBUG : file5.txt: size = 0 OK
2026/01/17 04:07:15 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:15 INFO  : file5.txt: Copied (new)
2026/01/17 04:07:15 DEBUG : file6.txt: size = 0 OK
2026/01/17 04:07:15 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:07:15 INFO  : file6.txt: Copied (new)
2026/01/17 04:07:15 NOTICE: checking path2 B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2
2026/01/17 04:07:15 NOTICE: (01)  : test resync
2026/01/17 04:07:15 NOTICE: (02)  : test 1. resync with empty path1, resulting in copying all content from path2.
2026/01/17 04:07:15 NOTICE: (03)  : purge-children TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/
2026/01/17 04:07:15 DEBUG : RCLONE_TEST: Remove file
2026/01/17 04:07:15 DEBUG : file1.txt: Remove file
2026/01/17 04:07:16 DEBUG : file2.txt: Remove file
2026/01/17 04:07:16 DEBUG : file3.txt: Remove file
2026/01/17 04:07:16 DEBUG : file4.txt: Remove file
2026/01/17 04:07:16 DEBUG : file5.txt: Remove file
2026/01/17 04:07:16 DEBUG : file6.txt: Remove file
2026/01/17 04:07:17 DEBUG : file7.txt: Remove file
2026/01/17 04:07:17 NOTICE: (04)  : bisync resync
2026/01/17 04:07:25 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:07:25 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:07:25 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:07:25 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:07:25 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:25 INFO  : Copying Path2 files to Path1
2026/01/17 04:07:25 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:07:25 INFO  : RCLONE_TEST: Copied (server-side copy)
2026/01/17 04:07:25 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file2.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file3.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file4.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file5.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file7.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : file6.txt: Copied (server-side copy)
2026/01/17 04:07:26 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:07:26 INFO  : Resync updating listings
2026/01/17 04:07:26 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:26 INFO  : Bisync successful
2026/01/17 04:07:26 NOTICE: (05)  : move-listings empty-path1
2026/01/17 04:07:26 NOTICE: (06)  : test 2. resync with empty path2, resulting in syncing all content to path2.
2026/01/17 04:07:26 NOTICE: (07)  : purge-children TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/
2026/01/17 04:07:26 DEBUG : RCLONE_TEST: Remove file
2026/01/17 04:07:27 DEBUG : file1.txt: Remove file
2026/01/17 04:07:27 DEBUG : file2.txt: Remove file
2026/01/17 04:07:27 DEBUG : file3.txt: Remove file
2026/01/17 04:07:27 DEBUG : file4.txt: Remove file
2026/01/17 04:07:27 DEBUG : file5.txt: Remove file
2026/01/17 04:07:27 DEBUG : file6.txt: Remove file
2026/01/17 04:07:28 DEBUG : file7.txt: Remove file
2026/01/17 04:07:28 NOTICE: (08)  : bisync resync
2026/01/17 04:07:36 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:07:36 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:07:36 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:07:36 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:07:36 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:36 INFO  : Copying Path2 files to Path1
2026/01/17 04:07:36 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:07:36 INFO  : There was nothing to transfer
2026/01/17 04:07:36 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:07:37 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:07:37 INFO  : file3.txt: Copied (server-side copy)
2026/01/17 04:07:37 INFO  : file4.txt: Copied (server-side copy)
2026/01/17 04:07:37 INFO  : file2.txt: Copied (server-side copy)
2026/01/17 04:07:37 INFO  : RCLONE_TEST: Copied (server-side copy)
2026/01/17 04:07:38 INFO  : file5.txt: Copied (server-side copy)
2026/01/17 04:07:38 INFO  : file6.txt: Copied (server-side copy)
2026/01/17 04:07:38 INFO  : file7.txt: Copied (server-side copy)
2026/01/17 04:07:38 INFO  : Resync updating listings
2026/01/17 04:07:38 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:38 INFO  : Bisync successful
2026/01/17 04:07:38 NOTICE: (09)  : move-listings empty-path2
2026/01/17 04:07:38 NOTICE: (10)  : test 3. exercise all of the various file difference scenarios during a resync.
2026/01/17 04:07:38 NOTICE: (11)  : touch-glob 2002-02-02 /tmp/040704he/datadir/test_resync-litetuc4/ fileA.txt
2026/01/17 04:07:38 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/"
2026/01/17 04:07:38 DEBUG : fs cache: renaming cache item "/tmp/040704he/datadir/test_resync-litetuc4/" to be canonical "/tmp/040704he/datadir/test_resync-litetuc4"
2026/01/17 04:07:38 DEBUG : fileA.txt: Set modification time 2002-02-02
2026/01/17 04:07:38 NOTICE: (12)  : touch-glob 1999-09-09 /tmp/040704he/datadir/test_resync-litetuc4/ fileB.txt
2026/01/17 04:07:38 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync-litetuc4/" for canonical name "/tmp/040704he/datadir/test_resync-litetuc4"
2026/01/17 04:07:38 DEBUG : fileB.txt: Set modification time 1999-09-09
2026/01/17 04:07:38 NOTICE: (13)  : test = file      - path1      - path2      - expected action    - who wins
2026/01/17 04:07:38 NOTICE: (14)  : test - file1.txt - exists     - missing    - sync path1 > path2 - path1
2026/01/17 04:07:38 NOTICE: (15)  : delete-file TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/file1.txt
2026/01/17 04:07:38 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:39 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/" to be canonical "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2"
2026/01/17 04:07:40 INFO  : file1.txt: Deleted
2026/01/17 04:07:40 NOTICE: (16)  : test - file2.txt - missing    - exists     - copy path2 > path1 - path2
2026/01/17 04:07:40 NOTICE: (17)  : delete-file TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/file2.txt
2026/01/17 04:07:40 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/"
2026/01/17 04:07:41 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" to be canonical "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1"
2026/01/17 04:07:42 INFO  : file2.txt: Deleted
2026/01/17 04:07:42 NOTICE: (18)  : test - file3.txt - exists     - newer date - sync path1 > path2 - path1
2026/01/17 04:07:42 NOTICE: (19)  : copy-as /tmp/040704he/datadir/test_resync-litetuc4/fileA.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/ file3.txt
2026/01/17 04:07:42 DEBUG : copyFile "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/" as "file3.txt"
2026/01/17 04:07:42 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt"
2026/01/17 04:07:42 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:43 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2" as "file3.txt"
2026/01/17 04:07:43 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040704he/datadir/test_resync-litetuc4)
2026/01/17 04:07:43 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2)
2026/01/17 04:07:43 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:07:45 DEBUG : file3.txt: size = 19 OK
2026/01/17 04:07:45 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:07:45 INFO  : fileA.txt: Copied (replaced existing) to: file3.txt
2026/01/17 04:07:45 NOTICE: (20)  : test - file4.txt - missing    - newer date - copy path2 > path1 - path2
2026/01/17 04:07:45 NOTICE: (21)  : delete-file TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/file4.txt
2026/01/17 04:07:45 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" for canonical name "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1"
2026/01/17 04:07:46 INFO  : file4.txt: Deleted
2026/01/17 04:07:46 NOTICE: (22)  : copy-as /tmp/040704he/datadir/test_resync-litetuc4/fileA.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/ file4.txt
2026/01/17 04:07:46 DEBUG : copyFile "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/" as "file4.txt"
2026/01/17 04:07:46 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt"
2026/01/17 04:07:46 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:47 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2" as "file4.txt"
2026/01/17 04:07:47 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040704he/datadir/test_resync-litetuc4)
2026/01/17 04:07:47 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2)
2026/01/17 04:07:47 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:07:48 DEBUG : file4.txt: size = 19 OK
2026/01/17 04:07:48 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:07:48 INFO  : fileA.txt: Copied (replaced existing) to: file4.txt
2026/01/17 04:07:48 NOTICE: (23)  : test - file5.txt - exists     - older date - sync path1 > path2 - path1
2026/01/17 04:07:48 NOTICE: (24)  : copy-as /tmp/040704he/datadir/test_resync-litetuc4/fileB.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/ file5.txt
2026/01/17 04:07:48 DEBUG : copyFile "/tmp/040704he/datadir/test_resync-litetuc4/fileB.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/" as "file5.txt"
2026/01/17 04:07:48 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/fileB.txt"
2026/01/17 04:07:48 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:50 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2" as "file5.txt"
2026/01/17 04:07:50 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/040704he/datadir/test_resync-litetuc4)
2026/01/17 04:07:50 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2)
2026/01/17 04:07:50 DEBUG : fileB.txt: Sizes differ
2026/01/17 04:07:51 DEBUG : file5.txt: size = 19 OK
2026/01/17 04:07:51 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:07:51 INFO  : fileB.txt: Copied (replaced existing) to: file5.txt
2026/01/17 04:07:51 NOTICE: (25)  : test - file6.txt - older date - newer date - sync path1 > path2	- path1
2026/01/17 04:07:51 NOTICE: (26)  : copy-as /tmp/040704he/datadir/test_resync-litetuc4/fileB.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/ file6.txt
2026/01/17 04:07:51 DEBUG : copyFile "/tmp/040704he/datadir/test_resync-litetuc4/fileB.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" as "file6.txt"
2026/01/17 04:07:51 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/fileB.txt"
2026/01/17 04:07:51 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/"
2026/01/17 04:07:52 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1" as "file6.txt"
2026/01/17 04:07:53 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/040704he/datadir/test_resync-litetuc4)
2026/01/17 04:07:53 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1)
2026/01/17 04:07:53 DEBUG : fileB.txt: Sizes differ
2026/01/17 04:07:54 DEBUG : file6.txt: size = 19 OK
2026/01/17 04:07:54 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:07:54 INFO  : fileB.txt: Copied (replaced existing) to: file6.txt
2026/01/17 04:07:54 NOTICE: (27)  : copy-as /tmp/040704he/datadir/test_resync-litetuc4/fileA.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/ file6.txt
2026/01/17 04:07:54 DEBUG : copyFile "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/" as "file6.txt"
2026/01/17 04:07:54 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync-litetuc4/fileA.txt"
2026/01/17 04:07:54 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:07:55 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2" as "file6.txt"
2026/01/17 04:07:56 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/040704he/datadir/test_resync-litetuc4)
2026/01/17 04:07:56 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2)
2026/01/17 04:07:56 DEBUG : fileA.txt: Sizes differ
2026/01/17 04:07:58 DEBUG : file6.txt: size = 19 OK
2026/01/17 04:07:58 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/17 04:07:58 INFO  : fileA.txt: Copied (replaced existing) to: file6.txt
2026/01/17 04:07:58 NOTICE: (28)  : test - file7.txt - exists     - exists (same) - none            - same
2026/01/17 04:07:58 NOTICE: (29)  : test run bisync with resync
2026/01/17 04:07:58 NOTICE: (30)  : bisync resync
2026/01/17 04:08:08 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:08 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:08 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:08:08 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:08:08 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:08:08 INFO  : Copying Path2 files to Path1
2026/01/17 04:08:08 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:08:09 INFO  : file2.txt: Copied (server-side copy)
2026/01/17 04:08:09 INFO  : file4.txt: Copied (server-side copy)
2026/01/17 04:08:09 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:08:10 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:08:10 INFO  : file3.txt: Copied (server-side copy)
2026/01/17 04:08:10 INFO  : file5.txt: Copied (server-side copy)
2026/01/17 04:08:10 INFO  : file6.txt: Updated modification time in destination
2026/01/17 04:08:10 INFO  : Resync updating listings
2026/01/17 04:08:10 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:08:10 INFO  : Bisync successful
2026/01/17 04:08:10 NOTICE: (31)  : copy-listings mixed-diffs
2026/01/17 04:08:10 NOTICE: (32)  : test run normal bisync
2026/01/17 04:08:10 NOTICE: (33)  : bisync
2026/01/17 04:08:18 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:18 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:18 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:08:18 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:08:18 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:08:18 INFO  : Building Path1 and Path2 listings
2026/01/17 04:08:19 INFO  : Path1 checking for diffs
2026/01/17 04:08:19 INFO  : Path2 checking for diffs
2026/01/17 04:08:19 INFO  : No changes found
2026/01/17 04:08:19 INFO  : Updating listings
2026/01/17 04:08:19 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:08:19 INFO  : Bisync successful
2026/01/17 04:08:19 NOTICE: (34)  : test 4. confirm critical error on normal sync of empty path.
2026/01/17 04:08:19 NOTICE: (35)  : purge-children TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/
2026/01/17 04:08:19 DEBUG : RCLONE_TEST: Remove file
2026/01/17 04:08:19 DEBUG : file1.txt: Remove file
2026/01/17 04:08:19 DEBUG : file2.txt: Remove file
2026/01/17 04:08:19 DEBUG : file3.txt: Remove file
2026/01/17 04:08:20 DEBUG : file4.txt: Remove file
2026/01/17 04:08:20 DEBUG : file5.txt: Remove file
2026/01/17 04:08:20 DEBUG : file6.txt: Remove file
2026/01/17 04:08:20 DEBUG : file7.txt: Remove file
2026/01/17 04:08:20 NOTICE: (36)  : bisync
2026/01/17 04:08:28 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:28 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:28 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:08:28 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:08:28 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync/path2/"
2026/01/17 04:08:28 INFO  : Building Path1 and Path2 listings
2026/01/17 04:08:28 INFO  : Path1 checking for diffs
2026/01/17 04:08:28 INFO  : Path2 checking for diffs
2026/01/17 04:08:28 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/040704he/workdir/TestB2_rclone-test-cudexuk6qoqu_040704he_resync_path1..TestB2_rclone-test-cudexuk6qoqu_040704he_resync_path2.path2.lst-new
2026/01/17 04:08:28 ERROR : Bisync critical error: empty current Path2 listing: /tmp/040704he/workdir/TestB2_rclone-test-cudexuk6qoqu_040704he_resync_path1..TestB2_rclone-test-cudexuk6qoqu_040704he_resync_path2.path2.lst-new
2026/01/17 04:08:28 ERROR : Bisync aborted. Must run --resync to recover.
2026/01/17 04:08:28 NOTICE: Bisync error: bisync aborted
2026/01/17 04:08:28 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:08:29 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10362371b82936b6_d20260117_m040725_c001_v0001040_t0026_u01768622845330")
2026/01/17 04:08:29 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb514_d20260117_m040715_c001_v7007000_t0000_u01768622835806")
2026/01/17 04:08:29 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1182a56ccb507d1d_d20260117_m040712_c001_v0001185_t0031_u01768622832226")
2026/01/17 04:08:29 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10100b1c26beaab7_d20260117_m040725_c001_v0001172_t0031_u01768622845698")
2026/01/17 04:08:29 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb518_d20260117_m040715_c001_v7007000_t0000_u01768622835998")
2026/01/17 04:08:29 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10364853c6f37d6e_d20260117_m040712_c001_v0001167_t0010_u01768622832034")
2026/01/17 04:08:29 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101e8061f6d9f9ee_d20260117_m040809_c001_v0001100_t0035_u01768622889023")
2026/01/17 04:08:29 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4097da7e9a411e61_d20260117_m040742_c001_v7007000_t0000_u01768622862481")
2026/01/17 04:08:29 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f106f3577c417fda9_d20260117_m040725_c001_v0001101_t0051_u01768622845700")
2026/01/17 04:08:29 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb51b_d20260117_m040716_c001_v7007000_t0000_u01768622836185")
2026/01/17 04:08:29 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1123efc2a3ef7304_d20260117_m040711_c001_v0001179_t0051_u01768622831857")
2026/01/17 04:08:29 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f103ac4ec669f4029_d20260117_m040725_c001_v0001100_t0003_u01768622845718")
2026/01/17 04:08:29 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb51e_d20260117_m040716_c001_v7007000_t0000_u01768622836371")
2026/01/17 04:08:29 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f115455fac330ca1f_d20260117_m040712_c001_v0001167_t0032_u01768622832412")
2026/01/17 04:08:29 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1127c2909d3ed65b_d20260117_m040809_c001_v0001146_t0048_u01768622889375")
2026/01/17 04:08:29 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4097da7e9a411e81_d20260117_m040745_c001_v7007000_t0000_u01768622865965")
2026/01/17 04:08:29 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118b08e2f6be8aab_d20260117_m040725_c001_v0001173_t0039_u01768622845754")
2026/01/17 04:08:30 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb520_d20260117_m040716_c001_v7007000_t0000_u01768622836557")
2026/01/17 04:08:30 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1123efc2a3ef730a_d20260117_m040712_c001_v0001179_t0026_u01768622832069")
2026/01/17 04:08:30 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118b5e835956e1a2_d20260117_m040726_c001_v0001176_t0009_u01768622846084")
2026/01/17 04:08:30 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb523_d20260117_m040716_c001_v7007000_t0000_u01768622836744")
2026/01/17 04:08:30 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1182a56ccb507d2f_d20260117_m040712_c001_v0001185_t0043_u01768622832467")
2026/01/17 04:08:30 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1074c1f70948357c_d20260117_m040754_c001_v0001172_t0006_u01768622874612")
2026/01/17 04:08:30 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1198f5c5287787e1_d20260117_m040726_c001_v0001040_t0019_u01768622846121")
2026/01/17 04:08:30 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb526_d20260117_m040716_c001_v7007000_t0000_u01768622836930")
2026/01/17 04:08:30 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10364853c6f37d83_d20260117_m040712_c001_v0001167_t0047_u01768622832606")
2026/01/17 04:08:30 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f111c5a7e9ef65ed4_d20260117_m040726_c001_v0001157_t0024_u01768622846163")
2026/01/17 04:08:30 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb529_d20260117_m040717_c001_v7007000_t0000_u01768622837116")
2026/01/17 04:08:30 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1123efc2a3ef730c_d20260117_m040712_c001_v0001179_t0021_u01768622832607")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4071406699849a91_d20260117_m040824_c001_v7007000_t0000_u01768622904531")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f105e11d48ca77b22_d20260117_m040823_c001_v0001185_t0045_u01768622903338")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1182a56ccb508a3d_d20260117_m040821_c001_v0001185_t0002_u01768622901346")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4071406699849a26_d20260117_m040814_c001_v7007000_t0000_u01768622894823")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f113bc8660195de3e_d20260117_m040813_c001_v0001091_t0008_u01768622893352")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10364853c6f3871d_d20260117_m040811_c001_v0001167_t0025_u01768622891244")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4198cf6005071eaf_d20260117_m040803_c001_v7007000_t0000_u01768622883203")
2026/01/17 04:08:30 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1074e32f74350ebf_d20260117_m040801_c001_v0001145_t0015_u01768622881476")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f115455fac330d0d0_d20260117_m040758_c001_v0001167_t0012_u01768622878507")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f41559e7b1bb6dd73_d20260117_m040732_c001_v7007000_t0000_u01768622852085")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f105c95119e42ef06_d20260117_m040730_c001_v0001043_t0040_u01768622850657")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1123efc2a3ef7346_d20260117_m040728_c001_v0001179_t0022_u01768622848868")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418997e5516bb55e_d20260117_m040720_c001_v7007000_t0000_u01768622840716")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11499796e4dd0f26_d20260117_m040719_c001_v0001167_t0048_u01768622839153")
2026/01/17 04:08:31 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1182a56ccb507e17_d20260117_m040717_c001_v0001185_t0059_u01768622837304")
2026/01/17 04:08:31 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:08:32 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07313_d20260117_m040819_c001_v7007000_t0000_u01768622899474")
2026/01/17 04:08:32 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10131d3d0ed81bd3_d20260117_m040737_c001_v0001185_t0018_u01768622857443")
2026/01/17 04:08:32 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a5_d20260117_m040726_c001_v7007000_t0000_u01768622846956")
2026/01/17 04:08:32 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1145e6d287e0076e_d20260117_m040714_c001_v0001173_t0012_u01768622834687")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07314_d20260117_m040819_c001_v7007000_t0000_u01768622899661")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1045f2a8b50e59ee_d20260117_m040810_c001_v0001176_t0053_u01768622890079")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4051b62e5f03cc5b_d20260117_m040740_c001_v7007000_t0000_u01768622860270")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107d40104add5a81_d20260117_m040737_c001_v0001173_t0045_u01768622857071")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a6_d20260117_m040727_c001_v7007000_t0000_u01768622847142")
2026/01/17 04:08:32 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101ace14e4331230_d20260117_m040714_c001_v0001109_t0003_u01768622834134")
2026/01/17 04:08:32 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07315_d20260117_m040819_c001_v7007000_t0000_u01768622899847")
2026/01/17 04:08:32 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1078c51f6c1cdb0c_d20260117_m040737_c001_v0001146_t0021_u01768622857466")
2026/01/17 04:08:32 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a7_d20260117_m040727_c001_v7007000_t0000_u01768622847328")
2026/01/17 04:08:32 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2971c96_d20260117_m040714_c001_v0001185_t0037_u01768622834482")
2026/01/17 04:08:32 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07316_d20260117_m040820_c001_v7007000_t0000_u01768622900035")
2026/01/17 04:08:32 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101a8cdf3d706fe7_d20260117_m040810_c001_v0001183_t0040_u01768622890456")
2026/01/17 04:08:32 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f100beb604d4de418_d20260117_m040745_c001_v0001113_t0003_u01768622865300")
2026/01/17 04:08:32 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f105bef6c39e2653f_d20260117_m040737_c001_v0001178_t0053_u01768622857531")
2026/01/17 04:08:32 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a8_d20260117_m040727_c001_v7007000_t0000_u01768622847516")
2026/01/17 04:08:33 DEBUG : file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10990f117719c51f_d20260117_m040714_c001_v0001098_t0045_u01768622834331")
2026/01/17 04:08:33 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07317_d20260117_m040820_c001_v7007000_t0000_u01768622900220")
2026/01/17 04:08:33 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101e8d34a2dd9c23_d20260117_m040748_c001_v0001179_t0040_u01768622868802")
2026/01/17 04:08:33 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107f3c366ac708b4_d20260117_m040737_c001_v0001181_t0040_u01768622857574")
2026/01/17 04:08:33 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a9_d20260117_m040727_c001_v7007000_t0000_u01768622847704")
2026/01/17 04:08:33 DEBUG : file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2971c9e_d20260117_m040714_c001_v0001185_t0044_u01768622834674")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07318_d20260117_m040820_c001_v7007000_t0000_u01768622900406")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11072d0921e7a415_d20260117_m040810_c001_v0001185_t0040_u01768622890479")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1157ffdfca86b05e_d20260117_m040751_c001_v0001150_t0027_u01768622871635")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11072d0921e79d4d_d20260117_m040737_c001_v0001185_t0020_u01768622857767")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61aa_d20260117_m040727_c001_v7007000_t0000_u01768622847889")
2026/01/17 04:08:33 DEBUG : file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101ace14e4331234_d20260117_m040714_c001_v0001109_t0000_u01768622834716")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07319_d20260117_m040820_c001_v7007000_t0000_u01768622900590")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f106bc3008e12a906_d20260117_m040810_c001_v0001040_t0045_u01768622890490")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f111bd18e09dbb7cc_d20260117_m040757_c001_v0001167_t0009_u01768622877570")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1078105fd719cf84_d20260117_m040737_c001_v0001116_t0056_u01768622857823")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61ab_d20260117_m040728_c001_v7007000_t0000_u01768622848075")
2026/01/17 04:08:33 DEBUG : file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10990f117719c527_d20260117_m040714_c001_v0001098_t0015_u01768622834744")
2026/01/17 04:08:33 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e0731a_d20260117_m040820_c001_v7007000_t0000_u01768622900776")
2026/01/17 04:08:33 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1090a0db1b7381b0_d20260117_m040737_c001_v0001090_t0036_u01768622857970")
2026/01/17 04:08:33 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61ac_d20260117_m040728_c001_v7007000_t0000_u01768622848269")
2026/01/17 04:08:33 DEBUG : file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2971cb8_d20260117_m040714_c001_v0001185_t0047_u01768622834866")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4068695031cb7ffa_d20260117_m040828_c001_v7007000_t0000_u01768622908660")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f102c2ad621a1034c_d20260117_m040827_c001_v0001102_t0019_u01768622907326")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2972ad5_d20260117_m040825_c001_v0001185_t0017_u01768622905103")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e07312_d20260117_m040818_c001_v7007000_t0000_u01768622898901")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11739e9e2f26fe5f_d20260117_m040817_c001_v0001173_t0006_u01768622897321")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10990f117719c6ca_d20260117_m040815_c001_v0001098_t0051_u01768622895415")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4104ec19f8adb2bd_d20260117_m040808_c001_v7007000_t0000_u01768622888247")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11826f3dddd890c2_d20260117_m040806_c001_v0001117_t0035_u01768622886725")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f101ace14e4331301_d20260117_m040803_c001_v0001109_t0046_u01768622883794")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418c3cd044d5516b_d20260117_m040736_c001_v7007000_t0000_u01768622856480")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10675b4c0c0645cf_d20260117_m040735_c001_v0001137_t0020_u01768622855111")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1145e6d287e009e0_d20260117_m040732_c001_v0001173_t0007_u01768622852654")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f422855ddb34c61a3_d20260117_m040724_c001_v7007000_t0000_u01768622844926")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10839d0d489679cb_d20260117_m040723_c001_v0001041_t0029_u01768622843512")
2026/01/17 04:08:34 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2971e61_d20260117_m040721_c001_v0001185_t0034_u01768622841288")
    bisync_test.go:608: TEST resync PASSED
=== RUN   TestBisyncRemoteRemote/resync_modes
2026/01/17 04:08:35 INFO  : path1: Making directory
2026/01/17 04:08:35 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1"
2026/01/17 04:08:36 INFO  : path2: Making directory
2026/01/17 04:08:36 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2"
2026/01/17 04:08:37 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial"
2026/01/17 04:08:37 DEBUG : Creating backend with remote "/tmp/040704he/initdir/test_resync_modes-zoyiyes2"
2026/01/17 04:08:37 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : Local file system at /tmp/040704he/initdir/test_resync_modes-zoyiyes2: Waiting for checks to finish
2026/01/17 04:08:37 DEBUG : Local file system at /tmp/040704he/initdir/test_resync_modes-zoyiyes2: Waiting for transfers to finish
2026/01/17 04:08:37 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:08:37 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:08:37 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/17 04:08:37 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:08:37 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:08:37 INFO  : file1.txt: Copied (new)
2026/01/17 04:08:37 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/17 04:08:37 INFO  : file2.txt: Copied (new)
2026/01/17 04:08:37 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:08:37 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:08:37 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:08:37 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:08:37 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles"
2026/01/17 04:08:37 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:08:37 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:37 DEBUG : Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7: Waiting for checks to finish
2026/01/17 04:08:37 DEBUG : Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7: Waiting for transfers to finish
2026/01/17 04:08:37 DEBUG : file1L.txt.684d937d.partial: size = 33 OK
2026/01/17 04:08:37 DEBUG : file2.txt.ac4156f2.partial: size = 37 OK
2026/01/17 04:08:37 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2026/01/17 04:08:37 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2026/01/17 04:08:37 DEBUG : file1R.txt.d467e63a.partial: size = 42 OK
2026/01/17 04:08:37 DEBUG : file1L.txt.684d937d.partial: renamed to: file1L.txt
2026/01/17 04:08:37 INFO  : file1L.txt: Copied (new)
2026/01/17 04:08:37 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK
2026/01/17 04:08:37 DEBUG : file2.txt.ac4156f2.partial: renamed to: file2.txt
2026/01/17 04:08:37 INFO  : file2.txt: Copied (new)
2026/01/17 04:08:37 DEBUG : file1R.txt.d467e63a.partial: renamed to: file1R.txt
2026/01/17 04:08:37 INFO  : file1R.txt: Copied (new)
2026/01/17 04:08:37 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:08:38 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:08:39 NOTICE: checking initFs Local file system at /tmp/040704he/initdir/test_resync_modes-zoyiyes2
2026/01/17 04:08:39 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:08:39 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:39 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:39 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Waiting for checks to finish
2026/01/17 04:08:39 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Waiting for transfers to finish
2026/01/17 04:08:40 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:08:40 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:08:40 INFO  : file1.txt: Copied (new)
2026/01/17 04:08:40 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:08:40 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:08:40 INFO  : file2.txt: Copied (new)
2026/01/17 04:08:40 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:08:40 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:08:40 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:08:40 NOTICE: checking Path1 B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1
2026/01/17 04:08:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:08:41 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:41 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:08:41 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Waiting for checks to finish
2026/01/17 04:08:41 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Waiting for transfers to finish
2026/01/17 04:08:42 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:08:42 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:08:42 INFO  : file1.txt: Copied (new)
2026/01/17 04:08:42 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:08:42 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:08:42 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:08:42 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:08:42 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:08:42 INFO  : file2.txt: Copied (new)
2026/01/17 04:08:42 NOTICE: checking path2 B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2
2026/01/17 04:08:42 NOTICE: (01)  : test resync-mode
2026/01/17 04:08:42 NOTICE: (02)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:08:42 NOTICE: (03)  : touch-glob 2001-01-02 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:08:42 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/"
2026/01/17 04:08:42 DEBUG : fs cache: renaming cache item "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" to be canonical "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:08:42 DEBUG : file1R.txt: Set modification time 2001-01-02
2026/01/17 04:08:42 NOTICE: (04)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:08:42 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:08:42 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:08:42 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:08:43 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:08:43 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:08:43 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:08:43 DEBUG : file1R.txt: Sizes differ
2026/01/17 04:08:45 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:08:45 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:08:45 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:08:45 NOTICE: (05)  : touch-glob 2001-03-04 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:08:45 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:08:45 DEBUG : file1L.txt: Set modification time 2001-03-04
2026/01/17 04:08:45 NOTICE: (06)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:08:45 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:08:45 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:08:45 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:08:47 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:08:47 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:08:47 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1)
2026/01/17 04:08:47 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:08:49 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:08:49 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:08:49 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:08:49 NOTICE: (07)  : test bisync run with --resync-mode=newer
2026/01/17 04:08:49 NOTICE: (08)  : bisync resync resync-mode=newer
2026/01/17 04:08:57 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:57 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:08:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:08:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:08:57 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:08:57 INFO  : Copying Path2 files to Path1
2026/01/17 04:08:57 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:08:57 INFO  : There was nothing to transfer
2026/01/17 04:08:57 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:08:58 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:08:58 INFO  : Resync updating listings
2026/01/17 04:08:58 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:08:58 INFO  : Bisync successful
2026/01/17 04:08:58 NOTICE: (09)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:08:58 NOTICE: (10)  : touch-glob 2001-07-23 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:08:58 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:08:58 DEBUG : file1R.txt: Set modification time 2001-07-23
2026/01/17 04:08:58 NOTICE: (11)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:08:58 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:08:58 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:08:58 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:08:59 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:08:59 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:08:59 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:08:59 DEBUG : file1R.txt: Sizes differ
2026/01/17 04:09:01 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:09:01 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:09:01 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:09:01 NOTICE: (12)  : touch-glob 2001-08-26 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:09:01 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:01 DEBUG : file1L.txt: Set modification time 2001-08-26
2026/01/17 04:09:01 NOTICE: (13)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:09:01 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:09:01 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:09:01 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:09:02 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:09:02 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:09:02 DEBUG : file1L.txt: Modification times differ by -4200h0m0s: 2001-08-26 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC
2026/01/17 04:09:02 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:09:03 INFO  : file1L.txt: Updated modification time in destination
2026/01/17 04:09:03 DEBUG : file1L.txt: Unchanged skipping
2026/01/17 04:09:03 NOTICE: (14)  : test bisync run with --resync-mode=path2
2026/01/17 04:09:03 NOTICE: (15)  : bisync resync resync-mode=path2
2026/01/17 04:09:11 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:11 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:11 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:09:11 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:09:11 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:11 INFO  : Copying Path2 files to Path1
2026/01/17 04:09:11 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:09:12 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:09:12 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:09:12 INFO  : Resync updating listings
2026/01/17 04:09:12 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:12 INFO  : Bisync successful
2026/01/17 04:09:12 NOTICE: (16)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:09:12 NOTICE: (17)  : touch-glob 2002-07-23 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:09:12 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:12 DEBUG : file1R.txt: Set modification time 2002-07-23
2026/01/17 04:09:12 NOTICE: (18)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:09:12 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:09:12 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:09:12 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:13 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:09:13 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:09:13 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2002-07-23 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC
2026/01/17 04:09:13 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:09:15 INFO  : file1R.txt: Updated modification time in destination
2026/01/17 04:09:15 DEBUG : file1R.txt: Unchanged skipping
2026/01/17 04:09:15 NOTICE: (19)  : touch-glob 2002-08-26 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:09:15 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:15 DEBUG : file1L.txt: Set modification time 2002-08-26
2026/01/17 04:09:15 NOTICE: (20)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:09:15 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:09:15 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:09:15 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:09:16 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:09:16 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:09:16 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1)
2026/01/17 04:09:16 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:09:18 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:09:18 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:09:18 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:09:18 NOTICE: (21)  : test bisync run with --resync-mode=larger
2026/01/17 04:09:18 NOTICE: (22)  : bisync resync resync-mode=larger
2026/01/17 04:09:27 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:27 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:27 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:09:27 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:09:27 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:27 INFO  : Copying Path2 files to Path1
2026/01/17 04:09:27 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:09:27 INFO  : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9
2026/01/17 04:09:28 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:09:28 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:09:28 INFO  : Resync updating listings
2026/01/17 04:09:28 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:28 INFO  : Bisync successful
2026/01/17 04:09:28 NOTICE: (23)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:09:28 NOTICE: (24)  : touch-glob 2003-07-23 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:09:28 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:28 DEBUG : file1R.txt: Set modification time 2003-07-23
2026/01/17 04:09:28 NOTICE: (25)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:09:28 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:09:28 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:09:28 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:29 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:09:29 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:09:29 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2003-07-23 00:00:00 +0000 UTC, 2002-07-23 00:00:00 +0000 UTC
2026/01/17 04:09:29 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:09:31 INFO  : file1R.txt: Updated modification time in destination
2026/01/17 04:09:31 DEBUG : file1R.txt: Unchanged skipping
2026/01/17 04:09:31 NOTICE: (26)  : touch-glob 2003-09-04 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:09:31 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:31 DEBUG : file1L.txt: Set modification time 2003-09-04
2026/01/17 04:09:31 NOTICE: (27)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:09:31 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:09:31 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:09:31 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:09:32 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:09:32 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:09:32 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1)
2026/01/17 04:09:32 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:09:34 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:09:34 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:09:34 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:09:34 NOTICE: (28)  : test bisync run with --resync-mode=older
2026/01/17 04:09:34 NOTICE: (29)  : bisync resync resync-mode=older
2026/01/17 04:09:43 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:43 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:43 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:09:43 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:09:43 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:43 INFO  : Copying Path2 files to Path1
2026/01/17 04:09:43 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:09:43 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
2026/01/17 04:09:44 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:09:44 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:09:44 INFO  : Resync updating listings
2026/01/17 04:09:44 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:44 INFO  : Bisync successful
2026/01/17 04:09:44 NOTICE: (30)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:09:44 NOTICE: (31)  : touch-glob 2004-07-23 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:09:44 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:44 DEBUG : file1R.txt: Set modification time 2004-07-23
2026/01/17 04:09:44 NOTICE: (32)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:09:44 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:09:44 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:09:44 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:45 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:09:45 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:09:45 DEBUG : file1R.txt: Modification times differ by -8784h0m0s: 2004-07-23 00:00:00 +0000 UTC, 2003-07-23 00:00:00 +0000 UTC
2026/01/17 04:09:45 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:09:46 INFO  : file1R.txt: Updated modification time in destination
2026/01/17 04:09:46 DEBUG : file1R.txt: Unchanged skipping
2026/01/17 04:09:46 NOTICE: (33)  : touch-glob 2004-07-23 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:09:46 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:46 DEBUG : file1L.txt: Set modification time 2004-07-23
2026/01/17 04:09:46 NOTICE: (34)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:09:46 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:09:46 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:09:46 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:09:47 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:09:48 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:09:48 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1)
2026/01/17 04:09:48 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:09:49 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:09:49 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:09:49 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:09:49 NOTICE: (35)  : test bisync run with --resync-mode=smaller
2026/01/17 04:09:49 NOTICE: (36)  : bisync resync resync-mode=smaller
2026/01/17 04:09:57 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:57 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:09:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:09:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:09:57 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:57 INFO  : Copying Path2 files to Path1
2026/01/17 04:09:57 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:09:57 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2026/01/17 04:09:57 INFO  : There was nothing to transfer
2026/01/17 04:09:57 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:09:58 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2026/01/17 04:09:58 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:09:58 INFO  : Resync updating listings
2026/01/17 04:09:58 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:58 INFO  : Bisync successful
2026/01/17 04:09:58 NOTICE: (37)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/17 04:09:58 NOTICE: (38)  : touch-glob 2005-01-02 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:09:58 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:09:58 DEBUG : file1R.txt: Set modification time 2005-01-02
2026/01/17 04:09:58 NOTICE: (39)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:09:58 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:09:58 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:09:58 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:09:59 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:09:59 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:09:59 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:09:59 DEBUG : file1R.txt: Sizes differ
2026/01/17 04:10:01 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:10:01 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:10:01 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:10:01 NOTICE: (40)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file2.txt
2026/01/17 04:10:01 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file2.txt"
2026/01/17 04:10:01 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:10:01 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:10:02 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file2.txt"
2026/01/17 04:10:02 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:10:02 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1)
2026/01/17 04:10:02 DEBUG : file1R.txt: Sizes differ
2026/01/17 04:10:04 DEBUG : file2.txt: size = 42 OK
2026/01/17 04:10:04 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:10:04 INFO  : file1R.txt: Copied (replaced existing) to: file2.txt
2026/01/17 04:10:04 NOTICE: (41)  : touch-glob 2006-03-04 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:10:04 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:10:04 DEBUG : file1L.txt: Set modification time 2006-03-04
2026/01/17 04:10:04 NOTICE: (42)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:10:04 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:10:04 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:10:04 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:10:06 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:10:06 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:10:06 DEBUG : file1L.txt: Modification times differ by -14136h0m0s: 2006-03-04 00:00:00 +0000 UTC, 2004-07-23 00:00:00 +0000 UTC
2026/01/17 04:10:06 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:10:08 INFO  : file1L.txt: Updated modification time in destination
2026/01/17 04:10:08 DEBUG : file1L.txt: Unchanged skipping
2026/01/17 04:10:08 NOTICE: (43)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file2.txt
2026/01/17 04:10:08 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file2.txt"
2026/01/17 04:10:08 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:10:08 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:09 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file2.txt"
2026/01/17 04:10:09 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:10:09 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:10:09 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:10:11 DEBUG : file2.txt: size = 33 OK
2026/01/17 04:10:11 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:10:11 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2026/01/17 04:10:11 NOTICE: (44)  : test bisync run with --resync-mode=path1
2026/01/17 04:10:11 NOTICE: (45)  : bisync resync resync-mode=path1
2026/01/17 04:10:20 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:10:20 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:10:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:10:20 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:10:20 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:20 INFO  : Copying Path2 files to Path1
2026/01/17 04:10:20 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:10:21 INFO  : There was nothing to transfer
2026/01/17 04:10:21 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:10:21 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:10:21 INFO  : file2.txt: Copied (server-side copy)
2026/01/17 04:10:21 INFO  : Resync updating listings
2026/01/17 04:10:21 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:21 INFO  : Bisync successful
2026/01/17 04:10:21 NOTICE: (46)  : test no winner
2026/01/17 04:10:21 NOTICE: (47)  : touch-glob 2022-02-22 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1R.txt
2026/01/17 04:10:21 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:10:21 DEBUG : file1R.txt: Set modification time 2022-02-22
2026/01/17 04:10:21 NOTICE: (48)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file1.txt
2026/01/17 04:10:21 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file1.txt"
2026/01/17 04:10:21 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:10:21 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:23 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file1.txt"
2026/01/17 04:10:23 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:10:23 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:10:23 DEBUG : file1R.txt: Sizes differ
2026/01/17 04:10:24 DEBUG : file1.txt: size = 42 OK
2026/01/17 04:10:24 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:10:24 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/17 04:10:24 NOTICE: (49)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file2.txt
2026/01/17 04:10:24 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file2.txt"
2026/01/17 04:10:24 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1R.txt"
2026/01/17 04:10:24 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:10:26 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file2.txt"
2026/01/17 04:10:26 DEBUG : file2.txt: size = 42 OK
2026/01/17 04:10:26 DEBUG : file1R.txt: Modification times differ by -150240h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2005-01-02 00:00:00 +0000 UTC
2026/01/17 04:10:26 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/17 04:10:27 INFO  : file1R.txt: Updated modification time in destination
2026/01/17 04:10:27 DEBUG : file1R.txt: Unchanged skipping
2026/01/17 04:10:27 NOTICE: (50)  : touch-glob 2022-02-22 /tmp/040704he/datadir/test_resync_modes-fihibaw7/ file1L.txt
2026/01/17 04:10:27 DEBUG : fs cache: switching user supplied name "/tmp/040704he/datadir/test_resync_modes-fihibaw7/" for canonical name "/tmp/040704he/datadir/test_resync_modes-fihibaw7"
2026/01/17 04:10:27 DEBUG : file1L.txt: Set modification time 2022-02-22
2026/01/17 04:10:27 NOTICE: (51)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/ file1.txt
2026/01/17 04:10:27 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" as "file1.txt"
2026/01/17 04:10:27 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:10:27 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/"
2026/01/17 04:10:28 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1" as "file1.txt"
2026/01/17 04:10:29 DEBUG : file1.txt: size = 33 OK
2026/01/17 04:10:29 DEBUG : file1L.txt: Modification times differ by -140016h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2006-03-04 00:00:00 +0000 UTC
2026/01/17 04:10:29 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:10:30 INFO  : file1L.txt: Updated modification time in destination
2026/01/17 04:10:30 DEBUG : file1L.txt: Unchanged skipping
2026/01/17 04:10:30 NOTICE: (52)  : copy-as /tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/ file2.txt
2026/01/17 04:10:30 DEBUG : copyFile "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt" to "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/" as "file2.txt"
2026/01/17 04:10:30 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_resync_modes-fihibaw7/file1L.txt"
2026/01/17 04:10:30 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:31 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2" as "file2.txt"
2026/01/17 04:10:31 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/040704he/datadir/test_resync_modes-fihibaw7)
2026/01/17 04:10:31 DEBUG : file2.txt: size = 42 (B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2)
2026/01/17 04:10:31 DEBUG : file1L.txt: Sizes differ
2026/01/17 04:10:33 DEBUG : file2.txt: size = 33 OK
2026/01/17 04:10:33 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/17 04:10:33 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2026/01/17 04:10:33 NOTICE: (53)  : test bisync run with --resync-mode=newer
2026/01/17 04:10:33 NOTICE: (54)  : bisync resync resync-mode=newer
2026/01/17 04:10:41 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:10:41 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/17 04:10:41 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/17 04:10:41 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2026/01/17 04:10:41 INFO  : Synching Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" with Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:41 INFO  : Copying Path2 files to Path1
2026/01/17 04:10:41 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/17 04:10:42 INFO  : file1.txt: Copied (server-side copy)
2026/01/17 04:10:42 INFO  : file2.txt: Copied (server-side copy)
2026/01/17 04:10:42 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/17 04:10:42 INFO  : Resync updating listings
2026/01/17 04:10:42 INFO  : Validating listings for Path1 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path1/" vs Path2 "TestB2:rclone-test-cudexuk6qoqu/040704he/resync_modes/path2/"
2026/01/17 04:10:42 INFO  : Bisync successful
2026/01/17 04:10:42 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:10:43 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1102bfd2a369199d_d20260117_m040840_c001_v0001137_t0013_u01768622920453")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f105f3d103a492a96_d20260117_m041041_c001_v0001167_t0055_u01768623041994")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f102ce67e8360fbd3_d20260117_m041030_c001_v0001134_t0045_u01768623030057")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f108528687ca2bfab_d20260117_m041007_c001_v0001185_t0042_u01768623007944")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10126f29478838db_d20260117_m040949_c001_v0001040_t0036_u01768622989456")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107c772c4bedacf5_d20260117_m040943_c001_v0001090_t0009_u01768622983655")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107d40104add6905_d20260117_m040934_c001_v0001173_t0035_u01768622974412")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f102626aa80dc9d7b_d20260117_m040927_c001_v0001173_t0042_u01768622967904")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f103af105a554c43e_d20260117_m040917_c001_v0001173_t0052_u01768622957853")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f109b3b552f3b9dec_d20260117_m040912_c001_v0001041_t0000_u01768622952123")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10740581d759ea9b_d20260117_m040903_c001_v0001099_t0046_u01768622943476")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11455a5c3af3da20_d20260117_m040848_c001_v0001090_t0029_u01768622928627")
2026/01/17 04:10:43 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e5426eba8_d20260117_m040840_c001_v0001185_t0030_u01768622920052")
2026/01/17 04:10:43 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f115f837342ab7eca_d20260117_m041042_c001_v0001157_t0025_u01768623042350")
2026/01/17 04:10:43 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11058606533d9b65_d20260117_m041027_c001_v0001146_t0006_u01768623027290")
2026/01/17 04:10:43 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1002e9bb3447529e_d20260117_m041004_c001_v0001150_t0007_u01768623004225")
2026/01/17 04:10:43 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118b782278e4bba5_d20260117_m040840_c001_v0001182_t0014_u01768622920257")
2026/01/17 04:10:43 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f407aeecfd2e68061_d20260117_m041037_c001_v7007000_t0000_u01768623037210")
2026/01/17 04:10:43 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f100ddcf443444930_d20260117_m041035_c001_v0001180_t0017_u01768623035939")
2026/01/17 04:10:43 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e542700e7_d20260117_m041033_c001_v0001185_t0029_u01768623033790")
2026/01/17 04:10:43 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4071406699849ba9_d20260117_m041015_c001_v7007000_t0000_u01768623015528")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117fdfab3abdb023_d20260117_m041013_c001_v0001167_t0050_u01768623013764")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1102bfd2a3691adb_d20260117_m041011_c001_v0001137_t0053_u01768623011517")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4111a4b555021589_d20260117_m040953_c001_v7007000_t0000_u01768622993633")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2973a23_d20260117_m040952_c001_v0001185_t0004_u01768622992413")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118b782278e4bd86_d20260117_m040950_c001_v0001182_t0038_u01768622990234")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4104ec19f8adb3b3_d20260117_m040938_c001_v7007000_t0000_u01768622978765")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1198f5c528778933_d20260117_m040937_c001_v0001040_t0021_u01768622977314")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e5426f6f7_d20260117_m040935_c001_v0001185_t0043_u01768622975170")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f416ddd01e60de9a7_d20260117_m040922_c001_v7007000_t0000_u01768622962935")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f108fc46a0cad90ce_d20260117_m040921_c001_v0001173_t0027_u01768622961092")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1102bfd2a3691a3a_d20260117_m040918_c001_v0001137_t0033_u01768622958844")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f414667f59f6acf62_d20260117_m040907_c001_v7007000_t0000_u01768622947658")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1152f8789588f093_d20260117_m040906_c001_v0001180_t0005_u01768622946447")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118b782278e4bc5b_d20260117_m040904_c001_v0001182_t0002_u01768622944280")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4196ab431b505f7b_d20260117_m040853_c001_v7007000_t0000_u01768622933041")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10336ad5400e7bcb_d20260117_m040851_c001_v0001185_t0047_u01768622931774")
2026/01/17 04:10:44 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e5426edca_d20260117_m040849_c001_v0001185_t0059_u01768622929650")
2026/01/17 04:10:45 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/resync_modes/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:10:45 DEBUG : RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117c883aac10858d_d20260117_m040842_c001_v0001178_t0028_u01768622922244")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f113469f3b741b56b_d20260117_m041024_c001_v0001098_t0001_u01768623024696")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f105e11d48ca78f73_d20260117_m041021_c001_v0001185_t0042_u01768623021457")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1004c5eced12880f_d20260117_m041001_c001_v0001146_t0001_u01768623001177")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f113cc5f87cf31cf0_d20260117_m040958_c001_v0001185_t0011_u01768622998290")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1019ef9b743694f2_d20260117_m040946_c001_v0001182_t0027_u01768622986635")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1130edb3d77a7e08_d20260117_m040930_c001_v0001116_t0009_u01768622970984")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107931aa15125861_d20260117_m040915_c001_v0001185_t0032_u01768622955071")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f103e556051f5f82b_d20260117_m040900_c001_v0001157_t0035_u01768622940832")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1138af0f4a679349_d20260117_m040857_c001_v0001113_t0000_u01768622937711")
2026/01/17 04:10:45 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1025d03b3a35f015_d20260117_m040845_c001_v0001115_t0028_u01768622925348")
2026/01/17 04:10:46 DEBUG : file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1096dcae58920359_d20260117_m040842_c001_v0001146_t0037_u01768622922031")
2026/01/17 04:10:46 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f104d37df1aafc513_d20260117_m041033_c001_v0001154_t0001_u01768623033076")
2026/01/17 04:10:46 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10260ad349eb55c9_d20260117_m041021_c001_v0001098_t0047_u01768623021735")
2026/01/17 04:10:46 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f116ae07a6602d716_d20260117_m041010_c001_v0001177_t0056_u01768623010910")
2026/01/17 04:10:46 DEBUG : file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1002cfdb6516b255_d20260117_m040841_c001_v0001167_t0043_u01768622921856")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4085c38a89413aee_d20260117_m041041_c001_v7007000_t0000_u01768623041585")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1193074960ac832d_d20260117_m041039_c001_v0001167_t0007_u01768623039835")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1096dcae5892057b_d20260117_m041037_c001_v0001146_t0007_u01768623037785")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f416ddd01e60de9ff_d20260117_m041020_c001_v7007000_t0000_u01768623020363")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1011c77447b2e044_d20260117_m041018_c001_v0001173_t0031_u01768623018724")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1002cfdb6516be9f_d20260117_m041016_c001_v0001167_t0018_u01768623016104")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4196ab431b50619c_d20260117_m040957_c001_v7007000_t0000_u01768622997707")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1027380499e4a5de_d20260117_m040956_c001_v0001037_t0048_u01768622996391")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117c883aac10869b_d20260117_m040954_c001_v0001178_t0025_u01768622994228")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f4158660ba5e073c0_d20260117_m040943_c001_v7007000_t0000_u01768622983267")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10336ad5400e853f_d20260117_m040941_c001_v0001185_t0004_u01768622981926")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1096dcae58920486_d20260117_m040939_c001_v0001146_t0017_u01768622979315")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f403f8aa98f78445f_d20260117_m040927_c001_v7007000_t0000_u01768622967510")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f112a055f5d5387d7_d20260117_m040925_c001_v0001116_t0004_u01768622965905")
2026/01/17 04:10:46 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1002cfdb6516b7e9_d20260117_m040923_c001_v0001167_t0038_u01768622963542")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f416ddd01e60de9a4_d20260117_m040911_c001_v7007000_t0000_u01768622951733")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1137e4e5bee815c8_d20260117_m040910_c001_v0001120_t0041_u01768622950448")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117c883aac1085cb_d20260117_m040908_c001_v0001178_t0036_u01768622948252")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f418c3cd044d551eb_d20260117_m040857_c001_v7007000_t0000_u01768622937129")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f107931aa151254be_d20260117_m040855_c001_v0001185_t0004_u01768622935938")
2026/01/17 04:10:47 DEBUG : modtime_write_test: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1096dcae5892038d_d20260117_m040853_c001_v0001146_t0023_u01768622933615")
    bisync_test.go:608: TEST resync_modes PASSED
=== RUN   TestBisyncRemoteRemote/rmdirs
2026/01/17 04:10:47 INFO  : path1: Making directory
2026/01/17 04:10:47 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/rmdirs/path1"
2026/01/17 04:10:48 INFO  : path2: Making directory
2026/01/17 04:10:48 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/rmdirs/path2"
2026/01/17 04:10:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial"
2026/01/17 04:10:50 DEBUG : Creating backend with remote "/tmp/040704he/initdir/test_rmdirs-nokalag6"
2026/01/17 04:10:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : subdir: Making directory with metadata
2026/01/17 04:10:50 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2026/01/17 04:10:50 DEBUG : Added delayed dir = "subdir", newDst=subdir
2026/01/17 04:10:50 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2026/01/17 04:10:50 INFO  : file1.copy1.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : Local file system at /tmp/040704he/initdir/test_rmdirs-nokalag6: Waiting for checks to finish
2026/01/17 04:10:50 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : Local file system at /tmp/040704he/initdir/test_rmdirs-nokalag6: Waiting for transfers to finish
2026/01/17 04:10:50 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2026/01/17 04:10:50 INFO  : file1.copy2.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2026/01/17 04:10:50 INFO  : file1.copy4.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2026/01/17 04:10:50 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:10:50 INFO  : file1.copy3.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:10:50 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2026/01/17 04:10:50 INFO  : file1.copy5.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:10:50 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:10:50 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:10:50 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK
2026/01/17 04:10:50 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2026/01/17 04:10:50 INFO  : subdir/file20.txt: Copied (new)
2026/01/17 04:10:50 INFO  : subdir: Set directory modification time (using SetModTime)
2026/01/17 04:10:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles"
2026/01/17 04:10:50 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_rmdirs-sirorop3"
2026/01/17 04:10:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:50 DEBUG : Local file system at /tmp/040704he/datadir/test_rmdirs-sirorop3: Waiting for checks to finish
2026/01/17 04:10:50 DEBUG : Local file system at /tmp/040704he/datadir/test_rmdirs-sirorop3: Waiting for transfers to finish
2026/01/17 04:10:50 DEBUG : file1.txt.f41fd5ee.partial: size = 19 OK
2026/01/17 04:10:50 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:50 DEBUG : file1.txt.f41fd5ee.partial: renamed to: file1.txt
2026/01/17 04:10:50 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:50 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:10:50 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:10:51 NOTICE: checking initFs Local file system at /tmp/040704he/initdir/test_rmdirs-nokalag6
2026/01/17 04:10:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 INFO  : subdir: Making directory
2026/01/17 04:10:52 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:52 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path1: Waiting for checks to finish
2026/01/17 04:10:52 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path1: Waiting for transfers to finish
2026/01/17 04:10:52 DEBUG : file1.copy1.txt: size = 0 OK
2026/01/17 04:10:52 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:52 INFO  : file1.copy1.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : file1.copy4.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : file1.copy4.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : file1.copy2.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : file1.copy2.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : file1.copy5.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : file1.copy5.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : file1.copy3.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : file1.copy3.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : subdir/file20.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : subdir/file20.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:10:53 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:53 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:53 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:10:53 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:10:53 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:10:53 NOTICE: checking Path1 B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path1
2026/01/17 04:10:54 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 INFO  : subdir: Making directory
2026/01/17 04:10:54 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:54 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path2: Waiting for checks to finish
2026/01/17 04:10:54 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path2: Waiting for transfers to finish
2026/01/17 04:10:55 DEBUG : file1.copy1.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.copy1.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : file1.copy2.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.copy2.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : file1.copy4.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.copy4.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : file1.copy5.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.copy5.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:10:55 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:10:55 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:10:55 DEBUG : file1.copy3.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : file1.copy3.txt: Copied (new)
2026/01/17 04:10:55 DEBUG : subdir/file20.txt: size = 0 OK
2026/01/17 04:10:55 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:10:55 INFO  : subdir/file20.txt: Copied (new)
2026/01/17 04:10:55 NOTICE: checking path2 B2 bucket rclone-test-cudexuk6qoqu path 040704he/rmdirs/path2
2026/01/17 04:10:56 NOTICE: (01)  : test rmdirs
2026/01/17 04:10:56 NOTICE: (02)  : test initial bisync
2026/01/17 04:10:56 NOTICE: (03)  : bisync resync
    bisync_test.go:1007: skipping test as remote does not support empty dirs
=== RUN   TestBisyncRemoteRemote/volatile
2026/01/17 04:10:56 INFO  : path1: Making directory
2026/01/17 04:10:56 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/volatile/path1"
2026/01/17 04:10:57 INFO  : path2: Making directory
2026/01/17 04:10:57 DEBUG : Creating backend with remote "TestB2:rclone-test-cudexuk6qoqu/040704he/volatile/path2"
2026/01/17 04:10:58 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial"
2026/01/17 04:10:58 DEBUG : Creating backend with remote "/tmp/040704he/initdir/test_volatile-sezarim6"
2026/01/17 04:10:58 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : Local file system at /tmp/040704he/initdir/test_volatile-sezarim6: Waiting for checks to finish
2026/01/17 04:10:58 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : Local file system at /tmp/040704he/initdir/test_volatile-sezarim6: Waiting for transfers to finish
2026/01/17 04:10:58 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/17 04:10:58 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/17 04:10:58 INFO  : file2.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/17 04:10:58 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/17 04:10:58 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 INFO  : file3.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/17 04:10:58 INFO  : file4.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/17 04:10:58 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/17 04:10:58 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/17 04:10:58 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:10:58 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/17 04:10:58 INFO  : file6.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file8.txt.b300b322.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/17 04:10:58 INFO  : file7.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2026/01/17 04:10:58 INFO  : file8.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/17 04:10:58 INFO  : file5.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles"
2026/01/17 04:10:58 DEBUG : Creating backend with remote "/tmp/040704he/datadir/test_volatile-nadisem0"
2026/01/17 04:10:58 DEBUG : dummy.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file10.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file11.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:10:58 DEBUG : dummy.txt.b3782999.partial: size = 0 OK
2026/01/17 04:10:58 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/17 04:10:58 DEBUG : Local file system at /tmp/040704he/datadir/test_volatile-nadisem0: Waiting for checks to finish
2026/01/17 04:10:58 DEBUG : Local file system at /tmp/040704he/datadir/test_volatile-nadisem0: Waiting for transfers to finish
2026/01/17 04:10:58 DEBUG : dummy.txt.b3782999.partial: renamed to: dummy.txt
2026/01/17 04:10:58 INFO  : dummy.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file1.txt.be52b1c9.partial: size = 19 OK
2026/01/17 04:10:58 DEBUG : file11.txt.d4a7309d.partial: size = 19 OK
2026/01/17 04:10:58 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:58 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:58 DEBUG : file10.txt.bdde3bf8.partial: size = 19 OK
2026/01/17 04:10:58 DEBUG : file11.txt.d4a7309d.partial: renamed to: file11.txt
2026/01/17 04:10:58 INFO  : file11.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file1.txt.be52b1c9.partial: renamed to: file1.txt
2026/01/17 04:10:58 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:58 INFO  : file1.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file10.txt.bdde3bf8.partial: renamed to: file10.txt
2026/01/17 04:10:58 INFO  : file10.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file2.txt.23ff1769.partial: size = 13 OK
2026/01/17 04:10:58 DEBUG : file6.txt.7b4c87b3.partial: size = 19 OK
2026/01/17 04:10:58 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2026/01/17 04:10:58 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:58 DEBUG : file2.txt.23ff1769.partial: renamed to: file2.txt
2026/01/17 04:10:58 INFO  : file2.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file6.txt.7b4c87b3.partial: renamed to: file6.txt
2026/01/17 04:10:58 INFO  : file6.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file5R.txt.ee3b9525.partial: size = 39 OK
2026/01/17 04:10:58 DEBUG : file5L.txt.8dd6541a.partial: size = 39 OK
2026/01/17 04:10:58 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2026/01/17 04:10:58 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2026/01/17 04:10:58 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2026/01/17 04:10:58 INFO  : file5R.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file7.txt.38c43fbf.partial: size = 19 OK
2026/01/17 04:10:58 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2026/01/17 04:10:58 INFO  : file5L.txt: Copied (new)
2026/01/17 04:10:58 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/17 04:10:58 DEBUG : file7.txt.38c43fbf.partial: renamed to: file7.txt
2026/01/17 04:10:58 INFO  : file7.txt: Copied (new)
2026/01/17 04:10:58 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path1: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:10:59 INFO  : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path2: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:11:00 NOTICE: checking initFs Local file system at /tmp/040704he/initdir/test_volatile-sezarim6
2026/01/17 04:11:00 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:00 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path1: Waiting for checks to finish
2026/01/17 04:11:00 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path1: Waiting for transfers to finish
2026/01/17 04:11:01 DEBUG : file3.txt: size = 0 OK
2026/01/17 04:11:01 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:01 INFO  : file3.txt: Copied (new)
2026/01/17 04:11:01 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:11:01 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:01 INFO  : file2.txt: Copied (new)
2026/01/17 04:11:01 DEBUG : file4.txt: size = 0 OK
2026/01/17 04:11:01 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:01 INFO  : file4.txt: Copied (new)
2026/01/17 04:11:01 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:11:01 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:01 INFO  : file1.txt: Copied (new)
2026/01/17 04:11:01 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:11:01 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:11:01 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:11:02 DEBUG : file6.txt: size = 0 OK
2026/01/17 04:11:02 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:02 INFO  : file6.txt: Copied (new)
2026/01/17 04:11:02 DEBUG : file5.txt: size = 0 OK
2026/01/17 04:11:02 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:02 INFO  : file5.txt: Copied (new)
2026/01/17 04:11:02 DEBUG : file7.txt: size = 0 OK
2026/01/17 04:11:02 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:02 INFO  : file7.txt: Copied (new)
2026/01/17 04:11:02 DEBUG : file8.txt: size = 0 OK
2026/01/17 04:11:02 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:02 INFO  : file8.txt: Copied (new)
2026/01/17 04:11:02 NOTICE: checking Path1 B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path1
2026/01/17 04:11:03 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/17 04:11:03 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path2: Waiting for checks to finish
2026/01/17 04:11:03 DEBUG : B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path2: Waiting for transfers to finish
2026/01/17 04:11:04 DEBUG : file1.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file1.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file2.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file2.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/17 04:11:04 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/17 04:11:04 INFO  : RCLONE_TEST: Copied (new)
2026/01/17 04:11:04 DEBUG : file3.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file3.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file4.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file4.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file6.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file6.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file5.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file5.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file8.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file8.txt: Copied (new)
2026/01/17 04:11:04 DEBUG : file7.txt: size = 0 OK
2026/01/17 04:11:04 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/17 04:11:04 INFO  : file7.txt: Copied (new)
2026/01/17 04:11:04 NOTICE: checking path2 B2 bucket rclone-test-cudexuk6qoqu path 040704he/volatile/path2
2026/01/17 04:11:05 NOTICE: (01)  : test volatile
2026/01/17 04:11:05 NOTICE: (02)  : test initial bisync
2026/01/17 04:11:05 NOTICE: (03)  : bisync resync
    bisync_test.go:978: skipping 'volatile' test on non-local as it requires uploading 100 files
2026/01/17 04:11:05 DEBUG : B2 bucket rclone-test-cudexuk6qoqu: Purge remote
2026/01/17 04:11:05 INFO  : B2 bucket rclone-test-cudexuk6qoqu: cleaning bucket "rclone-test-cudexuk6qoqu" of all files
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f115455fac330e669_d20260117_m041053_c001_v0001167_t0013_u01768623053377")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.copy1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1146c29a980a5849_d20260117_m041052_c001_v0001183_t0041_u01768623052807")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.copy2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f111dfb2a68fb7677_d20260117_m041053_c001_v0001145_t0029_u01768623053014")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.copy3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f11624f59433e4559_d20260117_m041053_c001_v0001157_t0024_u01768623053223")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.copy4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1146c29a980a584b_d20260117_m041053_c001_v0001183_t0041_u01768623053021")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.copy5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1146c29a980a584d_d20260117_m041053_c001_v0001183_t0043_u01768623053233")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f111dfb2a68fb7679_d20260117_m041053_c001_v0001145_t0009_u01768623053269")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path1/subdir/file20.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1146c29a980a584f_d20260117_m041053_c001_v0001183_t0004_u01768623053459")
2026/01/17 04:11:05 DEBUG : 040704he/rmdirs/path2/RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1089b641b9b37dc1_d20260117_m041055_c001_v0001183_t0006_u01768623055514")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.copy1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b2974335_d20260117_m041054_c001_v0001185_t0054_u01768623054918")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.copy2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f100905c6ad45a257_d20260117_m041055_c001_v0001185_t0038_u01768623055108")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.copy3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10531d78cb191603_d20260117_m041055_c001_v0001173_t0012_u01768623055301")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.copy4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b297433f_d20260117_m041055_c001_v0001185_t0028_u01768623055119")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.copy5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f100905c6ad45a26b_d20260117_m041055_c001_v0001185_t0022_u01768623055493")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1175b490b297434f_d20260117_m041055_c001_v0001185_t0030_u01768623055522")
2026/01/17 04:11:06 DEBUG : 040704he/rmdirs/path2/subdir/file20.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f100905c6ad45a26f_d20260117_m041055_c001_v0001185_t0024_u01768623055711")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118a26d44afb79e4_d20260117_m041101_c001_v0001137_t0026_u01768623061552")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f112363e076d48e4d_d20260117_m041101_c001_v0001167_t0049_u01768623061359")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117fdfab3abdb5eb_d20260117_m041100_c001_v0001167_t0029_u01768623060974")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e542703ba_d20260117_m041101_c001_v0001185_t0019_u01768623061170")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e542703c6_d20260117_m041101_c001_v0001185_t0040_u01768623061477")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f117fdfab3abdb5fc_d20260117_m041101_c001_v0001167_t0018_u01768623061543")
2026/01/17 04:11:06 DEBUG : 040704he/volatile/path1/file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1126ac1e542703dc_d20260117_m041101_c001_v0001185_t0041_u01768623061902")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path1/file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f112363e076d48e55_d20260117_m041101_c001_v0001167_t0038_u01768623061910")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path1/file8.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f118a26d44afb79e6_d20260117_m041101_c001_v0001137_t0005_u01768623061969")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/RCLONE_TEST: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f104bb544b8b4b6df_d20260117_m041104_c001_v0001185_t0049_u01768623064290")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file1.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1078c51f6c1cde6a_d20260117_m041103_c001_v0001146_t0001_u01768623063740")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file2.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10197938661fff81_d20260117_m041103_c001_v0001131_t0048_u01768623063929")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file3.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1104a922e16a10cd_d20260117_m041104_c001_v0001131_t0045_u01768623064118")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file4.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1078c51f6c1cde6c_d20260117_m041104_c001_v0001146_t0045_u01768623064173")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file5.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f10197938661fff85_d20260117_m041104_c001_v0001131_t0001_u01768623064417")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file6.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f104bb544b8b4b6e3_d20260117_m041104_c001_v0001185_t0006_u01768623064481")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file7.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1104a922e16a10cf_d20260117_m041104_c001_v0001131_t0019_u01768623064570")
2026/01/17 04:11:07 DEBUG : 040704he/volatile/path2/file8.txt: Deleting (id "4_z2f12ad43202dcbab9fb80e1b_f1078c51f6c1cde70_d20260117_m041104_c001_v0001146_t0053_u01768623064592")
--- PASS: TestBisyncRemoteRemote (243.92s)
    --- PASS: TestBisyncRemoteRemote/resync (90.22s)
    --- PASS: TestBisyncRemoteRemote/resync_modes (132.58s)
    --- SKIP: TestBisyncRemoteRemote/rmdirs (8.29s)
    --- SKIP: TestBisyncRemoteRemote/volatile (9.08s)
FAIL
2026/01/17 04:11:08 DEBUG : B2 bucket rclone-test-wimiguf1tebu: Purge remote
2026/01/17 04:11:08 INFO  : B2 bucket rclone-test-wimiguf1tebu: cleaning bucket "rclone-test-wimiguf1tebu" of all files
2026/01/17 04:11:09 NOTICE: purge failed: directory not found
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^resync$|^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Finished ERROR in 4m46.056725462s (try 2/5): exit status 1: Failed [TestBisyncLocalRemote/resync]