"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5)
2026/01/30 05:18:33 DEBUG : Creating backend with remote "TestB2:rclone-test-tiyaqap7yuho"
2026/01/30 05:18:33 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/01/30 05:18:33 DEBUG : Creating backend with remote "/tmp/rclone3244619330"
=== RUN   TestBisyncRemoteRemote
2026/01/30 05:18:33 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu"
2026/01/30 05:18:34 NOTICE: remote: TestB2:rclone-test-tijezur9semu
=== RUN   TestBisyncRemoteRemote/resync
2026/01/30 05:18:34 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa"
2026/01/30 05:18:35 INFO  : path1: Making directory
2026/01/30 05:18:36 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1"
2026/01/30 05:18:37 INFO  : path2: Making directory
2026/01/30 05:18:37 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2"
2026/01/30 05:18:38 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial"
2026/01/30 05:18:38 DEBUG : Creating backend with remote "/tmp/051834xa/initdir/test_resync-juzepul6"
2026/01/30 05:18:38 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/30 05:18:38 DEBUG : Local file system at /tmp/051834xa/initdir/test_resync-juzepul6: Waiting for checks to finish
2026/01/30 05:18:38 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/30 05:18:38 INFO  : file1.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/30 05:18:38 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/30 05:18:38 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/30 05:18:38 DEBUG : Local file system at /tmp/051834xa/initdir/test_resync-juzepul6: Waiting for transfers to finish
2026/01/30 05:18:38 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/30 05:18:38 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:18:38 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/30 05:18:38 INFO  : file4.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/30 05:18:38 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/30 05:18:38 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/30 05:18:38 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/30 05:18:38 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/30 05:18:38 INFO  : file5.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/30 05:18:38 INFO  : file6.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/30 05:18:38 INFO  : file2.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/30 05:18:38 INFO  : file7.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/30 05:18:38 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:18:38 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/30 05:18:38 INFO  : file3.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles"
2026/01/30 05:18:38 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2"
2026/01/30 05:18:38 DEBUG : fileA.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : fileB.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:38 DEBUG : Local file system at /tmp/051834xa/datadir/test_resync-rahizay2: Waiting for checks to finish
2026/01/30 05:18:38 DEBUG : Local file system at /tmp/051834xa/datadir/test_resync-rahizay2: Waiting for transfers to finish
2026/01/30 05:18:38 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK
2026/01/30 05:18:38 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK
2026/01/30 05:18:38 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:18:38 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:18:38 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt
2026/01/30 05:18:38 INFO  : fileB.txt: Copied (new)
2026/01/30 05:18:38 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt
2026/01/30 05:18:38 INFO  : fileA.txt: Copied (new)
2026/01/30 05:18:38 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:18:39 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:18:40 NOTICE: checking initFs Local file system at /tmp/051834xa/initdir/test_resync-juzepul6
2026/01/30 05:18:40 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:40 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Waiting for checks to finish
2026/01/30 05:18:40 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Waiting for transfers to finish
2026/01/30 05:18:41 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:18:41 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:41 INFO  : file2.txt: Copied (new)
2026/01/30 05:18:41 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:18:41 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:41 INFO  : file1.txt: Copied (new)
2026/01/30 05:18:41 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:18:41 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:18:41 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:18:42 DEBUG : file3.txt: size = 0 OK
2026/01/30 05:18:42 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:42 INFO  : file3.txt: Copied (new)
2026/01/30 05:18:42 DEBUG : file5.txt: size = 0 OK
2026/01/30 05:18:42 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:42 INFO  : file5.txt: Copied (new)
2026/01/30 05:18:42 DEBUG : file6.txt: size = 0 OK
2026/01/30 05:18:42 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:42 INFO  : file6.txt: Copied (new)
2026/01/30 05:18:42 DEBUG : file4.txt: size = 0 OK
2026/01/30 05:18:42 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:42 INFO  : file4.txt: Copied (new)
2026/01/30 05:18:42 DEBUG : file7.txt: size = 0 OK
2026/01/30 05:18:42 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:42 INFO  : file7.txt: Copied (new)
2026/01/30 05:18:42 NOTICE: checking Path1 B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1
2026/01/30 05:18:43 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:18:43 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Waiting for checks to finish
2026/01/30 05:18:43 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Waiting for transfers to finish
2026/01/30 05:18:43 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:18:43 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:43 INFO  : file2.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : file4.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file4.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : file3.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file3.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : file5.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file5.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file1.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:18:44 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:18:44 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:18:44 DEBUG : file7.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file7.txt: Copied (new)
2026/01/30 05:18:44 DEBUG : file6.txt: size = 0 OK
2026/01/30 05:18:44 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:18:44 INFO  : file6.txt: Copied (new)
2026/01/30 05:18:44 NOTICE: checking path2 B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2
2026/01/30 05:18:44 NOTICE: (01)  : test resync
2026/01/30 05:18:44 NOTICE: (02)  : test 1. resync with empty path1, resulting in copying all content from path2.
2026/01/30 05:18:44 NOTICE: (03)  : purge-children TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/
2026/01/30 05:18:45 DEBUG : RCLONE_TEST: Remove file
2026/01/30 05:18:45 DEBUG : file1.txt: Remove file
2026/01/30 05:18:45 DEBUG : file2.txt: Remove file
2026/01/30 05:18:45 DEBUG : file3.txt: Remove file
2026/01/30 05:18:45 DEBUG : file4.txt: Remove file
2026/01/30 05:18:45 DEBUG : file5.txt: Remove file
2026/01/30 05:18:46 DEBUG : file6.txt: Remove file
2026/01/30 05:18:46 DEBUG : file7.txt: Remove file
2026/01/30 05:18:46 NOTICE: (04)  : bisync resync
2026/01/30 05:18:54 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:18:54 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:18:54 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:18:54 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/30 05:18:54 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:18:54 INFO  : Copying Path2 files to Path1
2026/01/30 05:18:54 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:18:54 INFO  : RCLONE_TEST: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file4.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file2.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file3.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file5.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file7.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : file6.txt: Copied (server-side copy)
2026/01/30 05:18:55 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:18:56 INFO  : Resync updating listings
2026/01/30 05:18:56 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:18:56 INFO  : Bisync successful
2026/01/30 05:18:56 NOTICE: (05)  : move-listings empty-path1
2026/01/30 05:18:56 NOTICE: (06)  : test 2. resync with empty path2, resulting in syncing all content to path2.
2026/01/30 05:18:56 NOTICE: (07)  : purge-children TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/
2026/01/30 05:18:56 DEBUG : RCLONE_TEST: Remove file
2026/01/30 05:18:56 DEBUG : file1.txt: Remove file
2026/01/30 05:18:56 DEBUG : file2.txt: Remove file
2026/01/30 05:18:56 DEBUG : file3.txt: Remove file
2026/01/30 05:18:56 DEBUG : file4.txt: Remove file
2026/01/30 05:18:57 DEBUG : file5.txt: Remove file
2026/01/30 05:18:57 DEBUG : file6.txt: Remove file
2026/01/30 05:18:57 DEBUG : file7.txt: Remove file
2026/01/30 05:18:57 NOTICE: (08)  : bisync resync
2026/01/30 05:19:05 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:05 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:05 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:19:05 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/30 05:19:05 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:05 INFO  : Copying Path2 files to Path1
2026/01/30 05:19:05 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:19:05 INFO  : There was nothing to transfer
2026/01/30 05:19:05 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:19:06 INFO  : file3.txt: Copied (server-side copy)
2026/01/30 05:19:06 INFO  : RCLONE_TEST: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file5.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file2.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file4.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file6.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : file7.txt: Copied (server-side copy)
2026/01/30 05:19:07 INFO  : Resync updating listings
2026/01/30 05:19:07 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:07 INFO  : Bisync successful
2026/01/30 05:19:07 NOTICE: (09)  : move-listings empty-path2
2026/01/30 05:19:07 NOTICE: (10)  : test 3. exercise all of the various file difference scenarios during a resync.
2026/01/30 05:19:07 NOTICE: (11)  : touch-glob 2002-02-02 /tmp/051834xa/datadir/test_resync-rahizay2/ fileA.txt
2026/01/30 05:19:07 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/"
2026/01/30 05:19:07 DEBUG : fs cache: renaming cache item "/tmp/051834xa/datadir/test_resync-rahizay2/" to be canonical "/tmp/051834xa/datadir/test_resync-rahizay2"
2026/01/30 05:19:07 DEBUG : fileA.txt: Set modification time 2002-02-02
2026/01/30 05:19:07 NOTICE: (12)  : touch-glob 1999-09-09 /tmp/051834xa/datadir/test_resync-rahizay2/ fileB.txt
2026/01/30 05:19:07 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync-rahizay2/" for canonical name "/tmp/051834xa/datadir/test_resync-rahizay2"
2026/01/30 05:19:07 DEBUG : fileB.txt: Set modification time 1999-09-09
2026/01/30 05:19:07 NOTICE: (13)  : test = file      - path1      - path2      - expected action    - who wins
2026/01/30 05:19:07 NOTICE: (14)  : test - file1.txt - exists     - missing    - sync path1 > path2 - path1
2026/01/30 05:19:07 NOTICE: (15)  : delete-file TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/file1.txt
2026/01/30 05:19:07 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:08 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/" to be canonical "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2"
2026/01/30 05:19:09 INFO  : file1.txt: Deleted
2026/01/30 05:19:09 NOTICE: (16)  : test - file2.txt - missing    - exists     - copy path2 > path1 - path2
2026/01/30 05:19:09 NOTICE: (17)  : delete-file TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/file2.txt
2026/01/30 05:19:09 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/"
2026/01/30 05:19:10 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" to be canonical "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1"
2026/01/30 05:19:11 INFO  : file2.txt: Deleted
2026/01/30 05:19:11 NOTICE: (18)  : test - file3.txt - exists     - newer date - sync path1 > path2 - path1
2026/01/30 05:19:11 NOTICE: (19)  : copy-as /tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/ file3.txt
2026/01/30 05:19:11 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/" as "file3.txt"
2026/01/30 05:19:11 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt"
2026/01/30 05:19:11 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:12 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2" as "file3.txt"
2026/01/30 05:19:12 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051834xa/datadir/test_resync-rahizay2)
2026/01/30 05:19:12 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2)
2026/01/30 05:19:12 DEBUG : fileA.txt: Sizes differ
2026/01/30 05:19:14 DEBUG : file3.txt: size = 19 OK
2026/01/30 05:19:14 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/30 05:19:14 INFO  : fileA.txt: Copied (replaced existing) to: file3.txt
2026/01/30 05:19:14 NOTICE: (20)  : test - file4.txt - missing    - newer date - copy path2 > path1 - path2
2026/01/30 05:19:14 NOTICE: (21)  : delete-file TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/file4.txt
2026/01/30 05:19:14 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" for canonical name "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1"
2026/01/30 05:19:15 INFO  : file4.txt: Deleted
2026/01/30 05:19:15 NOTICE: (22)  : copy-as /tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/ file4.txt
2026/01/30 05:19:15 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/" as "file4.txt"
2026/01/30 05:19:15 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt"
2026/01/30 05:19:15 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:16 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2" as "file4.txt"
2026/01/30 05:19:16 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051834xa/datadir/test_resync-rahizay2)
2026/01/30 05:19:16 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2)
2026/01/30 05:19:16 DEBUG : fileA.txt: Sizes differ
2026/01/30 05:19:18 DEBUG : file4.txt: size = 19 OK
2026/01/30 05:19:18 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/30 05:19:18 INFO  : fileA.txt: Copied (replaced existing) to: file4.txt
2026/01/30 05:19:18 NOTICE: (23)  : test - file5.txt - exists     - older date - sync path1 > path2 - path1
2026/01/30 05:19:18 NOTICE: (24)  : copy-as /tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/ file5.txt
2026/01/30 05:19:18 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/" as "file5.txt"
2026/01/30 05:19:18 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt"
2026/01/30 05:19:18 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:19 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2" as "file5.txt"
2026/01/30 05:19:19 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/051834xa/datadir/test_resync-rahizay2)
2026/01/30 05:19:19 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2)
2026/01/30 05:19:19 DEBUG : fileB.txt: Sizes differ
2026/01/30 05:19:20 DEBUG : file5.txt: size = 19 OK
2026/01/30 05:19:20 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/30 05:19:20 INFO  : fileB.txt: Copied (replaced existing) to: file5.txt
2026/01/30 05:19:20 NOTICE: (25)  : test - file6.txt - older date - newer date - sync path1 > path2	- path1
2026/01/30 05:19:20 NOTICE: (26)  : copy-as /tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/ file6.txt
2026/01/30 05:19:20 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" as "file6.txt"
2026/01/30 05:19:20 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/fileB.txt"
2026/01/30 05:19:20 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/"
2026/01/30 05:19:22 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1" as "file6.txt"
2026/01/30 05:19:22 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/051834xa/datadir/test_resync-rahizay2)
2026/01/30 05:19:22 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1)
2026/01/30 05:19:22 DEBUG : fileB.txt: Sizes differ
2026/01/30 05:19:24 DEBUG : file6.txt: size = 19 OK
2026/01/30 05:19:24 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/30 05:19:24 INFO  : fileB.txt: Copied (replaced existing) to: file6.txt
2026/01/30 05:19:24 NOTICE: (27)  : copy-as /tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/ file6.txt
2026/01/30 05:19:24 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/" as "file6.txt"
2026/01/30 05:19:24 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync-rahizay2/fileA.txt"
2026/01/30 05:19:24 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:25 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2" as "file6.txt"
2026/01/30 05:19:25 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051834xa/datadir/test_resync-rahizay2)
2026/01/30 05:19:25 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2)
2026/01/30 05:19:25 DEBUG : fileA.txt: Sizes differ
2026/01/30 05:19:27 DEBUG : file6.txt: size = 19 OK
2026/01/30 05:19:27 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK
2026/01/30 05:19:27 INFO  : fileA.txt: Copied (replaced existing) to: file6.txt
2026/01/30 05:19:27 NOTICE: (28)  : test - file7.txt - exists     - exists (same) - none            - same
2026/01/30 05:19:27 NOTICE: (29)  : test run bisync with resync
2026/01/30 05:19:27 NOTICE: (30)  : bisync resync
2026/01/30 05:19:35 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:35 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:35 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:19:35 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/30 05:19:35 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:35 INFO  : Copying Path2 files to Path1
2026/01/30 05:19:35 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:19:36 INFO  : file2.txt: Copied (server-side copy)
2026/01/30 05:19:37 INFO  : file4.txt: Copied (server-side copy)
2026/01/30 05:19:37 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:19:38 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:19:38 INFO  : file3.txt: Copied (server-side copy)
2026/01/30 05:19:38 INFO  : file5.txt: Copied (server-side copy)
2026/01/30 05:19:38 INFO  : file6.txt: Updated modification time in destination
2026/01/30 05:19:38 INFO  : Resync updating listings
2026/01/30 05:19:38 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:38 INFO  : Bisync successful
2026/01/30 05:19:38 NOTICE: (31)  : copy-listings mixed-diffs
2026/01/30 05:19:38 NOTICE: (32)  : test run normal bisync
2026/01/30 05:19:38 NOTICE: (33)  : bisync
2026/01/30 05:19:46 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:46 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:46 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:19:46 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/30 05:19:46 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:46 INFO  : Building Path1 and Path2 listings
2026/01/30 05:19:46 INFO  : Path1 checking for diffs
2026/01/30 05:19:46 INFO  : Path2 checking for diffs
2026/01/30 05:19:46 INFO  : No changes found
2026/01/30 05:19:46 INFO  : Updating listings
2026/01/30 05:19:46 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:46 INFO  : Bisync successful
2026/01/30 05:19:46 NOTICE: (34)  : test 4. confirm critical error on normal sync of empty path.
2026/01/30 05:19:46 NOTICE: (35)  : purge-children TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/
2026/01/30 05:19:46 DEBUG : RCLONE_TEST: Remove file
2026/01/30 05:19:47 DEBUG : file1.txt: Remove file
2026/01/30 05:19:47 DEBUG : file2.txt: Remove file
2026/01/30 05:19:47 DEBUG : file3.txt: Remove file
2026/01/30 05:19:47 DEBUG : file4.txt: Remove file
2026/01/30 05:19:47 DEBUG : file5.txt: Remove file
2026/01/30 05:19:48 DEBUG : file6.txt: Remove file
2026/01/30 05:19:48 DEBUG : file7.txt: Remove file
2026/01/30 05:19:48 NOTICE: (36)  : bisync
2026/01/30 05:19:57 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:57 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:19:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:19: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/30 05:19:57 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync/path2/"
2026/01/30 05:19:57 INFO  : Building Path1 and Path2 listings
2026/01/30 05:19:57 INFO  : Path1 checking for diffs
2026/01/30 05:19:57 INFO  : Path2 checking for diffs
2026/01/30 05:19:57 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/051834xa/workdir/TestB2_rclone-test-tijezur9semu_051834xa_resync_path1..TestB2_rclone-test-tijezur9semu_051834xa_resync_path2.path2.lst-new
2026/01/30 05:19:57 ERROR : Bisync critical error: empty current Path2 listing: /tmp/051834xa/workdir/TestB2_rclone-test-tijezur9semu_051834xa_resync_path1..TestB2_rclone-test-tijezur9semu_051834xa_resync_path2.path2.lst-new
2026/01/30 05:19:57 ERROR : Bisync aborted. Must run --resync to recover.
2026/01/30 05:19:57 NOTICE: Bisync error: bisync aborted
2026/01/30 05:19:57 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:19:58 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102ec9ec99d6c384_d20260130_m051854_c001_v0001093_t0041_u01769750334641")
2026/01/30 05:19:58 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9542_d20260130_m051845_c001_v7007000_t0000_u01769750325147")
2026/01/30 05:19:58 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2ba60_d20260130_m051841_c001_v0001185_t0016_u01769750321814")
2026/01/30 05:19:58 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10951aa8e7fb14b7_d20260130_m051855_c001_v0001173_t0017_u01769750335041")
2026/01/30 05:19:58 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9544_d20260130_m051845_c001_v7007000_t0000_u01769750325332")
2026/01/30 05:19:58 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1013417beb21d991_d20260130_m051841_c001_v0001137_t0015_u01769750321266")
2026/01/30 05:19:58 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10180f6e68878e30_d20260130_m051936_c001_v0001167_t0042_u01769750376242")
2026/01/30 05:19:58 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f404deeb63aed779f_d20260130_m051911_c001_v7007000_t0000_u01769750351471")
2026/01/30 05:19:58 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102a5e7c06fc7621_d20260130_m051855_c001_v0001167_t0003_u01769750335011")
2026/01/30 05:19:58 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9545_d20260130_m051845_c001_v7007000_t0000_u01769750325514")
2026/01/30 05:19:58 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1021fe8d86aede3a_d20260130_m051841_c001_v0001136_t0040_u01769750321449")
2026/01/30 05:19:58 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101a5259b6d0860d_d20260130_m051855_c001_v0001131_t0058_u01769750335029")
2026/01/30 05:19:58 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9546_d20260130_m051845_c001_v7007000_t0000_u01769750325695")
2026/01/30 05:19:58 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118407e63f03a351_d20260130_m051841_c001_v0001173_t0003_u01769750321646")
2026/01/30 05:19:58 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f113cdf8926f9f810_d20260130_m051936_c001_v0001173_t0050_u01769750376569")
2026/01/30 05:19:58 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f404deeb63aed77bf_d20260130_m051915_c001_v7007000_t0000_u01769750355262")
2026/01/30 05:19:58 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1129f7d23cf653b7_d20260130_m051855_c001_v0001182_t0018_u01769750335033")
2026/01/30 05:19:58 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9549_d20260130_m051845_c001_v7007000_t0000_u01769750325876")
2026/01/30 05:19:58 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1021fe8d86aede40_d20260130_m051841_c001_v0001136_t0001_u01769750321832")
2026/01/30 05:19:58 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1158ca80f77d7806_d20260130_m051855_c001_v0001090_t0008_u01769750335263")
2026/01/30 05:19:58 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c954c_d20260130_m051846_c001_v7007000_t0000_u01769750326059")
2026/01/30 05:19:58 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1013417beb21d997_d20260130_m051841_c001_v0001137_t0043_u01769750321906")
2026/01/30 05:19:59 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1022dd64f0744f99_d20260130_m051923_c001_v0001106_t0046_u01769750363612")
2026/01/30 05:19:59 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1138ad46105f8d90_d20260130_m051855_c001_v0001134_t0049_u01769750335574")
2026/01/30 05:19:59 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c954f_d20260130_m051846_c001_v7007000_t0000_u01769750326242")
2026/01/30 05:19:59 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2ba68_d20260130_m051842_c001_v0001185_t0059_u01769750322068")
2026/01/30 05:19:59 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1136c2503b671d06_d20260130_m051855_c001_v0001176_t0028_u01769750335608")
2026/01/30 05:19:59 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9551_d20260130_m051846_c001_v7007000_t0000_u01769750326423")
2026/01/30 05:19:59 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118407e63f03a363_d20260130_m051842_c001_v0001173_t0026_u01769750322196")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f42245155851fd411_d20260130_m051952_c001_v7007000_t0000_u01769750392084")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1108ab7840443e21_d20260130_m051950_c001_v0001090_t0036_u01769750390804")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1013417beb21da2e_d20260130_m051948_c001_v0001137_t0028_u01769750388924")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f42245155851fd3f5_d20260130_m051942_c001_v7007000_t0000_u01769750382493")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102c36574fc80b39_d20260130_m051941_c001_v0001179_t0014_u01769750381285")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118407e63f03a854_d20260130_m051939_c001_v0001173_t0034_u01769750379029")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f413eb592fb7c652d_d20260130_m051931_c001_v7007000_t0000_u01769750371466")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1158fd64cebf6557_d20260130_m051929_c001_v0001134_t0022_u01769750369975")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1021fe8d86aedec7_d20260130_m051927_c001_v0001136_t0022_u01769750367673")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4020961a36e82a66_d20260130_m051901_c001_v7007000_t0000_u01769750341364")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f106aaa25402b314e_d20260130_m051859_c001_v0001145_t0051_u01769750339915")
2026/01/30 05:19:59 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2bbdb_d20260130_m051858_c001_v0001185_t0002_u01769750338152")
2026/01/30 05:20:00 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c9657_d20260130_m051850_c001_v7007000_t0000_u01769750330099")
2026/01/30 05:20:00 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11717a783d300128_d20260130_m051848_c001_v0001167_t0032_u01769750328526")
2026/01/30 05:20:00 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1013417beb21d9a3_d20260130_m051846_c001_v0001137_t0027_u01769750326607")
2026/01/30 05:20:00 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:20:00 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229093_d20260130_m051947_c001_v7007000_t0000_u01769750387086")
2026/01/30 05:20:00 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1085024f755e02a4_d20260130_m051906_c001_v0001167_t0015_u01769750346033")
2026/01/30 05:20:00 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424741_d20260130_m051856_c001_v7007000_t0000_u01769750336319")
2026/01/30 05:20:00 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101c6d4bc4967278_d20260130_m051844_c001_v0001185_t0038_u01769750324335")
2026/01/30 05:20:00 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229094_d20260130_m051947_c001_v7007000_t0000_u01769750387267")
2026/01/30 05:20:00 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11229be01ed69922_d20260130_m051937_c001_v0001136_t0047_u01769750377821")
2026/01/30 05:20:00 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f40883f6e41d28687_d20260130_m051909_c001_v7007000_t0000_u01769750349667")
2026/01/30 05:20:00 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1063ac641d44d601_d20260130_m051906_c001_v0001167_t0010_u01769750346419")
2026/01/30 05:20:00 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424744_d20260130_m051856_c001_v7007000_t0000_u01769750336500")
2026/01/30 05:20:01 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11137d9c571e652e_d20260130_m051844_c001_v0001113_t0055_u01769750324152")
2026/01/30 05:20:01 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229095_d20260130_m051947_c001_v7007000_t0000_u01769750387449")
2026/01/30 05:20:01 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f113b7ebfcfe44730_d20260130_m051906_c001_v0001167_t0035_u01769750346543")
2026/01/30 05:20:01 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424745_d20260130_m051856_c001_v7007000_t0000_u01769750336681")
2026/01/30 05:20:01 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10742f98f3875d05_d20260130_m051843_c001_v0001178_t0020_u01769750323773")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229096_d20260130_m051947_c001_v7007000_t0000_u01769750387631")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11017a6542cd982b_d20260130_m051938_c001_v0001136_t0008_u01769750378214")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1122143e21e68800_d20260130_m051914_c001_v0001167_t0014_u01769750354287")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2bc87_d20260130_m051906_c001_v0001185_t0041_u01769750346429")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424746_d20260130_m051856_c001_v7007000_t0000_u01769750336863")
2026/01/30 05:20:01 DEBUG : file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f113109d145b50208_d20260130_m051843_c001_v0001099_t0017_u01769750323984")
2026/01/30 05:20:01 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229097_d20260130_m051947_c001_v7007000_t0000_u01769750387815")
2026/01/30 05:20:01 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2bd4e_d20260130_m051918_c001_v0001185_t0022_u01769750358004")
2026/01/30 05:20:01 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1165de636f60134d_d20260130_m051906_c001_v0001173_t0019_u01769750346723")
2026/01/30 05:20:01 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424747_d20260130_m051857_c001_v7007000_t0000_u01769750337043")
2026/01/30 05:20:02 DEBUG : file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10742f98f3875d07_d20260130_m051843_c001_v0001178_t0052_u01769750323991")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229098_d20260130_m051947_c001_v7007000_t0000_u01769750387998")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115544fb268d6bca_d20260130_m051938_c001_v0001137_t0039_u01769750378224")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102071b6dded020e_d20260130_m051920_c001_v0001185_t0005_u01769750360731")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f117e27da7a632dba_d20260130_m051907_c001_v0001181_t0032_u01769750347027")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424748_d20260130_m051857_c001_v7007000_t0000_u01769750337225")
2026/01/30 05:20:02 DEBUG : file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10742f98f3875d0b_d20260130_m051844_c001_v0001178_t0020_u01769750324196")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed2022909a_d20260130_m051948_c001_v7007000_t0000_u01769750388179")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10806f127cc02d3c_d20260130_m051938_c001_v0001040_t0052_u01769750378216")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1180cfbab6081ad2_d20260130_m051926_c001_v0001153_t0008_u01769750366900")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f109c6cf770d83234_d20260130_m051907_c001_v0001109_t0002_u01769750347275")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a6424749_d20260130_m051857_c001_v7007000_t0000_u01769750337407")
2026/01/30 05:20:02 DEBUG : file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f113109d145b5020a_d20260130_m051844_c001_v0001099_t0008_u01769750324371")
2026/01/30 05:20:02 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed2022909b_d20260130_m051948_c001_v7007000_t0000_u01769750388359")
2026/01/30 05:20:02 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1060fda23e02879f_d20260130_m051907_c001_v0001120_t0034_u01769750347568")
2026/01/30 05:20:02 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a642474a_d20260130_m051857_c001_v7007000_t0000_u01769750337590")
2026/01/30 05:20:02 DEBUG : file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10742f98f3875d0d_d20260130_m051844_c001_v0001178_t0004_u01769750324410")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f42245155851fd41f_d20260130_m051957_c001_v7007000_t0000_u01769750397026")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1085024f755e0655_d20260130_m051955_c001_v0001167_t0030_u01769750395388")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11137d9c571e65d6_d20260130_m051952_c001_v0001113_t0012_u01769750392626")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f411e73ed20229091_d20260130_m051946_c001_v7007000_t0000_u01769750386521")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102ec9ec99d6c3af_d20260130_m051945_c001_v0001093_t0012_u01769750385037")
2026/01/30 05:20:02 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f113109d145b5029a_d20260130_m051943_c001_v0001099_t0025_u01769750383079")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f418ff0a5e4020e81_d20260130_m051935_c001_v7007000_t0000_u01769750375793")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10180f6e68878dfe_d20260130_m051934_c001_v0001167_t0008_u01769750374182")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10742f98f3875d6b_d20260130_m051932_c001_v0001178_t0044_u01769750372032")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416f34a5356c968b_d20260130_m051905_c001_v7007000_t0000_u01769750345445")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f117c95ff0916ad1f_d20260130_m051904_c001_v0001172_t0021_u01769750344045")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101c6d4bc4967474_d20260130_m051901_c001_v0001185_t0016_u01769750341914")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4125d018a642473f_d20260130_m051854_c001_v7007000_t0000_u01769750334253")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10976ae7560fbb18_d20260130_m051853_c001_v0001178_t0054_u01769750333027")
2026/01/30 05:20:03 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11137d9c571e653e_d20260130_m051850_c001_v0001113_t0034_u01769750330663")
    bisync_test.go:608: TEST resync PASSED
