"./bisync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^TestBisyncLocalRemote$/^(compare_all|max_delete_path2_force)$|^TestBisyncRemoteRemote$/^(check_access_filters|check_sync|dry_run|max_delete_path2_force|normalization|resync|rmdirs)$'" - Starting (try 5/5)
=== RUN   TestBisyncLocalRemote
2025/06/08 07:00:58 NOTICE: remote: TestPutio:rclone-test-fatuxar7yeci
=== RUN   TestBisyncLocalRemote/compare_all
2025/06/08 07:00:59 ERROR : error listing: directory not found
2025/06/08 07:00:59 ERROR : error listing: directory not found
2025/06/08 07:00:59 NOTICE: checking initFs Local file system at /tmp/070058ba/initdir/test_compare_all-mimagib3
2025/06/08 07:00:59 NOTICE: checking Path1 Local file system at /tmp/070058ba/compare_all/path1
2025/06/08 07:01:03 NOTICE: checking path2 Putio root 'rclone-test-fatuxar7yeci/070058ba/compare_all/path2'
2025/06/08 07:01:03 NOTICE: (01)  : test changes compare-all
2025/06/08 07:01:03 NOTICE: (02)  : test initial bisync
2025/06/08 07:01:03 NOTICE: (03)  : bisync resync compare-all
2025/06/08 07:01:04 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/06/08 07:01:04 INFO  : Synching Path1 "/tmp/070058ba/compare_all/path1/" with Path2 "TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/"
2025/06/08 07:01:04 INFO  : Copying Path2 files to Path1
2025/06/08 07:01:04 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:01:04 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:01:05 INFO  : Resync updating listings
2025/06/08 07:01:05 INFO  : Validating listings for Path1 "/tmp/070058ba/compare_all/path1/" vs Path2 "TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/"
2025/06/08 07:01:05 INFO  : Bisync successful
2025/06/08 07:01:05 NOTICE: (04)  : test make modifications on both paths
2025/06/08 07:01:05 NOTICE: (05)  : test new on path2 - file10
2025/06/08 07:01:05 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file10.txt TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/
2025/06/08 07:01:06 NOTICE: (07)  : test newer on path2 - file1
2025/06/08 07:01:06 NOTICE: (08)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file1.txt TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/
2025/06/08 07:01:07 NOTICE: (09)  : test new on path1 - file11
2025/06/08 07:01:07 NOTICE: (10)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file11.txt /tmp/070058ba/compare_all/path1/
2025/06/08 07:01:07 NOTICE: (11)  : test newer on path1 - file2
2025/06/08 07:01:07 NOTICE: (12)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file2.txt /tmp/070058ba/compare_all/path1/
2025/06/08 07:01:07 NOTICE: (13)  : test deleted on path2 - file3
2025/06/08 07:01:07 NOTICE: (14)  : delete-file TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file3.txt
2025/06/08 07:01:08 NOTICE: (15)  : test deleted on path1 - file4
2025/06/08 07:01:08 NOTICE: (16)  : delete-file /tmp/070058ba/compare_all/path1/file4.txt
2025/06/08 07:01:08 NOTICE: (17)  : test deleted on both paths - file8
2025/06/08 07:01:08 NOTICE: (18)  : delete-file /tmp/070058ba/compare_all/path1/file8.txt
2025/06/08 07:01:08 NOTICE: (19)  : delete-file TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file8.txt
2025/06/08 07:01:08 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/06/08 07:01:08 NOTICE: (21)  : touch-glob 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/ file5R.txt
2025/06/08 07:01:08 NOTICE: (22)  : copy-as /tmp/070058ba/datadir/test_compare_all-detarih8/file5R.txt TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/ file5.txt
2025/06/08 07:01:09 NOTICE: (23)  : touch-glob 2001-03-04 /tmp/070058ba/datadir/test_compare_all-detarih8/ file5L.txt
2025/06/08 07:01:09 NOTICE: (24)  : copy-as /tmp/070058ba/datadir/test_compare_all-detarih8/file5L.txt /tmp/070058ba/compare_all/path1/ file5.txt
2025/06/08 07:01:09 NOTICE: (25)  : test newer on path2 and deleted on path1 - file6
2025/06/08 07:01:09 NOTICE: (26)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file6.txt TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/
2025/06/08 07:01:11 NOTICE: (27)  : delete-file /tmp/070058ba/compare_all/path1/file6.txt
2025/06/08 07:01:11 NOTICE: (28)  : test newer on path1 and deleted on path2 - file7
2025/06/08 07:01:11 NOTICE: (29)  : touch-copy 2001-01-02 /tmp/070058ba/datadir/test_compare_all-detarih8/file7.txt /tmp/070058ba/compare_all/path1/
2025/06/08 07:01:11 NOTICE: (30)  : delete-file TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file7.txt
2025/06/08 07:01:11 NOTICE: (31)  : test bisync run
2025/06/08 07:01:11 NOTICE: (32)  : bisync compare-all
2025/06/08 07:01:12 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/06/08 07:01:12 INFO  : Synching Path1 "/tmp/070058ba/compare_all/path1/" with Path2 "TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/"
2025/06/08 07:01:12 INFO  : Building Path1 and Path2 listings
2025/06/08 07:01:12 INFO  : Path1 checking for diffs
2025/06/08 07:01:12 INFO  : - Path1    File changed: size (larger), time (newer), hash - file2.txt
2025/06/08 07:01:12 INFO  : - Path1    File was deleted          - file4.txt
2025/06/08 07:01:12 INFO  : - Path1    File changed: size (larger), time (newer), hash - file5.txt
2025/06/08 07:01:12 INFO  : - Path1    File was deleted          - file6.txt
2025/06/08 07:01:12 INFO  : - Path1    File changed: size (larger), time (newer), hash - file7.txt
2025/06/08 07:01:12 INFO  : - Path1    File was deleted          - file8.txt
2025/06/08 07:01:12 INFO  : - Path1    File is new               - file11.txt
2025/06/08 07:01:12 INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/06/08 07:01:12 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/06/08 07:01:12 INFO  : Path2 checking for diffs
2025/06/08 07:01:12 INFO  : - Path2    File changed: size (larger), time (newer), hash - file1.txt
2025/06/08 07:01:12 INFO  : - Path2    File was deleted          - file3.txt
2025/06/08 07:01:12 INFO  : - Path2    File changed: size (larger), time (newer), hash - file5.txt
2025/06/08 07:01:12 INFO  : - Path2    File changed: size (larger), time (newer), hash - file6.txt
2025/06/08 07:01:12 INFO  : - Path2    File was deleted          - file7.txt
2025/06/08 07:01:12 INFO  : - Path2    File was deleted          - file8.txt
2025/06/08 07:01:12 INFO  : - Path2    File is new               - file10.txt
2025/06/08 07:01:12 INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/06/08 07:01:12 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/06/08 07:01:12 INFO  : Applying changes
2025/06/08 07:01:12 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file11.txt
2025/06/08 07:01:12 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file2.txt
2025/06/08 07:01:12 INFO  : - Path2    Queue delete              - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file4.txt
2025/06/08 07:01:12 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/06/08 07:01:12 NOTICE: - Path1    Renaming Path1 copy                - /tmp/070058ba/compare_all/path1/file5.txt.conflict1
2025/06/08 07:01:12 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/06/08 07:01:12 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file5.txt.conflict1
2025/06/08 07:01:12 NOTICE: - Path2    Renaming Path2 copy                - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file5.txt.conflict2
2025/06/08 07:01:13 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/06/08 07:01:13 NOTICE: - Path2    Queue copy to Path1       - /tmp/070058ba/compare_all/path1/file5.txt.conflict2
2025/06/08 07:01:13 INFO  : - Path2    Queue copy to Path1       - /tmp/070058ba/compare_all/path1/file6.txt
2025/06/08 07:01:13 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/file7.txt
2025/06/08 07:01:13 INFO  : - Path2    Queue copy to Path1       - /tmp/070058ba/compare_all/path1/file1.txt
2025/06/08 07:01:13 INFO  : - Path2    Queue copy to Path1       - /tmp/070058ba/compare_all/path1/file10.txt
2025/06/08 07:01:13 INFO  : - Path1    Queue delete              - /tmp/070058ba/compare_all/path1/file3.txt
2025/06/08 07:01:13 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:01:13 INFO  : file10.txt: Copied (new)
2025/06/08 07:01:13 INFO  : file6.txt: Copied (new)
2025/06/08 07:01:13 INFO  : file5.txt.conflict2: Copied (new)
2025/06/08 07:01:13 INFO  : file1.txt: Copied (replaced existing)
2025/06/08 07:01:13 INFO  : file3.txt: Deleted
2025/06/08 07:01:13 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:01:14 INFO  : file5.txt.conflict1: Copied (new)
2025/06/08 07:01:14 INFO  : file7.txt: Copied (new)
2025/06/08 07:01:14 INFO  : file2.txt: Copied (replaced existing)
2025/06/08 07:01:14 INFO  : file11.txt: Copied (new)
2025/06/08 07:01:14 INFO  : file4.txt: Deleted
2025/06/08 07:01:14 INFO  : Updating listings
2025/06/08 07:01:14 INFO  : Validating listings for Path1 "/tmp/070058ba/compare_all/path1/" vs Path2 "TestPutio:rclone-test-fatuxar7yeci/070058ba/compare_all/path2/"
2025/06/08 07:01:14 INFO  : Bisync successful
    bisync_test.go:560: TEST compare_all PASSED
