"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^(max_delete_path2_force|resync)$|^TestBisyncRemoteLocal$/^check_access$|^TestBisyncRemoteRemote$/^(check_filename|resync_modes)$'" - Starting (try 2/5) === RUN TestBisyncRemoteLocal 2025/05/28 05:34:08 NOTICE: remote: TestB2:rclone-test-feqocut4dilo === RUN TestBisyncRemoteLocal/check_access 2025/05/28 05:34:12 ERROR : error listing: directory not found 2025/05/28 05:34:12 NOTICE: checking initFs Local file system at /tmp/053408fa/initdir/test_check_access-kimefun1 2025/05/28 05:34:13 NOTICE: checking Path1 B2 bucket rclone-test-feqocut4dilo path 053408fa/check_access/path1 2025/05/28 05:34:14 NOTICE: checking path2 Local file system at /tmp/053408fa/check_access/path2 2025/05/28 05:34:14 NOTICE: (01) : test check-access 2025/05/28 05:34:14 NOTICE: (02) : test initial bisync 2025/05/28 05:34:14 NOTICE: (03) : bisync resync 2025/05/28 05:34:15 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:15 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:15 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:15 INFO : Copying Path2 files to Path1 2025/05/28 05:34:15 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:34:15 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:34:15 INFO : Resync updating listings 2025/05/28 05:34:15 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:15 INFO : Bisync successful 2025/05/28 05:34:15 NOTICE: (04) : test 1. see that check-access passes with the initial setup 2025/05/28 05:34:15 NOTICE: (05) : bisync check-access 2025/05/28 05:34:17 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:17 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:17 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:17 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:17 INFO : Path1 checking for diffs 2025/05/28 05:34:17 INFO : Path2 checking for diffs 2025/05/28 05:34:17 INFO : Checking access health 2025/05/28 05:34:17 INFO : Found 2 matching "RCLONE_TEST" files on both paths 2025/05/28 05:34:17 INFO : No changes found 2025/05/28 05:34:17 INFO : Updating listings 2025/05/28 05:34:17 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:17 INFO : Bisync successful 2025/05/28 05:34:17 NOTICE: (06) : test 2. delete the path2 subdir RCLONE_TEST and run sync. should fail critical. 2025/05/28 05:34:17 NOTICE: (07) : delete-file /tmp/053408fa/check_access/path2/subdir/RCLONE_TEST 2025/05/28 05:34:17 NOTICE: (08) : bisync check-access 2025/05/28 05:34:18 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:18 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:18 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:18 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:18 INFO : Path1 checking for diffs 2025/05/28 05:34:18 INFO : Path2 checking for diffs 2025/05/28 05:34:18 INFO : - Path2 File was deleted - subdir/RCLONE_TEST 2025/05/28 05:34:18 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2025/05/28 05:34:18 INFO : Checking access health 2025/05/28 05:34:18 ERROR : Access test failed: Path1 count 2, Path2 count 1 - RCLONE_TEST 2025/05/28 05:34:18 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/RCLONE_TEST 2025/05/28 05:34:18 ERROR : Bisync critical error: check file check failed 2025/05/28 05:34:18 ERROR : Bisync aborted. Must run --resync to recover. 2025/05/28 05:34:18 NOTICE: Bisync error: bisync aborted 2025/05/28 05:34:18 NOTICE: (09) : copy-listings path2-missing 2025/05/28 05:34:18 NOTICE: (10) : test 3. put the path2 subdir RCLONE_TEST back, resync. 2025/05/28 05:34:18 NOTICE: (11) : copy-file TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/subdir/RCLONE_TEST /tmp/053408fa/check_access/path2/ 2025/05/28 05:34:19 NOTICE: (12) : bisync resync 2025/05/28 05:34:21 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:21 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:21 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:21 INFO : Copying Path2 files to Path1 2025/05/28 05:34:21 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:34:21 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:34:22 INFO : subdir/RCLONE_TEST: Copied (new) 2025/05/28 05:34:22 INFO : Resync updating listings 2025/05/28 05:34:22 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:22 INFO : Bisync successful 2025/05/28 05:34:22 NOTICE: (13) : test 4. run sync with check-access. should pass. 2025/05/28 05:34:22 NOTICE: (14) : bisync check-access 2025/05/28 05:34:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:23 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:23 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:23 INFO : Path1 checking for diffs 2025/05/28 05:34:23 INFO : Path2 checking for diffs 2025/05/28 05:34:23 INFO : Checking access health 2025/05/28 05:34:23 INFO : Found 2 matching "RCLONE_TEST" files on both paths 2025/05/28 05:34:23 INFO : No changes found 2025/05/28 05:34:23 INFO : Updating listings 2025/05/28 05:34:23 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:23 INFO : Bisync successful 2025/05/28 05:34:23 NOTICE: (15) : test 5. delete path1 top level RCLONE_TEST, run sync. should fail critical. 2025/05/28 05:34:23 NOTICE: (16) : delete-file TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/RCLONE_TEST 2025/05/28 05:34:25 NOTICE: (17) : bisync check-access 2025/05/28 05:34:26 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:26 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:26 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:26 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:26 INFO : Path1 checking for diffs 2025/05/28 05:34:26 INFO : - Path1 File was deleted - RCLONE_TEST 2025/05/28 05:34:26 INFO : Path1: 1 changes:  0 new,  0 modified,  1 deleted 2025/05/28 05:34:26 INFO : Path2 checking for diffs 2025/05/28 05:34:26 INFO : Checking access health 2025/05/28 05:34:26 ERROR : Access test failed: Path1 count 1, Path2 count 2 - RCLONE_TEST 2025/05/28 05:34:26 ERROR : -  Access test failed: Path2 file not found in Path1 - RCLONE_TEST 2025/05/28 05:34:26 ERROR : Bisync critical error: check file check failed 2025/05/28 05:34:26 ERROR : Bisync aborted. Must run --resync to recover. 2025/05/28 05:34:26 NOTICE: Bisync error: bisync aborted 2025/05/28 05:34:26 NOTICE: (18) : copy-listings path1-missing 2025/05/28 05:34:26 NOTICE: (19) : test 6. run again. should fail critical due to missing listings. 2025/05/28 05:34:26 NOTICE: (20) : bisync check-access 2025/05/28 05:34:28 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:28 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:28 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:28 ERROR : Bisync critical error: cannot find prior Path1 or Path2 listings, likely due to critical error on prior run Tip: here are the filenames we were looking for. Do they exist? Path1: /tmp/053408fa/workdir/TestB2_rclone-test-feqocut4dilo_053408fa_check_access_path1..tmp_053408fa_check_access_path2.path1.lst Path2: /tmp/053408fa/workdir/TestB2_rclone-test-feqocut4dilo_053408fa_check_access_path1..tmp_053408fa_check_access_path2.path2.lst Try running this command to inspect the work dir: rclone lsl "/tmp/053408fa/workdir" 2025/05/28 05:34:28 ERROR : Bisync aborted. Must run --resync to recover. 2025/05/28 05:34:28 NOTICE: Bisync error: bisync aborted 2025/05/28 05:34:28 NOTICE: (21) : move-listings missing-listings 2025/05/28 05:34:28 NOTICE: (22) : test 7. run resync, which will copy the path2 top level back to path1. 2025/05/28 05:34:28 NOTICE: (23) : bisync resync 2025/05/28 05:34:29 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:29 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:29 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:29 INFO : Copying Path2 files to Path1 2025/05/28 05:34:29 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:34:30 INFO : RCLONE_TEST: Copied (new) 2025/05/28 05:34:30 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:34:31 INFO : Resync updating listings 2025/05/28 05:34:31 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:31 INFO : Bisync successful 2025/05/28 05:34:31 NOTICE: (24) : test 8. run sync with --check-access. should pass. 2025/05/28 05:34:31 NOTICE: (25) : bisync check-access 2025/05/28 05:34:32 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:32 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:32 INFO : Synching Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" with Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:32 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:32 INFO : Path1 checking for diffs 2025/05/28 05:34:32 INFO : Path2 checking for diffs 2025/05/28 05:34:32 INFO : Checking access health 2025/05/28 05:34:32 INFO : Found 2 matching "RCLONE_TEST" files on both paths 2025/05/28 05:34:32 INFO : No changes found 2025/05/28 05:34:32 INFO : Updating listings 2025/05/28 05:34:32 INFO : Validating listings for Path1 "TestB2:rclone-test-feqocut4dilo/053408fa/check_access/path1/" vs Path2 "/tmp/053408fa/check_access/path2/" 2025/05/28 05:34:32 INFO : Bisync successful bisync_test.go:560: TEST check_access PASSED --- PASS: TestBisyncRemoteLocal (28.40s) --- PASS: TestBisyncRemoteLocal/check_access (26.64s) === RUN TestBisyncLocalRemote 2025/05/28 05:34:36 NOTICE: remote: TestB2:rclone-test-zedisoy6zibu === RUN TestBisyncLocalRemote/max_delete_path2_force 2025/05/28 05:34:40 ERROR : error listing: directory not found 2025/05/28 05:34:40 NOTICE: checking initFs Local file system at /tmp/053436ha/initdir/test_max_delete_path2_force-neqaved3 2025/05/28 05:34:40 NOTICE: checking Path1 Local file system at /tmp/053436ha/max_delete_path2_force/path1 2025/05/28 05:34:42 NOTICE: checking path2 B2 bucket rclone-test-zedisoy6zibu path 053436ha/max_delete_path2_force/path2 2025/05/28 05:34:43 NOTICE: (01) : test max-delete-path2-force 2025/05/28 05:34:43 NOTICE: (02) : test initial bisync 2025/05/28 05:34:43 NOTICE: (03) : bisync resync 2025/05/28 05:34:44 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:44 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:44 INFO : Synching Path1 "/tmp/053436ha/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/" 2025/05/28 05:34:44 INFO : Copying Path2 files to Path1 2025/05/28 05:34:44 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:34:44 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:34:44 INFO : Resync updating listings 2025/05/28 05:34:44 INFO : Validating listings for Path1 "/tmp/053436ha/max_delete_path2_force/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/" 2025/05/28 05:34:44 INFO : Bisync successful 2025/05/28 05:34:44 NOTICE: (04) : test delete >50% of remote files 2025/05/28 05:34:44 NOTICE: (05) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/file1.txt 2025/05/28 05:34:46 NOTICE: (06) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/file2.txt 2025/05/28 05:34:46 NOTICE: (07) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/file3.txt 2025/05/28 05:34:46 NOTICE: (08) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/file4.txt 2025/05/28 05:34:47 NOTICE: (09) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/file5.txt 2025/05/28 05:34:47 NOTICE: (10) : test sync should fail due to too many path2 deletes 2025/05/28 05:34:47 NOTICE: (11) : bisync 2025/05/28 05:34:48 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:48 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:48 INFO : Synching Path1 "/tmp/053436ha/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/" 2025/05/28 05:34:48 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:49 INFO : Path1 checking for diffs 2025/05/28 05:34:49 INFO : Path2 checking for diffs 2025/05/28 05:34:49 INFO : - Path2 File was deleted - file1.txt 2025/05/28 05:34:49 INFO : - Path2 File was deleted - file2.txt 2025/05/28 05:34:49 INFO : - Path2 File was deleted - file3.txt 2025/05/28 05:34:49 INFO : - Path2 File was deleted - file4.txt 2025/05/28 05:34:49 INFO : - Path2 File was deleted - file5.txt 2025/05/28 05:34:49 INFO : Path2: 5 changes:  0 new,  0 modified,  5 deleted 2025/05/28 05:34:49 ERROR : Safety abort: too many deletes (>50%, 5 of 9) on Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/". Run with --force if desired. 2025/05/28 05:34:49 NOTICE: Bisync aborted. Please try again. 2025/05/28 05:34:49 NOTICE: Bisync error: too many deletes 2025/05/28 05:34:49 NOTICE: (12) : copy-listings initial-fail 2025/05/28 05:34:49 NOTICE: (13) : test apply force option. sync should run. 2025/05/28 05:34:49 NOTICE: (14) : bisync force 2025/05/28 05:34:50 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:50 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:50 INFO : Synching Path1 "/tmp/053436ha/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/" 2025/05/28 05:34:50 INFO : Building Path1 and Path2 listings 2025/05/28 05:34:50 INFO : Path1 checking for diffs 2025/05/28 05:34:50 INFO : Path2 checking for diffs 2025/05/28 05:34:50 INFO : - Path2 File was deleted - file1.txt 2025/05/28 05:34:50 INFO : - Path2 File was deleted - file2.txt 2025/05/28 05:34:50 INFO : - Path2 File was deleted - file3.txt 2025/05/28 05:34:50 INFO : - Path2 File was deleted - file4.txt 2025/05/28 05:34:50 INFO : - Path2 File was deleted - file5.txt 2025/05/28 05:34:50 INFO : Path2: 5 changes:  0 new,  0 modified,  5 deleted 2025/05/28 05:34:50 INFO : Applying changes 2025/05/28 05:34:50 INFO : - Path1 Queue delete - /tmp/053436ha/max_delete_path2_force/path1/file1.txt 2025/05/28 05:34:50 INFO : - Path1 Queue delete - /tmp/053436ha/max_delete_path2_force/path1/file2.txt 2025/05/28 05:34:50 INFO : - Path1 Queue delete - /tmp/053436ha/max_delete_path2_force/path1/file3.txt 2025/05/28 05:34:50 INFO : - Path1 Queue delete - /tmp/053436ha/max_delete_path2_force/path1/file4.txt 2025/05/28 05:34:50 INFO : - Path1 Queue delete - /tmp/053436ha/max_delete_path2_force/path1/file5.txt 2025/05/28 05:34:50 INFO : - Path2 Do queued copies to - Path1 2025/05/28 05:34:51 INFO : file1.txt: Deleted 2025/05/28 05:34:51 INFO : file2.txt: Deleted 2025/05/28 05:34:51 INFO : file3.txt: Deleted 2025/05/28 05:34:51 INFO : file4.txt: Deleted 2025/05/28 05:34:51 INFO : file5.txt: Deleted 2025/05/28 05:34:51 INFO : Updating listings 2025/05/28 05:34:51 INFO : Validating listings for Path1 "/tmp/053436ha/max_delete_path2_force/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/max_delete_path2_force/path2/" 2025/05/28 05:34:51 INFO : Bisync successful bisync_test.go:560: TEST max_delete_path2_force PASSED === RUN TestBisyncLocalRemote/resync 2025/05/28 05:34:54 ERROR : error listing: directory not found 2025/05/28 05:34:54 NOTICE: checking initFs Local file system at /tmp/053436ha/initdir/test_resync-demecof6 2025/05/28 05:34:54 NOTICE: checking Path1 Local file system at /tmp/053436ha/resync/path1 2025/05/28 05:34:56 NOTICE: checking path2 B2 bucket rclone-test-zedisoy6zibu path 053436ha/resync/path2 2025/05/28 05:34:56 NOTICE: (01) : test resync 2025/05/28 05:34:56 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/05/28 05:34:56 NOTICE: (03) : purge-children /tmp/053436ha/resync/path1/ 2025/05/28 05:34:56 NOTICE: (04) : bisync resync 2025/05/28 05:34:57 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:34:57 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:34:57 INFO : Synching Path1 "/tmp/053436ha/resync/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:34:57 INFO : Copying Path2 files to Path1 2025/05/28 05:34:57 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:34:58 INFO : RCLONE_TEST: Copied (new) 2025/05/28 05:34:58 INFO : file1.txt: Copied (new) 2025/05/28 05:34:58 INFO : file2.txt: Copied (new) 2025/05/28 05:34:58 INFO : file5.txt: Copied (new) 2025/05/28 05:34:58 INFO : file4.txt: Copied (new) 2025/05/28 05:34:58 INFO : file3.txt: Copied (new) 2025/05/28 05:34:58 INFO : file6.txt: Copied (new) 2025/05/28 05:34:58 INFO : file7.txt: Copied (new) 2025/05/28 05:34:58 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:34:59 INFO : Resync updating listings 2025/05/28 05:34:59 INFO : Validating listings for Path1 "/tmp/053436ha/resync/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:34:59 INFO : Bisync successful 2025/05/28 05:34:59 NOTICE: (05) : move-listings empty-path1 2025/05/28 05:34:59 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/05/28 05:34:59 NOTICE: (07) : purge-children TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ 2025/05/28 05:35:00 NOTICE: (08) : bisync resync 2025/05/28 05:35:01 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:01 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:35:01 INFO : Synching Path1 "/tmp/053436ha/resync/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:01 INFO : Copying Path2 files to Path1 2025/05/28 05:35:01 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:35:01 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:35:02 INFO : file3.txt: Copied (new) 2025/05/28 05:35:02 INFO : file2.txt: Copied (new) 2025/05/28 05:35:02 INFO : file1.txt: Copied (new) 2025/05/28 05:35:02 INFO : file5.txt: Copied (new) 2025/05/28 05:35:03 INFO : file4.txt: Copied (new) 2025/05/28 05:35:03 INFO : RCLONE_TEST: Copied (new) 2025/05/28 05:35:03 INFO : file7.txt: Copied (new) 2025/05/28 05:35:03 INFO : file6.txt: Copied (new) 2025/05/28 05:35:03 INFO : Resync updating listings 2025/05/28 05:35:03 INFO : Validating listings for Path1 "/tmp/053436ha/resync/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:03 INFO : Bisync successful 2025/05/28 05:35:03 NOTICE: (09) : move-listings empty-path2 2025/05/28 05:35:03 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/05/28 05:35:03 NOTICE: (11) : touch-glob 2002-02-02 /tmp/053436ha/datadir/test_resync-bimobun8/ fileA.txt 2025/05/28 05:35:03 NOTICE: (12) : touch-glob 1999-09-09 /tmp/053436ha/datadir/test_resync-bimobun8/ fileB.txt 2025/05/28 05:35:03 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/05/28 05:35:03 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/05/28 05:35:03 NOTICE: (15) : delete-file TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/file1.txt 2025/05/28 05:35:05 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/05/28 05:35:05 NOTICE: (17) : delete-file /tmp/053436ha/resync/path1/file2.txt 2025/05/28 05:35:05 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/05/28 05:35:05 NOTICE: (19) : copy-as /tmp/053436ha/datadir/test_resync-bimobun8/fileA.txt TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ file3.txt 2025/05/28 05:35:09 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/05/28 05:35:09 NOTICE: (21) : delete-file /tmp/053436ha/resync/path1/file4.txt 2025/05/28 05:35:09 NOTICE: (22) : copy-as /tmp/053436ha/datadir/test_resync-bimobun8/fileA.txt TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ file4.txt 2025/05/28 05:35:12 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/05/28 05:35:12 NOTICE: (24) : copy-as /tmp/053436ha/datadir/test_resync-bimobun8/fileB.txt TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ file5.txt 2025/05/28 05:35:15 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/05/28 05:35:15 NOTICE: (26) : copy-as /tmp/053436ha/datadir/test_resync-bimobun8/fileB.txt /tmp/053436ha/resync/path1/ file6.txt 2025/05/28 05:35:15 NOTICE: (27) : copy-as /tmp/053436ha/datadir/test_resync-bimobun8/fileA.txt TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ file6.txt 2025/05/28 05:35:19 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/05/28 05:35:19 NOTICE: (29) : test run bisync with resync 2025/05/28 05:35:19 NOTICE: (30) : bisync resync 2025/05/28 05:35:21 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:21 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:35:21 INFO : Synching Path1 "/tmp/053436ha/resync/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:21 INFO : Copying Path2 files to Path1 2025/05/28 05:35:21 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:35:22 INFO : file2.txt: Copied (new) 2025/05/28 05:35:22 INFO : file4.txt: Copied (new) 2025/05/28 05:35:22 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:35:22 INFO : file6.txt: Updated modification time in destination 2025/05/28 05:35:22 INFO : file3.txt: Copied (replaced existing) 2025/05/28 05:35:23 INFO : file5.txt: Copied (replaced existing) 2025/05/28 05:35:23 INFO : file1.txt: Copied (new) 2025/05/28 05:35:23 INFO : Resync updating listings 2025/05/28 05:35:23 INFO : Validating listings for Path1 "/tmp/053436ha/resync/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:23 INFO : Bisync successful 2025/05/28 05:35:23 NOTICE: (31) : copy-listings mixed-diffs 2025/05/28 05:35:23 NOTICE: (32) : test run normal bisync 2025/05/28 05:35:23 NOTICE: (33) : bisync 2025/05/28 05:35:26 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:26 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:35:26 INFO : Synching Path1 "/tmp/053436ha/resync/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:26 INFO : Building Path1 and Path2 listings 2025/05/28 05:35:26 INFO : Path1 checking for diffs 2025/05/28 05:35:26 INFO : Path2 checking for diffs 2025/05/28 05:35:26 INFO : No changes found 2025/05/28 05:35:26 INFO : Updating listings 2025/05/28 05:35:26 INFO : Validating listings for Path1 "/tmp/053436ha/resync/path1/" vs Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:26 INFO : Bisync successful 2025/05/28 05:35:26 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/05/28 05:35:26 NOTICE: (35) : purge-children TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/ 2025/05/28 05:35:27 NOTICE: (36) : bisync 2025/05/28 05:35:30 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:30 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/05/28 05:35:30 INFO : Synching Path1 "/tmp/053436ha/resync/path1/" with Path2 "TestB2:rclone-test-zedisoy6zibu/053436ha/resync/path2/" 2025/05/28 05:35:30 INFO : Building Path1 and Path2 listings 2025/05/28 05:35:30 INFO : Path1 checking for diffs 2025/05/28 05:35:30 INFO : Path2 checking for diffs 2025/05/28 05:35:30 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/053436ha/workdir/tmp_053436ha_resync_path1..TestB2_rclone-test-zedisoy6zibu_053436ha_resync_path2.path2.lst-new 2025/05/28 05:35:30 ERROR : Bisync critical error: empty current Path2 listing: /tmp/053436ha/workdir/tmp_053436ha_resync_path1..TestB2_rclone-test-zedisoy6zibu_053436ha_resync_path2.path2.lst-new 2025/05/28 05:35:30 ERROR : Bisync aborted. Must run --resync to recover. 2025/05/28 05:35:30 NOTICE: Bisync error: bisync aborted bisync_test.go:560: TEST resync PASSED --- PASS: TestBisyncLocalRemote (58.91s) --- PASS: TestBisyncLocalRemote/max_delete_path2_force (16.03s) --- PASS: TestBisyncLocalRemote/resync (41.00s) === RUN TestBisyncRemoteRemote 2025/05/28 05:35:35 NOTICE: remote: TestB2:rclone-test-qeniqoy2buba === RUN TestBisyncRemoteRemote/check_filename 2025/05/28 05:35:41 NOTICE: checking initFs Local file system at /tmp/053535hu/initdir/test_check_filename-qaxuseq1 2025/05/28 05:35:43 NOTICE: checking Path1 B2 bucket rclone-test-qeniqoy2buba path 053535hu/check_filename/path1 2025/05/28 05:35:45 NOTICE: checking path2 B2 bucket rclone-test-qeniqoy2buba path 053535hu/check_filename/path2 2025/05/28 05:35:45 NOTICE: (01) : test check-filename 2025/05/28 05:35:45 NOTICE: (02) : test initial bisync 2025/05/28 05:35:45 NOTICE: (03) : bisync resync 2025/05/28 05:35:48 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:48 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:35:48 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:35:48 INFO : Copying Path2 files to Path1 2025/05/28 05:35:48 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:35:48 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:35:49 INFO : Resync updating listings 2025/05/28 05:35:49 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:35:49 INFO : Bisync successful 2025/05/28 05:35:49 NOTICE: (04) : test 1. see that check-access passes with the initial setup 2025/05/28 05:35:49 NOTICE: (05) : bisync check-access check-filename=.chk_file 2025/05/28 05:35:52 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:52 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:35:52 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:35:52 INFO : Building Path1 and Path2 listings 2025/05/28 05:35:52 INFO : Path1 checking for diffs 2025/05/28 05:35:52 INFO : Path2 checking for diffs 2025/05/28 05:35:52 INFO : Checking access health 2025/05/28 05:35:52 INFO : Found 2 matching ".chk_file" files on both paths 2025/05/28 05:35:52 INFO : No changes found 2025/05/28 05:35:52 INFO : Updating listings 2025/05/28 05:35:52 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:35:52 INFO : Bisync successful 2025/05/28 05:35:52 NOTICE: (06) : copy-listings initial-pass 2025/05/28 05:35:52 NOTICE: (07) : test 2. delete the remote subdir .chk_file, run sync. should fail critical. 2025/05/28 05:35:52 NOTICE: (08) : delete-file TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/subdir/.chk_file 2025/05/28 05:35:54 NOTICE: (09) : bisync check-access check-filename=.chk_file 2025/05/28 05:35:59 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:35:59 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:35:59 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:35:59 INFO : Building Path1 and Path2 listings 2025/05/28 05:35:59 INFO : Path1 checking for diffs 2025/05/28 05:35:59 INFO : Path2 checking for diffs 2025/05/28 05:35:59 INFO : - Path2 File was deleted - subdir/.chk_file 2025/05/28 05:35:59 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2025/05/28 05:35:59 INFO : Checking access health 2025/05/28 05:35:59 ERROR : Access test failed: Path1 count 2, Path2 count 1 - .chk_file 2025/05/28 05:35:59 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/.chk_file 2025/05/28 05:35:59 ERROR : Bisync critical error: check file check failed 2025/05/28 05:35:59 ERROR : Bisync aborted. Must run --resync to recover. 2025/05/28 05:35:59 NOTICE: Bisync error: bisync aborted 2025/05/28 05:35:59 NOTICE: (10) : move-listings path2-missing 2025/05/28 05:35:59 NOTICE: (11) : test 3. put the remote subdir .chk_file back, run resync. 2025/05/28 05:35:59 NOTICE: (12) : copy-file TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/subdir/.chk_file TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/subdir/ 2025/05/28 05:36:03 NOTICE: (13) : bisync check-access resync check-filename=.chk_file 2025/05/28 05:36:08 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:36:08 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:36:08 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:36:08 INFO : Copying Path2 files to Path1 2025/05/28 05:36:08 INFO : Checking access health 2025/05/28 05:36:08 INFO : Found 2 matching ".chk_file" files on both paths 2025/05/28 05:36:08 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:36:08 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:36:09 INFO : Resync updating listings 2025/05/28 05:36:09 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:36:09 INFO : Bisync successful 2025/05/28 05:36:09 NOTICE: (14) : test 4. run sync with check-access. should pass. 2025/05/28 05:36:09 NOTICE: (15) : bisync check-access check-filename=.chk_file 2025/05/28 05:36:12 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:36: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/05/28 05:36:12 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:36:12 INFO : Building Path1 and Path2 listings 2025/05/28 05:36:12 INFO : Path1 checking for diffs 2025/05/28 05:36:12 INFO : Path2 checking for diffs 2025/05/28 05:36:12 INFO : Checking access health 2025/05/28 05:36:12 INFO : Found 2 matching ".chk_file" files on both paths 2025/05/28 05:36:12 INFO : No changes found 2025/05/28 05:36:12 INFO : Updating listings 2025/05/28 05:36:12 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/check_filename/path2/" 2025/05/28 05:36:12 INFO : Bisync successful bisync_test.go:560: TEST check_filename PASSED === RUN TestBisyncRemoteRemote/resync_modes 2025/05/28 05:36:19 NOTICE: checking initFs Local file system at /tmp/053535hu/initdir/test_resync_modes-jilinuw6 2025/05/28 05:36:21 NOTICE: checking Path1 B2 bucket rclone-test-qeniqoy2buba path 053535hu/resync_modes/path1 2025/05/28 05:36:22 NOTICE: checking path2 B2 bucket rclone-test-qeniqoy2buba path 053535hu/resync_modes/path2 2025/05/28 05:36:23 NOTICE: (01) : test resync-mode 2025/05/28 05:36:23 NOTICE: (02) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:36:23 NOTICE: (03) : touch-glob 2001-01-02 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:36:23 NOTICE: (04) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:36:26 NOTICE: (05) : touch-glob 2001-03-04 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:36:26 NOTICE: (06) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:36:29 NOTICE: (07) : test bisync run with --resync-mode=newer 2025/05/28 05:36:29 NOTICE: (08) : bisync resync resync-mode=newer 2025/05/28 05:36:33 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:36:33 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:36:33 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:33 INFO : Copying Path2 files to Path1 2025/05/28 05:36:33 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:36:33 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:36:34 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:36:34 INFO : Resync updating listings 2025/05/28 05:36:34 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:34 INFO : Bisync successful 2025/05/28 05:36:34 NOTICE: (09) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:36:34 NOTICE: (10) : touch-glob 2001-07-23 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:36:34 NOTICE: (11) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:36:39 NOTICE: (12) : touch-glob 2001-08-26 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:36:39 NOTICE: (13) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:36:42 NOTICE: (14) : test bisync run with --resync-mode=path2 2025/05/28 05:36:42 NOTICE: (15) : bisync resync resync-mode=path2 2025/05/28 05:36:47 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:36:47 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:36:47 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:47 INFO : Copying Path2 files to Path1 2025/05/28 05:36:47 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:36:47 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:36:47 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:36:47 INFO : Resync updating listings 2025/05/28 05:36:47 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:47 INFO : Bisync successful 2025/05/28 05:36:47 NOTICE: (16) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:36:47 NOTICE: (17) : touch-glob 2002-07-23 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:36:47 NOTICE: (18) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:36:50 NOTICE: (19) : touch-glob 2002-08-26 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:36:50 NOTICE: (20) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:36:53 NOTICE: (21) : test bisync run with --resync-mode=larger 2025/05/28 05:36:53 NOTICE: (22) : bisync resync resync-mode=larger 2025/05/28 05:36:58 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:36: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/05/28 05:36:58 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:58 INFO : Copying Path2 files to Path1 2025/05/28 05:36:58 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:36:58 INFO : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9 2025/05/28 05:36:58 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:36:58 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:36:58 INFO : Resync updating listings 2025/05/28 05:36:58 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:36:58 INFO : Bisync successful 2025/05/28 05:36:58 NOTICE: (23) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:36:58 NOTICE: (24) : touch-glob 2003-07-23 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:36:58 NOTICE: (25) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:37:01 NOTICE: (26) : touch-glob 2003-09-04 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:37:01 NOTICE: (27) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:37:04 NOTICE: (28) : test bisync run with --resync-mode=older 2025/05/28 05:37:04 NOTICE: (29) : bisync resync resync-mode=older 2025/05/28 05:37:09 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:37:09 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:37:09 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:09 INFO : Copying Path2 files to Path1 2025/05/28 05:37:09 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:37:09 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/05/28 05:37:09 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:37:09 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:37:09 INFO : Resync updating listings 2025/05/28 05:37:09 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:09 INFO : Bisync successful 2025/05/28 05:37:09 NOTICE: (30) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:37:09 NOTICE: (31) : touch-glob 2004-07-23 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:37:09 NOTICE: (32) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:37:12 NOTICE: (33) : touch-glob 2004-07-23 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:37:12 NOTICE: (34) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:37:14 NOTICE: (35) : test bisync run with --resync-mode=smaller 2025/05/28 05:37:14 NOTICE: (36) : bisync resync resync-mode=smaller 2025/05/28 05:37:19 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:37: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/05/28 05:37:19 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:19 INFO : Copying Path2 files to Path1 2025/05/28 05:37:19 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:37:19 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/05/28 05:37:19 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:37:19 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/05/28 05:37:20 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:37:20 INFO : Resync updating listings 2025/05/28 05:37:20 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:20 INFO : Bisync successful 2025/05/28 05:37:20 NOTICE: (37) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/05/28 05:37:20 NOTICE: (38) : touch-glob 2005-01-02 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:37:20 NOTICE: (39) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:37:23 NOTICE: (40) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file2.txt 2025/05/28 05:37:26 NOTICE: (41) : touch-glob 2006-03-04 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:37:26 NOTICE: (42) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:37:28 NOTICE: (43) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file2.txt 2025/05/28 05:37:31 NOTICE: (44) : test bisync run with --resync-mode=path1 2025/05/28 05:37:31 NOTICE: (45) : bisync resync resync-mode=path1 2025/05/28 05:37:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:37: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/05/28 05:37:35 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:35 INFO : Copying Path2 files to Path1 2025/05/28 05:37:35 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:37:35 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:37:36 INFO : file2.txt: Copied (server-side copy) 2025/05/28 05:37:38 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:37:38 INFO : Resync updating listings 2025/05/28 05:37:38 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:38 INFO : Bisync successful 2025/05/28 05:37:38 NOTICE: (46) : test no winner 2025/05/28 05:37:38 NOTICE: (47) : touch-glob 2022-02-22 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1R.txt 2025/05/28 05:37:38 NOTICE: (48) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file1.txt 2025/05/28 05:37:41 NOTICE: (49) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1R.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file2.txt 2025/05/28 05:37:43 NOTICE: (50) : touch-glob 2022-02-22 /tmp/053535hu/datadir/test_resync_modes-ceqicop7/ file1L.txt 2025/05/28 05:37:43 NOTICE: (51) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/ file1.txt 2025/05/28 05:37:46 NOTICE: (52) : copy-as /tmp/053535hu/datadir/test_resync_modes-ceqicop7/file1L.txt TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/ file2.txt 2025/05/28 05:37:49 NOTICE: (53) : test bisync run with --resync-mode=newer 2025/05/28 05:37:49 NOTICE: (54) : bisync resync resync-mode=newer 2025/05/28 05:37:53 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/05/28 05:37:53 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/05/28 05:37:53 INFO : Synching Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" with Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:53 INFO : Copying Path2 files to Path1 2025/05/28 05:37:53 INFO : - Path2 Resync is copying files to - Path1 2025/05/28 05:37:53 INFO : file1.txt: Copied (server-side copy) 2025/05/28 05:37:54 INFO : file2.txt: Copied (server-side copy) 2025/05/28 05:37:54 INFO : - Path1 Resync is copying files to - Path2 2025/05/28 05:37:54 INFO : Resync updating listings 2025/05/28 05:37:54 INFO : Validating listings for Path1 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path1/" vs Path2 "TestB2:rclone-test-qeniqoy2buba/053535hu/resync_modes/path2/" 2025/05/28 05:37:54 INFO : Bisync successful bisync_test.go:560: TEST resync_modes PASSED --- PASS: TestBisyncRemoteRemote (145.41s) --- PASS: TestBisyncRemoteRemote/check_filename (40.22s) --- PASS: TestBisyncRemoteRemote/resync_modes (103.28s) PASS 2025/05/28 05:38:01 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^(max_delete_path2_force|resync)$|^TestBisyncRemoteLocal$/^check_access$|^TestBisyncRemoteRemote$/^(check_filename|resync_modes)$'" - Finished OK in 3m54.0812154s (try 2/5)