=== RUN   TestBisyncRemoteRemote/resync_modes
2026/01/30 05:20:03 INFO  : path1: Making directory
2026/01/30 05:20:03 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1"
2026/01/30 05:20:05 INFO  : path2: Making directory
2026/01/30 05:20:05 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2"
2026/01/30 05:20:06 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial"
2026/01/30 05:20:06 DEBUG : Creating backend with remote "/tmp/051834xa/initdir/test_resync_modes-hoqocew5"
2026/01/30 05:20:06 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/30 05:20:06 DEBUG : Local file system at /tmp/051834xa/initdir/test_resync_modes-hoqocew5: Waiting for checks to finish
2026/01/30 05:20:06 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:20:06 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/30 05:20:06 INFO  : file1.txt: Copied (new)
2026/01/30 05:20:06 DEBUG : Local file system at /tmp/051834xa/initdir/test_resync_modes-hoqocew5: Waiting for transfers to finish
2026/01/30 05:20:06 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/30 05:20:06 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:20:06 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/30 05:20:06 INFO  : file2.txt: Copied (new)
2026/01/30 05:20:06 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/30 05:20:06 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/30 05:20:06 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/30 05:20:06 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:20:06 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles"
2026/01/30 05:20:06 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:06 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:06 DEBUG : Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0: Waiting for checks to finish
2026/01/30 05:20:06 DEBUG : Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0: Waiting for transfers to finish
2026/01/30 05:20:06 DEBUG : file1L.txt.684d937d.partial: size = 33 OK
2026/01/30 05:20:06 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2026/01/30 05:20:06 DEBUG : file1R.txt.d467e63a.partial: size = 42 OK
2026/01/30 05:20:06 DEBUG : file1L.txt.684d937d.partial: renamed to: file1L.txt
2026/01/30 05:20:06 INFO  : file1L.txt: Copied (new)
2026/01/30 05:20:06 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK
2026/01/30 05:20:06 DEBUG : file1R.txt.d467e63a.partial: renamed to: file1R.txt
2026/01/30 05:20:06 INFO  : file1R.txt: Copied (new)
2026/01/30 05:20:06 DEBUG : file2.txt.ac4156f2.partial: size = 37 OK
2026/01/30 05:20:06 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2026/01/30 05:20:06 DEBUG : file2.txt.ac4156f2.partial: renamed to: file2.txt
2026/01/30 05:20:06 INFO  : file2.txt: Copied (new)
2026/01/30 05:20:06 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:20:06 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:20:07 NOTICE: checking initFs Local file system at /tmp/051834xa/initdir/test_resync_modes-hoqocew5
2026/01/30 05:20:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:20:08 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:08 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:08 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Waiting for checks to finish
2026/01/30 05:20:08 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Waiting for transfers to finish
2026/01/30 05:20:09 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:20:09 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:20:09 INFO  : file1.txt: Copied (new)
2026/01/30 05:20:09 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:20:09 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:20:09 INFO  : file2.txt: Copied (new)
2026/01/30 05:20:09 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:20:09 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:20:09 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:20:09 NOTICE: checking Path1 B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1
2026/01/30 05:20:10 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:20:10 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:10 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:20:10 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Waiting for checks to finish
2026/01/30 05:20:10 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Waiting for transfers to finish
2026/01/30 05:20:10 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:20:10 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:20:10 INFO  : file1.txt: Copied (new)
2026/01/30 05:20:11 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:20:11 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:20:11 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:20:11 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:20:11 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:20:11 INFO  : file2.txt: Copied (new)
2026/01/30 05:20:11 NOTICE: checking path2 B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2
2026/01/30 05:20:11 NOTICE: (01)  : test resync-mode
2026/01/30 05:20:11 NOTICE: (02)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:20:11 NOTICE: (03)  : touch-glob 2001-01-02 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:20:11 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/"
2026/01/30 05:20:11 DEBUG : fs cache: renaming cache item "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" to be canonical "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:11 DEBUG : file1R.txt: Set modification time 2001-01-02
2026/01/30 05:20:11 NOTICE: (04)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:20:11 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:20:11 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:20:11 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:12 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:20:13 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:20:13 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:20:13 DEBUG : file1R.txt: Sizes differ
2026/01/30 05:20:14 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:20:14 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:20:14 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:20:14 NOTICE: (05)  : touch-glob 2001-03-04 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:20:14 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:14 DEBUG : file1L.txt: Set modification time 2001-03-04
2026/01/30 05:20:14 NOTICE: (06)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:20:14 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:20:14 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:20:14 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:20:15 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:20:16 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:20:16 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1)
2026/01/30 05:20:16 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:20:17 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:20:17 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:20:17 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:20:17 NOTICE: (07)  : test bisync run with --resync-mode=newer
2026/01/30 05:20:17 NOTICE: (08)  : bisync resync resync-mode=newer
2026/01/30 05:20:26 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:26 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:26 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:20:26 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/30 05:20:26 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:26 INFO  : Copying Path2 files to Path1
2026/01/30 05:20:26 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:20:26 INFO  : There was nothing to transfer
2026/01/30 05:20:26 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:20:26 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:20:26 INFO  : Resync updating listings
2026/01/30 05:20:26 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:26 INFO  : Bisync successful
2026/01/30 05:20:26 NOTICE: (09)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:20:26 NOTICE: (10)  : touch-glob 2001-07-23 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:20:26 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:26 DEBUG : file1R.txt: Set modification time 2001-07-23
2026/01/30 05:20:26 NOTICE: (11)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:20:26 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:20:26 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:20:26 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:28 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:20:28 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:20:28 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:20:28 DEBUG : file1R.txt: Sizes differ
2026/01/30 05:20:29 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:20:29 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:20:29 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:20:29 NOTICE: (12)  : touch-glob 2001-08-26 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:20:29 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:29 DEBUG : file1L.txt: Set modification time 2001-08-26
2026/01/30 05:20:29 NOTICE: (13)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:20:29 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:20:29 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:20:29 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:20:31 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:20:31 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:20:31 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/30 05:20:31 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:20:32 INFO  : file1L.txt: Updated modification time in destination
2026/01/30 05:20:32 DEBUG : file1L.txt: Unchanged skipping
2026/01/30 05:20:32 NOTICE: (14)  : test bisync run with --resync-mode=path2
2026/01/30 05:20:32 NOTICE: (15)  : bisync resync resync-mode=path2
2026/01/30 05:20:40 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:40 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:40 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:20:40 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/30 05:20:40 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:40 INFO  : Copying Path2 files to Path1
2026/01/30 05:20:40 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:20:41 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:20:41 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:20:41 INFO  : Resync updating listings
2026/01/30 05:20:41 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:41 INFO  : Bisync successful
2026/01/30 05:20:41 NOTICE: (16)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:20:41 NOTICE: (17)  : touch-glob 2002-07-23 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:20:41 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:41 DEBUG : file1R.txt: Set modification time 2002-07-23
2026/01/30 05:20:41 NOTICE: (18)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:20:41 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:20:41 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:20:41 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:42 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:20:42 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:20:42 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/30 05:20:42 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:20:43 INFO  : file1R.txt: Updated modification time in destination
2026/01/30 05:20:43 DEBUG : file1R.txt: Unchanged skipping
2026/01/30 05:20:43 NOTICE: (19)  : touch-glob 2002-08-26 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:20:43 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:43 DEBUG : file1L.txt: Set modification time 2002-08-26
2026/01/30 05:20:43 NOTICE: (20)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:20:43 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:20:43 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:20:43 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:20:44 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:20:45 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:20:45 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1)
2026/01/30 05:20:45 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:20:46 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:20:46 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:20:46 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:20:46 NOTICE: (21)  : test bisync run with --resync-mode=larger
2026/01/30 05:20:46 NOTICE: (22)  : bisync resync resync-mode=larger
2026/01/30 05:20:56 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:56 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:20:56 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:20:56 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/30 05:20:56 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:56 INFO  : Copying Path2 files to Path1
2026/01/30 05:20:56 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:20:56 INFO  : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9
2026/01/30 05:20:56 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:20:56 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:20:56 INFO  : Resync updating listings
2026/01/30 05:20:56 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:56 INFO  : Bisync successful
2026/01/30 05:20:56 NOTICE: (23)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:20:56 NOTICE: (24)  : touch-glob 2003-07-23 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:20:56 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:56 DEBUG : file1R.txt: Set modification time 2003-07-23
2026/01/30 05:20:56 NOTICE: (25)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:20:56 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:20:56 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:20:56 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:20:57 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:20:58 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:20:58 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/30 05:20:58 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:20:59 INFO  : file1R.txt: Updated modification time in destination
2026/01/30 05:20:59 DEBUG : file1R.txt: Unchanged skipping
2026/01/30 05:20:59 NOTICE: (26)  : touch-glob 2003-09-04 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:20:59 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:20:59 DEBUG : file1L.txt: Set modification time 2003-09-04
2026/01/30 05:20:59 NOTICE: (27)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:20:59 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:20:59 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:20:59 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:00 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:21:00 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:00 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1)
2026/01/30 05:21:00 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:21:02 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:21:02 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:21:02 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:21:02 NOTICE: (28)  : test bisync run with --resync-mode=older
2026/01/30 05:21:02 NOTICE: (29)  : bisync resync resync-mode=older
2026/01/30 05:21:10 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:10 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:10 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:21:10 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/30 05:21:10 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:10 INFO  : Copying Path2 files to Path1
2026/01/30 05:21:10 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:21:10 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/30 05:21:11 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:21:11 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:21:11 INFO  : Resync updating listings
2026/01/30 05:21:11 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:11 INFO  : Bisync successful
2026/01/30 05:21:11 NOTICE: (30)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:21:11 NOTICE: (31)  : touch-glob 2004-07-23 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:21:11 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:11 DEBUG : file1R.txt: Set modification time 2004-07-23
2026/01/30 05:21:11 NOTICE: (32)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:21:11 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:21:11 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:21:11 DEBUG : Config file has changed externally - reloading
2026/01/30 05:21:11 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:12 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:21:12 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:21:12 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/30 05:21:12 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:21:14 INFO  : file1R.txt: Updated modification time in destination
2026/01/30 05:21:14 DEBUG : file1R.txt: Unchanged skipping
2026/01/30 05:21:14 NOTICE: (33)  : touch-glob 2004-07-23 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:21:14 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:14 DEBUG : file1L.txt: Set modification time 2004-07-23
2026/01/30 05:21:14 NOTICE: (34)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:21:14 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:21:14 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:21:14 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:15 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:21:15 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:15 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1)
2026/01/30 05:21:15 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:21:16 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:21:16 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:21:16 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:21:16 NOTICE: (35)  : test bisync run with --resync-mode=smaller
2026/01/30 05:21:16 NOTICE: (36)  : bisync resync resync-mode=smaller
2026/01/30 05:21:25 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:25 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:25 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:21: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/30 05:21:25 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:25 INFO  : Copying Path2 files to Path1
2026/01/30 05:21:25 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:21:25 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2026/01/30 05:21:25 INFO  : There was nothing to transfer
2026/01/30 05:21:25 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:21:26 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2026/01/30 05:21:26 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:21:26 INFO  : Resync updating listings
2026/01/30 05:21:26 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:26 INFO  : Bisync successful
2026/01/30 05:21:26 NOTICE: (37)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2026/01/30 05:21:26 NOTICE: (38)  : touch-glob 2005-01-02 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:21:26 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:26 DEBUG : file1R.txt: Set modification time 2005-01-02
2026/01/30 05:21:26 NOTICE: (39)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:21:26 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:21:26 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:21:26 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:27 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:21:27 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:27 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:21:27 DEBUG : file1R.txt: Sizes differ
2026/01/30 05:21:29 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:21:29 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:21:29 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:21:29 NOTICE: (40)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file2.txt
2026/01/30 05:21:29 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file2.txt"
2026/01/30 05:21:29 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:21:29 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:30 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file2.txt"
2026/01/30 05:21:30 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:30 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1)
2026/01/30 05:21:30 DEBUG : file1R.txt: Sizes differ
2026/01/30 05:21:32 DEBUG : file2.txt: size = 42 OK
2026/01/30 05:21:32 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:21:32 INFO  : file1R.txt: Copied (replaced existing) to: file2.txt
2026/01/30 05:21:32 NOTICE: (41)  : touch-glob 2006-03-04 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:21:32 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:32 DEBUG : file1L.txt: Set modification time 2006-03-04
2026/01/30 05:21:32 NOTICE: (42)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:21:32 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:21:32 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:21:32 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:33 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:21:33 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:21:33 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/30 05:21:33 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:21:38 INFO  : file1L.txt: Updated modification time in destination
2026/01/30 05:21:38 DEBUG : file1L.txt: Unchanged skipping
2026/01/30 05:21:38 NOTICE: (43)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file2.txt
2026/01/30 05:21:38 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file2.txt"
2026/01/30 05:21:38 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:21:38 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:39 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file2.txt"
2026/01/30 05:21:39 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:39 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:21:39 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:21:40 DEBUG : file2.txt: size = 33 OK
2026/01/30 05:21:40 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:21:40 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2026/01/30 05:21:40 NOTICE: (44)  : test bisync run with --resync-mode=path1
2026/01/30 05:21:40 NOTICE: (45)  : bisync resync resync-mode=path1
2026/01/30 05:21:50 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:50 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:21:50 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:21:50 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/30 05:21:50 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:50 INFO  : Copying Path2 files to Path1
2026/01/30 05:21:50 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:21:50 INFO  : There was nothing to transfer
2026/01/30 05:21:50 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:21:51 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:21:52 INFO  : file2.txt: Copied (server-side copy)
2026/01/30 05:21:52 INFO  : Resync updating listings
2026/01/30 05:21:52 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:52 INFO  : Bisync successful
2026/01/30 05:21:52 NOTICE: (46)  : test no winner
2026/01/30 05:21:52 NOTICE: (47)  : touch-glob 2022-02-22 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1R.txt
2026/01/30 05:21:52 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:52 DEBUG : file1R.txt: Set modification time 2022-02-22
2026/01/30 05:21:52 NOTICE: (48)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file1.txt
2026/01/30 05:21:52 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file1.txt"
2026/01/30 05:21:52 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:21:52 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:21:53 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file1.txt"
2026/01/30 05:21:53 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:21:53 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:21:53 DEBUG : file1R.txt: Sizes differ
2026/01/30 05:21:55 DEBUG : file1.txt: size = 42 OK
2026/01/30 05:21:55 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:21:55 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2026/01/30 05:21:55 NOTICE: (49)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file2.txt
2026/01/30 05:21:55 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file2.txt"
2026/01/30 05:21:55 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1R.txt"
2026/01/30 05:21:55 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:56 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file2.txt"
2026/01/30 05:21:56 DEBUG : file2.txt: size = 42 OK
2026/01/30 05:21:56 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/30 05:21:56 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK
2026/01/30 05:21:58 INFO  : file1R.txt: Updated modification time in destination
2026/01/30 05:21:58 DEBUG : file1R.txt: Unchanged skipping
2026/01/30 05:21:58 NOTICE: (50)  : touch-glob 2022-02-22 /tmp/051834xa/datadir/test_resync_modes-wurigap0/ file1L.txt
2026/01/30 05:21:58 DEBUG : fs cache: switching user supplied name "/tmp/051834xa/datadir/test_resync_modes-wurigap0/" for canonical name "/tmp/051834xa/datadir/test_resync_modes-wurigap0"
2026/01/30 05:21:58 DEBUG : file1L.txt: Set modification time 2022-02-22
2026/01/30 05:21:58 NOTICE: (51)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/ file1.txt
2026/01/30 05:21:58 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" as "file1.txt"
2026/01/30 05:21:58 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:21:58 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/"
2026/01/30 05:21:59 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1" as "file1.txt"
2026/01/30 05:21:59 DEBUG : file1.txt: size = 33 OK
2026/01/30 05:21:59 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/30 05:21:59 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:22:00 INFO  : file1L.txt: Updated modification time in destination
2026/01/30 05:22:00 DEBUG : file1L.txt: Unchanged skipping
2026/01/30 05:22:00 NOTICE: (52)  : copy-as /tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/ file2.txt
2026/01/30 05:22:00 DEBUG : copyFile "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt" to "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/" as "file2.txt"
2026/01/30 05:22:00 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_resync_modes-wurigap0/file1L.txt"
2026/01/30 05:22:00 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:22:02 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2" as "file2.txt"
2026/01/30 05:22:02 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/051834xa/datadir/test_resync_modes-wurigap0)
2026/01/30 05:22:02 DEBUG : file2.txt: size = 42 (B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2)
2026/01/30 05:22:02 DEBUG : file1L.txt: Sizes differ
2026/01/30 05:22:03 DEBUG : file2.txt: size = 33 OK
2026/01/30 05:22:03 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK
2026/01/30 05:22:03 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2026/01/30 05:22:03 NOTICE: (53)  : test bisync run with --resync-mode=newer
2026/01/30 05:22:03 NOTICE: (54)  : bisync resync resync-mode=newer
2026/01/30 05:22:12 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:22:12 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2026/01/30 05:22:12 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2026/01/30 05:22:12 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/30 05:22:12 INFO  : Synching Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" with Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:22:12 INFO  : Copying Path2 files to Path1
2026/01/30 05:22:12 INFO  : - Path2    Resync is copying files to         - Path1
2026/01/30 05:22:12 INFO  : file1.txt: Copied (server-side copy)
2026/01/30 05:22:13 INFO  : file2.txt: Copied (server-side copy)
2026/01/30 05:22:13 INFO  : - Path1    Resync is copying files to         - Path2
2026/01/30 05:22:13 INFO  : Resync updating listings
2026/01/30 05:22:13 INFO  : Validating listings for Path1 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path1/" vs Path2 "TestB2:rclone-test-tijezur9semu/051834xa/resync_modes/path2/"
2026/01/30 05:22:13 INFO  : Bisync successful
2026/01/30 05:22:13 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:13 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115d8f32d4d44bef_d20260130_m052009_c001_v0001167_t0031_u01769750409155")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f108880b0331c8d98_d20260130_m052212_c001_v0001185_t0028_u01769750532664")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11754c0abd1883ba_d20260130_m052200_c001_v0001179_t0052_u01769750520649")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1143af2cb7c99d23_d20260130_m052137_c001_v0001173_t0030_u01769750494883")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f114b8f5628a2c594_d20260130_m052116_c001_v0001185_t0022_u01769750476835")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f119d52237419e0be_d20260130_m052110_c001_v0001116_t0050_u01769750470994")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101c5705a31f22f0_d20260130_m052102_c001_v0001179_t0045_u01769750462085")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118d12ac458b57db_d20260130_m052056_c001_v0001181_t0003_u01769750456442")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11788384b2369c55_d20260130_m052046_c001_v0001185_t0037_u01769750446500")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1166b659cdd2522c_d20260130_m052040_c001_v0001098_t0033_u01769750440714")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d55940767_d20260130_m052032_c001_v0001185_t0041_u01769750432253")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1087b58ead8af010_d20260130_m052017_c001_v0001131_t0023_u01769750417536")
2026/01/30 05:22:13 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112362a03cf4da64_d20260130_m052008_c001_v0001150_t0051_u01769750408798")
2026/01/30 05:22:14 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f100846e4e5d52aa5_d20260130_m052212_c001_v0001176_t0013_u01769750532876")
2026/01/30 05:22:14 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112f2322127c6216_d20260130_m052157_c001_v0001144_t0046_u01769750517659")
2026/01/30 05:22:14 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f116bf40c472d0125_d20260130_m052132_c001_v0001100_t0030_u01769750492307")
2026/01/30 05:22:14 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d55940593_d20260130_m052008_c001_v0001185_t0017_u01769750408965")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4058e85fa0396fb2_d20260130_m052208_c001_v7007000_t0000_u01769750528073")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1196eb040b904eae_d20260130_m052206_c001_v0001130_t0056_u01769750526705")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112362a03cf4dbf9_d20260130_m052204_c001_v0001150_t0052_u01769750524332")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4094409dbde661e2_d20260130_m052145_c001_v7007000_t0000_u01769750505317")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112a8ef2de563ef1_d20260130_m052143_c001_v0001106_t0019_u01769750503891")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115d8f32d4d45574_d20260130_m052141_c001_v0001167_t0023_u01769750501333")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4058e85fa0396f0b_d20260130_m052120_c001_v7007000_t0000_u01769750480883")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1074d2c5b2edd4ee_d20260130_m052119_c001_v0001185_t0004_u01769750479600")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d55940b67_d20260130_m052117_c001_v0001185_t0048_u01769750477438")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4058e85fa0396eea_d20260130_m052106_c001_v7007000_t0000_u01769750466643")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1132c35ab7bdc6be_d20260130_m052105_c001_v0001102_t0008_u01769750465249")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112362a03cf4db14_d20260130_m052102_c001_v0001150_t0011_u01769750462745")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f42245155851fd48b_d20260130_m052051_c001_v7007000_t0000_u01769750451425")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f104533d1c6d04e31_d20260130_m052049_c001_v0001032_t0030_u01769750449940")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115d8f32d4d44f9c_d20260130_m052047_c001_v0001167_t0046_u01769750447198")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f417709f54c7ae6a1_d20260130_m052036_c001_v7007000_t0000_u01769750436278")
2026/01/30 05:22:14 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f107048e9938105c6_d20260130_m052035_c001_v0001179_t0035_u01769750435032")
2026/01/30 05:22:15 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d5594077d_d20260130_m052032_c001_v0001185_t0021_u01769750432815")
2026/01/30 05:22:15 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f406e15a4e833af95_d20260130_m052022_c001_v7007000_t0000_u01769750422257")
2026/01/30 05:22:15 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1085024f755e0892_d20260130_m052020_c001_v0001167_t0051_u01769750420643")
2026/01/30 05:22:15 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112362a03cf4da8c_d20260130_m052018_c001_v0001150_t0030_u01769750418250")
2026/01/30 05:22:15 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/resync_modes/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:15 DEBUG : RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11949b12342adb99_d20260130_m052011_c001_v0001105_t0019_u01769750411247")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f103a95186821fbf4_d20260130_m052154_c001_v0001172_t0006_u01769750514969")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10470d24f3f14a3c_d20260130_m052151_c001_v0001150_t0038_u01769750511294")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f119fd237a52dee82_d20260130_m052129_c001_v0001037_t0018_u01769750489335")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1046f00d4111c6b2_d20260130_m052126_c001_v0001104_t0017_u01769750486192")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10838c88402c1568_d20260130_m052114_c001_v0001179_t0045_u01769750474038")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1140596ecad81523_d20260130_m052059_c001_v0001150_t0009_u01769750459100")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f103964ea19b38797_d20260130_m052043_c001_v0001150_t0036_u01769750443617")
2026/01/30 05:22:15 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11353fc427570109_d20260130_m052029_c001_v0001185_t0052_u01769750429815")
2026/01/30 05:22:16 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10853c175e980f9f_d20260130_m052026_c001_v0001180_t0040_u01769750426875")
2026/01/30 05:22:16 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115d1fd6ed1ccae5_d20260130_m052014_c001_v0001146_t0039_u01769750414618")
2026/01/30 05:22:16 DEBUG : file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10502cac6daab130_d20260130_m052010_c001_v0001183_t0029_u01769750410869")
2026/01/30 05:22:16 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118f9d165fda6154_d20260130_m052203_c001_v0001130_t0045_u01769750523590")
2026/01/30 05:22:16 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f100ceb47eca2472a_d20260130_m052151_c001_v0001173_t0052_u01769750511627")
2026/01/30 05:22:16 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f109c1f5f35f4e4e3_d20260130_m052140_c001_v0001185_t0021_u01769750500703")
2026/01/30 05:22:16 DEBUG : file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10180f6e688790e8_d20260130_m052011_c001_v0001167_t0054_u01769750411038")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f416505aebd913556_d20260130_m052212_c001_v7007000_t0000_u01769750532263")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f110a8a45cdb9d400_d20260130_m052210_c001_v0001146_t0052_u01769750530890")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10502cac6daab35c_d20260130_m052208_c001_v0001183_t0008_u01769750528643")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f400b5d8253b50e0f_d20260130_m052150_c001_v7007000_t0000_u01769750510315")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f110c6333a0d10abb_d20260130_m052148_c001_v0001167_t0030_u01769750508346")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10180f6e68879ab8_d20260130_m052145_c001_v0001167_t0054_u01769750505870")
2026/01/30 05:22:16 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4085b6b12209c030_d20260130_m052125_c001_v7007000_t0000_u01769750485617")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f110bdd6b79b35f51_d20260130_m052123_c001_v0001106_t0045_u01769750483746")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11949b12342adc63_d20260130_m052121_c001_v0001105_t0026_u01769750481473")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f420428df53fbbd28_d20260130_m052110_c001_v7007000_t0000_u01769750470599")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1172c1784edb4ea4_d20260130_m052109_c001_v0001145_t0021_u01769750469352")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10502cac6daab22d_d20260130_m052107_c001_v0001183_t0054_u01769750467192")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f40301acc8befc246_d20260130_m052056_c001_v7007000_t0000_u01769750456054")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f119f37f824595052_d20260130_m052054_c001_v0001042_t0050_u01769750454600")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10180f6e68879489_d20260130_m052051_c001_v0001167_t0025_u01769750451965")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f4094409dbde660fa_d20260130_m052040_c001_v7007000_t0000_u01769750440248")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102957e4c71de418_d20260130_m052039_c001_v0001180_t0050_u01769750439027")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f11949b12342adbe7_d20260130_m052036_c001_v0001105_t0017_u01769750436865")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f400b5d8253b50d10_d20260130_m052026_c001_v7007000_t0000_u01769750426193")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f106cdcb6f6fa1778_d20260130_m052024_c001_v0001182_t0056_u01769750424978")
2026/01/30 05:22:17 DEBUG : modtime_write_test: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f10502cac6daab160_d20260130_m052022_c001_v0001183_t0018_u01769750422846")
    bisync_test.go:608: TEST resync_modes PASSED