=== RUN   TestBisyncLocalRemote/max_delete_path2_force
2025/06/08 07:01:15 ERROR : error listing: directory not found
2025/06/08 07:01:15 ERROR : error listing: directory not found
2025/06/08 07:01:15 NOTICE: checking initFs Local file system at /tmp/070058ba/initdir/test_max_delete_path2_force-kaqajaj5
2025/06/08 07:01:15 NOTICE: checking Path1 Local file system at /tmp/070058ba/max_delete_path2_force/path1
2025/06/08 07:01:16 ERROR : file1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s106.put.io/files/245189845e4e517a1a66351e7f593bb3d9b86539
2025/06/08 07:01:17 ERROR : file7.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s95.put.io/files/e1707af550e723da3102cb972c5e0fa4451021da
2025/06/08 07:01:17 ERROR : file5.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s96.put.io/files/3827c57fe40e2d1904a437409263d600e071fb13
2025/06/08 07:01:17 ERROR : file6.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s86.put.io/files/8592f5a1bf0a24ccbb9633c4f8768bea6efb6126
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:461
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s86.put.io/files/8592f5a1bf0a24ccbb9633c4f8768bea6efb6126
        	Test:       	TestBisyncLocalRemote/max_delete_path2_force
        	Messages:   	setting up path2
2025/06/08 07:01:18 NOTICE: checking path2 Putio root 'rclone-test-fatuxar7yeci/070058ba/max_delete_path2_force/path2'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncLocalRemote/max_delete_path2_force
        	Messages:   	listing wrong, want
        	            	  file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) got
        	            	  file2.txt (0), file3.txt (0), file4.txt (0), file8.txt (0), file9.txt (109)
    fstest.go:197: Not found "file1.txt"
    fstest.go:197: Not found "file7.txt"
    fstest.go:197: Not found "file5.txt"
    fstest.go:197: Not found "file6.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 4
        	Test:       	TestBisyncLocalRemote/max_delete_path2_force
        	Messages:   	4 objects not found
2025/06/08 07:01:25 NOTICE: (01)  : test max-delete-path2-force
2025/06/08 07:01:25 NOTICE: (02)  : test initial bisync
2025/06/08 07:01:25 NOTICE: (03)  : bisync resync
2025/06/08 07:01:26 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:01: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/06/08 07:01:26 INFO  : Synching Path1 "/tmp/070058ba/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-fatuxar7yeci/070058ba/max_delete_path2_force/path2/"
2025/06/08 07:01:26 INFO  : Copying Path2 files to Path1
2025/06/08 07:01:26 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:01:26 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:01:27 INFO  : file5.txt: Copied (new)
2025/06/08 07:01:27 ERROR : file1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s109.put.io/files/9017ca4dc801fb9d52facf1951cea011d2118890
2025/06/08 07:01:27 INFO  : file7.txt: Copied (new)
2025/06/08 07:01:27 INFO  : file6.txt: Copied (new)
2025/06/08 07:01:27 ERROR : Bisync critical error: unexpected status code (404) response while doing PATCH to https://s109.put.io/files/9017ca4dc801fb9d52facf1951cea011d2118890
2025/06/08 07:01:27 ERROR : Bisync aborted. Must run --resync to recover.
2025/06/08 07:01:27 NOTICE: Bisync error: bisync aborted
2025/06/08 07:01:27 NOTICE: (04)  : test delete >50% of remote files
2025/06/08 07:01:27 NOTICE: (05)  : delete-file TestPutio:rclone-test-fatuxar7yeci/070058ba/max_delete_path2_force/path2/file1.txt
    bisync_test.go:495: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:495
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	test step failed
        	Test:       	TestBisyncLocalRemote/max_delete_path2_force
        	Messages:   	step 5 failed: object not found
--- FAIL: TestBisyncLocalRemote (30.40s)
    --- PASS: TestBisyncLocalRemote/compare_all (16.77s)
    --- FAIL: TestBisyncLocalRemote/max_delete_path2_force (13.24s)
=== RUN   TestBisyncRemoteRemote
2025/06/08 07:01:28 NOTICE: remote: TestPutio:rclone-test-xadoqow6qaqe
=== RUN   TestBisyncRemoteRemote/check_access_filters
2025/06/08 07:01:30 ERROR : error listing: directory not found
2025/06/08 07:01:30 ERROR : error listing: directory not found
2025/06/08 07:01:30 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_check_access_filters-yazazuh8
2025/06/08 07:01:35 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1'
2025/06/08 07:01:40 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2'
2025/06/08 07:01:40 NOTICE: (01)  : test check-access-filters
2025/06/08 07:01:40 NOTICE: (02)  : test EXCLUDE - OTHER TESTS
2025/06/08 07:01:40 NOTICE: (03)  : copy-file /tmp/070128lu/datadir/test_check_access_filters-salukob3/exclude-other-filtersfile.txt /tmp/070128lu/workdir/
2025/06/08 07:01:40 NOTICE: (04)  : test resync to get the filters file md5 built.
2025/06/08 07:01:40 NOTICE: (05)  : bisync resync filters-file=/tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:42 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:01:42 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/08 07:01:42 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:42 INFO  : Using filters file /tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:42 INFO  : Storing filters file hash to /tmp/070128lu/workdir/exclude-other-filtersfile.txt.md5
2025/06/08 07:01:42 INFO  : Copying Path2 files to Path1
2025/06/08 07:01:42 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:01:42 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:01:42 INFO  : Resync updating listings
2025/06/08 07:01:42 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:42 INFO  : Bisync successful
2025/06/08 07:01:42 NOTICE: (06)  : test EXCLUDE - test filters for check access
2025/06/08 07:01:42 NOTICE: (07)  : bisync check-access filters-file=/tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:44 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:01:44 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/08 07:01:44 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:44 INFO  : Using filters file /tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:44 INFO  : Building Path1 and Path2 listings
2025/06/08 07:01:45 INFO  : Path1 checking for diffs
2025/06/08 07:01:45 INFO  : Path2 checking for diffs
2025/06/08 07:01:45 INFO  : Checking access health
2025/06/08 07:01:45 INFO  : Found 3 matching "RCLONE_TEST" files on both paths
2025/06/08 07:01:45 INFO  : No changes found
2025/06/08 07:01:45 INFO  : Updating listings
2025/06/08 07:01:45 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:45 INFO  : Bisync successful
2025/06/08 07:01:45 NOTICE: (08)  : copy-listings exclude-initial
2025/06/08 07:01:45 NOTICE: (09)  : test EXCLUDE - delete RCLONE_TEST files in excluded directories
2025/06/08 07:01:45 NOTICE: (10)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/subdir/subdirA/RCLONE_TEST
2025/06/08 07:01:45 NOTICE: (11)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/subdir-not/RCLONE_TEST
2025/06/08 07:01:46 NOTICE: (12)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/subdir-not/subdir-not2/RCLONE_TEST
2025/06/08 07:01:46 NOTICE: (13)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/subdirX/RCLONE_TEST
2025/06/08 07:01:47 NOTICE: (14)  : test EXCLUDE - test should PASS
2025/06/08 07:01:47 NOTICE: (15)  : bisync check-access filters-file=/tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:49 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07: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/06/08 07:01:49 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:49 INFO  : Using filters file /tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:49 INFO  : Building Path1 and Path2 listings
2025/06/08 07:01:49 INFO  : Path1 checking for diffs
2025/06/08 07:01:49 INFO  : Path2 checking for diffs
2025/06/08 07:01:49 INFO  : Checking access health
2025/06/08 07:01:49 INFO  : Found 3 matching "RCLONE_TEST" files on both paths
2025/06/08 07:01:49 INFO  : No changes found
2025/06/08 07:01:49 INFO  : Updating listings
2025/06/08 07:01:49 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:49 INFO  : Bisync successful
2025/06/08 07:01:49 NOTICE: (16)  : copy-listings exclude-pass-run
2025/06/08 07:01:49 NOTICE: (17)  : test EXCLUDE - delete RCLONE_TEST files in included directories
2025/06/08 07:01:49 NOTICE: (18)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/RCLONE_TEST
2025/06/08 07:01:49 NOTICE: (19)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/subdir/RCLONE_TEST
2025/06/08 07:01:50 NOTICE: (20)  : test EXCLUDE - test should ABORT
2025/06/08 07:01:50 NOTICE: (21)  : bisync check-access filters-file=/tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:01: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/06/08 07:01:52 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path2/"
2025/06/08 07:01:52 INFO  : Using filters file /tmp/070128lu/workdir/exclude-other-filtersfile.txt
2025/06/08 07:01:52 INFO  : Building Path1 and Path2 listings
2025/06/08 07:01:52 INFO  : Path1 checking for diffs
2025/06/08 07:01:52 INFO  : - Path1    File was deleted          - subdir/RCLONE_TEST
2025/06/08 07:01:52 INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/06/08 07:01:52 INFO  : Path2 checking for diffs
2025/06/08 07:01:52 INFO  : - Path2    File was deleted          - RCLONE_TEST
2025/06/08 07:01:52 INFO  : Path2:    1 changes:    0 new,    0 modified,    1 deleted
2025/06/08 07:01:52 INFO  : Checking access health
2025/06/08 07:01:52 ERROR : -          Access test failed: Path1 file not found in Path2 - RCLONE_TEST
2025/06/08 07:01:52 ERROR : -          Access test failed: Path2 file not found in Path1 - subdir/RCLONE_TEST
2025/06/08 07:01:52 ERROR : Bisync critical error: check file check failed
2025/06/08 07:01:52 ERROR : Bisync aborted. Must run --resync to recover.
2025/06/08 07:01:52 NOTICE: Bisync error: bisync aborted
2025/06/08 07:01:52 NOTICE: (22)  : move-listings exclude-error-run
2025/06/08 07:01:52 NOTICE: (23)  : test INCLUDE - OTHER TESTS
2025/06/08 07:01:52 NOTICE: (24)  : test reset to the initial state
2025/06/08 07:01:52 NOTICE: (25)  : copy-dir /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/initial TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_access_filters/path1/
2025/06/08 07:01:53 ERROR : subdir-not/RCLONE_TEST: Failed to copy: unexpected status code (404) response while doing HEAD to https://s64.put.io/files/d8402ee297235ea66eec4fbb411f45e9b5c112f9
    bisync_test.go:495: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:495
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	test step failed
        	Test:       	TestBisyncRemoteRemote/check_access_filters
        	Messages:   	step 25 failed: unexpected status code (404) response while doing HEAD to https://s64.put.io/files/d8402ee297235ea66eec4fbb411f45e9b5c112f9
