"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteLocal$/^check_sync$|^TestBisyncRemoteRemote$/^(max_delete_path2_force|resync)$'" - Starting (try 2/5) === RUN TestBisyncRemoteLocal 2025/06/15 02:36:56 NOTICE: remote: TestB2:rclone-test-kehihuj0bovo === RUN TestBisyncRemoteLocal/check_sync 2025/06/15 02:37:01 ERROR : error listing: directory not found 2025/06/15 02:37:01 NOTICE: checking initFs Local file system at /tmp/023656mo/initdir/test_check_sync-bakaced8 2025/06/15 02:37:02 NOTICE: checking Path1 B2 bucket rclone-test-kehihuj0bovo path 023656mo/check_sync/path1 2025/06/15 02:37:03 NOTICE: checking path2 Local file system at /tmp/023656mo/check_sync/path2 2025/06/15 02:37:03 NOTICE: (01) : test check-sync 2025/06/15 02:37:03 NOTICE: (02) : test initial bisync 2025/06/15 02:37:03 NOTICE: (03) : bisync resync 2025/06/15 02:37:04 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:04 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:04 INFO : Synching Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" with Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:04 INFO : Copying Path2 files to Path1 2025/06/15 02:37:04 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:37:04 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:37:04 INFO : Resync updating listings 2025/06/15 02:37:04 INFO : Validating listings for Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" vs Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:04 INFO : Bisync successful 2025/06/15 02:37:04 NOTICE: (04) : test 1. run check-sync-only on a clean sync 2025/06/15 02:37:04 NOTICE: (05) : bisync check-sync-only 2025/06/15 02:37:05 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:05 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:05 INFO : Validating listings for Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" vs Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:05 INFO : Bisync successful 2025/06/15 02:37:05 NOTICE: (06) : test 2. inject modified listings into the workdir 2025/06/15 02:37:05 NOTICE: (07) : copy-as /tmp/023656mo/datadir/test_check_sync-nahabeq2/_testdir_path1.._testdir_path2.path1.lst /tmp/023656mo/workdir/ TestB2_rclone-test-kehihuj0bovo_023656mo_check_sync_path1..tmp_023656mo_check_sync_path2.path1.lst 2025/06/15 02:37:05 NOTICE: (08) : copy-as /tmp/023656mo/datadir/test_check_sync-nahabeq2/_testdir_path1.._testdir_path2.path2.lst /tmp/023656mo/workdir/ TestB2_rclone-test-kehihuj0bovo_023656mo_check_sync_path1..tmp_023656mo_check_sync_path2.path2.lst 2025/06/15 02:37:05 NOTICE: (09) : test 3. run check-sync-only on modified listings 2025/06/15 02:37:05 NOTICE: (10) : bisync check-sync-only 2025/06/15 02:37:06 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:06 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:06 INFO : Validating listings for Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" vs Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:06 ERROR : -  Path1 file not found in Path2 - file2.txt 2025/06/15 02:37:06 ERROR : -  Path2 file not found in Path1 - file1.txt 2025/06/15 02:37:06 ERROR : Bisync critical error: path1 and path2 are out of sync, run --resync to recover 2025/06/15 02:37:06 ERROR : Bisync aborted. Must run --resync to recover. 2025/06/15 02:37:06 NOTICE: Bisync error: bisync aborted 2025/06/15 02:37:06 NOTICE: (11) : copy-listings check-sync-only 2025/06/15 02:37:06 NOTICE: (12) : test 4. run normal sync to check that it aborts 2025/06/15 02:37:06 NOTICE: (13) : bisync 2025/06/15 02:37:08 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:08 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:08 INFO : Synching Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" with Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:08 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/023656mo/workdir/TestB2_rclone-test-kehihuj0bovo_023656mo_check_sync_path1..tmp_023656mo_check_sync_path2.path1.lst Path2: /tmp/023656mo/workdir/TestB2_rclone-test-kehihuj0bovo_023656mo_check_sync_path1..tmp_023656mo_check_sync_path2.path2.lst Try running this command to inspect the work dir: rclone lsl "/tmp/023656mo/workdir" 2025/06/15 02:37:08 ERROR : Bisync aborted. Must run --resync to recover. 2025/06/15 02:37:08 NOTICE: Bisync error: bisync aborted 2025/06/15 02:37:08 NOTICE: (14) : test 5. prune failure listings after critical abort 2025/06/15 02:37:08 NOTICE: (15) : delete-glob /tmp/023656mo/workdir/ *.lst 2025/06/15 02:37:08 NOTICE: (16) : delete-glob /tmp/023656mo/workdir/ *.lst-err 2025/06/15 02:37:08 NOTICE: (17) : delete-glob /tmp/023656mo/workdir/ *.lst-new 2025/06/15 02:37:08 NOTICE: (18) : test 6. run resync 2025/06/15 02:37:08 NOTICE: (19) : bisync resync 2025/06/15 02:37:08 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:08 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:08 INFO : Synching Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" with Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:08 INFO : Copying Path2 files to Path1 2025/06/15 02:37:08 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:37:09 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:37:09 INFO : Resync updating listings 2025/06/15 02:37:09 INFO : Validating listings for Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" vs Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:09 INFO : Bisync successful 2025/06/15 02:37:09 NOTICE: (20) : test 7. run normal sync with check-sync enabled (default) 2025/06/15 02:37:09 NOTICE: (21) : bisync 2025/06/15 02:37:10 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:10 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:10 INFO : Synching Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" with Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:10 INFO : Building Path1 and Path2 listings 2025/06/15 02:37:10 INFO : Path1 checking for diffs 2025/06/15 02:37:10 INFO : Path2 checking for diffs 2025/06/15 02:37:10 INFO : No changes found 2025/06/15 02:37:10 INFO : Updating listings 2025/06/15 02:37:10 INFO : Validating listings for Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" vs Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:10 INFO : Bisync successful 2025/06/15 02:37:10 NOTICE: (22) : test 8. run normal sync with no-check-sync 2025/06/15 02:37:10 NOTICE: (23) : bisync no-check-sync 2025/06/15 02:37:11 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/06/15 02:37:11 INFO : Synching Path1 "TestB2:rclone-test-kehihuj0bovo/023656mo/check_sync/path1/" with Path2 "/tmp/023656mo/check_sync/path2/" 2025/06/15 02:37:11 INFO : Building Path1 and Path2 listings 2025/06/15 02:37:11 INFO : Path1 checking for diffs 2025/06/15 02:37:11 INFO : Path2 checking for diffs 2025/06/15 02:37:11 INFO : No changes found 2025/06/15 02:37:11 INFO : Updating listings 2025/06/15 02:37:11 INFO : Bisync successful bisync_test.go:560: TEST check_sync PASSED --- PASS: TestBisyncRemoteLocal (18.85s) --- PASS: TestBisyncRemoteLocal/check_sync (17.14s) === RUN TestBisyncRemoteRemote 2025/06/15 02:37:15 NOTICE: remote: TestB2:rclone-test-govepiv0jolu === RUN TestBisyncRemoteRemote/max_delete_path2_force 2025/06/15 02:37:21 NOTICE: checking initFs Local file system at /tmp/023715wo/initdir/test_max_delete_path2_force-minasaf4 2025/06/15 02:37:23 NOTICE: checking Path1 B2 bucket rclone-test-govepiv0jolu path 023715wo/max_delete_path2_force/path1 2025/06/15 02:37:25 NOTICE: checking path2 B2 bucket rclone-test-govepiv0jolu path 023715wo/max_delete_path2_force/path2 2025/06/15 02:37:25 NOTICE: (01) : test max-delete-path2-force 2025/06/15 02:37:25 NOTICE: (02) : test initial bisync 2025/06/15 02:37:25 NOTICE: (03) : bisync resync 2025/06/15 02:37:28 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:28 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:37:28 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/" 2025/06/15 02:37:28 INFO : Copying Path2 files to Path1 2025/06/15 02:37:28 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:37:28 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:37:28 INFO : Resync updating listings 2025/06/15 02:37:28 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/" 2025/06/15 02:37:28 INFO : Bisync successful 2025/06/15 02:37:28 NOTICE: (04) : test delete >50% of remote files 2025/06/15 02:37:28 NOTICE: (05) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/file1.txt 2025/06/15 02:37:30 NOTICE: (06) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/file2.txt 2025/06/15 02:37:30 NOTICE: (07) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/file3.txt 2025/06/15 02:37:30 NOTICE: (08) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/file4.txt 2025/06/15 02:37:31 NOTICE: (09) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/file5.txt 2025/06/15 02:37:31 NOTICE: (10) : test sync should fail due to too many path2 deletes 2025/06/15 02:37:31 NOTICE: (11) : bisync 2025/06/15 02:37:34 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37: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/06/15 02:37:34 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/" 2025/06/15 02:37:34 INFO : Building Path1 and Path2 listings 2025/06/15 02:37:34 INFO : Path1 checking for diffs 2025/06/15 02:37:34 INFO : Path2 checking for diffs 2025/06/15 02:37:34 INFO : - Path2 File was deleted - file1.txt 2025/06/15 02:37:34 INFO : - Path2 File was deleted - file2.txt 2025/06/15 02:37:34 INFO : - Path2 File was deleted - file3.txt 2025/06/15 02:37:34 INFO : - Path2 File was deleted - file4.txt 2025/06/15 02:37:34 INFO : - Path2 File was deleted - file5.txt 2025/06/15 02:37:34 INFO : Path2: 5 changes:  0 new,  0 modified,  5 deleted 2025/06/15 02:37:34 ERROR : Safety abort: too many deletes (>50%, 5 of 9) on Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/". Run with --force if desired. 2025/06/15 02:37:34 NOTICE: Bisync aborted. Please try again. 2025/06/15 02:37:34 NOTICE: Bisync error: too many deletes 2025/06/15 02:37:34 NOTICE: (12) : copy-listings initial-fail 2025/06/15 02:37:34 NOTICE: (13) : test apply force option. sync should run. 2025/06/15 02:37:34 NOTICE: (14) : bisync force 2025/06/15 02:37:37 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:37 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:37:37 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/" 2025/06/15 02:37:37 INFO : Building Path1 and Path2 listings 2025/06/15 02:37:38 INFO : Path1 checking for diffs 2025/06/15 02:37:38 INFO : Path2 checking for diffs 2025/06/15 02:37:38 INFO : - Path2 File was deleted - file1.txt 2025/06/15 02:37:38 INFO : - Path2 File was deleted - file2.txt 2025/06/15 02:37:38 INFO : - Path2 File was deleted - file3.txt 2025/06/15 02:37:38 INFO : - Path2 File was deleted - file4.txt 2025/06/15 02:37:38 INFO : - Path2 File was deleted - file5.txt 2025/06/15 02:37:38 INFO : Path2: 5 changes:  0 new,  0 modified,  5 deleted 2025/06/15 02:37:38 INFO : Applying changes 2025/06/15 02:37:38 INFO : - Path1 Queue delete - TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/file1.txt 2025/06/15 02:37:38 INFO : - Path1 Queue delete - TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/file2.txt 2025/06/15 02:37:38 INFO : - Path1 Queue delete - TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/file3.txt 2025/06/15 02:37:38 INFO : - Path1 Queue delete - TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/file4.txt 2025/06/15 02:37:38 INFO : - Path1 Queue delete - TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/file5.txt 2025/06/15 02:37:38 INFO : - Path2 Do queued copies to - Path1 2025/06/15 02:37:38 INFO : file4.txt: Deleted 2025/06/15 02:37:38 INFO : file5.txt: Deleted 2025/06/15 02:37:38 INFO : file1.txt: Deleted 2025/06/15 02:37:38 INFO : file2.txt: Deleted 2025/06/15 02:37:38 INFO : file3.txt: Deleted 2025/06/15 02:37:38 INFO : Updating listings 2025/06/15 02:37:38 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/max_delete_path2_force/path2/" 2025/06/15 02:37:38 INFO : Bisync successful bisync_test.go:560: TEST max_delete_path2_force PASSED === RUN TestBisyncRemoteRemote/resync 2025/06/15 02:37:46 NOTICE: checking initFs Local file system at /tmp/023715wo/initdir/test_resync-zojoret8 2025/06/15 02:37:48 NOTICE: checking Path1 B2 bucket rclone-test-govepiv0jolu path 023715wo/resync/path1 2025/06/15 02:37:49 NOTICE: checking path2 B2 bucket rclone-test-govepiv0jolu path 023715wo/resync/path2 2025/06/15 02:37:50 NOTICE: (01) : test resync 2025/06/15 02:37:50 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/06/15 02:37:50 NOTICE: (03) : purge-children TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/ 2025/06/15 02:37:51 NOTICE: (04) : bisync resync 2025/06/15 02:37:54 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:37:54 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:37:54 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:37:54 INFO : Copying Path2 files to Path1 2025/06/15 02:37:54 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:37:54 INFO : RCLONE_TEST: Copied (server-side copy) 2025/06/15 02:37:54 INFO : file3.txt: Copied (server-side copy) 2025/06/15 02:37:54 INFO : file2.txt: Copied (server-side copy) 2025/06/15 02:37:54 INFO : file1.txt: Copied (server-side copy) 2025/06/15 02:37:55 INFO : file4.txt: Copied (server-side copy) 2025/06/15 02:37:55 INFO : file6.txt: Copied (server-side copy) 2025/06/15 02:37:55 INFO : file7.txt: Copied (server-side copy) 2025/06/15 02:37:55 INFO : file5.txt: Copied (server-side copy) 2025/06/15 02:37:55 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:37:55 INFO : Resync updating listings 2025/06/15 02:37:55 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:37:55 INFO : Bisync successful 2025/06/15 02:37:55 NOTICE: (05) : move-listings empty-path1 2025/06/15 02:37:55 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/06/15 02:37:55 NOTICE: (07) : purge-children TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ 2025/06/15 02:37:57 NOTICE: (08) : bisync resync 2025/06/15 02:38:00 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:38:00 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:38:00 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:00 INFO : Copying Path2 files to Path1 2025/06/15 02:38:00 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:38:00 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:38:01 INFO : RCLONE_TEST: Copied (server-side copy) 2025/06/15 02:38:01 INFO : file2.txt: Copied (server-side copy) 2025/06/15 02:38:01 INFO : file3.txt: Copied (server-side copy) 2025/06/15 02:38:01 INFO : file1.txt: Copied (server-side copy) 2025/06/15 02:38:02 INFO : file5.txt: Copied (server-side copy) 2025/06/15 02:38:02 INFO : file6.txt: Copied (server-side copy) 2025/06/15 02:38:02 INFO : file4.txt: Copied (server-side copy) 2025/06/15 02:38:02 INFO : file7.txt: Copied (server-side copy) 2025/06/15 02:38:02 INFO : Resync updating listings 2025/06/15 02:38:02 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:02 INFO : Bisync successful 2025/06/15 02:38:02 NOTICE: (09) : move-listings empty-path2 2025/06/15 02:38:02 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/06/15 02:38:02 NOTICE: (11) : touch-glob 2002-02-02 /tmp/023715wo/datadir/test_resync-perekuk0/ fileA.txt 2025/06/15 02:38:02 NOTICE: (12) : touch-glob 1999-09-09 /tmp/023715wo/datadir/test_resync-perekuk0/ fileB.txt 2025/06/15 02:38:02 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/06/15 02:38:02 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/06/15 02:38:02 NOTICE: (15) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/file1.txt 2025/06/15 02:38:04 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/06/15 02:38:04 NOTICE: (17) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/file2.txt 2025/06/15 02:38:05 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/06/15 02:38:05 NOTICE: (19) : copy-as /tmp/023715wo/datadir/test_resync-perekuk0/fileA.txt TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ file3.txt 2025/06/15 02:38:08 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/06/15 02:38:08 NOTICE: (21) : delete-file TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/file4.txt 2025/06/15 02:38:09 NOTICE: (22) : copy-as /tmp/023715wo/datadir/test_resync-perekuk0/fileA.txt TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ file4.txt 2025/06/15 02:38:12 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/06/15 02:38:12 NOTICE: (24) : copy-as /tmp/023715wo/datadir/test_resync-perekuk0/fileB.txt TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ file5.txt 2025/06/15 02:38:15 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/06/15 02:38:15 NOTICE: (26) : copy-as /tmp/023715wo/datadir/test_resync-perekuk0/fileB.txt TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/ file6.txt 2025/06/15 02:38:18 NOTICE: (27) : copy-as /tmp/023715wo/datadir/test_resync-perekuk0/fileA.txt TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ file6.txt 2025/06/15 02:38:21 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/06/15 02:38:21 NOTICE: (29) : test run bisync with resync 2025/06/15 02:38:21 NOTICE: (30) : bisync resync 2025/06/15 02:38:25 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:38:25 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:38:25 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:25 INFO : Copying Path2 files to Path1 2025/06/15 02:38:25 INFO : - Path2 Resync is copying files to - Path1 2025/06/15 02:38:26 INFO : file2.txt: Copied (server-side copy) 2025/06/15 02:38:26 INFO : file4.txt: Copied (server-side copy) 2025/06/15 02:38:26 INFO : - Path1 Resync is copying files to - Path2 2025/06/15 02:38:26 INFO : file1.txt: Copied (server-side copy) 2025/06/15 02:38:27 INFO : file5.txt: Copied (server-side copy) 2025/06/15 02:38:27 INFO : file6.txt: Updated modification time in destination 2025/06/15 02:38:27 INFO : file3.txt: Copied (server-side copy) 2025/06/15 02:38:27 INFO : Resync updating listings 2025/06/15 02:38:27 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:27 INFO : Bisync successful 2025/06/15 02:38:27 NOTICE: (31) : copy-listings mixed-diffs 2025/06/15 02:38:27 NOTICE: (32) : test run normal bisync 2025/06/15 02:38:27 NOTICE: (33) : bisync 2025/06/15 02:38:30 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:38:30 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/06/15 02:38:30 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:30 INFO : Building Path1 and Path2 listings 2025/06/15 02:38:31 INFO : Path1 checking for diffs 2025/06/15 02:38:31 INFO : Path2 checking for diffs 2025/06/15 02:38:31 INFO : No changes found 2025/06/15 02:38:31 INFO : Updating listings 2025/06/15 02:38:31 INFO : Validating listings for Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" vs Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:31 INFO : Bisync successful 2025/06/15 02:38:31 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/06/15 02:38:31 NOTICE: (35) : purge-children TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/ 2025/06/15 02:38:32 NOTICE: (36) : bisync 2025/06/15 02:38:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/06/15 02:38: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/06/15 02:38:35 INFO : Synching Path1 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path1/" with Path2 "TestB2:rclone-test-govepiv0jolu/023715wo/resync/path2/" 2025/06/15 02:38:35 INFO : Building Path1 and Path2 listings 2025/06/15 02:38:35 INFO : Path1 checking for diffs 2025/06/15 02:38:35 INFO : Path2 checking for diffs 2025/06/15 02:38:35 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/023715wo/workdir/TestB2_rclone-test-govepiv0jolu_023715wo_resync_path1..TestB2_rclone-test-govepiv0jolu_023715wo_resync_path2.path2.lst-new 2025/06/15 02:38:35 ERROR : Bisync critical error: empty current Path2 listing: /tmp/023715wo/workdir/TestB2_rclone-test-govepiv0jolu_023715wo_resync_path1..TestB2_rclone-test-govepiv0jolu_023715wo_resync_path2.path2.lst-new 2025/06/15 02:38:35 ERROR : Bisync aborted. Must run --resync to recover. 2025/06/15 02:38:35 NOTICE: Bisync error: bisync aborted bisync_test.go:560: TEST resync PASSED --- PASS: TestBisyncRemoteRemote (88.12s) --- PASS: TestBisyncRemoteRemote/max_delete_path2_force (26.43s) --- PASS: TestBisyncRemoteRemote/resync (59.98s) PASS 2025/06/15 02:38:43 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteLocal$/^check_sync$|^TestBisyncRemoteRemote$/^(max_delete_path2_force|resync)$'" - Finished OK in 1m48.394228727s (try 2/5)