=== RUN   TestBisyncRemoteRemote/rmdirs
2026/01/30 05:22:18 INFO  : path1: Making directory
2026/01/30 05:22:18 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/rmdirs/path1"
2026/01/30 05:22:19 INFO  : path2: Making directory
2026/01/30 05:22:19 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/rmdirs/path2"
2026/01/30 05:22:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial"
2026/01/30 05:22:20 DEBUG : Creating backend with remote "/tmp/051834xa/initdir/test_rmdirs-zomikeh2"
2026/01/30 05:22:20 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : subdir: Making directory with metadata
2026/01/30 05:22:20 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2026/01/30 05:22:20 DEBUG : Added delayed dir = "subdir", newDst=subdir
2026/01/30 05:22:20 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : Local file system at /tmp/051834xa/initdir/test_rmdirs-zomikeh2: Waiting for checks to finish
2026/01/30 05:22:20 DEBUG : Local file system at /tmp/051834xa/initdir/test_rmdirs-zomikeh2: Waiting for transfers to finish
2026/01/30 05:22:20 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/30 05:22:20 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/30 05:22:20 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2026/01/30 05:22:20 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK
2026/01/30 05:22:20 INFO  : file1.copy1.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/30 05:22:20 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:20 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2026/01/30 05:22:20 INFO  : file1.copy2.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2026/01/30 05:22:20 INFO  : file1.copy5.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2026/01/30 05:22:20 INFO  : file1.copy3.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK
2026/01/30 05:22:20 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:20 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2026/01/30 05:22:20 INFO  : subdir/file20.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2026/01/30 05:22:20 INFO  : file1.copy4.txt: Copied (new)
2026/01/30 05:22:20 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/30 05:22:20 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:20 INFO  : subdir: Set directory modification time (using SetModTime)
2026/01/30 05:22:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles"
2026/01/30 05:22:20 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_rmdirs-sisocac8"
2026/01/30 05:22:20 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:20 DEBUG : Local file system at /tmp/051834xa/datadir/test_rmdirs-sisocac8: Waiting for checks to finish
2026/01/30 05:22:20 DEBUG : Local file system at /tmp/051834xa/datadir/test_rmdirs-sisocac8: Waiting for transfers to finish
2026/01/30 05:22:20 DEBUG : file1.txt.f41fd5ee.partial: size = 19 OK
2026/01/30 05:22:20 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:20 DEBUG : file1.txt.f41fd5ee.partial: renamed to: file1.txt
2026/01/30 05:22:20 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:20 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:20 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:22 NOTICE: checking initFs Local file system at /tmp/051834xa/initdir/test_rmdirs-zomikeh2
2026/01/30 05:22:22 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 INFO  : subdir: Making directory
2026/01/30 05:22:22 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:22 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path1: Waiting for checks to finish
2026/01/30 05:22:22 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path1: Waiting for transfers to finish
2026/01/30 05:22:23 DEBUG : file1.copy1.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.copy1.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : file1.copy4.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.copy4.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : file1.copy5.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.copy5.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : file1.copy2.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.copy2.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : file1.copy3.txt: size = 0 OK
2026/01/30 05:22:23 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:23 INFO  : file1.copy3.txt: Copied (new)
2026/01/30 05:22:23 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:22:23 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:22:23 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:24 DEBUG : subdir/file20.txt: size = 0 OK
2026/01/30 05:22:24 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:24 INFO  : subdir/file20.txt: Copied (new)
2026/01/30 05:22:24 NOTICE: checking Path1 B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path1
2026/01/30 05:22:24 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 INFO  : subdir: Making directory
2026/01/30 05:22:24 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:24 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path2: Waiting for checks to finish
2026/01/30 05:22:24 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path2: Waiting for transfers to finish
2026/01/30 05:22:25 DEBUG : file1.copy2.txt: size = 0 OK
2026/01/30 05:22:25 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:25 INFO  : file1.copy2.txt: Copied (new)
2026/01/30 05:22:25 DEBUG : file1.copy3.txt: size = 0 OK
2026/01/30 05:22:25 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:25 INFO  : file1.copy3.txt: Copied (new)
2026/01/30 05:22:25 DEBUG : file1.copy5.txt: size = 0 OK
2026/01/30 05:22:25 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:25 INFO  : file1.copy5.txt: Copied (new)
2026/01/30 05:22:25 DEBUG : file1.copy1.txt: size = 0 OK
2026/01/30 05:22:25 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:25 INFO  : file1.copy1.txt: Copied (new)
2026/01/30 05:22:25 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:22:25 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:25 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:26 DEBUG : file1.copy4.txt: size = 0 OK
2026/01/30 05:22:26 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:26 INFO  : file1.copy4.txt: Copied (new)
2026/01/30 05:22:26 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:22:26 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:22:26 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:26 DEBUG : subdir/file20.txt: size = 0 OK
2026/01/30 05:22:26 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:26 INFO  : subdir/file20.txt: Copied (new)
2026/01/30 05:22:26 NOTICE: checking path2 B2 bucket rclone-test-tijezur9semu path 051834xa/rmdirs/path2
2026/01/30 05:22:26 NOTICE: (01)  : test rmdirs
2026/01/30 05:22:26 NOTICE: (02)  : test initial bisync
2026/01/30 05:22:26 NOTICE: (03)  : bisync resync
    bisync_test.go:1007: skipping test as remote does not support empty dirs