=== RUN   TestBisyncRemoteRemote/check_sync
2025/06/08 07:01:54 ERROR : error listing: directory not found
2025/06/08 07:01:54 ERROR : error listing: directory not found
2025/06/08 07:01:54 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_check_sync-nomefoz8
2025/06/08 07:01:56 ERROR : file2.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s74.put.io/files/6123e8a00f8d04890e095b3792ab944d49908deb
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:458
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s74.put.io/files/6123e8a00f8d04890e095b3792ab944d49908deb
        	Test:       	TestBisyncRemoteRemote/check_sync
        	Messages:   	setting up path1
2025/06/08 07:01:57 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/check_sync/path1'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncRemoteRemote/check_sync
        	Messages:   	listing wrong, want
        	            	  RCLONE_TEST (109), file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0) got
        	            	  RCLONE_TEST (109), file1.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0)
    fstest.go:197: Not found "file2.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestBisyncRemoteRemote/check_sync
        	Messages:   	1 objects not found
2025/06/08 07:02:07 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/check_sync/path2'
2025/06/08 07:02:07 NOTICE: (01)  : test check-sync
2025/06/08 07:02:07 NOTICE: (02)  : test initial bisync
2025/06/08 07:02:07 NOTICE: (03)  : bisync resync
2025/06/08 07:02:10 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:10 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/08 07:02:10 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:10 INFO  : Copying Path2 files to Path1
2025/06/08 07:02:10 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:02:10 INFO  : file2.txt: Copied (server-side copy)
2025/06/08 07:02:10 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:02:10 INFO  : Resync updating listings
2025/06/08 07:02:10 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:10 INFO  : Bisync successful
2025/06/08 07:02:10 NOTICE: (04)  : test 1. run check-sync-only on a clean sync
2025/06/08 07:02:10 NOTICE: (05)  : bisync check-sync-only
2025/06/08 07:02:12 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02: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/06/08 07:02:12 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:12 INFO  : Bisync successful
2025/06/08 07:02:12 NOTICE: (06)  : test 2. inject modified listings into the workdir
2025/06/08 07:02:12 NOTICE: (07)  : copy-as /tmp/070128lu/datadir/test_check_sync-ropuzic6/_testdir_path1.._testdir_path2.path1.lst /tmp/070128lu/workdir/ TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path1..TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path2.path1.lst
2025/06/08 07:02:12 NOTICE: (08)  : copy-as /tmp/070128lu/datadir/test_check_sync-ropuzic6/_testdir_path1.._testdir_path2.path2.lst /tmp/070128lu/workdir/ TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path1..TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path2.path2.lst
2025/06/08 07:02:12 NOTICE: (09)  : test 3. run check-sync-only on modified listings
2025/06/08 07:02:12 NOTICE: (10)  : bisync check-sync-only
2025/06/08 07:02:14 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:14 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/08 07:02:14 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:14 ERROR : -          Path1 file not found in Path2      - file2.txt
2025/06/08 07:02:14 ERROR : -          Path2 file not found in Path1      - file1.txt
2025/06/08 07:02:14 ERROR : Bisync critical error: path1 and path2 are out of sync, run --resync to recover
2025/06/08 07:02:14 ERROR : Bisync aborted. Must run --resync to recover.
2025/06/08 07:02:14 NOTICE: Bisync error: bisync aborted
2025/06/08 07:02:14 NOTICE: (11)  : copy-listings check-sync-only
2025/06/08 07:02:14 NOTICE: (12)  : test 4. run normal sync to check that it aborts
2025/06/08 07:02:14 NOTICE: (13)  : bisync
2025/06/08 07:02:16 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:16 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/08 07:02:16 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:16 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/070128lu/workdir/TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path1..TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path2.path1.lst
Path2: /tmp/070128lu/workdir/TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path1..TestPutio_rclone-test-xadoqow6qaqe_070128lu_check_sync_path2.path2.lst
Try running this command to inspect the work dir: 
rclone lsl "/tmp/070128lu/workdir"
2025/06/08 07:02:16 ERROR : Bisync aborted. Must run --resync to recover.
2025/06/08 07:02:16 NOTICE: Bisync error: bisync aborted
2025/06/08 07:02:16 NOTICE: (14)  : test 5. prune failure listings after critical abort
2025/06/08 07:02:16 NOTICE: (15)  : delete-glob /tmp/070128lu/workdir/ *.lst
2025/06/08 07:02:16 NOTICE: (16)  : delete-glob /tmp/070128lu/workdir/ *.lst-err
2025/06/08 07:02:16 NOTICE: (17)  : delete-glob /tmp/070128lu/workdir/ *.lst-new
2025/06/08 07:02:16 NOTICE: (18)  : test 6. run resync
2025/06/08 07:02:16 NOTICE: (19)  : bisync resync
2025/06/08 07:02:18 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:18 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/08 07:02:18 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:18 INFO  : Copying Path2 files to Path1
2025/06/08 07:02:18 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:02:18 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:02:18 INFO  : Resync updating listings
2025/06/08 07:02:18 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:18 INFO  : Bisync successful
2025/06/08 07:02:18 NOTICE: (20)  : test 7. run normal sync with check-sync enabled (default)
2025/06/08 07:02:18 NOTICE: (21)  : bisync
2025/06/08 07:02:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:20 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/08 07:02:20 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:20 INFO  : Building Path1 and Path2 listings
2025/06/08 07:02:20 INFO  : Path1 checking for diffs
2025/06/08 07:02:20 INFO  : Path2 checking for diffs
2025/06/08 07:02:20 INFO  : No changes found
2025/06/08 07:02:20 INFO  : Updating listings
2025/06/08 07:02:20 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:20 INFO  : Bisync successful
2025/06/08 07:02:20 NOTICE: (22)  : test 8. run normal sync with no-check-sync
2025/06/08 07:02:20 NOTICE: (23)  : bisync no-check-sync
2025/06/08 07:02:22 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02: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/06/08 07:02:22 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/check_sync/path2/"
2025/06/08 07:02:22 INFO  : Building Path1 and Path2 listings
2025/06/08 07:02:22 INFO  : Path1 checking for diffs
2025/06/08 07:02:22 INFO  : Path2 checking for diffs
2025/06/08 07:02:22 INFO  : No changes found
2025/06/08 07:02:22 INFO  : Updating listings
2025/06/08 07:02:22 INFO  : Bisync successful
    bisync_test.go:560: TEST check_sync PASSED
