"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resolve|resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5) 2025/12/16 03:56:53 DEBUG : Creating backend with remote "TestB2:rclone-test-tehocaj2dafi" 2025/12/16 03:56:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/16 03:56:54 DEBUG : Creating backend with remote "/tmp/rclone3466081704" === RUN TestBisyncRemoteRemote 2025/12/16 03:56:54 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu" 2025/12/16 03:56:54 NOTICE: remote: TestB2:rclone-test-vococog9denu === RUN TestBisyncRemoteRemote/resolve 2025/12/16 03:56:54 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo" 2025/12/16 03:56:55 INFO : path1: Making directory 2025/12/16 03:56:56 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1" 2025/12/16 03:56:57 INFO : path2: Making directory 2025/12/16 03:56:57 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2" 2025/12/16 03:56:58 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/initial" 2025/12/16 03:56:58 DEBUG : Creating backend with remote "/tmp/035654xo/initdir/test_resolve-jodusaq9" 2025/12/16 03:56:58 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/16 03:56:58 DEBUG : Local file system at /tmp/035654xo/initdir/test_resolve-jodusaq9: Waiting for checks to finish 2025/12/16 03:56:58 DEBUG : Local file system at /tmp/035654xo/initdir/test_resolve-jodusaq9: Waiting for transfers to finish 2025/12/16 03:56:58 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:56:58 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/16 03:56:58 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/16 03:56:58 INFO : file1.txt: Copied (new) 2025/12/16 03:56:58 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:56:58 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/16 03:56:58 INFO : file2.txt: Copied (new) 2025/12/16 03:56:58 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/16 03:56:58 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/16 03:56:58 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/16 03:56:58 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:56:58 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/modfiles" 2025/12/16 03:56:58 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:56:58 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:56:58 DEBUG : Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5: Waiting for checks to finish 2025/12/16 03:56:58 DEBUG : Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5: Waiting for transfers to finish 2025/12/16 03:56:58 DEBUG : file1L.txt.6455455d.partial: size = 33 OK 2025/12/16 03:56:58 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2025/12/16 03:56:58 DEBUG : file1L.txt.6455455d.partial: renamed to: file1L.txt 2025/12/16 03:56:58 INFO : file1L.txt: Copied (new) 2025/12/16 03:56:58 DEBUG : file1R.txt.f5ef699a.partial: size = 33 OK 2025/12/16 03:56:58 DEBUG : file2.txt.67fcf9d0.partial: size = 37 OK 2025/12/16 03:56:58 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2025/12/16 03:56:58 DEBUG : file2.txt.67fcf9d0.partial: renamed to: file2.txt 2025/12/16 03:56:58 INFO : file2.txt: Copied (new) 2025/12/16 03:56:58 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK 2025/12/16 03:56:58 DEBUG : file1R.txt.f5ef699a.partial: renamed to: file1R.txt 2025/12/16 03:56:58 INFO : file1R.txt: Copied (new) 2025/12/16 03:56:58 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:56:59 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:57:00 NOTICE: checking initFs Local file system at /tmp/035654xo/initdir/test_resolve-jodusaq9 2025/12/16 03:57:00 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:57:00 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:57:00 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:57:00 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Waiting for checks to finish 2025/12/16 03:57:00 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Waiting for transfers to finish 2025/12/16 03:57:01 DEBUG : file1.txt: size = 0 OK 2025/12/16 03:57:01 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:57:01 INFO : file1.txt: Copied (new) 2025/12/16 03:57:01 DEBUG : file2.txt: size = 0 OK 2025/12/16 03:57:01 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:57:01 INFO : file2.txt: Copied (new) 2025/12/16 03:57:02 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 03:57:02 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 03:57:02 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:57:02 NOTICE: checking Path1 B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1 2025/12/16 03:57:03 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:57:03 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:57:03 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:57:03 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Waiting for checks to finish 2025/12/16 03:57:03 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Waiting for transfers to finish 2025/12/16 03:57:04 DEBUG : file1.txt: size = 0 OK 2025/12/16 03:57:04 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:57:04 INFO : file1.txt: Copied (new) 2025/12/16 03:57:04 DEBUG : file2.txt: size = 0 OK 2025/12/16 03:57:04 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:57:04 INFO : file2.txt: Copied (new) 2025/12/16 03:57:04 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 03:57:04 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 03:57:04 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:57:04 NOTICE: checking path2 B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2 2025/12/16 03:57:04 NOTICE: (01) : test resolve 2025/12/16 03:57:04 NOTICE: (02) : test initial bisync 2025/12/16 03:57:04 NOTICE: (03) : bisync resync 2025/12/16 03:57:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:11 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:57:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:57:11 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:11 INFO : Copying Path2 files to Path1 2025/12/16 03:57:11 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 03:57:12 INFO : There was nothing to transfer 2025/12/16 03:57:12 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 03:57:12 INFO : There was nothing to transfer 2025/12/16 03:57:12 INFO : Resync updating listings 2025/12/16 03:57:12 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:12 INFO : Bisync successful 2025/12/16 03:57:12 NOTICE: (04) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 03:57:12 NOTICE: (05) : touch-glob 2001-01-02 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:57:12 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/" 2025/12/16 03:57:12 DEBUG : fs cache: renaming cache item "/tmp/035654xo/datadir/test_resolve-kupinux5/" to be canonical "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:12 DEBUG : file1R.txt: Set modification time 2001-01-02 2025/12/16 03:57:12 NOTICE: (06) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:57:12 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:57:12 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:57:12 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:13 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:57:13 DEBUG : file1R.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:57:13 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2) 2025/12/16 03:57:13 DEBUG : file1R.txt: Sizes differ 2025/12/16 03:57:15 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:15 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:57:15 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 03:57:15 NOTICE: (07) : touch-glob 2001-03-04 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:57:15 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:15 DEBUG : file1L.txt: Set modification time 2001-03-04 2025/12/16 03:57:15 NOTICE: (08) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:57:15 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:57:15 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:57:15 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:57:16 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:57:16 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:57:16 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1) 2025/12/16 03:57:16 DEBUG : file1L.txt: Sizes differ 2025/12/16 03:57:17 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:17 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:57:17 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 03:57:17 NOTICE: (09) : test bisync run with --conflict-resolve=newer --conflict-loser=delete --conflict-suffix=potato 2025/12/16 03:57:17 NOTICE: (10) : bisync conflict-resolve=newer conflict-loser=delete conflict-suffix=potato 2025/12/16 03:57:26 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:26 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:26 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:57:26 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:57:26 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:26 INFO : Building Path1 and Path2 listings 2025/12/16 03:57:26 INFO : Path1 checking for diffs 2025/12/16 03:57:26 INFO : - Path1 File changed: size (larger), time (newer) - file1.txt 2025/12/16 03:57:26 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2025/12/16 03:57:26 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2025/12/16 03:57:26 INFO : Path2 checking for diffs 2025/12/16 03:57:26 INFO : - Path2 File changed: size (larger), time (newer) - file1.txt 2025/12/16 03:57:26 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/12/16 03:57:26 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2025/12/16 03:57:26 INFO : Applying changes 2025/12/16 03:57:26 INFO : Checking potential conflicts... 2025/12/16 03:57:26 ERROR : file1.txt: sha1 differ 2025/12/16 03:57:26 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 differences found 2025/12/16 03:57:26 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 errors while checking 2025/12/16 03:57:26 INFO : Finished checking the potential conflicts. 1 differences found 2025/12/16 03:57:26 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:57:26 INFO : file1.txt: Path1 is newer. Path1: 2001-03-04 00:00:00 +0000 UTC, Path2: 2001-01-02 00:00:00 +0000 UTC, Difference: 1464h0m0s 2025/12/16 03:57:26 INFO : file1.txt: The winner is: Path1 2025/12/16 03:57:26 NOTICE: - Path2 Deleting Path2 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt 2025/12/16 03:57:27 INFO : file1.txt: Deleted 2025/12/16 03:57:27 INFO : - Path1 Queue copy to Path2 - file1.txt 2025/12/16 03:57:27 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:57:28 INFO : file1.txt: Copied (server-side copy) 2025/12/16 03:57:28 INFO : Updating listings 2025/12/16 03:57:28 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:28 INFO : Bisync successful 2025/12/16 03:57:28 NOTICE: (11) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 03:57:28 NOTICE: (12) : touch-glob 2001-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:57:28 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:28 DEBUG : file1R.txt: Set modification time 2001-07-23 2025/12/16 03:57:28 NOTICE: (13) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:57:28 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:57:28 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:57:28 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:29 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:57:29 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:29 DEBUG : file1R.txt: Modification times differ by -3384h0m0s: 2001-07-23 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC 2025/12/16 03:57:29 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:57:29 DEBUG : file1.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2) 2025/12/16 03:57:29 DEBUG : file1R.txt: sha1 differ 2025/12/16 03:57:30 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:30 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:57:30 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 03:57:30 NOTICE: (14) : touch-glob 2001-08-26 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:57:30 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:30 DEBUG : file1L.txt: Set modification time 2001-08-26 2025/12/16 03:57:30 NOTICE: (15) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:57:30 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:57:30 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:57:30 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:57:32 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:57:32 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:32 DEBUG : file1L.txt: Modification times differ by -4200h0m0s: 2001-08-26 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC 2025/12/16 03:57:32 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:57:33 INFO : file1L.txt: Updated modification time in destination 2025/12/16 03:57:33 DEBUG : file1L.txt: Unchanged skipping 2025/12/16 03:57:33 NOTICE: (16) : test bisync run with --conflict-resolve=path2 --conflict-loser=num --conflict-suffix=dinosaur 2025/12/16 03:57:33 NOTICE: (17) : bisync conflict-resolve=path2 conflict-loser=num conflict-suffix=dinosaur 2025/12/16 03:57:41 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:41 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:57:41 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:57:41 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:41 INFO : Building Path1 and Path2 listings 2025/12/16 03:57:41 INFO : Path1 checking for diffs 2025/12/16 03:57:41 INFO : - Path1 File changed: time (newer) - file1.txt 2025/12/16 03:57:41 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2025/12/16 03:57:41 INFO : (Modified:  1 newer,  0 older) 2025/12/16 03:57:41 INFO : Path2 checking for diffs 2025/12/16 03:57:41 INFO : - Path2 File changed: time (newer) - file1.txt 2025/12/16 03:57:41 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/12/16 03:57:41 INFO : (Modified:  1 newer,  0 older) 2025/12/16 03:57:41 INFO : Applying changes 2025/12/16 03:57:41 INFO : Checking potential conflicts... 2025/12/16 03:57:42 ERROR : file1.txt: sha1 differ 2025/12/16 03:57:42 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 differences found 2025/12/16 03:57:42 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 errors while checking 2025/12/16 03:57:42 INFO : Finished checking the potential conflicts. 1 differences found 2025/12/16 03:57:42 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:57:42 INFO : file1.txt: The winner is: Path2 2025/12/16 03:57:42 NOTICE: - Path1 Renaming Path1 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt.dinosaur1 2025/12/16 03:57:43 INFO : file1.txt: Copied (server-side copy) to: file1.txt.dinosaur1 2025/12/16 03:57:43 INFO : file1.txt: Deleted 2025/12/16 03:57:43 NOTICE: - Path1 Queue copy to Path2 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt.dinosaur1 2025/12/16 03:57:43 NOTICE: - Path2 Not renaming Path2 copy, as it was determined the winner - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt 2025/12/16 03:57:43 NOTICE: - Path2 Queue copy to Path1 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt 2025/12/16 03:57:43 INFO : - Path2 Do queued copies to - Path1 2025/12/16 03:57:43 INFO : file1.txt: Copied (server-side copy) 2025/12/16 03:57:43 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:57:44 INFO : file1.txt.dinosaur1: Copied (server-side copy) 2025/12/16 03:57:44 INFO : Updating listings 2025/12/16 03:57:44 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:44 INFO : Bisync successful 2025/12/16 03:57:44 NOTICE: (18) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 03:57:44 NOTICE: (19) : touch-glob 2002-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:57:44 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:44 DEBUG : file1R.txt: Set modification time 2002-07-23 2025/12/16 03:57:44 NOTICE: (20) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:57:44 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:57:44 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:57:44 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:45 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:57:45 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:45 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2002-07-23 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC 2025/12/16 03:57:45 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:57:46 INFO : file1R.txt: Updated modification time in destination 2025/12/16 03:57:46 DEBUG : file1R.txt: Unchanged skipping 2025/12/16 03:57:46 NOTICE: (21) : touch-glob 2002-08-26 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:57:46 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:57:46 DEBUG : file1L.txt: Set modification time 2002-08-26 2025/12/16 03:57:46 NOTICE: (22) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:57:46 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:57:46 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:57:46 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:57:48 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:57:48 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:48 DEBUG : file1L.txt: Modification times differ by -9576h0m0s: 2002-08-26 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC 2025/12/16 03:57:48 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:57:48 DEBUG : file1.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1) 2025/12/16 03:57:48 DEBUG : file1L.txt: sha1 differ 2025/12/16 03:57:49 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:57:49 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:57:49 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 03:57:49 NOTICE: (23) : test bisync run with --conflict-resolve=larger --conflict-loser=num --conflict-suffix=apple 2025/12/16 03:57:49 NOTICE: (24) : bisync conflict-resolve=larger conflict-loser=num conflict-suffix=apple 2025/12/16 03:57:58 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:58 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:57:58 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:57:58 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:57:58 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:57:58 INFO : Building Path1 and Path2 listings 2025/12/16 03:57:58 INFO : Path1 checking for diffs 2025/12/16 03:57:58 INFO : - Path1 File is new - file1.txt 2025/12/16 03:57:58 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:57:58 INFO : Path2 checking for diffs 2025/12/16 03:57:58 INFO : - Path2 File is new - file1.txt 2025/12/16 03:57:58 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:57:58 INFO : Applying changes 2025/12/16 03:57:58 INFO : Checking potential conflicts... 2025/12/16 03:57:58 ERROR : file1.txt: sha1 differ 2025/12/16 03:57:58 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 differences found 2025/12/16 03:57:58 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 errors while checking 2025/12/16 03:57:58 INFO : Finished checking the potential conflicts. 1 differences found 2025/12/16 03:57:58 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:57:58 INFO : file1.txt: Winner cannot be determined as sizes are equal. Path1: 33, Path2: 33, Difference: 0 2025/12/16 03:57:58 INFO : file1.txt: A winner could not be determined. 2025/12/16 03:57:58 NOTICE: - Path1 Renaming Path1 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt.apple1 2025/12/16 03:57:59 INFO : file1.txt: Copied (server-side copy) to: file1.txt.apple1 2025/12/16 03:58:00 INFO : file1.txt: Deleted 2025/12/16 03:58:00 NOTICE: - Path1 Queue copy to Path2 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt.apple1 2025/12/16 03:58:00 NOTICE: - Path2 Renaming Path2 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt.apple2 2025/12/16 03:58:00 INFO : file1.txt: Copied (server-side copy) to: file1.txt.apple2 2025/12/16 03:58:01 INFO : file1.txt: Deleted 2025/12/16 03:58:01 NOTICE: - Path2 Queue copy to Path1 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt.apple2 2025/12/16 03:58:01 INFO : - Path2 Do queued copies to - Path1 2025/12/16 03:58:01 INFO : file1.txt.apple2: Copied (server-side copy) 2025/12/16 03:58:01 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:58:02 INFO : file1.txt.apple1: Copied (server-side copy) 2025/12/16 03:58:02 INFO : Updating listings 2025/12/16 03:58:02 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:02 INFO : Bisync successful 2025/12/16 03:58:02 NOTICE: (25) : test different suffixes 2025/12/16 03:58:02 NOTICE: (26) : touch-glob 2003-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:58:02 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:02 DEBUG : file1R.txt: Set modification time 2003-07-23 2025/12/16 03:58:02 NOTICE: (27) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:58:02 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:58:02 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:58:02 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:03 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:58:03 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:05 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:05 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:58:05 INFO : file1R.txt: Copied (new) to: file1.txt 2025/12/16 03:58:05 NOTICE: (28) : touch-glob 2003-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:58:05 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:05 DEBUG : file1L.txt: Set modification time 2003-07-23 2025/12/16 03:58:05 NOTICE: (29) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:58:05 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:58:05 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:58:05 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:58:06 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:58:06 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:08 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:08 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:58:08 INFO : file1L.txt: Copied (new) to: file1.txt 2025/12/16 03:58:08 NOTICE: (30) : test bisync run with --conflict-resolve=older --conflict-loser=num --conflict-suffix=cloud,local 2025/12/16 03:58:08 NOTICE: (31) : bisync conflict-resolve=older conflict-loser=num conflict-suffix=cloud,local 2025/12/16 03:58:17 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:17 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:17 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:58:17 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:58:17 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:17 INFO : Building Path1 and Path2 listings 2025/12/16 03:58:17 INFO : Path1 checking for diffs 2025/12/16 03:58:17 INFO : - Path1 File is new - file1.txt 2025/12/16 03:58:17 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:58:17 INFO : Path2 checking for diffs 2025/12/16 03:58:17 INFO : - Path2 File is new - file1.txt 2025/12/16 03:58:17 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:58:17 INFO : Applying changes 2025/12/16 03:58:17 INFO : Checking potential conflicts... 2025/12/16 03:58:17 ERROR : file1.txt: sha1 differ 2025/12/16 03:58:17 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 differences found 2025/12/16 03:58:17 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 errors while checking 2025/12/16 03:58:17 INFO : Finished checking the potential conflicts. 1 differences found 2025/12/16 03:58:17 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:58:17 INFO : file1.txt: Winner cannot be determined as times are equal. Path1: 2003-07-23 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 0s 2025/12/16 03:58:17 INFO : file1.txt: A winner could not be determined. 2025/12/16 03:58:17 NOTICE: - Path1 Renaming Path1 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt.cloud1 2025/12/16 03:58:18 INFO : file1.txt: Copied (server-side copy) to: file1.txt.cloud1 2025/12/16 03:58:18 INFO : file1.txt: Deleted 2025/12/16 03:58:18 NOTICE: - Path1 Queue copy to Path2 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt.cloud1 2025/12/16 03:58:18 NOTICE: - Path2 Renaming Path2 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt.local1 2025/12/16 03:58:19 INFO : file1.txt: Copied (server-side copy) to: file1.txt.local1 2025/12/16 03:58:19 INFO : file1.txt: Deleted 2025/12/16 03:58:19 NOTICE: - Path2 Queue copy to Path1 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt.local1 2025/12/16 03:58:19 INFO : - Path2 Do queued copies to - Path1 2025/12/16 03:58:20 INFO : file1.txt.local1: Copied (server-side copy) 2025/12/16 03:58:20 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:58:20 INFO : file1.txt.cloud1: Copied (server-side copy) 2025/12/16 03:58:20 INFO : Updating listings 2025/12/16 03:58:20 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:20 INFO : Bisync successful 2025/12/16 03:58:20 NOTICE: (32) : test legacy 2025/12/16 03:58:20 NOTICE: (33) : touch-glob 2004-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:58:20 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:20 DEBUG : file1R.txt: Set modification time 2004-07-23 2025/12/16 03:58:20 NOTICE: (34) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:58:20 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:58:20 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:58:20 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:21 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:58:22 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:23 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:23 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:58:23 INFO : file1R.txt: Copied (new) to: file1.txt 2025/12/16 03:58:23 NOTICE: (35) : touch-glob 2004-07-23 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:58:23 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:23 DEBUG : file1L.txt: Set modification time 2004-07-23 2025/12/16 03:58:23 NOTICE: (36) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:58:23 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:58:23 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:58:23 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:58:24 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:58:25 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:26 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:26 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:58:26 INFO : file1L.txt: Copied (new) to: file1.txt 2025/12/16 03:58:26 NOTICE: (37) : test bisync run with --conflict-resolve=none --conflict-loser=pathname --conflict-suffix=.path 2025/12/16 03:58:26 NOTICE: (38) : bisync conflict-resolve=none conflict-loser=pathname conflict-suffix=.path 2025/12/16 03:58:35 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:35 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:58:35 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:58:35 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:35 INFO : Building Path1 and Path2 listings 2025/12/16 03:58:35 INFO : Path1 checking for diffs 2025/12/16 03:58:35 INFO : - Path1 File is new - file1.txt 2025/12/16 03:58:35 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:58:35 INFO : Path2 checking for diffs 2025/12/16 03:58:35 INFO : - Path2 File is new - file1.txt 2025/12/16 03:58:35 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2025/12/16 03:58:35 INFO : Applying changes 2025/12/16 03:58:35 INFO : Checking potential conflicts... 2025/12/16 03:58:35 ERROR : file1.txt: sha1 differ 2025/12/16 03:58:35 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 differences found 2025/12/16 03:58:35 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 1 errors while checking 2025/12/16 03:58:35 INFO : Finished checking the potential conflicts. 1 differences found 2025/12/16 03:58:35 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:58:35 NOTICE: - Path1 Renaming Path1 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt..path1 2025/12/16 03:58:36 INFO : file1.txt: Copied (server-side copy) to: file1.txt..path1 2025/12/16 03:58:36 INFO : file1.txt: Deleted 2025/12/16 03:58:36 NOTICE: - Path1 Queue copy to Path2 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt..path1 2025/12/16 03:58:36 NOTICE: - Path2 Renaming Path2 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt..path2 2025/12/16 03:58:37 INFO : file1.txt: Copied (server-side copy) to: file1.txt..path2 2025/12/16 03:58:37 INFO : file1.txt: Deleted 2025/12/16 03:58:37 NOTICE: - Path2 Queue copy to Path1 - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file1.txt..path2 2025/12/16 03:58:37 INFO : - Path2 Do queued copies to - Path1 2025/12/16 03:58:38 INFO : file1.txt..path2: Copied (server-side copy) 2025/12/16 03:58:38 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:58:38 INFO : file1.txt..path1: Copied (server-side copy) 2025/12/16 03:58:38 INFO : Updating listings 2025/12/16 03:58:38 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:38 INFO : Bisync successful 2025/12/16 03:58:38 NOTICE: (39) : test deletes on both sides with default suffix 2025/12/16 03:58:38 NOTICE: (40) : touch-glob 2005-01-02 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1R.txt 2025/12/16 03:58:38 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:38 DEBUG : file1R.txt: Set modification time 2005-01-02 2025/12/16 03:58:38 NOTICE: (41) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file1.txt 2025/12/16 03:58:38 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file1.txt" 2025/12/16 03:58:38 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:58:38 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:39 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file1.txt" 2025/12/16 03:58:40 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:41 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:41 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:58:41 INFO : file1R.txt: Copied (new) to: file1.txt 2025/12/16 03:58:41 NOTICE: (42) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file2.txt 2025/12/16 03:58:41 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file2.txt" 2025/12/16 03:58:41 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1R.txt" 2025/12/16 03:58:41 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:58:42 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file2.txt" 2025/12/16 03:58:42 DEBUG : file1R.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:58:42 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1) 2025/12/16 03:58:42 DEBUG : file1R.txt: Sizes differ 2025/12/16 03:58:44 DEBUG : file2.txt: size = 33 OK 2025/12/16 03:58:44 DEBUG : file1R.txt: sha1 = 65c38b0ea2471fffaeb286d75ed7a07ae09fded8 OK 2025/12/16 03:58:44 INFO : file1R.txt: Copied (replaced existing) to: file2.txt 2025/12/16 03:58:44 NOTICE: (43) : touch-glob 2006-03-04 /tmp/035654xo/datadir/test_resolve-kupinux5/ file1L.txt 2025/12/16 03:58:44 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resolve-kupinux5/" for canonical name "/tmp/035654xo/datadir/test_resolve-kupinux5" 2025/12/16 03:58:44 DEBUG : file1L.txt: Set modification time 2006-03-04 2025/12/16 03:58:44 NOTICE: (44) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/ file1.txt 2025/12/16 03:58:44 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" as "file1.txt" 2025/12/16 03:58:44 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:58:44 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" 2025/12/16 03:58:45 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1" as "file1.txt" 2025/12/16 03:58:45 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/16 03:58:47 DEBUG : file1.txt: size = 33 OK 2025/12/16 03:58:47 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:58:47 INFO : file1L.txt: Copied (new) to: file1.txt 2025/12/16 03:58:47 NOTICE: (45) : copy-as /tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/ file2.txt 2025/12/16 03:58:47 DEBUG : copyFile "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" as "file2.txt" 2025/12/16 03:58:47 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resolve-kupinux5/file1L.txt" 2025/12/16 03:58:47 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:48 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2" as "file2.txt" 2025/12/16 03:58:48 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resolve-kupinux5) 2025/12/16 03:58:48 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2) 2025/12/16 03:58:48 DEBUG : file1L.txt: Sizes differ 2025/12/16 03:58:50 DEBUG : file2.txt: size = 33 OK 2025/12/16 03:58:50 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 03:58:50 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/12/16 03:58:50 NOTICE: (46) : test bisync run with --conflict-resolve=newer --conflict-loser=delete 2025/12/16 03:58:50 NOTICE: (47) : bisync conflict-resolve=newer conflict-loser=delete 2025/12/16 03:58:58 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:58 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:58:58 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:58:58 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:58:58 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:58:58 INFO : Building Path1 and Path2 listings 2025/12/16 03:58:58 INFO : Path1 checking for diffs 2025/12/16 03:58:58 INFO : - Path1 File changed: size (larger), time (newer) - file2.txt 2025/12/16 03:58:58 INFO : - Path1 File is new - file1.txt 2025/12/16 03:58:58 INFO : Path1: 2 changes:  1 new,  1 modified,  0 deleted 2025/12/16 03:58:58 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2025/12/16 03:58:58 INFO : Path2 checking for diffs 2025/12/16 03:58:58 INFO : - Path2 File changed: size (larger), time (newer) - file2.txt 2025/12/16 03:58:58 INFO : - Path2 File is new - file1.txt 2025/12/16 03:58:58 INFO : Path2: 2 changes:  1 new,  1 modified,  0 deleted 2025/12/16 03:58:58 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2025/12/16 03:58:58 INFO : Applying changes 2025/12/16 03:58:58 INFO : Checking potential conflicts... 2025/12/16 03:58:58 ERROR : file1.txt: sha1 differ 2025/12/16 03:58:58 ERROR : file2.txt: sha1 differ 2025/12/16 03:58:58 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 2 differences found 2025/12/16 03:58:58 NOTICE: B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: 2 errors while checking 2025/12/16 03:58:58 INFO : Finished checking the potential conflicts. 2 differences found 2025/12/16 03:58:58 NOTICE: - WARNING New or changed in both paths - file1.txt 2025/12/16 03:58:58 INFO : file1.txt: Path1 is newer. Path1: 2006-03-04 00:00:00 +0000 UTC, Path2: 2005-01-02 00:00:00 +0000 UTC, Difference: 10224h0m0s 2025/12/16 03:58:58 INFO : file1.txt: The winner is: Path1 2025/12/16 03:58:58 NOTICE: - Path2 Deleting Path2 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/file1.txt 2025/12/16 03:58:59 INFO : file1.txt: Deleted 2025/12/16 03:58:59 INFO : - Path1 Queue copy to Path2 - file1.txt 2025/12/16 03:58:59 NOTICE: - WARNING New or changed in both paths - file2.txt 2025/12/16 03:58:59 INFO : file2.txt: Path2 is newer. Path1: 2005-01-02 00:00:00 +0000 UTC, Path2: 2006-03-04 00:00:00 +0000 UTC, Difference: 10224h0m0s 2025/12/16 03:58:59 INFO : file2.txt: The winner is: Path2 2025/12/16 03:58:59 NOTICE: - Path1 Deleting Path1 copy - TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/file2.txt 2025/12/16 03:59:00 INFO : file2.txt: Deleted 2025/12/16 03:59:00 INFO : - Path2 Queue copy to Path1 - file2.txt 2025/12/16 03:59:00 INFO : - Path2 Do queued copies to - Path1 2025/12/16 03:59:00 INFO : file2.txt: Copied (server-side copy) 2025/12/16 03:59:00 INFO : - Path1 Do queued copies to - Path2 2025/12/16 03:59:01 INFO : file1.txt: Copied (server-side copy) 2025/12/16 03:59:01 INFO : Updating listings 2025/12/16 03:59:01 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resolve/path2/" 2025/12/16 03:59:01 INFO : Bisync successful 2025/12/16 03:59:01 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:59:01 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f115ea61e93cf2c49_d20251216_m035701_c001_v0001104_t0022_u01765857421811") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047db472d2f1728_d20251216_m035847_c001_v0001136_t0003_u01765857527034") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f407bab0f722f632f_d20251216_m035836_c001_v7007000_t0000_u01765857516515") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f119373231063d7d1_d20251216_m035826_c001_v0001181_t0059_u01765857506454") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192b86a0ebda6a0_d20251216_m035818_c001_v7007000_t0000_u01765857498778") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11304819c6ad5132_d20251216_m035808_c001_v0001099_t0039_u01765857488221") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192343406e4d5b5_d20251216_m035759_c001_v7007000_t0000_u01765857479926") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102e403416808475_d20251216_m035749_c001_v0001157_t0034_u01765857469582") 2025/12/16 03:59:01 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f109a0f9305762800_d20251216_m035743_c001_v0001137_t0037_u01765857463586") 2025/12/16 03:59:02 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4177fc3baadf1820_d20251216_m035743_c001_v7007000_t0000_u01765857463201") 2025/12/16 03:59:02 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1080c70d5866370d_d20251216_m035733_c001_v0001183_t0044_u01765857453232") 2025/12/16 03:59:02 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebeb453_d20251216_m035717_c001_v0001185_t0042_u01765857437785") 2025/12/16 03:59:02 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047a14729c1dca6_d20251216_m035701_c001_v0001105_t0006_u01765857421434") 2025/12/16 03:59:02 DEBUG : file1.txt..path1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10183f68c5c1168d_d20251216_m035836_c001_v0001181_t0004_u01765857516301") 2025/12/16 03:59:02 DEBUG : file1.txt..path2: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1016ddf9f285d4b4_d20251216_m035837_c001_v0001185_t0059_u01765857517920") 2025/12/16 03:59:02 DEBUG : file1.txt.apple1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c64149899a_d20251216_m035759_c001_v0001185_t0011_u01765857479732") 2025/12/16 03:59:02 DEBUG : file1.txt.apple2: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11434975e6952c10_d20251216_m035801_c001_v0001032_t0014_u01765857481479") 2025/12/16 03:59:02 DEBUG : file1.txt.cloud1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebebf99_d20251216_m035818_c001_v0001185_t0003_u01765857498347") 2025/12/16 03:59:02 DEBUG : file1.txt.dinosaur1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f105b1f940c8a91d1_d20251216_m035742_c001_v0001171_t0012_u01765857462945") 2025/12/16 03:59:02 DEBUG : file1.txt.local1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1075e66f21df3d90_d20251216_m035820_c001_v0001131_t0017_u01765857500076") 2025/12/16 03:59:02 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1172b64231287353_d20251216_m035900_c001_v0001185_t0039_u01765857540349") 2025/12/16 03:59:02 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4057f0ce6401fc5f_d20251216_m035859_c001_v7007000_t0000_u01765857539911") 2025/12/16 03:59:02 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1075129bd168aa5a_d20251216_m035844_c001_v0001180_t0059_u01765857524266") 2025/12/16 03:59:03 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502460964_d20251216_m035701_c001_v0001185_t0030_u01765857421610") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4057f0ce6401fc56_d20251216_m035854_c001_v7007000_t0000_u01765857534273") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1155a03241027fee_d20251216_m035853_c001_v0001185_t0024_u01765857533054") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047a14729c1dd8a_d20251216_m035850_c001_v0001105_t0056_u01765857530806") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f407bab0f722f632c_d20251216_m035831_c001_v7007000_t0000_u01765857511092") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116b7eae34e65657_d20251216_m035829_c001_v0001157_t0018_u01765857509766") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f115ea61e93cf2cba_d20251216_m035827_c001_v0001104_t0022_u01765857507053") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192b86a0ebda69d_d20251216_m035812_c001_v7007000_t0000_u01765857492665") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1163f196c77e8f19_d20251216_m035811_c001_v0001185_t0023_u01765857491443") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502461590_d20251216_m035809_c001_v0001185_t0028_u01765857489115") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192343406e4d5ab_d20251216_m035754_c001_v7007000_t0000_u01765857474162") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10142f277258d2ae_d20251216_m035752_c001_v0001090_t0058_u01765857472713") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047a14729c1dd1f_d20251216_m035750_c001_v0001105_t0043_u01765857470361") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4177fc3baadf17fa_d20251216_m035737_c001_v7007000_t0000_u01765857457679") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10400547ee715c96_d20251216_m035736_c001_v0001161_t0045_u01765857456284") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f115ea61e93cf2c71_d20251216_m035733_c001_v0001104_t0059_u01765857453865") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4057f0ce6401fc07_d20251216_m035722_c001_v7007000_t0000_u01765857442170") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee504_d20251216_m035720_c001_v0001113_t0041_u01765857440774") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502460c52_d20251216_m035718_c001_v0001185_t0043_u01765857438450") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f422b76d1c7ef0afd_d20251216_m035707_c001_v7007000_t0000_u01765857427887") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10939c30dc48dfe1_d20251216_m035706_c001_v0001181_t0051_u01765857426632") 2025/12/16 03:59:03 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047a14729c1dcad_d20251216_m035704_c001_v0001105_t0006_u01765857424561") 2025/12/16 03:59:04 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resolve/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:59:04 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11223734ea71fa81_d20251216_m035704_c001_v0001178_t0027_u01765857424167") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1171f579dde77d86_d20251216_m035900_c001_v0001036_t0055_u01765857540857") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f409c3109b920207b_d20251216_m035859_c001_v7007000_t0000_u01765857539180") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f105989e033d80c4a_d20251216_m035841_c001_v0001185_t0058_u01765857521440") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f422b76d1c7ef0b57_d20251216_m035837_c001_v7007000_t0000_u01765857517530") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102039fc8da04cf9_d20251216_m035823_c001_v0001032_t0055_u01765857503445") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f411726b563d1d1ad_d20251216_m035819_c001_v7007000_t0000_u01765857499682") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f103459fe75f26da4_d20251216_m035805_c001_v0001137_t0000_u01765857485174") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae138f_d20251216_m035801_c001_v7007000_t0000_u01765857481084") 2025/12/16 03:59:04 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f113facc9c7c0517c_d20251216_m035746_c001_v0001185_t0057_u01765857466728") 2025/12/16 03:59:05 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11412eee07b939c7_d20251216_m035730_c001_v0001099_t0053_u01765857450706") 2025/12/16 03:59:05 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f104b82a4fe9d0f62_d20251216_m035727_c001_v0001032_t0036_u01765857447605") 2025/12/16 03:59:05 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4057f0ce6401fc0b_d20251216_m035727_c001_v7007000_t0000_u01765857447152") 2025/12/16 03:59:05 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11223734ea71fa8f_d20251216_m035714_c001_v0001178_t0022_u01765857434947") 2025/12/16 03:59:05 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee4e5_d20251216_m035703_c001_v0001113_t0019_u01765857423806") 2025/12/16 03:59:05 DEBUG : file1.txt..path1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11786ab8159aa014_d20251216_m035838_c001_v0001092_t0031_u01765857518490") 2025/12/16 03:59:05 DEBUG : file1.txt..path2: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c641498fe8_d20251216_m035837_c001_v0001185_t0028_u01765857517076") 2025/12/16 03:59:05 DEBUG : file1.txt.apple1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11058f9c9b5b825f_d20251216_m035802_c001_v0001038_t0052_u01765857482174") 2025/12/16 03:59:05 DEBUG : file1.txt.apple2: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1152501f7482c469_d20251216_m035800_c001_v0001130_t0000_u01765857480500") 2025/12/16 03:59:05 DEBUG : file1.txt.cloud1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11444ab3f2d35a10_d20251216_m035820_c001_v0001182_t0030_u01765857500641") 2025/12/16 03:59:05 DEBUG : file1.txt.dinosaur1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11574326374e6ffc_d20251216_m035744_c001_v0001157_t0003_u01765857464209") 2025/12/16 03:59:05 DEBUG : file1.txt.local1: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10329d8b40fa085f_d20251216_m035819_c001_v0001185_t0038_u01765857499379") 2025/12/16 03:59:05 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102e40341680852a_d20251216_m035850_c001_v0001157_t0057_u01765857530027") 2025/12/16 03:59:05 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f110f8969e088adb8_d20251216_m035703_c001_v0001161_t0050_u01765857423980") 2025/12/16 03:59:05 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f409c3109b9202079_d20251216_m035858_c001_v7007000_t0000_u01765857538416") 2025/12/16 03:59:05 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebec4da_d20251216_m035857_c001_v0001185_t0034_u01765857537043") 2025/12/16 03:59:05 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee5af_d20251216_m035854_c001_v0001113_t0052_u01765857534813") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f422b76d1c7ef0b52_d20251216_m035835_c001_v7007000_t0000_u01765857515005") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1101d4cc5ec89504_d20251216_m035833_c001_v0001181_t0037_u01765857513762") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11223734ea71fb28_d20251216_m035831_c001_v0001178_t0005_u01765857511634") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f411726b563d1d1aa_d20251216_m035816_c001_v7007000_t0000_u01765857496974") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10857cd47f2daa11_d20251216_m035815_c001_v0001153_t0001_u01765857495650") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f110f8969e088ae75_d20251216_m035813_c001_v0001161_t0037_u01765857493231") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae138c_d20251216_m035758_c001_v7007000_t0000_u01765857478405") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebebc76_d20251216_m035757_c001_v0001185_t0037_u01765857477047") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee549_d20251216_m035754_c001_v0001113_t0026_u01765857474741") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f418db0b85c6d7179_d20251216_m035741_c001_v7007000_t0000_u01765857461660") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1067de77e2b0d4bb_d20251216_m035740_c001_v0001171_t0017_u01765857460393") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11223734ea71fabb_d20251216_m035738_c001_v0001178_t0011_u01765857458219") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4057f0ce6401fc09_d20251216_m035726_c001_v7007000_t0000_u01765857446426") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1054b85c28193ed7_d20251216_m035725_c001_v0001102_t0017_u01765857445098") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f110f8969e088addb_d20251216_m035722_c001_v0001161_t0006_u01765857442706") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe30c_d20251216_m035711_c001_v7007000_t0000_u01765857431738") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102a32561cfad3c0_d20251216_m035710_c001_v0001105_t0037_u01765857430348") 2025/12/16 03:59:06 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee4ed_d20251216_m035708_c001_v0001113_t0056_u01765857428067") bisync_test.go:608: TEST resolve PASSED === RUN TestBisyncRemoteRemote/resync 2025/12/16 03:59:07 INFO : path1: Making directory 2025/12/16 03:59:07 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path1" 2025/12/16 03:59:08 INFO : path2: Making directory 2025/12/16 03:59:08 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2" 2025/12/16 03:59:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2025/12/16 03:59:09 DEBUG : Creating backend with remote "/tmp/035654xo/initdir/test_resync-vabojaf8" 2025/12/16 03:59:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : Local file system at /tmp/035654xo/initdir/test_resync-vabojaf8: Waiting for checks to finish 2025/12/16 03:59:09 DEBUG : Local file system at /tmp/035654xo/initdir/test_resync-vabojaf8: Waiting for transfers to finish 2025/12/16 03:59:09 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/16 03:59:09 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/16 03:59:09 INFO : file3.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/16 03:59:09 INFO : file2.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/16 03:59:09 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/16 03:59:09 INFO : file5.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/16 03:59:09 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:59:09 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/16 03:59:09 INFO : file6.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/16 03:59:09 INFO : file4.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/16 03:59:09 INFO : file7.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/16 03:59:09 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 03:59:09 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/16 03:59:09 INFO : file1.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2025/12/16 03:59:09 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8" 2025/12/16 03:59:09 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:09 DEBUG : Local file system at /tmp/035654xo/datadir/test_resync-zedubum8: Waiting for checks to finish 2025/12/16 03:59:09 DEBUG : Local file system at /tmp/035654xo/datadir/test_resync-zedubum8: Waiting for transfers to finish 2025/12/16 03:59:09 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK 2025/12/16 03:59:09 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK 2025/12/16 03:59:09 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 03:59:09 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 03:59:09 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2025/12/16 03:59:09 INFO : fileA.txt: Copied (new) 2025/12/16 03:59:09 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2025/12/16 03:59:09 INFO : fileB.txt: Copied (new) 2025/12/16 03:59:09 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:59:10 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 03:59:11 NOTICE: checking initFs Local file system at /tmp/035654xo/initdir/test_resync-vabojaf8 2025/12/16 03:59:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Waiting for checks to finish 2025/12/16 03:59:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Waiting for transfers to finish 2025/12/16 03:59:12 DEBUG : file1.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file1.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : file3.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file3.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : file2.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file2.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : file5.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file5.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 03:59:12 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 03:59:12 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:59:12 DEBUG : file7.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file7.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : file4.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file4.txt: Copied (new) 2025/12/16 03:59:12 DEBUG : file6.txt: size = 0 OK 2025/12/16 03:59:12 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:12 INFO : file6.txt: Copied (new) 2025/12/16 03:59:12 NOTICE: checking Path1 B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1 2025/12/16 03:59:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 03:59:13 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Waiting for checks to finish 2025/12/16 03:59:13 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Waiting for transfers to finish 2025/12/16 03:59:14 DEBUG : file1.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file1.txt: Copied (new) 2025/12/16 03:59:14 DEBUG : file3.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file3.txt: Copied (new) 2025/12/16 03:59:14 DEBUG : file4.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file4.txt: Copied (new) 2025/12/16 03:59:14 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 03:59:14 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 03:59:14 INFO : RCLONE_TEST: Copied (new) 2025/12/16 03:59:14 DEBUG : file5.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file5.txt: Copied (new) 2025/12/16 03:59:14 DEBUG : file2.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file2.txt: Copied (new) 2025/12/16 03:59:14 DEBUG : file6.txt: size = 0 OK 2025/12/16 03:59:14 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:14 INFO : file6.txt: Copied (new) 2025/12/16 03:59:15 DEBUG : file7.txt: size = 0 OK 2025/12/16 03:59:15 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 03:59:15 INFO : file7.txt: Copied (new) 2025/12/16 03:59:15 NOTICE: checking path2 B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2 2025/12/16 03:59:15 NOTICE: (01) : test resync 2025/12/16 03:59:15 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/12/16 03:59:15 NOTICE: (03) : purge-children TestB2:rclone-test-vococog9denu/035654xo/resync/path1/ 2025/12/16 03:59:15 DEBUG : RCLONE_TEST: Remove file 2025/12/16 03:59:15 DEBUG : file1.txt: Remove file 2025/12/16 03:59:16 DEBUG : file2.txt: Remove file 2025/12/16 03:59:16 DEBUG : file3.txt: Remove file 2025/12/16 03:59:16 DEBUG : file4.txt: Remove file 2025/12/16 03:59:16 DEBUG : file5.txt: Remove file 2025/12/16 03:59:16 DEBUG : file6.txt: Remove file 2025/12/16 03:59:16 DEBUG : file7.txt: Remove file 2025/12/16 03:59:17 NOTICE: (04) : bisync resync 2025/12/16 03:59:24 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:59:24 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:59:24 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:59:24 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:59:24 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:24 INFO : Copying Path2 files to Path1 2025/12/16 03:59:24 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 03:59:24 INFO : RCLONE_TEST: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file1.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file2.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file5.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file3.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file4.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file7.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : file6.txt: Copied (server-side copy) 2025/12/16 03:59:25 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 03:59:25 INFO : Resync updating listings 2025/12/16 03:59:25 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:25 INFO : Bisync successful 2025/12/16 03:59:25 NOTICE: (05) : move-listings empty-path1 2025/12/16 03:59:25 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/12/16 03:59:25 NOTICE: (07) : purge-children TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ 2025/12/16 03:59:26 DEBUG : RCLONE_TEST: Remove file 2025/12/16 03:59:26 DEBUG : file1.txt: Remove file 2025/12/16 03:59:26 DEBUG : file2.txt: Remove file 2025/12/16 03:59:26 DEBUG : file3.txt: Remove file 2025/12/16 03:59:26 DEBUG : file4.txt: Remove file 2025/12/16 03:59:26 DEBUG : file5.txt: Remove file 2025/12/16 03:59:27 DEBUG : file6.txt: Remove file 2025/12/16 03:59:27 DEBUG : file7.txt: Remove file 2025/12/16 03:59:27 NOTICE: (08) : bisync resync 2025/12/16 03:59:35 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:59:35 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 03:59:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 03:59:35 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 03:59:35 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:35 INFO : Copying Path2 files to Path1 2025/12/16 03:59:35 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 03:59:35 INFO : There was nothing to transfer 2025/12/16 03:59:35 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 03:59:36 INFO : RCLONE_TEST: Copied (server-side copy) 2025/12/16 03:59:36 INFO : file3.txt: Copied (server-side copy) 2025/12/16 03:59:36 INFO : file1.txt: Copied (server-side copy) 2025/12/16 03:59:36 INFO : file5.txt: Copied (server-side copy) 2025/12/16 03:59:36 INFO : file6.txt: Copied (server-side copy) 2025/12/16 03:59:37 INFO : file2.txt: Copied (server-side copy) 2025/12/16 03:59:37 INFO : file4.txt: Copied (server-side copy) 2025/12/16 03:59:37 INFO : file7.txt: Copied (server-side copy) 2025/12/16 03:59:37 INFO : Resync updating listings 2025/12/16 03:59:37 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:37 INFO : Bisync successful 2025/12/16 03:59:37 NOTICE: (09) : move-listings empty-path2 2025/12/16 03:59:37 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/12/16 03:59:37 NOTICE: (11) : touch-glob 2002-02-02 /tmp/035654xo/datadir/test_resync-zedubum8/ fileA.txt 2025/12/16 03:59:37 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/" 2025/12/16 03:59:37 DEBUG : fs cache: renaming cache item "/tmp/035654xo/datadir/test_resync-zedubum8/" to be canonical "/tmp/035654xo/datadir/test_resync-zedubum8" 2025/12/16 03:59:37 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/12/16 03:59:37 NOTICE: (12) : touch-glob 1999-09-09 /tmp/035654xo/datadir/test_resync-zedubum8/ fileB.txt 2025/12/16 03:59:37 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync-zedubum8/" for canonical name "/tmp/035654xo/datadir/test_resync-zedubum8" 2025/12/16 03:59:37 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/12/16 03:59:37 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/12/16 03:59:37 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/12/16 03:59:37 NOTICE: (15) : delete-file TestB2:rclone-test-vococog9denu/035654xo/resync/path2/file1.txt 2025/12/16 03:59:37 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:38 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" to be canonical "TestB2:rclone-test-vococog9denu/035654xo/resync/path2" 2025/12/16 03:59:38 INFO : file1.txt: Deleted 2025/12/16 03:59:38 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/12/16 03:59:38 NOTICE: (17) : delete-file TestB2:rclone-test-vococog9denu/035654xo/resync/path1/file2.txt 2025/12/16 03:59:38 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" 2025/12/16 03:59:39 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" to be canonical "TestB2:rclone-test-vococog9denu/035654xo/resync/path1" 2025/12/16 03:59:40 INFO : file2.txt: Deleted 2025/12/16 03:59:40 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/12/16 03:59:40 NOTICE: (19) : copy-as /tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ file3.txt 2025/12/16 03:59:40 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" as "file3.txt" 2025/12/16 03:59:40 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" 2025/12/16 03:59:40 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:41 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2" as "file3.txt" 2025/12/16 03:59:41 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/035654xo/datadir/test_resync-zedubum8) 2025/12/16 03:59:41 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2) 2025/12/16 03:59:41 DEBUG : fileA.txt: Sizes differ 2025/12/16 03:59:43 DEBUG : file3.txt: size = 19 OK 2025/12/16 03:59:43 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/16 03:59:43 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/12/16 03:59:43 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/12/16 03:59:43 NOTICE: (21) : delete-file TestB2:rclone-test-vococog9denu/035654xo/resync/path1/file4.txt 2025/12/16 03:59:43 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" for canonical name "TestB2:rclone-test-vococog9denu/035654xo/resync/path1" 2025/12/16 03:59:43 INFO : file4.txt: Deleted 2025/12/16 03:59:43 NOTICE: (22) : copy-as /tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ file4.txt 2025/12/16 03:59:43 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" as "file4.txt" 2025/12/16 03:59:43 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" 2025/12/16 03:59:43 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:44 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2" as "file4.txt" 2025/12/16 03:59:45 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/035654xo/datadir/test_resync-zedubum8) 2025/12/16 03:59:45 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2) 2025/12/16 03:59:45 DEBUG : fileA.txt: Sizes differ 2025/12/16 03:59:46 DEBUG : file4.txt: size = 19 OK 2025/12/16 03:59:46 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/16 03:59:46 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/12/16 03:59:46 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/12/16 03:59:46 NOTICE: (24) : copy-as /tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ file5.txt 2025/12/16 03:59:46 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" as "file5.txt" 2025/12/16 03:59:46 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt" 2025/12/16 03:59:46 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:47 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2" as "file5.txt" 2025/12/16 03:59:47 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/035654xo/datadir/test_resync-zedubum8) 2025/12/16 03:59:47 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2) 2025/12/16 03:59:47 DEBUG : fileB.txt: Sizes differ 2025/12/16 03:59:49 DEBUG : file5.txt: size = 19 OK 2025/12/16 03:59:49 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/16 03:59:49 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/12/16 03:59:49 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/12/16 03:59:49 NOTICE: (26) : copy-as /tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt TestB2:rclone-test-vococog9denu/035654xo/resync/path1/ file6.txt 2025/12/16 03:59:49 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" as "file6.txt" 2025/12/16 03:59:49 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/fileB.txt" 2025/12/16 03:59:49 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" 2025/12/16 03:59:50 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1" as "file6.txt" 2025/12/16 03:59:50 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/035654xo/datadir/test_resync-zedubum8) 2025/12/16 03:59:50 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1) 2025/12/16 03:59:50 DEBUG : fileB.txt: Sizes differ 2025/12/16 03:59:52 DEBUG : file6.txt: size = 19 OK 2025/12/16 03:59:52 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/16 03:59:52 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/12/16 03:59:52 NOTICE: (27) : copy-as /tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ file6.txt 2025/12/16 03:59:52 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" as "file6.txt" 2025/12/16 03:59:52 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync-zedubum8/fileA.txt" 2025/12/16 03:59:52 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 03:59:53 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2" as "file6.txt" 2025/12/16 03:59:53 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/035654xo/datadir/test_resync-zedubum8) 2025/12/16 03:59:53 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2) 2025/12/16 03:59:53 DEBUG : fileA.txt: Sizes differ 2025/12/16 03:59:55 DEBUG : file6.txt: size = 19 OK 2025/12/16 03:59:55 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/16 03:59:55 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/12/16 03:59:55 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/12/16 03:59:55 NOTICE: (29) : test run bisync with resync 2025/12/16 03:59:55 NOTICE: (30) : bisync resync 2025/12/16 04:00:02 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:02 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:02 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:00:02 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:00:02 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 04:00:02 INFO : Copying Path2 files to Path1 2025/12/16 04:00:02 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:00:03 INFO : file2.txt: Copied (server-side copy) 2025/12/16 04:00:03 INFO : file4.txt: Copied (server-side copy) 2025/12/16 04:00:03 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:00:04 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:00:04 INFO : file3.txt: Copied (server-side copy) 2025/12/16 04:00:04 INFO : file6.txt: Updated modification time in destination 2025/12/16 04:00:04 INFO : file5.txt: Copied (server-side copy) 2025/12/16 04:00:04 INFO : Resync updating listings 2025/12/16 04:00:04 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 04:00:04 INFO : Bisync successful 2025/12/16 04:00:04 NOTICE: (31) : copy-listings mixed-diffs 2025/12/16 04:00:04 NOTICE: (32) : test run normal bisync 2025/12/16 04:00:04 NOTICE: (33) : bisync 2025/12/16 04:00:12 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:12 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:12 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:00:12 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:00:12 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 04:00:12 INFO : Building Path1 and Path2 listings 2025/12/16 04:00:12 INFO : Path1 checking for diffs 2025/12/16 04:00:12 INFO : Path2 checking for diffs 2025/12/16 04:00:12 INFO : No changes found 2025/12/16 04:00:12 INFO : Updating listings 2025/12/16 04:00:12 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 04:00:12 INFO : Bisync successful 2025/12/16 04:00:12 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/12/16 04:00:12 NOTICE: (35) : purge-children TestB2:rclone-test-vococog9denu/035654xo/resync/path2/ 2025/12/16 04:00:12 DEBUG : RCLONE_TEST: Remove file 2025/12/16 04:00:12 DEBUG : file1.txt: Remove file 2025/12/16 04:00:12 DEBUG : file2.txt: Remove file 2025/12/16 04:00:13 DEBUG : file3.txt: Remove file 2025/12/16 04:00:13 DEBUG : file4.txt: Remove file 2025/12/16 04:00:13 DEBUG : file5.txt: Remove file 2025/12/16 04:00:13 DEBUG : file6.txt: Remove file 2025/12/16 04:00:13 DEBUG : file7.txt: Remove file 2025/12/16 04:00:14 NOTICE: (36) : bisync 2025/12/16 04:00:22 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:22 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:22 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:00:22 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:00:22 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync/path2/" 2025/12/16 04:00:22 INFO : Building Path1 and Path2 listings 2025/12/16 04:00:22 INFO : Path1 checking for diffs 2025/12/16 04:00:22 INFO : Path2 checking for diffs 2025/12/16 04:00:22 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/035654xo/workdir/TestB2_rclone-test-vococog9denu_035654xo_resync_path1..TestB2_rclone-test-vococog9denu_035654xo_resync_path2.path2.lst-new 2025/12/16 04:00:22 ERROR : Bisync critical error: empty current Path2 listing: /tmp/035654xo/workdir/TestB2_rclone-test-vococog9denu_035654xo_resync_path1..TestB2_rclone-test-vococog9denu_035654xo_resync_path2.path2.lst-new 2025/12/16 04:00:22 ERROR : Bisync aborted. Must run --resync to recover. 2025/12/16 04:00:22 NOTICE: Bisync error: bisync aborted 2025/12/16 04:00:22 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:00:22 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107c4d4163b96fb5_d20251216_m035924_c001_v0001185_t0043_u01765857564716") 2025/12/16 04:00:22 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addf5_d20251216_m035915_c001_v7007000_t0000_u01765857555732") 2025/12/16 04:00:22 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebec7a0_d20251216_m035912_c001_v0001185_t0039_u01765857552580") 2025/12/16 04:00:22 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f113a60be39973d33_d20251216_m035924_c001_v0001136_t0015_u01765857564935") 2025/12/16 04:00:22 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addf6_d20251216_m035915_c001_v7007000_t0000_u01765857555914") 2025/12/16 04:00:22 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1122013760ed350b_d20251216_m035912_c001_v0001093_t0023_u01765857552035") 2025/12/16 04:00:22 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f100633050246276a_d20251216_m040002_c001_v0001185_t0055_u01765857602982") 2025/12/16 04:00:22 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4065558d1c5fd262_d20251216_m035940_c001_v7007000_t0000_u01765857580485") 2025/12/16 04:00:22 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107c4d4163b96fc8_d20251216_m035925_c001_v0001185_t0019_u01765857565105") 2025/12/16 04:00:22 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addf7_d20251216_m035916_c001_v7007000_t0000_u01765857556096") 2025/12/16 04:00:22 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11319c068ed0d9c2_d20251216_m035912_c001_v0001101_t0008_u01765857552222") 2025/12/16 04:00:23 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1106129006b14f71_d20251216_m035925_c001_v0001032_t0011_u01765857565095") 2025/12/16 04:00:23 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addf9_d20251216_m035916_c001_v7007000_t0000_u01765857556288") 2025/12/16 04:00:23 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1039330b1acf452e_d20251216_m035912_c001_v0001165_t0008_u01765857552407") 2025/12/16 04:00:23 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10830d5ca6b680cb_d20251216_m040003_c001_v0001098_t0000_u01765857603199") 2025/12/16 04:00:23 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4065558d1c5fd265_d20251216_m035943_c001_v7007000_t0000_u01765857583635") 2025/12/16 04:00:23 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1086cdbb9ac0411c_d20251216_m035925_c001_v0001185_t0037_u01765857565133") 2025/12/16 04:00:23 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addfa_d20251216_m035916_c001_v7007000_t0000_u01765857556470") 2025/12/16 04:00:23 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1122013760ed350d_d20251216_m035912_c001_v0001093_t0037_u01765857552579") 2025/12/16 04:00:23 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102dedb12ac16e1d_d20251216_m035925_c001_v0001177_t0037_u01765857565213") 2025/12/16 04:00:23 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addfb_d20251216_m035916_c001_v7007000_t0000_u01765857556654") 2025/12/16 04:00:23 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1039330b1acf4530_d20251216_m035912_c001_v0001165_t0052_u01765857552626") 2025/12/16 04:00:23 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1086cdbb9ac04604_d20251216_m035952_c001_v0001185_t0005_u01765857592057") 2025/12/16 04:00:23 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f111313e821a382e6_d20251216_m035925_c001_v0001043_t0021_u01765857565429") 2025/12/16 04:00:23 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addfc_d20251216_m035916_c001_v7007000_t0000_u01765857556836") 2025/12/16 04:00:23 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11319c068ed0d9c6_d20251216_m035912_c001_v0001101_t0049_u01765857552661") 2025/12/16 04:00:23 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f104f7134cc326762_d20251216_m035925_c001_v0001178_t0051_u01765857565451") 2025/12/16 04:00:23 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addfd_d20251216_m035917_c001_v7007000_t0000_u01765857557020") 2025/12/16 04:00:23 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1039330b1acf4534_d20251216_m035912_c001_v0001165_t0050_u01765857552828") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f400f9c01326d2270_d20251216_m040018_c001_v7007000_t0000_u01765857618142") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f109d8fa0635b108e_d20251216_m040016_c001_v0001109_t0039_u01765857616531") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebed2c4_d20251216_m040014_c001_v0001185_t0042_u01765857614588") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f400f9c01326d2269_d20251216_m040008_c001_v7007000_t0000_u01765857608172") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11223734ea71fbb6_d20251216_m040006_c001_v0001178_t0005_u01765857606955") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11319c068ed0da1c_d20251216_m040004_c001_v0001101_t0038_u01765857604973") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f400f9c01326d2263_d20251216_m035958_c001_v7007000_t0000_u01765857598743") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107468d5530a2fc6_d20251216_m035957_c001_v0001146_t0007_u01765857597444") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1122013760ed3548_d20251216_m035955_c001_v0001093_t0054_u01765857595539") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4065558d1c5fd25d_d20251216_m035931_c001_v7007000_t0000_u01765857571227") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1134ef561025e5de_d20251216_m035929_c001_v0001157_t0057_u01765857569813") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1039330b1acf4566_d20251216_m035928_c001_v0001165_t0025_u01765857568004") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f404fed91225addfe_d20251216_m035920_c001_v7007000_t0000_u01765857560200") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1174ba8a6979a956_d20251216_m035918_c001_v0001183_t0049_u01765857558978") 2025/12/16 04:00:24 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebec84d_d20251216_m035917_c001_v0001185_t0013_u01765857557207") 2025/12/16 04:00:25 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:00:25 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae142e_d20251216_m040012_c001_v7007000_t0000_u01765857612657") 2025/12/16 04:00:25 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f102daa58b65f2df3_d20251216_m035935_c001_v0001185_t0014_u01765857575999") 2025/12/16 04:00:25 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe360_d20251216_m035926_c001_v7007000_t0000_u01765857566154") 2025/12/16 04:00:25 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c6414994d9_d20251216_m035914_c001_v0001185_t0013_u01765857554557") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae142f_d20251216_m040012_c001_v7007000_t0000_u01765857612842") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11565758f58bc97f_d20251216_m040003_c001_v0001041_t0043_u01765857603765") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4232905ecc6c8951_d20251216_m035938_c001_v7007000_t0000_u01765857578684") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f113e4817ba08826a_d20251216_m035936_c001_v0001137_t0033_u01765857576238") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe361_d20251216_m035926_c001_v7007000_t0000_u01765857566338") 2025/12/16 04:00:25 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1065f88b376a022f_d20251216_m035914_c001_v0001157_t0004_u01765857554018") 2025/12/16 04:00:25 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1430_d20251216_m040013_c001_v7007000_t0000_u01765857613030") 2025/12/16 04:00:25 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11200b76c1fe1108_d20251216_m035936_c001_v0001144_t0047_u01765857576459") 2025/12/16 04:00:25 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe363_d20251216_m035926_c001_v7007000_t0000_u01765857566519") 2025/12/16 04:00:25 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502461fdf_d20251216_m035914_c001_v0001185_t0033_u01765857554171") 2025/12/16 04:00:25 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1431_d20251216_m040013_c001_v7007000_t0000_u01765857613215") 2025/12/16 04:00:26 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11302b6d99f91b92_d20251216_m040004_c001_v0001134_t0057_u01765857604178") 2025/12/16 04:00:26 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f100ef286a80582ae_d20251216_m035943_c001_v0001184_t0046_u01765857583249") 2025/12/16 04:00:26 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1080c70d5866391b_d20251216_m035936_c001_v0001183_t0056_u01765857576462") 2025/12/16 04:00:26 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe364_d20251216_m035926_c001_v7007000_t0000_u01765857566701") 2025/12/16 04:00:26 DEBUG : file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1174ba8a6979a93e_d20251216_m035914_c001_v0001183_t0025_u01765857554384") 2025/12/16 04:00:26 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1432_d20251216_m040013_c001_v7007000_t0000_u01765857613447") 2025/12/16 04:00:26 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11236fd375ce55c7_d20251216_m035946_c001_v0001185_t0021_u01765857586413") 2025/12/16 04:00:26 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1163f196c77e9d74_d20251216_m035936_c001_v0001185_t0059_u01765857576408") 2025/12/16 04:00:26 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe365_d20251216_m035926_c001_v7007000_t0000_u01765857566882") 2025/12/16 04:00:26 DEBUG : file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1065f88b376a0233_d20251216_m035914_c001_v0001157_t0047_u01765857554327") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1433_d20251216_m040013_c001_v7007000_t0000_u01765857613636") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11307aeb15e30414_d20251216_m040004_c001_v0001161_t0030_u01765857604152") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1122620c515e088b_d20251216_m035949_c001_v0001181_t0003_u01765857589257") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107c4d4163b97270_d20251216_m035936_c001_v0001185_t0048_u01765857576680") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe366_d20251216_m035927_c001_v7007000_t0000_u01765857567063") 2025/12/16 04:00:26 DEBUG : file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1174ba8a6979a944_d20251216_m035914_c001_v0001183_t0024_u01765857554597") 2025/12/16 04:00:26 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1434_d20251216_m040013_c001_v7007000_t0000_u01765857613820") 2025/12/16 04:00:26 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502462792_d20251216_m040004_c001_v0001185_t0043_u01765857604217") 2025/12/16 04:00:26 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10329d8b40fa17f5_d20251216_m035954_c001_v0001185_t0026_u01765857594800") 2025/12/16 04:00:26 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f105989e033d81bf9_d20251216_m035936_c001_v0001185_t0051_u01765857576723") 2025/12/16 04:00:27 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe367_d20251216_m035927_c001_v7007000_t0000_u01765857567246") 2025/12/16 04:00:27 DEBUG : file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1065f88b376a0235_d20251216_m035914_c001_v0001157_t0053_u01765857554675") 2025/12/16 04:00:27 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1435_d20251216_m040014_c001_v7007000_t0000_u01765857614005") 2025/12/16 04:00:27 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1197c68fb127cd4c_d20251216_m035936_c001_v0001185_t0003_u01765857576901") 2025/12/16 04:00:27 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe368_d20251216_m035927_c001_v7007000_t0000_u01765857567428") 2025/12/16 04:00:27 DEBUG : file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c6414994e8_d20251216_m035914_c001_v0001185_t0000_u01765857554800") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f413d632638a6575f_d20251216_m040022_c001_v7007000_t0000_u01765857622101") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1163f196c77ea567_d20251216_m040020_c001_v0001185_t0036_u01765857620879") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1174ba8a6979aaa4_d20251216_m040018_c001_v0001183_t0023_u01765857618752") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae142c_d20251216_m040012_c001_v7007000_t0000_u01765857612092") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10830d5ca6b680d5_d20251216_m040010_c001_v0001098_t0054_u01765857610772") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c641499e53_d20251216_m040008_c001_v0001185_t0014_u01765857608761") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192b86a0ebda70b_d20251216_m040002_c001_v7007000_t0000_u01765857602569") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebed03a_d20251216_m040001_c001_v0001185_t0017_u01765857601219") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1065f88b376a027c_d20251216_m035959_c001_v0001157_t0016_u01765857599322") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f416b4098413e3576_d20251216_m035935_c001_v7007000_t0000_u01765857575413") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1038a3a60df7b70e_d20251216_m035934_c001_v0001183_t0003_u01765857574206") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10063305024622a0_d20251216_m035931_c001_v0001185_t0044_u01765857571764") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4171bc638c8fe35b_d20251216_m035924_c001_v7007000_t0000_u01765857564332") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f110374d3fc62bcc3_d20251216_m035922_c001_v0001109_t0047_u01765857562910") 2025/12/16 04:00:27 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1174ba8a6979a95f_d20251216_m035920_c001_v0001183_t0058_u01765857560768") bisync_test.go:608: TEST resync PASSED === RUN TestBisyncRemoteRemote/resync_modes 2025/12/16 04:00:28 INFO : path1: Making directory 2025/12/16 04:00:28 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1" 2025/12/16 04:00:29 INFO : path2: Making directory 2025/12/16 04:00:29 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2" 2025/12/16 04:00:30 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial" 2025/12/16 04:00:30 DEBUG : Creating backend with remote "/tmp/035654xo/initdir/test_resync_modes-jaqoxuq1" 2025/12/16 04:00:30 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/16 04:00:30 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/16 04:00:30 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:00:30 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/16 04:00:30 INFO : file1.txt: Copied (new) 2025/12/16 04:00:30 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:00:30 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/16 04:00:30 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/16 04:00:30 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/16 04:00:30 INFO : file2.txt: Copied (new) 2025/12/16 04:00:30 DEBUG : Local file system at /tmp/035654xo/initdir/test_resync_modes-jaqoxuq1: Waiting for checks to finish 2025/12/16 04:00:30 DEBUG : Local file system at /tmp/035654xo/initdir/test_resync_modes-jaqoxuq1: Waiting for transfers to finish 2025/12/16 04:00:30 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/16 04:00:30 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:00:30 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles" 2025/12/16 04:00:30 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:00:30 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:30 DEBUG : Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0: Waiting for checks to finish 2025/12/16 04:00:30 DEBUG : Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0: Waiting for transfers to finish 2025/12/16 04:00:30 DEBUG : file1R.txt.d467e63a.partial: size = 42 OK 2025/12/16 04:00:30 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK 2025/12/16 04:00:30 DEBUG : file1R.txt.d467e63a.partial: renamed to: file1R.txt 2025/12/16 04:00:30 INFO : file1R.txt: Copied (new) 2025/12/16 04:00:30 DEBUG : file1L.txt.684d937d.partial: size = 33 OK 2025/12/16 04:00:30 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2025/12/16 04:00:30 DEBUG : file2.txt.ac4156f2.partial: size = 37 OK 2025/12/16 04:00:30 DEBUG : file1L.txt.684d937d.partial: renamed to: file1L.txt 2025/12/16 04:00:30 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2025/12/16 04:00:30 DEBUG : file2.txt.ac4156f2.partial: renamed to: file2.txt 2025/12/16 04:00:30 INFO : file2.txt: Copied (new) 2025/12/16 04:00:30 INFO : file1L.txt: Copied (new) 2025/12/16 04:00:30 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:00:31 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:00:32 NOTICE: checking initFs Local file system at /tmp/035654xo/initdir/test_resync_modes-jaqoxuq1 2025/12/16 04:00:32 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:00:32 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:32 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:32 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Waiting for checks to finish 2025/12/16 04:00:32 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Waiting for transfers to finish 2025/12/16 04:00:33 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:00:33 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:00:33 INFO : file1.txt: Copied (new) 2025/12/16 04:00:33 DEBUG : file2.txt: size = 0 OK 2025/12/16 04:00:33 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:00:33 INFO : file2.txt: Copied (new) 2025/12/16 04:00:33 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:00:33 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:00:33 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:00:33 NOTICE: checking Path1 B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1 2025/12/16 04:00:34 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:00:34 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:34 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:00:34 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Waiting for checks to finish 2025/12/16 04:00:34 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Waiting for transfers to finish 2025/12/16 04:00:35 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:00:35 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:00:35 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:00:35 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:00:35 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:00:35 INFO : file1.txt: Copied (new) 2025/12/16 04:00:35 DEBUG : file2.txt: size = 0 OK 2025/12/16 04:00:35 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:00:35 INFO : file2.txt: Copied (new) 2025/12/16 04:00:35 NOTICE: checking path2 B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2 2025/12/16 04:00:35 NOTICE: (01) : test resync-mode 2025/12/16 04:00:35 NOTICE: (02) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:00:35 NOTICE: (03) : touch-glob 2001-01-02 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:00:35 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" 2025/12/16 04:00:35 DEBUG : fs cache: renaming cache item "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" to be canonical "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:00:35 DEBUG : file1R.txt: Set modification time 2001-01-02 2025/12/16 04:00:35 NOTICE: (04) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:00:35 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:00:35 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:00:35 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:00:36 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:00:36 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:00:36 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:00:36 DEBUG : file1R.txt: Sizes differ 2025/12/16 04:00:38 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:00:38 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:00:38 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:00:38 NOTICE: (05) : touch-glob 2001-03-04 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:00:38 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:00:38 DEBUG : file1L.txt: Set modification time 2001-03-04 2025/12/16 04:00:38 NOTICE: (06) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:00:38 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:00:38 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:00:38 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:00:39 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:00:40 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:00:40 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1) 2025/12/16 04:00:40 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:00:41 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:00:41 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:00:41 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:00:41 NOTICE: (07) : test bisync run with --resync-mode=newer 2025/12/16 04:00:41 NOTICE: (08) : bisync resync resync-mode=newer 2025/12/16 04:00:50 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:50 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:00:50 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:00:50 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:00:50 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:00:50 INFO : Copying Path2 files to Path1 2025/12/16 04:00:50 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:00:50 INFO : There was nothing to transfer 2025/12/16 04:00:50 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:00:51 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:00:51 INFO : Resync updating listings 2025/12/16 04:00:51 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:00:51 INFO : Bisync successful 2025/12/16 04:00:51 NOTICE: (09) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:00:51 NOTICE: (10) : touch-glob 2001-07-23 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:00:51 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:00:51 DEBUG : file1R.txt: Set modification time 2001-07-23 2025/12/16 04:00:51 NOTICE: (11) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:00:51 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:00:51 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:00:51 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:00:52 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:00:52 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:00:52 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:00:52 DEBUG : file1R.txt: Sizes differ 2025/12/16 04:00:54 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:00:54 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:00:54 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:00:54 NOTICE: (12) : touch-glob 2001-08-26 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:00:54 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:00:54 DEBUG : file1L.txt: Set modification time 2001-08-26 2025/12/16 04:00:54 NOTICE: (13) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:00:54 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:00:54 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:00:54 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:00:55 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:00:55 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:00:55 DEBUG : file1L.txt: Modification times differ by -4200h0m0s: 2001-08-26 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC 2025/12/16 04:00:55 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:00:56 INFO : file1L.txt: Updated modification time in destination 2025/12/16 04:00:56 DEBUG : file1L.txt: Unchanged skipping 2025/12/16 04:00:56 NOTICE: (14) : test bisync run with --resync-mode=path2 2025/12/16 04:00:56 NOTICE: (15) : bisync resync resync-mode=path2 2025/12/16 04:01:05 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:05 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:05 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:01:05 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:01:05 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:05 INFO : Copying Path2 files to Path1 2025/12/16 04:01:05 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:01:05 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:01:05 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:01:05 INFO : Resync updating listings 2025/12/16 04:01:05 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:05 INFO : Bisync successful 2025/12/16 04:01:05 NOTICE: (16) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:01:05 NOTICE: (17) : touch-glob 2002-07-23 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:01:05 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:05 DEBUG : file1R.txt: Set modification time 2002-07-23 2025/12/16 04:01:05 NOTICE: (18) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:01:05 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:01:05 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:01:05 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:06 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:01:07 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:01:07 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2002-07-23 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC 2025/12/16 04:01:07 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:01:08 INFO : file1R.txt: Updated modification time in destination 2025/12/16 04:01:08 DEBUG : file1R.txt: Unchanged skipping 2025/12/16 04:01:08 NOTICE: (19) : touch-glob 2002-08-26 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:01:08 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:08 DEBUG : file1L.txt: Set modification time 2002-08-26 2025/12/16 04:01:08 NOTICE: (20) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:01:08 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:01:08 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:01:08 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:01:09 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:01:09 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:01:09 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1) 2025/12/16 04:01:09 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:01:11 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:01:11 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:01:11 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:01:11 NOTICE: (21) : test bisync run with --resync-mode=larger 2025/12/16 04:01:11 NOTICE: (22) : bisync resync resync-mode=larger 2025/12/16 04:01:19 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:19 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:19 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:01:19 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:01:19 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:19 INFO : Copying Path2 files to Path1 2025/12/16 04:01:19 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:01:19 INFO : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9 2025/12/16 04:01:20 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:01:20 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:01:20 INFO : Resync updating listings 2025/12/16 04:01:20 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:20 INFO : Bisync successful 2025/12/16 04:01:20 NOTICE: (23) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:01:20 NOTICE: (24) : touch-glob 2003-07-23 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:01:20 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:20 DEBUG : file1R.txt: Set modification time 2003-07-23 2025/12/16 04:01:20 NOTICE: (25) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:01:20 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:01:20 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:01:20 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:21 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:01:21 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:01:21 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2003-07-23 00:00:00 +0000 UTC, 2002-07-23 00:00:00 +0000 UTC 2025/12/16 04:01:21 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:01:22 INFO : file1R.txt: Updated modification time in destination 2025/12/16 04:01:22 DEBUG : file1R.txt: Unchanged skipping 2025/12/16 04:01:22 NOTICE: (26) : touch-glob 2003-09-04 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:01:22 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:22 DEBUG : file1L.txt: Set modification time 2003-09-04 2025/12/16 04:01:22 NOTICE: (27) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:01:22 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:01:22 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:01:22 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:01:24 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:01:24 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:01:24 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1) 2025/12/16 04:01:24 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:01:25 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:01:25 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:01:25 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:01:25 NOTICE: (28) : test bisync run with --resync-mode=older 2025/12/16 04:01:25 NOTICE: (29) : bisync resync resync-mode=older 2025/12/16 04:01:34 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:34 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:34 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:01:34 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:01:34 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:34 INFO : Copying Path2 files to Path1 2025/12/16 04:01:34 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:01:34 INFO : file1.txt: Path2 is older. Path1: 2003-09-04 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 1032h0m0s 2025/12/16 04:01:35 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:01:35 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:01:35 INFO : Resync updating listings 2025/12/16 04:01:35 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:35 INFO : Bisync successful 2025/12/16 04:01:35 NOTICE: (30) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:01:35 NOTICE: (31) : touch-glob 2004-07-23 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:01:35 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:35 DEBUG : file1R.txt: Set modification time 2004-07-23 2025/12/16 04:01:35 NOTICE: (32) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:01:35 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:01:35 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:01:35 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:36 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:01:36 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:01:36 DEBUG : file1R.txt: Modification times differ by -8784h0m0s: 2004-07-23 00:00:00 +0000 UTC, 2003-07-23 00:00:00 +0000 UTC 2025/12/16 04:01:36 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:01:38 INFO : file1R.txt: Updated modification time in destination 2025/12/16 04:01:38 DEBUG : file1R.txt: Unchanged skipping 2025/12/16 04:01:38 NOTICE: (33) : touch-glob 2004-07-23 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:01:38 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:38 DEBUG : file1L.txt: Set modification time 2004-07-23 2025/12/16 04:01:38 NOTICE: (34) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:01:38 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:01:38 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:01:38 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:01:39 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:01:39 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:01:39 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1) 2025/12/16 04:01:39 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:01:40 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:01:40 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:01:40 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:01:40 NOTICE: (35) : test bisync run with --resync-mode=smaller 2025/12/16 04:01:40 NOTICE: (36) : bisync resync resync-mode=smaller 2025/12/16 04:01:49 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:49 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:01:49 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:01:49 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:01:49 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:49 INFO : Copying Path2 files to Path1 2025/12/16 04:01:49 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:01:49 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/12/16 04:01:49 INFO : There was nothing to transfer 2025/12/16 04:01:49 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:01:49 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/12/16 04:01:50 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:01:50 INFO : Resync updating listings 2025/12/16 04:01:50 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:50 INFO : Bisync successful 2025/12/16 04:01:50 NOTICE: (37) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/16 04:01:50 NOTICE: (38) : touch-glob 2005-01-02 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:01:50 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:50 DEBUG : file1R.txt: Set modification time 2005-01-02 2025/12/16 04:01:50 NOTICE: (39) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:01:50 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:01:50 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:01:50 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:51 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:01:51 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:01:51 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:01:51 DEBUG : file1R.txt: Sizes differ 2025/12/16 04:01:52 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:01:52 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:01:52 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:01:52 NOTICE: (40) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file2.txt 2025/12/16 04:01:52 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file2.txt" 2025/12/16 04:01:52 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:01:52 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:01:54 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file2.txt" 2025/12/16 04:01:54 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:01:54 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1) 2025/12/16 04:01:54 DEBUG : file1R.txt: Sizes differ 2025/12/16 04:01:55 DEBUG : file2.txt: size = 42 OK 2025/12/16 04:01:55 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:01:55 INFO : file1R.txt: Copied (replaced existing) to: file2.txt 2025/12/16 04:01:55 NOTICE: (41) : touch-glob 2006-03-04 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:01:55 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:01:55 DEBUG : file1L.txt: Set modification time 2006-03-04 2025/12/16 04:01:55 NOTICE: (42) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:01:55 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:01:55 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:01:55 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:01:56 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:01:57 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:01:57 DEBUG : file1L.txt: Modification times differ by -14136h0m0s: 2006-03-04 00:00:00 +0000 UTC, 2004-07-23 00:00:00 +0000 UTC 2025/12/16 04:01:57 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:01:58 INFO : file1L.txt: Updated modification time in destination 2025/12/16 04:01:58 DEBUG : file1L.txt: Unchanged skipping 2025/12/16 04:01:58 NOTICE: (43) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file2.txt 2025/12/16 04:01:58 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file2.txt" 2025/12/16 04:01:58 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:01:58 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:01:59 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file2.txt" 2025/12/16 04:02:00 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:02:00 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:02:00 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:02:02 DEBUG : file2.txt: size = 33 OK 2025/12/16 04:02:02 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:02:02 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/12/16 04:02:02 NOTICE: (44) : test bisync run with --resync-mode=path1 2025/12/16 04:02:02 NOTICE: (45) : bisync resync resync-mode=path1 2025/12/16 04:02:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:02:11 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:02:11 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:02:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:02:11 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:11 INFO : Copying Path2 files to Path1 2025/12/16 04:02:11 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:02:11 INFO : There was nothing to transfer 2025/12/16 04:02:11 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:02:11 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:02:12 INFO : file2.txt: Copied (server-side copy) 2025/12/16 04:02:12 INFO : Resync updating listings 2025/12/16 04:02:12 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:12 INFO : Bisync successful 2025/12/16 04:02:12 NOTICE: (46) : test no winner 2025/12/16 04:02:12 NOTICE: (47) : touch-glob 2022-02-22 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1R.txt 2025/12/16 04:02:12 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:02:12 DEBUG : file1R.txt: Set modification time 2022-02-22 2025/12/16 04:02:12 NOTICE: (48) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file1.txt 2025/12/16 04:02:12 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file1.txt" 2025/12/16 04:02:12 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:02:12 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:13 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file1.txt" 2025/12/16 04:02:13 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:02:13 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:02:13 DEBUG : file1R.txt: Sizes differ 2025/12/16 04:02:15 DEBUG : file1.txt: size = 42 OK 2025/12/16 04:02:15 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:02:15 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/16 04:02:15 NOTICE: (49) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file2.txt 2025/12/16 04:02:15 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file2.txt" 2025/12/16 04:02:15 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1R.txt" 2025/12/16 04:02:15 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:02:16 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file2.txt" 2025/12/16 04:02:16 DEBUG : file2.txt: size = 42 OK 2025/12/16 04:02:16 DEBUG : file1R.txt: Modification times differ by -150240h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2005-01-02 00:00:00 +0000 UTC 2025/12/16 04:02:16 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/16 04:02:17 INFO : file1R.txt: Updated modification time in destination 2025/12/16 04:02:17 DEBUG : file1R.txt: Unchanged skipping 2025/12/16 04:02:17 NOTICE: (50) : touch-glob 2022-02-22 /tmp/035654xo/datadir/test_resync_modes-tumoxev0/ file1L.txt 2025/12/16 04:02:17 DEBUG : fs cache: switching user supplied name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/" for canonical name "/tmp/035654xo/datadir/test_resync_modes-tumoxev0" 2025/12/16 04:02:17 DEBUG : file1L.txt: Set modification time 2022-02-22 2025/12/16 04:02:17 NOTICE: (51) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/ file1.txt 2025/12/16 04:02:17 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" as "file1.txt" 2025/12/16 04:02:17 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:02:17 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" 2025/12/16 04:02:18 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1" as "file1.txt" 2025/12/16 04:02:19 DEBUG : file1.txt: size = 33 OK 2025/12/16 04:02:19 DEBUG : file1L.txt: Modification times differ by -140016h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2006-03-04 00:00:00 +0000 UTC 2025/12/16 04:02:19 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:02:20 INFO : file1L.txt: Updated modification time in destination 2025/12/16 04:02:20 DEBUG : file1L.txt: Unchanged skipping 2025/12/16 04:02:20 NOTICE: (52) : copy-as /tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/ file2.txt 2025/12/16 04:02:20 DEBUG : copyFile "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" to "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" as "file2.txt" 2025/12/16 04:02:20 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_resync_modes-tumoxev0/file1L.txt" 2025/12/16 04:02:20 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:21 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2" as "file2.txt" 2025/12/16 04:02:21 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/035654xo/datadir/test_resync_modes-tumoxev0) 2025/12/16 04:02:21 DEBUG : file2.txt: size = 42 (B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2) 2025/12/16 04:02:21 DEBUG : file1L.txt: Sizes differ 2025/12/16 04:02:23 DEBUG : file2.txt: size = 33 OK 2025/12/16 04:02:23 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/16 04:02:23 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/12/16 04:02:23 NOTICE: (53) : test bisync run with --resync-mode=newer 2025/12/16 04:02:23 NOTICE: (54) : bisync resync resync-mode=newer 2025/12/16 04:02:31 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:02:31 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/16 04:02:31 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/16 04:02:31 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/16 04:02:31 INFO : Synching Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" with Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:31 INFO : Copying Path2 files to Path1 2025/12/16 04:02:31 INFO : - Path2 Resync is copying files to - Path1 2025/12/16 04:02:31 INFO : file1.txt: Copied (server-side copy) 2025/12/16 04:02:32 INFO : file2.txt: Copied (server-side copy) 2025/12/16 04:02:32 INFO : - Path1 Resync is copying files to - Path2 2025/12/16 04:02:32 INFO : Resync updating listings 2025/12/16 04:02:32 INFO : Validating listings for Path1 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path1/" vs Path2 "TestB2:rclone-test-vococog9denu/035654xo/resync_modes/path2/" 2025/12/16 04:02:32 INFO : Bisync successful 2025/12/16 04:02:32 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:32 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1143e699d0ffa9b9_d20251216_m040033_c001_v0001185_t0025_u01765857633632") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10183f68c5c11bf9_d20251216_m040231_c001_v0001181_t0003_u01765857751846") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107d093648a15c30_d20251216_m040220_c001_v0001100_t0043_u01765857740145") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f104b903bf904d68b_d20251216_m040158_c001_v0001144_t0051_u01765857718121") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11236fd375ce7240_d20251216_m040140_c001_v0001185_t0037_u01765857700741") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11124da8764c39ee_d20251216_m040134_c001_v0001100_t0058_u01765857694866") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f104543ab4998b029_d20251216_m040125_c001_v0001185_t0001_u01765857685544") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f114da3353343d274_d20251216_m040119_c001_v0001109_t0017_u01765857679823") 2025/12/16 04:02:32 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f109dfcb6ecc3e3e4_d20251216_m040111_c001_v0001176_t0035_u01765857671126") 2025/12/16 04:02:33 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f114fc86d7e97cf4b_d20251216_m040105_c001_v0001092_t0046_u01765857665420") 2025/12/16 04:02:33 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f110573bee1c4bc7e_d20251216_m040056_c001_v0001165_t0006_u01765857656359") 2025/12/16 04:02:33 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1086cdbb9ac0505f_d20251216_m040041_c001_v0001185_t0006_u01765857641451") 2025/12/16 04:02:33 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10932efdd6ce83f3_d20251216_m040033_c001_v0001161_t0034_u01765857633277") 2025/12/16 04:02:33 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10329d8b40fa35d9_d20251216_m040232_c001_v0001185_t0001_u01765857752105") 2025/12/16 04:02:33 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f117c3f8e31e026e2_d20251216_m040217_c001_v0001038_t0055_u01765857737420") 2025/12/16 04:02:33 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f108015105399c8ad_d20251216_m040155_c001_v0001180_t0024_u01765857715606") 2025/12/16 04:02:33 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1118360db7000617_d20251216_m040033_c001_v0001136_t0022_u01765857633467") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4042dcf7acdb5dac_d20251216_m040227_c001_v7007000_t0000_u01765857747643") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11236fd375ce7c6f_d20251216_m040226_c001_v0001185_t0033_u01765857746302") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10932efdd6ce8513_d20251216_m040223_c001_v0001161_t0047_u01765857743905") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f420d67f029981f33_d20251216_m040206_c001_v7007000_t0000_u01765857726930") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f111bf918fee7cf15_d20251216_m040205_c001_v0001183_t0020_u01765857725729") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1143e699d0ffbaf7_d20251216_m040202_c001_v0001185_t0047_u01765857722895") 2025/12/16 04:02:33 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f416b4098413e35e4_d20251216_m040144_c001_v7007000_t0000_u01765857704984") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f109994f6037c1a05_d20251216_m040143_c001_v0001177_t0001_u01765857703766") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1118360db70006c5_d20251216_m040141_c001_v0001136_t0024_u01765857701407") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4065558d1c5fe41d_d20251216_m040130_c001_v7007000_t0000_u01765857690221") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10329d8b40fa2c3a_d20251216_m040128_c001_v0001185_t0043_u01765857688671") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10932efdd6ce849c_d20251216_m040126_c001_v0001161_t0050_u01765857686453") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f418db0b85c6d7252_d20251216_m040115_c001_v7007000_t0000_u01765857675397") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1047a14729c1de5a_d20251216_m040114_c001_v0001105_t0017_u01765857674013") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1143e699d0ffb26f_d20251216_m040111_c001_v0001185_t0009_u01765857671720") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f41508b4c2bd4d456_d20251216_m040100_c001_v7007000_t0000_u01765857660552") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f111b4dab93864a74_d20251216_m040059_c001_v0001150_t0015_u01765857659313") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1118360db7000657_d20251216_m040056_c001_v0001136_t0019_u01765857656984") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4065558d1c5fe3da_d20251216_m040045_c001_v7007000_t0000_u01765857645784") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f105989e033d831da_d20251216_m040044_c001_v0001185_t0045_u01765857644538") 2025/12/16 04:02:34 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10932efdd6ce8417_d20251216_m040042_c001_v0001161_t0022_u01765857642043") 2025/12/16 04:02:35 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/resync_modes/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:35 DEBUG : RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1197c68fb127de17_d20251216_m040034_c001_v0001185_t0030_u01765857634844") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f117cdd4295af8e42_d20251216_m040214_c001_v0001171_t0023_u01765857734907") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1086cdbb9ac062e4_d20251216_m040211_c001_v0001185_t0026_u01765857731814") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1016ddf9f285f929_d20251216_m040152_c001_v0001185_t0030_u01765857712641") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f108430a56b3691ef_d20251216_m040149_c001_v0001091_t0011_u01765857709613") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10830d5ca6b68151_d20251216_m040137_c001_v0001098_t0049_u01765857697879") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116ec0de97164d24_d20251216_m040122_c001_v0001181_t0021_u01765857682789") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebedfe8_d20251216_m040108_c001_v0001185_t0048_u01765857668150") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f100880108185157e_d20251216_m040053_c001_v0001032_t0056_u01765857653713") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11889c582eaecbd4_d20251216_m040050_c001_v0001109_t0052_u01765857650644") 2025/12/16 04:02:35 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f104543ab4998a4c3_d20251216_m040038_c001_v0001185_t0028_u01765857638388") 2025/12/16 04:02:36 DEBUG : file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f108655ad045b5b60_d20251216_m040035_c001_v0001040_t0053_u01765857635047") 2025/12/16 04:02:36 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11048f76b561dafe_d20251216_m040223_c001_v0001185_t0051_u01765857743079") 2025/12/16 04:02:36 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107e212e30a8a504_d20251216_m040212_c001_v0001184_t0027_u01765857732080") 2025/12/16 04:02:36 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f113d284fe0e1b0c9_d20251216_m040201_c001_v0001109_t0017_u01765857721465") 2025/12/16 04:02:36 DEBUG : file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502462e4a_d20251216_m040035_c001_v0001185_t0023_u01765857635210") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f416b4098413e360d_d20251216_m040231_c001_v7007000_t0000_u01765857751437") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10539cd2e3db2d81_d20251216_m040230_c001_v0001116_t0045_u01765857750005") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1197c68fb127fb33_d20251216_m040228_c001_v0001185_t0043_u01765857748206") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f403c7da09cae1503_d20251216_m040211_c001_v7007000_t0000_u01765857731206") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f107dd33a3ce74bff_d20251216_m040209_c001_v0001161_t0027_u01765857729650") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502463fbd_d20251216_m040207_c001_v0001185_t0006_u01765857727486") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4232905ecc6c89c9_d20251216_m040149_c001_v7007000_t0000_u01765857709014") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118518f4bebee70a_d20251216_m040147_c001_v0001185_t0008_u01765857707791") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f108655ad045b5bb2_d20251216_m040145_c001_v0001040_t0052_u01765857705528") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f410a5a2d11f0fef1_d20251216_m040134_c001_v7007000_t0000_u01765857694475") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11048f76b561d485_d20251216_m040133_c001_v0001185_t0041_u01765857693043") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1197c68fb127eebc_d20251216_m040130_c001_v0001185_t0028_u01765857690804") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4053c04b7d127d86_d20251216_m040119_c001_v7007000_t0000_u01765857679398") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f118e377d7bc9f946_d20251216_m040118_c001_v0001180_t0023_u01765857678197") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502463729_d20251216_m040115_c001_v0001185_t0051_u01765857675933") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4192b86a0ebda751_d20251216_m040105_c001_v7007000_t0000_u01765857665025") 2025/12/16 04:02:36 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1086cdbb9ac05582_d20251216_m040103_c001_v0001185_t0028_u01765857663671") 2025/12/16 04:02:37 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f108655ad045b5b7e_d20251216_m040101_c001_v0001040_t0049_u01765857661146") 2025/12/16 04:02:37 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f4177fc3baadf18fa_d20251216_m040050_c001_v7007000_t0000_u01765857650029") 2025/12/16 04:02:37 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006e9a92d5809ef_d20251216_m040048_c001_v0001106_t0014_u01765857648548") 2025/12/16 04:02:37 DEBUG : modtime_write_test: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1197c68fb127e199_d20251216_m040046_c001_v0001185_t0047_u01765857646325") bisync_test.go:608: TEST resync_modes PASSED === RUN TestBisyncRemoteRemote/rmdirs 2025/12/16 04:02:37 INFO : path1: Making directory 2025/12/16 04:02:37 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/rmdirs/path1" 2025/12/16 04:02:38 INFO : path2: Making directory 2025/12/16 04:02:38 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/rmdirs/path2" 2025/12/16 04:02:39 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial" 2025/12/16 04:02:39 DEBUG : Creating backend with remote "/tmp/035654xo/initdir/test_rmdirs-rosumon2" 2025/12/16 04:02:39 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : subdir: Making directory with metadata 2025/12/16 04:02:39 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/12/16 04:02:39 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/12/16 04:02:39 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt 2025/12/16 04:02:39 INFO : file1.copy1.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : Local file system at /tmp/035654xo/initdir/test_rmdirs-rosumon2: Waiting for checks to finish 2025/12/16 04:02:39 DEBUG : Local file system at /tmp/035654xo/initdir/test_rmdirs-rosumon2: Waiting for transfers to finish 2025/12/16 04:02:39 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/16 04:02:39 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/16 04:02:39 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/16 04:02:39 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:39 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt 2025/12/16 04:02:39 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt 2025/12/16 04:02:39 INFO : file1.copy5.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 INFO : file1.copy2.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt 2025/12/16 04:02:39 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 INFO : file1.copy4.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt 2025/12/16 04:02:39 INFO : file1.copy3.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/16 04:02:39 INFO : file1.txt: Copied (new) 2025/12/16 04:02:39 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2025/12/16 04:02:39 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:39 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2025/12/16 04:02:39 INFO : subdir/file20.txt: Copied (new) 2025/12/16 04:02:39 INFO : subdir: Set directory modification time (using SetModTime) 2025/12/16 04:02:39 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles" 2025/12/16 04:02:39 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_rmdirs-yegaqos2" 2025/12/16 04:02:39 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:39 DEBUG : Local file system at /tmp/035654xo/datadir/test_rmdirs-yegaqos2: Waiting for checks to finish 2025/12/16 04:02:39 DEBUG : Local file system at /tmp/035654xo/datadir/test_rmdirs-yegaqos2: Waiting for transfers to finish 2025/12/16 04:02:39 DEBUG : file1.txt.f41fd5ee.partial: size = 19 OK 2025/12/16 04:02:39 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:39 DEBUG : file1.txt.f41fd5ee.partial: renamed to: file1.txt 2025/12/16 04:02:39 INFO : file1.txt: Copied (new) 2025/12/16 04:02:39 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:40 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:41 NOTICE: checking initFs Local file system at /tmp/035654xo/initdir/test_rmdirs-rosumon2 2025/12/16 04:02:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 INFO : subdir: Making directory 2025/12/16 04:02:41 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:41 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path1: Waiting for checks to finish 2025/12/16 04:02:41 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path1: Waiting for transfers to finish 2025/12/16 04:02:42 DEBUG : file1.copy1.txt: size = 0 OK 2025/12/16 04:02:42 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:42 INFO : file1.copy1.txt: Copied (new) 2025/12/16 04:02:42 DEBUG : file1.copy2.txt: size = 0 OK 2025/12/16 04:02:42 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:42 INFO : file1.copy2.txt: Copied (new) 2025/12/16 04:02:43 DEBUG : file1.copy4.txt: size = 0 OK 2025/12/16 04:02:43 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:43 INFO : file1.copy4.txt: Copied (new) 2025/12/16 04:02:43 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:02:43 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:02:43 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:43 DEBUG : file1.copy5.txt: size = 0 OK 2025/12/16 04:02:43 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:43 INFO : file1.copy5.txt: Copied (new) 2025/12/16 04:02:43 DEBUG : file1.copy3.txt: size = 0 OK 2025/12/16 04:02:43 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:43 INFO : file1.copy3.txt: Copied (new) 2025/12/16 04:02:43 DEBUG : subdir/file20.txt: size = 0 OK 2025/12/16 04:02:43 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:43 INFO : subdir/file20.txt: Copied (new) 2025/12/16 04:02:43 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:02:43 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:43 INFO : file1.txt: Copied (new) 2025/12/16 04:02:43 NOTICE: checking Path1 B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path1 2025/12/16 04:02:44 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 INFO : subdir: Making directory 2025/12/16 04:02:44 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:44 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path2: Waiting for checks to finish 2025/12/16 04:02:44 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path2: Waiting for transfers to finish 2025/12/16 04:02:44 DEBUG : file1.copy1.txt: size = 0 OK 2025/12/16 04:02:44 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:44 INFO : file1.copy1.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : file1.copy2.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : file1.copy2.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : file1.copy4.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : file1.copy4.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : file1.copy3.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : file1.copy3.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : file1.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : subdir/file20.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : subdir/file20.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : file1.copy5.txt: size = 0 OK 2025/12/16 04:02:45 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:45 INFO : file1.copy5.txt: Copied (new) 2025/12/16 04:02:45 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:02:45 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:02:45 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:45 NOTICE: checking path2 B2 bucket rclone-test-vococog9denu path 035654xo/rmdirs/path2 2025/12/16 04:02:46 NOTICE: (01) : test rmdirs 2025/12/16 04:02:46 NOTICE: (02) : test initial bisync 2025/12/16 04:02:46 NOTICE: (03) : bisync resync bisync_test.go:1007: skipping test as remote does not support empty dirs === RUN TestBisyncRemoteRemote/volatile 2025/12/16 04:02:46 INFO : path1: Making directory 2025/12/16 04:02:46 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/volatile/path1" 2025/12/16 04:02:47 INFO : path2: Making directory 2025/12/16 04:02:47 DEBUG : Creating backend with remote "TestB2:rclone-test-vococog9denu/035654xo/volatile/path2" 2025/12/16 04:02:48 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial" 2025/12/16 04:02:48 DEBUG : Creating backend with remote "/tmp/035654xo/initdir/test_volatile-jiwugoq5" 2025/12/16 04:02:48 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : Local file system at /tmp/035654xo/initdir/test_volatile-jiwugoq5: Waiting for checks to finish 2025/12/16 04:02:48 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/16 04:02:48 INFO : file1.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : Local file system at /tmp/035654xo/initdir/test_volatile-jiwugoq5: Waiting for transfers to finish 2025/12/16 04:02:48 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/16 04:02:48 INFO : file2.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/16 04:02:48 INFO : file3.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/16 04:02:48 INFO : file4.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/16 04:02:48 INFO : file5.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/16 04:02:48 INFO : file7.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/16 04:02:48 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2025/12/16 04:02:48 INFO : file6.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2025/12/16 04:02:48 INFO : file8.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/16 04:02:48 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/16 04:02:48 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/16 04:02:48 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:48 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles" 2025/12/16 04:02:48 DEBUG : Creating backend with remote "/tmp/035654xo/datadir/test_volatile-xejiqof4" 2025/12/16 04:02:48 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file10.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file11.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:48 DEBUG : dummy.txt.b3782999.partial: size = 0 OK 2025/12/16 04:02:48 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/16 04:02:48 DEBUG : file1.txt.be52b1c9.partial: size = 19 OK 2025/12/16 04:02:48 DEBUG : dummy.txt.b3782999.partial: renamed to: dummy.txt 2025/12/16 04:02:48 DEBUG : Local file system at /tmp/035654xo/datadir/test_volatile-xejiqof4: Waiting for checks to finish 2025/12/16 04:02:48 DEBUG : Local file system at /tmp/035654xo/datadir/test_volatile-xejiqof4: Waiting for transfers to finish 2025/12/16 04:02:48 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:48 INFO : dummy.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file1.txt.be52b1c9.partial: renamed to: file1.txt 2025/12/16 04:02:48 INFO : file1.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file10.txt.bdde3bf8.partial: size = 19 OK 2025/12/16 04:02:48 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:48 DEBUG : file5L.txt.8dd6541a.partial: size = 39 OK 2025/12/16 04:02:48 DEBUG : file11.txt.d4a7309d.partial: size = 19 OK 2025/12/16 04:02:48 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2025/12/16 04:02:48 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:48 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt 2025/12/16 04:02:48 INFO : file5L.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file11.txt.d4a7309d.partial: renamed to: file11.txt 2025/12/16 04:02:48 INFO : file11.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file10.txt.bdde3bf8.partial: renamed to: file10.txt 2025/12/16 04:02:48 INFO : file10.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file2.txt.23ff1769.partial: size = 13 OK 2025/12/16 04:02:48 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2025/12/16 04:02:48 DEBUG : file6.txt.7b4c87b3.partial: size = 19 OK 2025/12/16 04:02:48 DEBUG : file2.txt.23ff1769.partial: renamed to: file2.txt 2025/12/16 04:02:48 INFO : file2.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:48 DEBUG : file7.txt.38c43fbf.partial: size = 19 OK 2025/12/16 04:02:48 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/16 04:02:48 DEBUG : file5R.txt.ee3b9525.partial: size = 39 OK 2025/12/16 04:02:48 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2025/12/16 04:02:48 DEBUG : file6.txt.7b4c87b3.partial: renamed to: file6.txt 2025/12/16 04:02:48 INFO : file6.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt 2025/12/16 04:02:48 INFO : file5R.txt: Copied (new) 2025/12/16 04:02:48 DEBUG : file7.txt.38c43fbf.partial: renamed to: file7.txt 2025/12/16 04:02:48 INFO : file7.txt: Copied (new) 2025/12/16 04:02:48 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path1: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:48 INFO : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path2: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:50 NOTICE: checking initFs Local file system at /tmp/035654xo/initdir/test_volatile-jiwugoq5 2025/12/16 04:02:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:50 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path1: Waiting for checks to finish 2025/12/16 04:02:50 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path1: Waiting for transfers to finish 2025/12/16 04:02:51 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file1.txt: Copied (new) 2025/12/16 04:02:51 DEBUG : file2.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file2.txt: Copied (new) 2025/12/16 04:02:51 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:02:51 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:02:51 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:51 DEBUG : file3.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file3.txt: Copied (new) 2025/12/16 04:02:51 DEBUG : file4.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file4.txt: Copied (new) 2025/12/16 04:02:51 DEBUG : file6.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file6.txt: Copied (new) 2025/12/16 04:02:51 DEBUG : file5.txt: size = 0 OK 2025/12/16 04:02:51 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:51 INFO : file5.txt: Copied (new) 2025/12/16 04:02:52 DEBUG : file8.txt: size = 0 OK 2025/12/16 04:02:52 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:52 INFO : file8.txt: Copied (new) 2025/12/16 04:02:52 DEBUG : file7.txt: size = 0 OK 2025/12/16 04:02:52 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:52 INFO : file7.txt: Copied (new) 2025/12/16 04:02:52 NOTICE: checking Path1 B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path1 2025/12/16 04:02:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/16 04:02:52 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path2: Waiting for checks to finish 2025/12/16 04:02:52 DEBUG : B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path2: Waiting for transfers to finish 2025/12/16 04:02:53 DEBUG : file2.txt: size = 0 OK 2025/12/16 04:02:53 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:53 INFO : file2.txt: Copied (new) 2025/12/16 04:02:53 DEBUG : file1.txt: size = 0 OK 2025/12/16 04:02:53 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:53 INFO : file1.txt: Copied (new) 2025/12/16 04:02:53 DEBUG : file4.txt: size = 0 OK 2025/12/16 04:02:53 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:53 INFO : file4.txt: Copied (new) 2025/12/16 04:02:53 DEBUG : file3.txt: size = 0 OK 2025/12/16 04:02:53 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:53 INFO : file3.txt: Copied (new) 2025/12/16 04:02:54 DEBUG : file6.txt: size = 0 OK 2025/12/16 04:02:54 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:54 INFO : file6.txt: Copied (new) 2025/12/16 04:02:54 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/16 04:02:54 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/16 04:02:54 INFO : RCLONE_TEST: Copied (new) 2025/12/16 04:02:54 DEBUG : file7.txt: size = 0 OK 2025/12/16 04:02:54 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:54 INFO : file7.txt: Copied (new) 2025/12/16 04:02:54 DEBUG : file8.txt: size = 0 OK 2025/12/16 04:02:54 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:54 INFO : file8.txt: Copied (new) 2025/12/16 04:02:54 DEBUG : file5.txt: size = 0 OK 2025/12/16 04:02:54 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/16 04:02:54 INFO : file5.txt: Copied (new) 2025/12/16 04:02:54 NOTICE: checking path2 B2 bucket rclone-test-vococog9denu path 035654xo/volatile/path2 2025/12/16 04:02:54 NOTICE: (01) : test volatile 2025/12/16 04:02:54 NOTICE: (02) : test initial bisync 2025/12/16 04:02:54 NOTICE: (03) : bisync resync bisync_test.go:978: skipping 'volatile' test on non-local as it requires uploading 100 files 2025/12/16 04:02:54 DEBUG : B2 bucket rclone-test-vococog9denu: Purge remote 2025/12/16 04:02:54 INFO : B2 bucket rclone-test-vococog9denu: cleaning bucket "rclone-test-vococog9denu" of all files 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116f1462362e7779_d20251216_m040242_c001_v0001172_t0051_u01765857762998") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.copy1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f101cb82fbb6edae5_d20251216_m040242_c001_v0001042_t0014_u01765857762459") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.copy2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c64149be78_d20251216_m040242_c001_v0001185_t0015_u01765857762605") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.copy3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f113d8aac129ec2cc_d20251216_m040242_c001_v0001098_t0011_u01765857762810") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.copy4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f101cb82fbb6edae7_d20251216_m040242_c001_v0001042_t0056_u01765857762877") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.copy5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c64149be94_d20251216_m040243_c001_v0001185_t0047_u01765857763089") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f101cb82fbb6edae9_d20251216_m040243_c001_v0001042_t0022_u01765857763284") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path1/subdir/file20.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116f1462362e777b_d20251216_m040243_c001_v0001172_t0043_u01765857763294") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11029f8017226bd8_d20251216_m040245_c001_v0001115_t0047_u01765857765238") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.copy1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11604053d4de6cf5_d20251216_m040244_c001_v0001177_t0040_u01765857764641") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.copy2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee726_d20251216_m040244_c001_v0001113_t0017_u01765857764866") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.copy3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106260bb5f80d07a_d20251216_m040245_c001_v0001113_t0054_u01765857765028") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.copy4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11604053d4de6cf9_d20251216_m040244_c001_v0001177_t0044_u01765857764913") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.copy5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1198655c23bee72a_d20251216_m040245_c001_v0001113_t0038_u01765857765327") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f11604053d4de6cfe_d20251216_m040245_c001_v0001177_t0037_u01765857765353") 2025/12/16 04:02:55 DEBUG : 035654xo/rmdirs/path2/subdir/file20.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106260bb5f80d07c_d20251216_m040245_c001_v0001113_t0052_u01765857765361") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f101f4a4149ed2196_d20251216_m040251_c001_v0001184_t0013_u01765857771536") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10076646be4a98b2_d20251216_m040250_c001_v0001029_t0040_u01765857770970") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c64149c079_d20251216_m040251_c001_v0001185_t0058_u01765857771121") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10054b596516e153_d20251216_m040251_c001_v0001043_t0047_u01765857771343") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10076646be4a98b4_d20251216_m040251_c001_v0001029_t0031_u01765857771330") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f106720c64149c08b_d20251216_m040251_c001_v0001185_t0048_u01765857771663") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f101f4a4149ed2198_d20251216_m040251_c001_v0001184_t0056_u01765857771733") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10054b596516e157_d20251216_m040251_c001_v0001043_t0026_u01765857771754") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path1/file8.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10076646be4a98b6_d20251216_m040251_c001_v0001029_t0029_u01765857771765") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/RCLONE_TEST: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1006330502464775_d20251216_m040253_c001_v0001185_t0059_u01765857773606") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file1.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10158a539c9e0d73_d20251216_m040253_c001_v0001115_t0058_u01765857773276") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file2.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116c3f77de6a2edf_d20251216_m040253_c001_v0001182_t0058_u01765857773466") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file3.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1107d887985e5ab3_d20251216_m040253_c001_v0001182_t0002_u01765857773830") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file4.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116c3f77de6a2ee1_d20251216_m040253_c001_v0001182_t0047_u01765857773683") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file5.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f10158a539c9e0d75_d20251216_m040253_c001_v0001115_t0008_u01765857773791") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file6.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116c3f77de6a2ee3_d20251216_m040253_c001_v0001182_t0016_u01765857773885") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file7.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f1107d887985e5ab5_d20251216_m040254_c001_v0001182_t0058_u01765857774046") 2025/12/16 04:02:56 DEBUG : 035654xo/volatile/path2/file8.txt: Deleting (id "4_z3fd2dd4340dd2b5b9fb80e1b_f116c3f77de6a2ee5_d20251216_m040254_c001_v0001182_t0039_u01765857774094") --- PASS: TestBisyncRemoteRemote (363.48s) --- PASS: TestBisyncRemoteRemote/resolve (132.47s) --- PASS: TestBisyncRemoteRemote/resync (81.23s) --- PASS: TestBisyncRemoteRemote/resync_modes (129.23s) --- SKIP: TestBisyncRemoteRemote/rmdirs (8.42s) --- SKIP: TestBisyncRemoteRemote/volatile (8.40s) PASS 2025/12/16 04:02:57 DEBUG : B2 bucket rclone-test-tehocaj2dafi: Purge remote 2025/12/16 04:02:57 INFO : B2 bucket rclone-test-tehocaj2dafi: cleaning bucket "rclone-test-tehocaj2dafi" of all files 2025/12/16 04:02:58 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resolve|resync|resync_modes|rmdirs|volatile)$'" - Finished OK in 6m4.928391399s (try 2/5)