=== RUN   TestBisyncRemoteRemote/volatile
2026/01/30 05:22:26 INFO  : path1: Making directory
2026/01/30 05:22:26 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/volatile/path1"
2026/01/30 05:22:27 INFO  : path2: Making directory
2026/01/30 05:22:27 DEBUG : Creating backend with remote "TestB2:rclone-test-tijezur9semu/051834xa/volatile/path2"
2026/01/30 05:22:28 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial"
2026/01/30 05:22:28 DEBUG : Creating backend with remote "/tmp/051834xa/initdir/test_volatile-zericab4"
2026/01/30 05:22:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : Local file system at /tmp/051834xa/initdir/test_volatile-zericab4: Waiting for checks to finish
2026/01/30 05:22:28 DEBUG : Local file system at /tmp/051834xa/initdir/test_volatile-zericab4: Waiting for transfers to finish
2026/01/30 05:22:28 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file2.txt.3230ad67.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/01/30 05:22:28 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2026/01/30 05:22:28 INFO  : file2.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2026/01/30 05:22:28 INFO  : file4.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2026/01/30 05:22:28 INFO  : file5.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2026/01/30 05:22:28 INFO  : file6.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file7.txt.9f102165.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2026/01/30 05:22:28 INFO  : file7.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file8.txt.b300b322.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2026/01/30 05:22:28 INFO  : file8.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file3.txt.a74079f2.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2026/01/30 05:22:28 INFO  : file3.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/01/30 05:22:28 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/01/30 05:22:28 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/01/30 05:22:28 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:28 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles"
2026/01/30 05:22:28 DEBUG : Creating backend with remote "/tmp/051834xa/datadir/test_volatile-qusijon5"
2026/01/30 05:22:28 DEBUG : dummy.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file10.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file11.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:28 DEBUG : dummy.txt.b3782999.partial: size = 0 OK
2026/01/30 05:22:28 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/01/30 05:22:28 DEBUG : Local file system at /tmp/051834xa/datadir/test_volatile-qusijon5: Waiting for checks to finish
2026/01/30 05:22:28 DEBUG : dummy.txt.b3782999.partial: renamed to: dummy.txt
2026/01/30 05:22:28 DEBUG : file1.txt.be52b1c9.partial: size = 19 OK
2026/01/30 05:22:28 DEBUG : Local file system at /tmp/051834xa/datadir/test_volatile-qusijon5: Waiting for transfers to finish
2026/01/30 05:22:28 INFO  : dummy.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file10.txt.bdde3bf8.partial: size = 19 OK
2026/01/30 05:22:28 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:28 DEBUG : file10.txt.bdde3bf8.partial: renamed to: file10.txt
2026/01/30 05:22:28 INFO  : file10.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:28 DEBUG : file1.txt.be52b1c9.partial: renamed to: file1.txt
2026/01/30 05:22:28 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file11.txt.d4a7309d.partial: size = 19 OK
2026/01/30 05:22:28 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:28 DEBUG : file11.txt.d4a7309d.partial: renamed to: file11.txt
2026/01/30 05:22:28 INFO  : file11.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file5R.txt.ee3b9525.partial: size = 39 OK
2026/01/30 05:22:28 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2026/01/30 05:22:28 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2026/01/30 05:22:28 INFO  : file5R.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file5L.txt.8dd6541a.partial: size = 39 OK
2026/01/30 05:22:28 DEBUG : file2.txt.23ff1769.partial: size = 13 OK
2026/01/30 05:22:28 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2026/01/30 05:22:28 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2026/01/30 05:22:28 INFO  : file5L.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2026/01/30 05:22:28 DEBUG : file2.txt.23ff1769.partial: renamed to: file2.txt
2026/01/30 05:22:28 INFO  : file2.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file6.txt.7b4c87b3.partial: size = 19 OK
2026/01/30 05:22:28 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:28 DEBUG : file6.txt.7b4c87b3.partial: renamed to: file6.txt
2026/01/30 05:22:28 INFO  : file6.txt: Copied (new)
2026/01/30 05:22:28 DEBUG : file7.txt.38c43fbf.partial: size = 19 OK
2026/01/30 05:22:28 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2026/01/30 05:22:28 DEBUG : file7.txt.38c43fbf.partial: renamed to: file7.txt
2026/01/30 05:22:28 INFO  : file7.txt: Copied (new)
2026/01/30 05:22:28 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path1: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:29 INFO  : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path2: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:30 NOTICE: checking initFs Local file system at /tmp/051834xa/initdir/test_volatile-zericab4
2026/01/30 05:22:31 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:31 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path1: Waiting for checks to finish
2026/01/30 05:22:31 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path1: Waiting for transfers to finish
2026/01/30 05:22:32 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file2.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : file3.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file3.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : file4.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file4.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:22:32 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:22:32 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:32 DEBUG : file5.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file5.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : file6.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file6.txt: Copied (new)
2026/01/30 05:22:32 DEBUG : file7.txt: size = 0 OK
2026/01/30 05:22:32 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:32 INFO  : file7.txt: Copied (new)
2026/01/30 05:22:33 DEBUG : file8.txt: size = 0 OK
2026/01/30 05:22:33 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:33 INFO  : file8.txt: Copied (new)
2026/01/30 05:22:33 NOTICE: checking Path1 B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path1
2026/01/30 05:22:33 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file2.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file3.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file4.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file5.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file6.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file7.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : file8.txt: Need to transfer - File not found at Destination
2026/01/30 05:22:33 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path2: Waiting for checks to finish
2026/01/30 05:22:33 DEBUG : B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path2: Waiting for transfers to finish
2026/01/30 05:22:34 DEBUG : file1.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file1.txt: Copied (new)
2026/01/30 05:22:34 DEBUG : file4.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file4.txt: Copied (new)
2026/01/30 05:22:34 DEBUG : RCLONE_TEST: size = 109 OK
2026/01/30 05:22:34 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2026/01/30 05:22:34 INFO  : RCLONE_TEST: Copied (new)
2026/01/30 05:22:34 DEBUG : file5.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file5.txt: Copied (new)
2026/01/30 05:22:34 DEBUG : file2.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file2.txt: Copied (new)
2026/01/30 05:22:34 DEBUG : file6.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file6.txt: Copied (new)
2026/01/30 05:22:34 DEBUG : file7.txt: size = 0 OK
2026/01/30 05:22:34 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:34 INFO  : file7.txt: Copied (new)
2026/01/30 05:22:35 DEBUG : file8.txt: size = 0 OK
2026/01/30 05:22:35 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:35 INFO  : file8.txt: Copied (new)
2026/01/30 05:22:35 DEBUG : file3.txt: size = 0 OK
2026/01/30 05:22:35 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2026/01/30 05:22:35 INFO  : file3.txt: Copied (new)
2026/01/30 05:22:35 NOTICE: checking path2 B2 bucket rclone-test-tijezur9semu path 051834xa/volatile/path2
2026/01/30 05:22:35 NOTICE: (01)  : test volatile
2026/01/30 05:22:35 NOTICE: (02)  : test initial bisync
2026/01/30 05:22:35 NOTICE: (03)  : bisync resync
    bisync_test.go:978: skipping 'volatile' test on non-local as it requires uploading 100 files