=== RUN   TestBisyncRemoteRemote/dry_run
2025/06/08 07:02:24 ERROR : error listing: directory not found
2025/06/08 07:02:24 ERROR : error listing: directory not found
2025/06/08 07:02:24 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_dry_run-cihuhip2
2025/06/08 07:02:26 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path1'
2025/06/08 07:02:27 ERROR : file1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s85.put.io/files/ba62d819b2a743e9355a773bfcdce9887d667fd8
2025/06/08 07:02:27 ERROR : file7.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s80.put.io/files/33cee9d174f8310377d86575955b07f6600cf841
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:461
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s80.put.io/files/33cee9d174f8310377d86575955b07f6600cf841
        	Test:       	TestBisyncRemoteRemote/dry_run
        	Messages:   	setting up path2
2025/06/08 07:02:27 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path2'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncRemoteRemote/dry_run
        	Messages:   	listing wrong, want
        	            	  RCLONE_TEST (109), file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0) got
        	            	  RCLONE_TEST (109), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0)
    fstest.go:197: Not found "file7.txt"
    fstest.go:197: Not found "file1.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 2
        	Test:       	TestBisyncRemoteRemote/dry_run
        	Messages:   	2 objects not found
2025/06/08 07:02:35 NOTICE: (01)  : test dry-run
2025/06/08 07:02:35 NOTICE: (02)  : test initial bisync
2025/06/08 07:02:35 NOTICE: (03)  : bisync resync
2025/06/08 07:02:37 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02: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/08 07:02:37 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:37 INFO  : Copying Path2 files to Path1
2025/06/08 07:02:37 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:02:37 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:02:38 INFO  : file1.txt: Copied (server-side copy)
2025/06/08 07:02:38 INFO  : file7.txt: Copied (server-side copy)
2025/06/08 07:02:38 INFO  : Resync updating listings
2025/06/08 07:02:38 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:38 INFO  : Bisync successful
2025/06/08 07:02:38 NOTICE: (04)  : test new on path2 - file10
2025/06/08 07:02:38 NOTICE: (05)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file10.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/
2025/06/08 07:02:39 NOTICE: (06)  : test newer on path2 - file1
2025/06/08 07:02:39 NOTICE: (07)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/
2025/06/08 07:02:40 NOTICE: (08)  : test new on path1 - file11
2025/06/08 07:02:40 NOTICE: (09)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file11.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/
2025/06/08 07:02:41 NOTICE: (10)  : test newer on path1 - file2
2025/06/08 07:02:41 NOTICE: (11)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file2.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/
2025/06/08 07:02:42 NOTICE: (12)  : test deleted on path2 - file3
2025/06/08 07:02:42 NOTICE: (13)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file3.txt
2025/06/08 07:02:43 NOTICE: (14)  : test deleted on path1 - file4
2025/06/08 07:02:43 NOTICE: (15)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file4.txt
2025/06/08 07:02:43 NOTICE: (16)  : test changed on path2 and on path1 - file5 (file5R, file5L)
2025/06/08 07:02:43 NOTICE: (17)  : touch-glob 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/ file5R.txt
2025/06/08 07:02:43 NOTICE: (18)  : copy-as /tmp/070128lu/datadir/test_dry_run-madogog0/file5R.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/ file5.txt
2025/06/08 07:02:45 NOTICE: (19)  : touch-glob 2001-03-04 /tmp/070128lu/datadir/test_dry_run-madogog0/ file5L.txt
2025/06/08 07:02:45 NOTICE: (20)  : copy-as /tmp/070128lu/datadir/test_dry_run-madogog0/file5L.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/ file5.txt
2025/06/08 07:02:46 NOTICE: (21)  : test newer on path2 and deleted on path1 - file6
2025/06/08 07:02:46 NOTICE: (22)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file6.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/
2025/06/08 07:02:47 NOTICE: (23)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file6.txt
2025/06/08 07:02:47 NOTICE: (24)  : test newer on path1 and deleted on path2 - file7
2025/06/08 07:02:47 NOTICE: (25)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_dry_run-madogog0/file7.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/
2025/06/08 07:02:48 NOTICE: (26)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file7.txt
2025/06/08 07:02:49 NOTICE: (27)  : test sync with dry-run and resync
2025/06/08 07:02:49 NOTICE: (28)  : bisync dry-run resync
2025/06/08 07:02:50 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02: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/06/08 07:02:50 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:50 INFO  : Copying Path2 files to Path1
2025/06/08 07:02:50 NOTICE: - Path2    Resync is copying files to         - Path1
2025/06/08 07:02:51 NOTICE: file10.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:51 NOTICE: file4.txt: Skipped copy as --dry-run is set (size 0)
2025/06/08 07:02:51 NOTICE: file6.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:51 NOTICE: - Path1    Resync is copying files to         - Path2
2025/06/08 07:02:51 NOTICE: file11.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:51 NOTICE: file3.txt: Skipped copy as --dry-run is set (size 0)
2025/06/08 07:02:51 NOTICE: file2.txt: Skipped copy as --dry-run is set (size 13)
2025/06/08 07:02:51 NOTICE: file5.txt: Skipped copy as --dry-run is set (size 39)
2025/06/08 07:02:51 NOTICE: file1.txt: Skipped copy as --dry-run is set (size 0)
2025/06/08 07:02:51 NOTICE: file7.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:51 INFO  : Resync updating listings
2025/06/08 07:02:51 INFO  : Bisync successful
2025/06/08 07:02:51 NOTICE: (29)  : copy-listings dryrun-resync
2025/06/08 07:02:51 NOTICE: (30)  : test sync with dry-run
2025/06/08 07:02:51 NOTICE: (31)  : bisync dry-run
2025/06/08 07:02:53 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02: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/06/08 07:02:53 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:53 INFO  : Building Path1 and Path2 listings
2025/06/08 07:02:53 INFO  : Path1 checking for diffs
2025/06/08 07:02:53 NOTICE: - Path1    File changed: size (larger), time (newer) - file2.txt
2025/06/08 07:02:53 NOTICE: - Path1    File was deleted          - file4.txt
2025/06/08 07:02:53 NOTICE: - Path1    File changed: size (larger), time (newer) - file5.txt
2025/06/08 07:02:53 NOTICE: - Path1    File was deleted          - file6.txt
2025/06/08 07:02:53 NOTICE: - Path1    File changed: size (larger), time (newer) - file7.txt
2025/06/08 07:02:53 NOTICE: - Path1    File is new               - file11.txt
2025/06/08 07:02:53 INFO  : Path1:    6 changes:    1 new,    3 modified,    2 deleted
2025/06/08 07:02:53 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/06/08 07:02:53 INFO  : Path2 checking for diffs
2025/06/08 07:02:53 NOTICE: - Path2    File changed: size (larger), time (newer) - file1.txt
2025/06/08 07:02:53 NOTICE: - Path2    File was deleted          - file3.txt
2025/06/08 07:02:53 NOTICE: - Path2    File changed: size (larger), time (newer) - file5.txt
2025/06/08 07:02:53 NOTICE: - Path2    File changed: size (larger), time (newer) - file6.txt
2025/06/08 07:02:53 NOTICE: - Path2    File was deleted          - file7.txt
2025/06/08 07:02:53 NOTICE: - Path2    File is new               - file10.txt
2025/06/08 07:02:53 INFO  : Path2:    6 changes:    1 new,    3 modified,    2 deleted
2025/06/08 07:02:53 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/06/08 07:02:53 INFO  : Applying changes
2025/06/08 07:02:53 INFO  : Checking potential conflicts...
2025/06/08 07:02:53 ERROR : file5.txt: crc32 differ
2025/06/08 07:02:53 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path2': 1 differences found
2025/06/08 07:02:53 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path2': 1 errors while checking
2025/06/08 07:02:53 INFO  : Finished checking the potential conflicts. 1 differences found
2025/06/08 07:02:53 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file11.txt
2025/06/08 07:02:53 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file2.txt
2025/06/08 07:02:53 NOTICE: - Path2    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file4.txt
2025/06/08 07:02:53 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/06/08 07:02:53 NOTICE: file5.txt: Skipped rename as --dry-run is set
2025/06/08 07:02:53 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file5.txt.conflict1
2025/06/08 07:02:53 NOTICE: file5.txt: Skipped rename as --dry-run is set
2025/06/08 07:02:53 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file5.txt.conflict2
2025/06/08 07:02:53 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file6.txt
2025/06/08 07:02:53 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file7.txt
2025/06/08 07:02:53 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file1.txt
2025/06/08 07:02:53 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file10.txt
2025/06/08 07:02:53 NOTICE: - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file3.txt
2025/06/08 07:02:53 NOTICE: - Path2    Do queued copies to                - Path1
2025/06/08 07:02:53 NOTICE: file10.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:53 NOTICE: file1.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:53 NOTICE: file6.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:53 NOTICE: file3.txt: Skipped delete as --dry-run is set (size 0)
2025/06/08 07:02:53 NOTICE: - Path1    Do queued copies to                - Path2
2025/06/08 07:02:53 NOTICE: file11.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:53 NOTICE: file7.txt: Skipped copy as --dry-run is set (size 19)
2025/06/08 07:02:53 NOTICE: file2.txt: Skipped copy as --dry-run is set (size 13)
2025/06/08 07:02:53 NOTICE: file4.txt: Skipped delete as --dry-run is set (size 0)
2025/06/08 07:02:53 INFO  : Updating listings
2025/06/08 07:02:53 INFO  : Bisync successful
2025/06/08 07:02:53 NOTICE: (32)  : copy-listings dryrun
2025/06/08 07:02:53 NOTICE: (33)  : test sync without dry-run
2025/06/08 07:02:53 NOTICE: (34)  : bisync
2025/06/08 07:02:55 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:02:55 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/08 07:02:55 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:55 INFO  : Building Path1 and Path2 listings
2025/06/08 07:02:55 INFO  : Path1 checking for diffs
2025/06/08 07:02:55 INFO  : - Path1    File changed: size (larger), time (newer) - file2.txt
2025/06/08 07:02:55 INFO  : - Path1    File was deleted          - file4.txt
2025/06/08 07:02:55 INFO  : - Path1    File changed: size (larger), time (newer) - file5.txt
2025/06/08 07:02:55 INFO  : - Path1    File was deleted          - file6.txt
2025/06/08 07:02:55 INFO  : - Path1    File changed: size (larger), time (newer) - file7.txt
2025/06/08 07:02:55 INFO  : - Path1    File is new               - file11.txt
2025/06/08 07:02:55 INFO  : Path1:    6 changes:    1 new,    3 modified,    2 deleted
2025/06/08 07:02:55 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/06/08 07:02:55 INFO  : Path2 checking for diffs
2025/06/08 07:02:55 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/06/08 07:02:55 INFO  : - Path2    File was deleted          - file3.txt
2025/06/08 07:02:55 INFO  : - Path2    File changed: size (larger), time (newer) - file5.txt
2025/06/08 07:02:55 INFO  : - Path2    File changed: size (larger), time (newer) - file6.txt
2025/06/08 07:02:55 INFO  : - Path2    File was deleted          - file7.txt
2025/06/08 07:02:55 INFO  : - Path2    File is new               - file10.txt
2025/06/08 07:02:55 INFO  : Path2:    6 changes:    1 new,    3 modified,    2 deleted
2025/06/08 07:02:55 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/06/08 07:02:55 INFO  : Applying changes
2025/06/08 07:02:55 INFO  : Checking potential conflicts...
2025/06/08 07:02:55 ERROR : file5.txt: crc32 differ
2025/06/08 07:02:55 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path2': 1 differences found
2025/06/08 07:02:55 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/dry_run/path2': 1 errors while checking
2025/06/08 07:02:55 INFO  : Finished checking the potential conflicts. 1 differences found
2025/06/08 07:02:55 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file11.txt
2025/06/08 07:02:55 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file2.txt
2025/06/08 07:02:55 INFO  : - Path2    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file4.txt
2025/06/08 07:02:55 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/06/08 07:02:55 NOTICE: - Path1    Renaming Path1 copy                - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file5.txt.conflict1
2025/06/08 07:02:55 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/06/08 07:02:55 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file5.txt.conflict1
2025/06/08 07:02:55 NOTICE: - Path2    Renaming Path2 copy                - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file5.txt.conflict2
2025/06/08 07:02:56 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/06/08 07:02:56 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file5.txt.conflict2
2025/06/08 07:02:56 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file6.txt
2025/06/08 07:02:56 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/file7.txt
2025/06/08 07:02:56 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file1.txt
2025/06/08 07:02:56 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file10.txt
2025/06/08 07:02:56 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/file3.txt
2025/06/08 07:02:56 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:02:56 INFO  : file5.txt.conflict2: Copied (server-side copy)
2025/06/08 07:02:56 INFO  : file10.txt: Copied (server-side copy)
2025/06/08 07:02:56 INFO  : file6.txt: Copied (server-side copy)
2025/06/08 07:02:56 INFO  : file1.txt: Copied (server-side copy)
2025/06/08 07:02:56 INFO  : file3.txt: Deleted
2025/06/08 07:02:56 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:02:57 INFO  : file11.txt: Copied (server-side copy)
2025/06/08 07:02:57 INFO  : file7.txt: Copied (server-side copy)
2025/06/08 07:02:57 INFO  : file2.txt: Copied (server-side copy)
2025/06/08 07:02:58 INFO  : file5.txt.conflict1: Copied (server-side copy)
2025/06/08 07:02:58 INFO  : file4.txt: Deleted
2025/06/08 07:02:58 INFO  : Updating listings
2025/06/08 07:02:58 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/dry_run/path2/"
2025/06/08 07:02:58 INFO  : Bisync successful
    bisync_test.go:560: TEST dry_run PASSED
=== RUN   TestBisyncRemoteRemote/max_delete_path2_force
2025/06/08 07:02:59 ERROR : error listing: directory not found
2025/06/08 07:02:59 ERROR : error listing: directory not found
2025/06/08 07:02:59 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_max_delete_path2_force-nutohel7
2025/06/08 07:03:01 ERROR : file3.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s73.put.io/files/8faed5734173cd2733e9d87d95dcbb2487468aac
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:458
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s73.put.io/files/8faed5734173cd2733e9d87d95dcbb2487468aac
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	setting up path1
2025/06/08 07:03:03 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	listing wrong, want
        	            	  file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) got
        	            	  file1.txt (0), file2.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109)
    fstest.go:197: Not found "file3.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	1 objects not found
2025/06/08 07:03:13 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2'
2025/06/08 07:03:13 NOTICE: (01)  : test max-delete-path2-force
2025/06/08 07:03:13 NOTICE: (02)  : test initial bisync
2025/06/08 07:03:13 NOTICE: (03)  : bisync resync
2025/06/08 07:03:15 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:03:15 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/08 07:03:15 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/"
2025/06/08 07:03:15 INFO  : Copying Path2 files to Path1
2025/06/08 07:03:15 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:03:16 INFO  : file3.txt: Copied (server-side copy)
2025/06/08 07:03:16 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:03:16 INFO  : Resync updating listings
2025/06/08 07:03:16 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/"
2025/06/08 07:03:16 INFO  : Bisync successful
2025/06/08 07:03:16 NOTICE: (04)  : test delete >50% of remote files
2025/06/08 07:03:16 NOTICE: (05)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/file1.txt
2025/06/08 07:03:16 NOTICE: (06)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/file2.txt
2025/06/08 07:03:17 NOTICE: (07)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/file3.txt
2025/06/08 07:03:17 NOTICE: (08)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/file4.txt
2025/06/08 07:03:17 NOTICE: (09)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/file5.txt
2025/06/08 07:03:17 NOTICE: (10)  : test sync should fail due to too many path2 deletes
2025/06/08 07:03:17 NOTICE: (11)  : bisync
2025/06/08 07:03:19 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:03: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/06/08 07:03:19 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/"
2025/06/08 07:03:19 INFO  : Building Path1 and Path2 listings
2025/06/08 07:03:19 INFO  : Path1 checking for diffs
2025/06/08 07:03:19 INFO  : Path2 checking for diffs
2025/06/08 07:03:19 INFO  : - Path2    File was deleted          - file1.txt
2025/06/08 07:03:19 INFO  : - Path2    File was deleted          - file2.txt
2025/06/08 07:03:19 INFO  : - Path2    File was deleted          - file3.txt
2025/06/08 07:03:19 INFO  : - Path2    File was deleted          - file4.txt
2025/06/08 07:03:19 INFO  : - Path2    File was deleted          - file5.txt
2025/06/08 07:03:19 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/06/08 07:03:19 ERROR : Safety abort: too many deletes (>50%, 5 of 9) on Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/". Run with --force if desired.
2025/06/08 07:03:19 NOTICE: Bisync aborted. Please try again.
2025/06/08 07:03:19 NOTICE: Bisync error: too many deletes
2025/06/08 07:03:19 NOTICE: (12)  : copy-listings initial-fail
2025/06/08 07:03:19 NOTICE: (13)  : test apply force option. sync should run.
2025/06/08 07:03:19 NOTICE: (14)  : bisync force
2025/06/08 07:03:21 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:03:21 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/08 07:03:21 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/"
2025/06/08 07:03:21 INFO  : Building Path1 and Path2 listings
2025/06/08 07:03:21 INFO  : Path1 checking for diffs
2025/06/08 07:03:21 INFO  : Path2 checking for diffs
2025/06/08 07:03:21 INFO  : - Path2    File was deleted          - file1.txt
2025/06/08 07:03:21 INFO  : - Path2    File was deleted          - file2.txt
2025/06/08 07:03:21 INFO  : - Path2    File was deleted          - file3.txt
2025/06/08 07:03:21 INFO  : - Path2    File was deleted          - file4.txt
2025/06/08 07:03:21 INFO  : - Path2    File was deleted          - file5.txt
2025/06/08 07:03:21 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/06/08 07:03:21 INFO  : Applying changes
2025/06/08 07:03:21 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/file1.txt
2025/06/08 07:03:21 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/file2.txt
2025/06/08 07:03:21 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/file3.txt
2025/06/08 07:03:21 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/file4.txt
2025/06/08 07:03:21 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/file5.txt
2025/06/08 07:03:21 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:03:21 INFO  : file4.txt: Deleted
2025/06/08 07:03:22 INFO  : file3.txt: Deleted
2025/06/08 07:03:23 INFO  : file5.txt: Deleted
2025/06/08 07:03:24 INFO  : file2.txt: Deleted
2025/06/08 07:03:25 INFO  : file1.txt: Deleted
2025/06/08 07:03:25 INFO  : Updating listings
2025/06/08 07:03:25 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/max_delete_path2_force/path2/"
2025/06/08 07:03:25 INFO  : Bisync successful
    bisync_test.go:560: TEST max_delete_path2_force PASSED