2026/01/30 05:22:35 DEBUG : B2 bucket rclone-test-tijezur9semu: Purge remote
2026/01/30 05:22:35 INFO  : B2 bucket rclone-test-tijezur9semu: cleaning bucket "rclone-test-tijezur9semu" of all files
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1012143426b8bec8_d20260130_m052223_c001_v0001101_t0012_u01769750543504")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.copy1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118eba721b833967_d20260130_m052222_c001_v0001180_t0045_u01769750542951")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.copy2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1008645049088d87_d20260130_m052223_c001_v0001099_t0011_u01769750543142")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.copy3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f115d8f32d4d459b5_d20260130_m052223_c001_v0001167_t0034_u01769750543312")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.copy4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118eba721b833969_d20260130_m052223_c001_v0001180_t0058_u01769750543153")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.copy5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118eba721b83396d_d20260130_m052223_c001_v0001180_t0017_u01769750543370")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118eba721b833971_d20260130_m052223_c001_v0001180_t0027_u01769750543570")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path1/subdir/file20.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1008645049088d89_d20260130_m052223_c001_v0001099_t0008_u01769750543672")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102d9eb09472cfc2_d20260130_m052225_c001_v0001134_t0001_u01769750545633")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.copy1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1154f9b7ed23b8ab_d20260130_m052225_c001_v0001106_t0047_u01769750545093")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.copy2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f103abd4d97e5d714_d20260130_m052225_c001_v0001120_t0027_u01769750545284")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.copy3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d55941146_d20260130_m052225_c001_v0001185_t0014_u01769750545425")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.copy4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f103abd4d97e5d716_d20260130_m052225_c001_v0001120_t0053_u01769750545599")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.copy5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d5594114a_d20260130_m052225_c001_v0001185_t0050_u01769750545611")
2026/01/30 05:22:36 DEBUG : 051834xa/rmdirs/path2/file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1064281d55941150_d20260130_m052225_c001_v0001185_t0035_u01769750545825")
2026/01/30 05:22:37 DEBUG : 051834xa/rmdirs/path2/subdir/file20.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1154f9b7ed23b8ad_d20260130_m052225_c001_v0001106_t0040_u01769750545896")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f110dade238ad9a64_d20260130_m052232_c001_v0001131_t0002_u01769750552374")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f109aaf567a729629_d20260130_m052231_c001_v0001091_t0041_u01769750551784")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102f7f58db3d8772_d20260130_m052231_c001_v0001038_t0029_u01769750551972")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118cbaae9500952e_d20260130_m052232_c001_v0001150_t0034_u01769750552165")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f109aaf567a72962b_d20260130_m052232_c001_v0001091_t0056_u01769750552322")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f102f7f58db3d8778_d20260130_m052232_c001_v0001038_t0053_u01769750552347")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118cbaae95009532_d20260130_m052232_c001_v0001150_t0007_u01769750552489")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f109aaf567a72962d_d20260130_m052232_c001_v0001091_t0005_u01769750552671")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path1/file8.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f110dade238ad9a66_d20260130_m052232_c001_v0001131_t0025_u01769750552749")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/RCLONE_TEST: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101c6d4bc4968c8d_d20260130_m052234_c001_v0001185_t0035_u01769750554508")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file1.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118a60d6542cf223_d20260130_m052234_c001_v0001185_t0054_u01769750554116")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file2.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1093ad21f16a9fcf_d20260130_m052234_c001_v0001106_t0032_u01769750554347")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file3.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f112278f648c23044_d20260130_m052234_c001_v0001173_t0020_u01769750554709")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file4.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118a60d6542cf22b_d20260130_m052234_c001_v0001185_t0044_u01769750554424")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file5.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118a60d6542cf231_d20260130_m052234_c001_v0001185_t0008_u01769750554610")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file6.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f101c6d4bc4968c95_d20260130_m052234_c001_v0001185_t0011_u01769750554726")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file7.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f118a60d6542cf235_d20260130_m052234_c001_v0001185_t0023_u01769750554802")
2026/01/30 05:22:37 DEBUG : 051834xa/volatile/path2/file8.txt: Deleting (id "4_z2fd2cd43506d0bdb9fc80e1b_f1093ad21f16a9fd3_d20260130_m052234_c001_v0001106_t0015_u01769750554965")
--- PASS: TestBisyncRemoteRemote (244.67s)
    --- PASS: TestBisyncRemoteRemote/resync (89.41s)
    --- PASS: TestBisyncRemoteRemote/resync_modes (134.09s)
    --- SKIP: TestBisyncRemoteRemote/rmdirs (8.68s)
    --- SKIP: TestBisyncRemoteRemote/volatile (8.87s)
PASS
2026/01/30 05:22:38 DEBUG : B2 bucket rclone-test-tiyaqap7yuho: Purge remote
2026/01/30 05:22:38 INFO  : B2 bucket rclone-test-tiyaqap7yuho: cleaning bucket "rclone-test-tiyaqap7yuho" of all files
2026/01/30 05:22:39 NOTICE: purge failed: directory not found
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Finished OK in 4m6.026030786s (try 2/5)