=== RUN   TestBisyncRemoteRemote/normalization
2025/06/08 07:03:27 ERROR : error listing: directory not found
2025/06/08 07:03:27 ERROR : error listing: directory not found
2025/06/08 07:03:27 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_normalization-pimeqis3
2025/06/08 07:03:29 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path1'
2025/06/08 07:03:31 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path2'
2025/06/08 07:03:31 NOTICE: (01)  : test normalization
2025/06/08 07:03:31 NOTICE: (02)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:03:32 NOTICE: (03)  : test initial bisync
2025/06/08 07:03:32 NOTICE: (04)  : bisync resync
2025/06/08 07:03:37 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:03: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/08 07:03:37 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:03:37 INFO  : Copying Path2 files to Path1
2025/06/08 07:03:37 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:03:37 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:03:38 INFO  : file1.txt: Copied (server-side copy)
2025/06/08 07:03:38 INFO  : Resync updating listings
2025/06/08 07:03:38 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:03:38 INFO  : Bisync successful
2025/06/08 07:03:38 NOTICE: (05)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/06/08 07:03:40 NOTICE: (06)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/folder éééö.txt
2025/06/08 07:03:42 NOTICE: (07)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/folder HeLlO,wOrLd!.txt
2025/06/08 07:03:43 NOTICE: (08)  : touch-copy 2001-01-03 /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:03:44 NOTICE: (09)  : copy-as-NFD /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/folder éééö.txt
2025/06/08 07:03:46 NOTICE: (10)  : copy-as-NFD /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/folder hello,WORLD!.txt
2025/06/08 07:03:47 NOTICE: (11)  : test bisync run with fix-case
2025/06/08 07:03:47 NOTICE: (12)  : bisync fix-case
2025/06/08 07:03:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:03: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/06/08 07:03:52 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:03:52 INFO  : Building Path1 and Path2 listings
2025/06/08 07:03:52 INFO  : Path1 checking for diffs
2025/06/08 07:03:52 INFO  : - Path1    File is new               - folder/HeLlO,wOrLd!.txt
2025/06/08 07:03:52 INFO  : - Path1    File is new               - folder/éééö.txt
2025/06/08 07:03:52 INFO  : - Path1    File is new               - "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:03:52 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/06/08 07:03:52 INFO  : Path2 checking for diffs
2025/06/08 07:03:52 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/06/08 07:03:52 INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/06/08 07:03:52 INFO  : - Path2    File is new               - folder/éééö.txt
2025/06/08 07:03:52 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/06/08 07:03:52 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/06/08 07:03:52 INFO  : Applying changes
2025/06/08 07:03:52 INFO  : Checking potential conflicts...
2025/06/08 07:03:52 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path2': 0 differences found
2025/06/08 07:03:52 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path2': 2 matching files
2025/06/08 07:03:52 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/06/08 07:03:52 NOTICE: - WARNING  New or changed in both paths       - folder/HeLlO,wOrLd!.txt
2025/06/08 07:03:52 INFO  : folder/hello,WORLD!.txt: Files are equal but will copy anyway to fix case to folder/HeLlO,wOrLd!.txt
2025/06/08 07:03:52 NOTICE: - WARNING  New or changed in both paths       - folder/éééö.txt
2025/06/08 07:03:52 INFO  : folder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/06/08 07:03:52 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/folder/éééö.txt
2025/06/08 07:03:52 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:03:52 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/file1.txt
2025/06/08 07:03:52 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:03:52 INFO  : folder/éééö.txt: Updated modification time in destination
2025/06/08 07:03:53 INFO  : file1.txt: Copied (server-side copy)
2025/06/08 07:03:53 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:03:53 INFO  : folder/HeLlO,wOrLd!.txt: Updated modification time in destination
2025/06/08 07:03:53 INFO  : folder/hello,WORLD!.txt: Moved (server-side) to: folder/HeLlO,wOrLd!.txt
2025/06/08 07:03:53 INFO  : folder/hello,WORLD!.txt: Fixed case by renaming to: folder/HeLlO,wOrLd!.txt
2025/06/08 07:03:53 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy)
2025/06/08 07:03:53 INFO  : Updating listings
2025/06/08 07:03:53 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:03:53 INFO  : Bisync successful
2025/06/08 07:03:53 NOTICE: (13)  : purge-children TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/
2025/06/08 07:03:54 NOTICE: (14)  : purge-children TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:03:55 NOTICE: (15)  : touch-copy 2001-01-02 /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:03:58 NOTICE: (16)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/ file2.txt
2025/06/08 07:03:59 NOTICE: (17)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/ file3.txt
2025/06/08 07:04:01 NOTICE: (18)  : bisync resync
2025/06/08 07:04:06 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04:06 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/08 07:04:06 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:06 INFO  : Copying Path2 files to Path1
2025/06/08 07:04:06 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:04:07 INFO  : file1.txt: Copied (server-side copy)
2025/06/08 07:04:07 INFO  : file2.txt: Copied (server-side copy)
2025/06/08 07:04:07 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:04:07 INFO  : file3.txt: Copied (server-side copy)
2025/06/08 07:04:07 INFO  : Resync updating listings
2025/06/08 07:04:07 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:07 INFO  : Bisync successful
2025/06/08 07:04:07 NOTICE: (19)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/06/08 07:04:09 NOTICE: (20)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder éééö.txt
2025/06/08 07:04:11 NOTICE: (21)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/06/08 07:04:12 NOTICE: (22)  : touch-copy 2001-01-03 /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:04:12 NOTICE: (23)  : copy-as-NFD /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/newfolder éééö.txt
2025/06/08 07:04:14 NOTICE: (24)  : copy-as-NFD /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/newfolder hello,WORLD!.txt
2025/06/08 07:04:15 NOTICE: (25)  : test bisync run with normalization
2025/06/08 07:04:15 NOTICE: (26)  : bisync norm force
2025/06/08 07:04:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04:20 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/08 07:04:20 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:20 INFO  : Building Path1 and Path2 listings
2025/06/08 07:04:20 INFO  : Path1 checking for diffs
2025/06/08 07:04:20 INFO  : - Path1    File is new               - newfolder/HeLlO,wOrLd!.txt
2025/06/08 07:04:20 INFO  : - Path1    File is new               - newfolder/éééö.txt
2025/06/08 07:04:20 INFO  : - Path1    File is new               - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:04:20 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/06/08 07:04:20 INFO  : Path2 checking for diffs
2025/06/08 07:04:20 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/06/08 07:04:20 INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/06/08 07:04:20 INFO  : - Path2    File is new               - newfolder/éééö.txt
2025/06/08 07:04:20 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/06/08 07:04:20 INFO  : (Modified:    1 newer,    0 older)
2025/06/08 07:04:20 INFO  : Applying changes
2025/06/08 07:04:20 INFO  : Checking potential conflicts...
2025/06/08 07:04:20 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path2': 0 differences found
2025/06/08 07:04:20 NOTICE: Putio root 'rclone-test-xadoqow6qaqe/070128lu/normalization/path2': 2 matching files
2025/06/08 07:04:20 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/06/08 07:04:20 NOTICE: - WARNING  New or changed in both paths       - newfolder/HeLlO,wOrLd!.txt
2025/06/08 07:04:20 INFO  : newfolder/HeLlO,wOrLd!.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/06/08 07:04:20 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder/HeLlO,wOrLd!.txt
2025/06/08 07:04:20 NOTICE: - WARNING  New or changed in both paths       - newfolder/éééö.txt
2025/06/08 07:04:20 INFO  : newfolder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/06/08 07:04:20 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder/éééö.txt
2025/06/08 07:04:20 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:04:20 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/file1.txt
2025/06/08 07:04:20 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:04:21 INFO  : file1.txt: Updated modification time in destination
2025/06/08 07:04:21 INFO  : newfolder/hello,WORLD!.txt: Updated modification time in destination
2025/06/08 07:04:21 INFO  : newfolder/éééö.txt: Updated modification time in destination
2025/06/08 07:04:21 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:04:21 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy)
2025/06/08 07:04:21 INFO  : Updating listings
2025/06/08 07:04:21 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:21 INFO  : Bisync successful
2025/06/08 07:04:21 NOTICE: (27)  : test resync
2025/06/08 07:04:21 NOTICE: (28)  : bisync resync norm
2025/06/08 07:04:27 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04:27 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/08 07:04:27 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:27 INFO  : Copying Path2 files to Path1
2025/06/08 07:04:27 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:04:27 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:04:28 INFO  : Resync updating listings
2025/06/08 07:04:28 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:28 INFO  : Bisync successful
2025/06/08 07:04:28 NOTICE: (29)  : test changed on one path
2025/06/08 07:04:28 NOTICE: (30)  : touch-copy 2001-01-05 /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/
2025/06/08 07:04:28 NOTICE: (31)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/06/08 07:04:29 NOTICE: (32)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder éééö.txt
2025/06/08 07:04:29 NOTICE: (33)  : copy-as-NFC /tmp/070128lu/datadir/test_normalization-yudigoc0/file1.txt TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/06/08 07:04:30 NOTICE: (34)  : bisync norm
2025/06/08 07:04:35 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04: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/08 07:04:35 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:35 INFO  : Building Path1 and Path2 listings
2025/06/08 07:04:35 INFO  : Path1 checking for diffs
2025/06/08 07:04:35 INFO  : - Path1    File changed: time (newer) - newfolder/HeLlO,wOrLd!.txt
2025/06/08 07:04:35 INFO  : - Path1    File changed: time (newer) - newfolder/éééö.txt
2025/06/08 07:04:35 INFO  : - Path1    File changed: time (newer) - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:04:35 INFO  : Path1:    3 changes:    0 new,    3 modified,    0 deleted
2025/06/08 07:04:35 INFO  : (Modified:    3 newer,    0 older)
2025/06/08 07:04:35 INFO  : Path2 checking for diffs
2025/06/08 07:04:35 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/06/08 07:04:35 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/06/08 07:04:35 INFO  : (Modified:    1 newer,    0 older)
2025/06/08 07:04:35 INFO  : Applying changes
2025/06/08 07:04:35 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/newfolder/hello,WORLD!.txt
2025/06/08 07:04:35 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/newfolder/éééö.txt
2025/06/08 07:04:35 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/06/08 07:04:35 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/file1.txt
2025/06/08 07:04:35 INFO  : - Path2    Do queued copies to                - Path1
2025/06/08 07:04:35 INFO  : file1.txt: Updated modification time in destination
2025/06/08 07:04:35 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:04:35 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Updated modification time in destination
2025/06/08 07:04:35 INFO  : newfolder/HeLlO,wOrLd!.txt: Updated modification time in destination
2025/06/08 07:04:35 INFO  : newfolder/éééö.txt: Updated modification time in destination
2025/06/08 07:04:35 INFO  : Updating listings
2025/06/08 07:04:35 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/normalization/path2/"
2025/06/08 07:04:35 INFO  : Bisync successful
2025/06/08 07:04:35 NOTICE: ----------------------------------------------------------
2025/06/08 07:04:35 NOTICE: | MISCOMPARE  -Golden vs +Results for  test.log
2025/06/08 07:04:35 NOTICE: | @@ -48,0 +49 @@
2025/06/08 07:04:35 NOTICE: | +INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/06/08 07:04:35 NOTICE: | @@ -50 +50,0 @@
2025/06/08 07:04:35 NOTICE: | -INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/06/08 07:04:35 NOTICE: | @@ -61 +61,2 @@
2025/06/08 07:04:35 NOTICE: | -INFO  : folder/éééö.txt: Files are equal but will copy anyway to fix case to folder/éééö.txt
2025/06/08 07:04:35 NOTICE: | +INFO  : folder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/06/08 07:04:35 NOTICE: | +INFO  : - Path2    Queue copy to Path1       - {path1/}folder/éééö.txt
2025/06/08 07:04:35 NOTICE: | @@ -67 +67,0 @@
2025/06/08 07:04:35 NOTICE: | -INFO  : folder/éééö.txt: Fixed case by renaming to: folder/éééö.txt
2025/06/08 07:04:35 NOTICE: | @@ -120,0 +121 @@
2025/06/08 07:04:35 NOTICE: | +INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/06/08 07:04:35 NOTICE: | @@ -122 +122,0 @@
2025/06/08 07:04:35 NOTICE: | -INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/06/08 07:04:35 NOTICE: ----------------------------------------------------------
    bisync_test.go:560: TEST normalization FAILED - 1 MISCOMPARED FILES
=== RUN   TestBisyncRemoteRemote/resync
2025/06/08 07:04:37 ERROR : error listing: directory not found
2025/06/08 07:04:37 ERROR : error listing: directory not found
2025/06/08 07:04:37 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_resync-halugur3
2025/06/08 07:04:39 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/resync/path1'
2025/06/08 07:04:40 ERROR : file1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s101.put.io/files/b12ba233517e47e3a20cfee42f9a9e90867ec045
2025/06/08 07:04:41 ERROR : file4.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s105.put.io/files/84fb9fa7bbcd6080281bfe00a0f5bf27e8f2f12b
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:461
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s105.put.io/files/84fb9fa7bbcd6080281bfe00a0f5bf27e8f2f12b
        	Test:       	TestBisyncRemoteRemote/resync
        	Messages:   	setting up path2
2025/06/08 07:04:41 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/resync/path2'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncRemoteRemote/resync
        	Messages:   	listing wrong, want
        	            	  RCLONE_TEST (109), file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0) got
        	            	  RCLONE_TEST (109), file2.txt (0), file3.txt (0), file5.txt (0), file6.txt (0), file7.txt (0)
    fstest.go:197: Not found "file1.txt"
    fstest.go:197: Not found "file4.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 2
        	Test:       	TestBisyncRemoteRemote/resync
        	Messages:   	2 objects not found
2025/06/08 07:04:49 NOTICE: (01)  : test resync
2025/06/08 07:04:49 NOTICE: (02)  : test 1. resync with empty path1, resulting in copying all content from path2.
2025/06/08 07:04:49 NOTICE: (03)  : purge-children TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path1/
2025/06/08 07:04:50 NOTICE: (04)  : bisync resync
2025/06/08 07:04:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04: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/06/08 07:04:52 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/"
2025/06/08 07:04:52 INFO  : Copying Path2 files to Path1
2025/06/08 07:04:52 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:04:52 INFO  : file2.txt: Copied (server-side copy)
2025/06/08 07:04:52 INFO  : RCLONE_TEST: Copied (server-side copy)
2025/06/08 07:04:52 INFO  : file5.txt: Copied (server-side copy)
2025/06/08 07:04:52 INFO  : file3.txt: Copied (server-side copy)
2025/06/08 07:04:53 INFO  : file6.txt: Copied (server-side copy)
2025/06/08 07:04:53 INFO  : file7.txt: Copied (server-side copy)
2025/06/08 07:04:53 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:04:53 INFO  : Resync updating listings
2025/06/08 07:04:53 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/"
2025/06/08 07:04:53 INFO  : Bisync successful
2025/06/08 07:04:53 NOTICE: (05)  : move-listings empty-path1
2025/06/08 07:04:53 NOTICE: (06)  : test 2. resync with empty path2, resulting in syncing all content to path2.
2025/06/08 07:04:53 NOTICE: (07)  : purge-children TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/
2025/06/08 07:04:53 NOTICE: (08)  : bisync resync
2025/06/08 07:04:55 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:04:55 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/08 07:04:55 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/"
2025/06/08 07:04:55 INFO  : Copying Path2 files to Path1
2025/06/08 07:04:55 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:04:55 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:04:56 INFO  : file2.txt: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : file3.txt: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : RCLONE_TEST: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : file5.txt: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : file7.txt: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : file6.txt: Copied (server-side copy)
2025/06/08 07:04:56 INFO  : Resync updating listings
2025/06/08 07:04:56 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/"
2025/06/08 07:04:56 INFO  : Bisync successful
2025/06/08 07:04:56 NOTICE: (09)  : move-listings empty-path2
2025/06/08 07:04:56 NOTICE: (10)  : test 3. exercise all of the various file difference scenarios during a resync.
2025/06/08 07:04:56 NOTICE: (11)  : touch-glob 2002-02-02 /tmp/070128lu/datadir/test_resync-sefipaz3/ fileA.txt
2025/06/08 07:04:56 NOTICE: (12)  : touch-glob 1999-09-09 /tmp/070128lu/datadir/test_resync-sefipaz3/ fileB.txt
2025/06/08 07:04:56 NOTICE: (13)  : test = file      - path1      - path2      - expected action    - who wins
2025/06/08 07:04:56 NOTICE: (14)  : test - file1.txt - exists     - missing    - sync path1 > path2 - path1
2025/06/08 07:04:56 NOTICE: (15)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/resync/path2/file1.txt
    bisync_test.go:495: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:495
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	test step failed
        	Test:       	TestBisyncRemoteRemote/resync
        	Messages:   	step 15 failed: object not found
=== RUN   TestBisyncRemoteRemote/rmdirs
2025/06/08 07:04:58 ERROR : error listing: directory not found
2025/06/08 07:04:58 ERROR : error listing: directory not found
2025/06/08 07:04:58 NOTICE: checking initFs Local file system at /tmp/070128lu/initdir/test_rmdirs-mabeyor3
2025/06/08 07:04:59 ERROR : file1.copy3.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s106.put.io/files/f648dcb82bfa00b6b57780fea56f02783e2f8e09
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:458
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	unexpected status code (404) response while doing PATCH to https://s106.put.io/files/f648dcb82bfa00b6b57780fea56f02783e2f8e09
        	Test:       	TestBisyncRemoteRemote/rmdirs
        	Messages:   	setting up path1
2025/06/08 07:05:01 NOTICE: checking Path1 Putio root 'rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1'
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncRemoteRemote/rmdirs
        	Messages:   	listing wrong, want
        	            	  RCLONE_TEST (109), file1.copy1.txt (0), file1.copy2.txt (0), file1.copy3.txt (0), file1.copy4.txt (0), file1.copy5.txt (0), file1.txt (0), subdir/file20.txt (0) got
        	            	  RCLONE_TEST (109), file1.copy1.txt (0), file1.copy2.txt (0), file1.copy4.txt (0), file1.copy5.txt (0), file1.txt (0), subdir/file20.txt (0)
    fstest.go:197: Not found "file1.copy3.txt"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestBisyncRemoteRemote/rmdirs
        	Messages:   	1 objects not found
2025/06/08 07:05:12 NOTICE: checking path2 Putio root 'rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2'
2025/06/08 07:05:12 NOTICE: (01)  : test rmdirs
2025/06/08 07:05:12 NOTICE: (02)  : test initial bisync
2025/06/08 07:05:12 NOTICE: (03)  : bisync resync
2025/06/08 07:05:14 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:05:14 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/08 07:05:14 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:14 INFO  : Copying Path2 files to Path1
2025/06/08 07:05:14 INFO  : - Path2    Resync is copying files to         - Path1
2025/06/08 07:05:14 INFO  : file1.copy3.txt: Copied (server-side copy)
2025/06/08 07:05:14 INFO  : - Path1    Resync is copying files to         - Path2
2025/06/08 07:05:14 INFO  : Resync updating listings
2025/06/08 07:05:14 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:14 INFO  : Bisync successful
2025/06/08 07:05:14 NOTICE: (04)  : test 1. delete path1 subdir file
2025/06/08 07:05:14 NOTICE: (05)  : delete-file TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/subdir/file20.txt
2025/06/08 07:05:15 NOTICE: (06)  : test 2. run bisync without remove-empty-dirs
2025/06/08 07:05:15 NOTICE: (07)  : bisync
2025/06/08 07:05:17 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:05: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/06/08 07:05:17 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:17 INFO  : Building Path1 and Path2 listings
2025/06/08 07:05:17 INFO  : Path1 checking for diffs
2025/06/08 07:05:17 INFO  : - Path1    File was deleted          - subdir/file20.txt
2025/06/08 07:05:17 INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/06/08 07:05:17 INFO  : Path2 checking for diffs
2025/06/08 07:05:17 INFO  : Applying changes
2025/06/08 07:05:17 INFO  : - Path2    Queue delete              - TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/subdir/file20.txt
2025/06/08 07:05:17 INFO  : - Path1    Do queued copies to                - Path2
2025/06/08 07:05:17 INFO  : subdir/file20.txt: Deleted
2025/06/08 07:05:17 INFO  : Updating listings
2025/06/08 07:05:17 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:17 INFO  : Bisync successful
2025/06/08 07:05:17 NOTICE: (08)  : test 3. confirm the subdir still exists on both paths
2025/06/08 07:05:17 NOTICE: (09)  : list-dirs TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/
2025/06/08 07:05:18 NOTICE: subdir/ - filename hash: 86ae37b338459868804e9697025ba4c2
2025/06/08 07:05:18 NOTICE: (10)  : list-dirs TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/
2025/06/08 07:05:18 NOTICE: subdir/ - filename hash: 86ae37b338459868804e9697025ba4c2
2025/06/08 07:05:18 NOTICE: (11)  : test 4. run bisync with remove-empty-dirs
2025/06/08 07:05:18 NOTICE: (12)  : bisync remove-empty-dirs
2025/06/08 07:05:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/06/08 07:05:20 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/08 07:05:20 INFO  : Synching Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" with Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:20 INFO  : Building Path1 and Path2 listings
2025/06/08 07:05:20 INFO  : Path1 checking for diffs
2025/06/08 07:05:20 INFO  : Path2 checking for diffs
2025/06/08 07:05:20 INFO  : No changes found
2025/06/08 07:05:20 INFO  : Updating listings
2025/06/08 07:05:20 INFO  : Validating listings for Path1 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/" vs Path2 "TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/"
2025/06/08 07:05:20 INFO  : Removing empty directories
2025/06/08 07:05:20 INFO  : subdir: Removing directory
2025/06/08 07:05:21 INFO  : subdir: Removing directory
2025/06/08 07:05:21 INFO  : Bisync successful
2025/06/08 07:05:21 NOTICE: (13)  : test 5. confirm the subdir has been removed on both paths
2025/06/08 07:05:21 NOTICE: (14)  : list-dirs TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path1/
2025/06/08 07:05:21 NOTICE: (15)  : list-dirs TestPutio:rclone-test-xadoqow6qaqe/070128lu/rmdirs/path2/
    bisync_test.go:560: TEST rmdirs PASSED
--- FAIL: TestBisyncRemoteRemote (233.70s)
    --- FAIL: TestBisyncRemoteRemote/check_access_filters (25.23s)
    --- FAIL: TestBisyncRemoteRemote/check_sync (29.24s)
    --- FAIL: TestBisyncRemoteRemote/dry_run (35.64s)
    --- FAIL: TestBisyncRemoteRemote/max_delete_path2_force (27.28s)
    --- FAIL: TestBisyncRemoteRemote/normalization (70.29s)
    --- FAIL: TestBisyncRemoteRemote/resync (20.88s)
    --- FAIL: TestBisyncRemoteRemote/rmdirs (24.69s)
FAIL
2025/06/08 07:05:22 NOTICE: purge failed: Rmdir: directory not found
"./bisync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^TestBisyncLocalRemote$/^(compare_all|max_delete_path2_force)$|^TestBisyncRemoteRemote$/^(check_access_filters|check_sync|dry_run|max_delete_path2_force|normalization|resync|rmdirs)$'" - Finished ERROR in 4m24.569540118s (try 5/5): exit status 1: Failed [TestBisyncLocalRemote/max_delete_path2_force TestBisyncRemoteRemote/check_access_filters TestBisyncRemoteRemote/check_sync TestBisyncRemoteRemote/dry_run TestBisyncRemoteRemote/max_delete_path2_force TestBisyncRemoteRemote/normalization TestBisyncRemoteRemote/resync TestBisyncRemoteRemote/rmdirs]