"./bisync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^TestBisyncLocalRemote$/^(compare_all|max_delete_path2_force|volatile)$|^TestBisyncRemoteRemote$/^(check_sync|ignorelistingchecksum|max_delete_path2_force|nomodtime|normalization)$'" - Starting (try 5/5)
=== RUN   TestBisyncLocalRemote
2025/05/28 02:08:37 NOTICE: remote: TestPutio:rclone-test-xokixag3layo
=== RUN   TestBisyncLocalRemote/compare_all
2025/05/28 02:08:38 ERROR : error listing: directory not found
2025/05/28 02:08:38 ERROR : error listing: directory not found
2025/05/28 02:08:38 NOTICE: checking initFs Local file system at /tmp/020837bi/initdir/test_compare_all-dobisah9
2025/05/28 02:08:39 NOTICE: checking Path1 Local file system at /tmp/020837bi/compare_all/path1
2025/05/28 02:08:40 ERROR : file4.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s112.put.io/files/4c4f1c76786bb40ecb5c7d8b11a574ef975b3313
2025/05/28 02:08:40 ERROR : file6.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s81.put.io/files/aa39f085ac2a920275d16a2acdb20de0a4373cd7
    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://s81.put.io/files/aa39f085ac2a920275d16a2acdb20de0a4373cd7
        	Test:       	TestBisyncLocalRemote/compare_all
        	Messages:   	setting up path2
2025/05/28 02:08:41 NOTICE: checking path2 Putio root 'rclone-test-xokixag3layo/020837bi/compare_all/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/compare_all
        	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), file2.txt (0), file3.txt (0), file5.txt (0), file7.txt (0), file8.txt (0)
    fstest.go:197: Not found "file4.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  : 2
        	Test:       	TestBisyncLocalRemote/compare_all
        	Messages:   	2 objects not found
2025/05/28 02:08:48 NOTICE: (01)  : test changes compare-all
2025/05/28 02:08:48 NOTICE: (02)  : test initial bisync
2025/05/28 02:08:48 NOTICE: (03)  : bisync resync compare-all
2025/05/28 02:08:49 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/05/28 02:08:49 INFO  : Synching Path1 "/tmp/020837bi/compare_all/path1/" with Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/"
2025/05/28 02:08:49 INFO  : Copying Path2 files to Path1
2025/05/28 02:08:49 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:08:50 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:08:50 ERROR : file6.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s85.put.io/files/883a9ab3de2b65cd25c34db5da9db289a1093216
2025/05/28 02:08:50 INFO  : file4.txt: Copied (new)
2025/05/28 02:08:50 ERROR : Bisync critical error: unexpected status code (404) response while doing PATCH to https://s85.put.io/files/883a9ab3de2b65cd25c34db5da9db289a1093216
2025/05/28 02:08:50 ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:08:50 NOTICE: Bisync error: bisync aborted
2025/05/28 02:08:50 NOTICE: (04)  : test make modifications on both paths
2025/05/28 02:08:50 NOTICE: (05)  : test new on path2 - file10
2025/05/28 02:08:50 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file10.txt TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/
2025/05/28 02:08:51 NOTICE: (07)  : test newer on path2 - file1
2025/05/28 02:08:51 NOTICE: (08)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file1.txt TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/
2025/05/28 02:08:52 NOTICE: (09)  : test new on path1 - file11
2025/05/28 02:08:52 NOTICE: (10)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file11.txt /tmp/020837bi/compare_all/path1/
2025/05/28 02:08:52 NOTICE: (11)  : test newer on path1 - file2
2025/05/28 02:08:52 NOTICE: (12)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file2.txt /tmp/020837bi/compare_all/path1/
2025/05/28 02:08:52 NOTICE: (13)  : test deleted on path2 - file3
2025/05/28 02:08:52 NOTICE: (14)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/file3.txt
2025/05/28 02:08:53 NOTICE: (15)  : test deleted on path1 - file4
2025/05/28 02:08:53 NOTICE: (16)  : delete-file /tmp/020837bi/compare_all/path1/file4.txt
2025/05/28 02:08:53 NOTICE: (17)  : test deleted on both paths - file8
2025/05/28 02:08:53 NOTICE: (18)  : delete-file /tmp/020837bi/compare_all/path1/file8.txt
2025/05/28 02:08:53 NOTICE: (19)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/file8.txt
2025/05/28 02:08:53 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/05/28 02:08:53 NOTICE: (21)  : touch-glob 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/ file5R.txt
2025/05/28 02:08:53 NOTICE: (22)  : copy-as /tmp/020837bi/datadir/test_compare_all-wimukod4/file5R.txt TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/ file5.txt
2025/05/28 02:08:54 NOTICE: (23)  : touch-glob 2001-03-04 /tmp/020837bi/datadir/test_compare_all-wimukod4/ file5L.txt
2025/05/28 02:08:54 NOTICE: (24)  : copy-as /tmp/020837bi/datadir/test_compare_all-wimukod4/file5L.txt /tmp/020837bi/compare_all/path1/ file5.txt
2025/05/28 02:08:54 NOTICE: (25)  : test newer on path2 and deleted on path1 - file6
2025/05/28 02:08:54 NOTICE: (26)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file6.txt TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/
2025/05/28 02:08:55 NOTICE: (27)  : delete-file /tmp/020837bi/compare_all/path1/file6.txt
2025/05/28 02:08:55 NOTICE: (28)  : test newer on path1 and deleted on path2 - file7
2025/05/28 02:08:55 NOTICE: (29)  : touch-copy 2001-01-02 /tmp/020837bi/datadir/test_compare_all-wimukod4/file7.txt /tmp/020837bi/compare_all/path1/
2025/05/28 02:08:55 NOTICE: (30)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/file7.txt
2025/05/28 02:08:56 NOTICE: (31)  : test bisync run
2025/05/28 02:08:56 NOTICE: (32)  : bisync compare-all
2025/05/28 02:08:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/05/28 02:08:56 INFO  : Synching Path1 "/tmp/020837bi/compare_all/path1/" with Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/compare_all/path2/"
2025/05/28 02:08:56 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/020837bi/workdir/tmp_020837bi_compare_all_path1..TestPutio_rclone-test-xokixag3layo_020837bi_compare_all_path2.path1.lst
Path2: /tmp/020837bi/workdir/tmp_020837bi_compare_all_path1..TestPutio_rclone-test-xokixag3layo_020837bi_compare_all_path2.path2.lst
Try running this command to inspect the work dir: 
rclone lsl "/tmp/020837bi/workdir"
2025/05/28 02:08:56 ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:08:56 NOTICE: Bisync error: bisync aborted
2025/05/28 02:08:56 NOTICE: ----------------------------------------------------------
2025/05/28 02:08:56 NOTICE: MISCOMPARE - Number of Golden and Results files do not match:
2025/05/28 02:08:56 NOTICE:   Golden count: 11
2025/05/28 02:08:56 NOTICE:   Result count: 3
2025/05/28 02:08:56 NOTICE:   Golden files: _testdir_path1.._testdir_path2.copy1to2.que, _testdir_path1.._testdir_path2.copy2to1.que, _testdir_path1.._testdir_path2.delete1.que, _testdir_path1.._testdir_path2.delete2.que, _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, test.log
2025/05/28 02:08:56 NOTICE:   Result files: _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path2.lst-new, test.log
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.copy1to2.que
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.copy2to1.que
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.delete1.que
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.delete2.que
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.path1.lst
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.path1.lst-old
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.path2.lst
2025/05/28 02:08:56 NOTICE:   File found in Golden but not in Results:  _testdir_path1.._testdir_path2.path2.lst-old
2025/05/28 02:08:56 NOTICE: ----------------------------------------------------------
2025/05/28 02:08:56 NOTICE: | MISCOMPARE  -Golden vs +Results for  _testdir_path1.._testdir_path2.path1.lst-new
2025/05/28 02:08:56 NOTICE: | @@ -1 +0,0 @@
2025/05/28 02:08:56 NOTICE: | --      109 - - 2000-01-01 00:00:00 +0000 UTC "\"RCLONE_TEST\""
2025/05/28 02:08:56 NOTICE: | @@ -3,12 +1,0 @@
2025/05/28 02:08:56 NOTICE: | --        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file1.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       19 - - 2001-01-02 00:00:00 +0000 UTC "\"file11.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       13 - - 2001-01-02 00:00:00 +0000 UTC "\"file2.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file3.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       39 - - 2001-03-04 00:00:00 +0000 UTC "\"file5.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       19 - - 2001-01-02 00:00:00 +0000 UTC "\"file7.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: ----------------------------------------------------------
2025/05/28 02:08:56 NOTICE: | MISCOMPARE  -Golden vs +Results for  _testdir_path1.._testdir_path2.path2.lst-new
2025/05/28 02:08:56 NOTICE: | @@ -1 +0,0 @@
2025/05/28 02:08:56 NOTICE: | --      109 - - 2000-01-01 00:00:00 +0000 UTC "\"RCLONE_TEST\""
2025/05/28 02:08:56 NOTICE: | @@ -3,12 +1,0 @@
2025/05/28 02:08:56 NOTICE: | --       19 - - 2001-01-02 00:00:00 +0000 UTC "\"file1.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       19 - - 2001-01-02 00:00:00 +0000 UTC "\"file10.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file2.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --        0 - - 2000-01-01 00:00:00 +0000 UTC "\"file4.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       39 - - 2001-01-02 00:00:00 +0000 UTC "\"file5.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: | --       19 - - 2001-01-02 00:00:00 +0000 UTC "\"file6.txt\""
2025/05/28 02:08:56 NOTICE: | -
2025/05/28 02:08:56 NOTICE: ----------------------------------------------------------
2025/05/28 02:08:56 NOTICE: | MISCOMPARE  -Golden vs +Results for  test.log
2025/05/28 02:08:56 NOTICE: | @@ -17,3 +17,4 @@
2025/05/28 02:08:56 NOTICE: | -INFO  : Resync updating listings
2025/05/28 02:08:56 NOTICE: | -INFO  : Validating listings for Path1 "{path1/}" vs Path2 "{path2/}"
2025/05/28 02:08:56 NOTICE: | -INFO  : Bisync successful
2025/05/28 02:08:56 NOTICE: | +ERROR : file6.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s85.put.io/files/883a9ab3de2b65cd25c34db5da9db289a1093216
2025/05/28 02:08:56 NOTICE: | +ERROR : Bisync critical error: unexpected status code (404) response while doing PATCH to https://s85.put.io/files/883a9ab3de2b65cd25c34db5da9db289a1093216
2025/05/28 02:08:56 NOTICE: | +ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:08:56 NOTICE: | +Bisync error: bisync aborted
2025/05/28 02:08:56 NOTICE: | @@ -59,40 +60,8 @@
2025/05/28 02:08:56 NOTICE: | -INFO  : Building Path1 and Path2 listings
2025/05/28 02:08:56 NOTICE: | -INFO  : Path1 checking for diffs
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File changed: size (larger), time (newer), hash - file2.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File was deleted          - file4.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File changed: size (larger), time (newer), hash - file5.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File was deleted          - file6.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File changed: size (larger), time (newer), hash - file7.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File was deleted          - file8.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    File is new               - file11.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/05/28 02:08:56 NOTICE: | -INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/05/28 02:08:56 NOTICE: | -INFO  : Path2 checking for diffs
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File changed: size (larger), time (newer), hash - file1.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File changed: size (larger), time (newer), hash - file5.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File changed: size (larger), time (newer), hash - file6.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File was deleted          - file7.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File was deleted          - file8.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    File is new               - file10.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/05/28 02:08:56 NOTICE: | -INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/05/28 02:08:56 NOTICE: | -INFO  : Applying changes
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    Queue copy to Path2       - {path2/}file11.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    Queue copy to Path2       - {path2/}file2.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    Queue delete              - {path2/}file4.txt
2025/05/28 02:08:56 NOTICE: | -NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/05/28 02:08:56 NOTICE: | -NOTICE: - Path1    Renaming Path1 copy                - {path1/}file5.txt.conflict1
2025/05/28 02:08:56 NOTICE: | -NOTICE: - Path1    Queue copy to Path2       - {path2/}file5.txt.conflict1
2025/05/28 02:08:56 NOTICE: | -NOTICE: - Path2    Renaming Path2 copy                - {path2/}file5.txt.conflict2
2025/05/28 02:08:56 NOTICE: | -NOTICE: - Path2    Queue copy to Path1       - {path1/}file5.txt.conflict2
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    Queue copy to Path1       - {path1/}file6.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    Queue copy to Path2       - {path2/}file7.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    Queue copy to Path1       - {path1/}file1.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    Queue copy to Path1       - {path1/}file10.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    Queue delete              - {path1/}file3.txt
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:08:56 NOTICE: | -INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:08:56 NOTICE: | -INFO  : Updating listings
2025/05/28 02:08:56 NOTICE: | -INFO  : Validating listings for Path1 "{path1/}" vs Path2 "{path2/}"
2025/05/28 02:08:56 NOTICE: | -INFO  : Bisync successful
2025/05/28 02:08:56 NOTICE: | +ERROR : Bisync critical error: cannot find prior Path1 or Path2 listings, likely due to critical error on prior run
2025/05/28 02:08:56 NOTICE: | +Tip: here are the filenames we were looking for. Do they exist?
2025/05/28 02:08:56 NOTICE: | +Path1: {workdir/}{session}.path1.lst
2025/05/28 02:08:56 NOTICE: | +Path2: {workdir/}{session}.path2.lst
2025/05/28 02:08:56 NOTICE: | +Try running this command to inspect the work dir:
2025/05/28 02:08:56 NOTICE: | +rclone lsl "{workdir}"
2025/05/28 02:08:56 NOTICE: | +ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:08:56 NOTICE: | +Bisync error: bisync aborted
2025/05/28 02:08:56 NOTICE: ----------------------------------------------------------
    bisync_test.go:560: TEST compare_all FAILED - 11 MISCOMPARED FILES
=== RUN   TestBisyncLocalRemote/max_delete_path2_force
2025/05/28 02:08:57 ERROR : error listing: directory not found
2025/05/28 02:08:57 ERROR : error listing: directory not found
2025/05/28 02:08:57 NOTICE: checking initFs Local file system at /tmp/020837bi/initdir/test_max_delete_path2_force-keqigef4
2025/05/28 02:08:57 NOTICE: checking Path1 Local file system at /tmp/020837bi/max_delete_path2_force/path1
2025/05/28 02:08:59 NOTICE: checking path2 Putio root 'rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2'
2025/05/28 02:08:59 NOTICE: (01)  : test max-delete-path2-force
2025/05/28 02:08:59 NOTICE: (02)  : test initial bisync
2025/05/28 02:08:59 NOTICE: (03)  : bisync resync
2025/05/28 02:09:00 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:00 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/05/28 02:09:00 INFO  : Synching Path1 "/tmp/020837bi/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/"
2025/05/28 02:09:00 INFO  : Copying Path2 files to Path1
2025/05/28 02:09:00 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:09:00 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:09:01 INFO  : Resync updating listings
2025/05/28 02:09:01 INFO  : Validating listings for Path1 "/tmp/020837bi/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/"
2025/05/28 02:09:01 INFO  : Bisync successful
2025/05/28 02:09:01 NOTICE: (04)  : test delete >50% of remote files
2025/05/28 02:09:01 NOTICE: (05)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/file1.txt
2025/05/28 02:09:01 NOTICE: (06)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/file2.txt
2025/05/28 02:09:01 NOTICE: (07)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/file3.txt
2025/05/28 02:09:01 NOTICE: (08)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/file4.txt
2025/05/28 02:09:02 NOTICE: (09)  : delete-file TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/file5.txt
2025/05/28 02:09:02 NOTICE: (10)  : test sync should fail due to too many path2 deletes
2025/05/28 02:09:02 NOTICE: (11)  : bisync
2025/05/28 02:09:03 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:03 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/05/28 02:09:03 INFO  : Synching Path1 "/tmp/020837bi/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/"
2025/05/28 02:09:03 INFO  : Building Path1 and Path2 listings
2025/05/28 02:09:03 INFO  : Path1 checking for diffs
2025/05/28 02:09:03 INFO  : Path2 checking for diffs
2025/05/28 02:09:03 INFO  : - Path2    File was deleted          - file1.txt
2025/05/28 02:09:03 INFO  : - Path2    File was deleted          - file2.txt
2025/05/28 02:09:03 INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:09:03 INFO  : - Path2    File was deleted          - file4.txt
2025/05/28 02:09:03 INFO  : - Path2    File was deleted          - file5.txt
2025/05/28 02:09:03 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/05/28 02:09:03 ERROR : Safety abort: too many deletes (>50%, 5 of 9) on Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/". Run with --force if desired.
2025/05/28 02:09:03 NOTICE: Bisync aborted. Please try again.
2025/05/28 02:09:03 NOTICE: Bisync error: too many deletes
2025/05/28 02:09:03 NOTICE: (12)  : copy-listings initial-fail
2025/05/28 02:09:03 NOTICE: (13)  : test apply force option. sync should run.
2025/05/28 02:09:03 NOTICE: (14)  : bisync force
2025/05/28 02:09:04 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:04 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": false
}
2025/05/28 02:09:04 INFO  : Synching Path1 "/tmp/020837bi/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/"
2025/05/28 02:09:04 INFO  : Building Path1 and Path2 listings
2025/05/28 02:09:04 INFO  : Path1 checking for diffs
2025/05/28 02:09:04 INFO  : Path2 checking for diffs
2025/05/28 02:09:04 INFO  : - Path2    File was deleted          - file1.txt
2025/05/28 02:09:04 INFO  : - Path2    File was deleted          - file2.txt
2025/05/28 02:09:04 INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:09:04 INFO  : - Path2    File was deleted          - file4.txt
2025/05/28 02:09:04 INFO  : - Path2    File was deleted          - file5.txt
2025/05/28 02:09:04 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/05/28 02:09:04 INFO  : Applying changes
2025/05/28 02:09:04 INFO  : - Path1    Queue delete              - /tmp/020837bi/max_delete_path2_force/path1/file1.txt
2025/05/28 02:09:04 INFO  : - Path1    Queue delete              - /tmp/020837bi/max_delete_path2_force/path1/file2.txt
2025/05/28 02:09:04 INFO  : - Path1    Queue delete              - /tmp/020837bi/max_delete_path2_force/path1/file3.txt
2025/05/28 02:09:04 INFO  : - Path1    Queue delete              - /tmp/020837bi/max_delete_path2_force/path1/file4.txt
2025/05/28 02:09:04 INFO  : - Path1    Queue delete              - /tmp/020837bi/max_delete_path2_force/path1/file5.txt
2025/05/28 02:09:04 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:09:04 INFO  : file2.txt: Deleted
2025/05/28 02:09:04 INFO  : file3.txt: Deleted
2025/05/28 02:09:04 INFO  : file5.txt: Deleted
2025/05/28 02:09:04 INFO  : file1.txt: Deleted
2025/05/28 02:09:04 INFO  : file4.txt: Deleted
2025/05/28 02:09:04 INFO  : Updating listings
2025/05/28 02:09:04 INFO  : Validating listings for Path1 "/tmp/020837bi/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-xokixag3layo/020837bi/max_delete_path2_force/path2/"
2025/05/28 02:09:04 INFO  : Bisync successful
    bisync_test.go:560: TEST max_delete_path2_force PASSED
=== RUN   TestBisyncLocalRemote/volatile
2025/05/28 02:09:04 ERROR : error listing: directory not found
2025/05/28 02:09:05 ERROR : error listing: directory not found
2025/05/28 02:09:05 NOTICE: checking initFs Local file system at /tmp/020837bi/initdir/test_volatile-civagan9
2025/05/28 02:09:05 NOTICE: checking Path1 Local file system at /tmp/020837bi/volatile/path1
2025/05/28 02:09:06 ERROR : file5.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s61.put.io/files/dac20b63c756497689a02fcc46dcff6389ca708e
    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://s61.put.io/files/dac20b63c756497689a02fcc46dcff6389ca708e
        	Test:       	TestBisyncLocalRemote/volatile
        	Messages:   	setting up path2
2025/05/28 02:09:07 NOTICE: checking path2 Putio root 'rclone-test-xokixag3layo/020837bi/volatile/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/volatile
        	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), file2.txt (0), file3.txt (0), file4.txt (0), file6.txt (0), file7.txt (0), file8.txt (0)
    fstest.go:197: Not found "file5.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  : 1
        	Test:       	TestBisyncLocalRemote/volatile
        	Messages:   	1 objects not found
2025/05/28 02:09:15 NOTICE: (01)  : test volatile
2025/05/28 02:09:15 NOTICE: (02)  : test initial bisync
2025/05/28 02:09:15 NOTICE: (03)  : bisync resync
    bisync_test.go:937: skipping 'volatile' test on non-local as it requires uploading 100 files
--- FAIL: TestBisyncLocalRemote (37.76s)
    --- FAIL: TestBisyncLocalRemote/compare_all (19.39s)
    --- PASS: TestBisyncLocalRemote/max_delete_path2_force (7.36s)
    --- FAIL: TestBisyncLocalRemote/volatile (10.64s)
=== RUN   TestBisyncRemoteRemote
2025/05/28 02:09:15 NOTICE: remote: TestPutio:rclone-test-savocan1johu
=== RUN   TestBisyncRemoteRemote/check_sync
2025/05/28 02:09:17 ERROR : error listing: directory not found
2025/05/28 02:09:17 ERROR : error listing: directory not found
2025/05/28 02:09:17 NOTICE: checking initFs Local file system at /tmp/020915hu/initdir/test_check_sync-vodocam9
2025/05/28 02:09:19 NOTICE: checking Path1 Putio root 'rclone-test-savocan1johu/020915hu/check_sync/path1'
2025/05/28 02:09:21 NOTICE: checking path2 Putio root 'rclone-test-savocan1johu/020915hu/check_sync/path2'
2025/05/28 02:09:21 NOTICE: (01)  : test check-sync
2025/05/28 02:09:21 NOTICE: (02)  : test initial bisync
2025/05/28 02:09:21 NOTICE: (03)  : bisync resync
2025/05/28 02:09:23 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:23 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:23 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:23 INFO  : Copying Path2 files to Path1
2025/05/28 02:09:23 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:09:23 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:09:23 INFO  : Resync updating listings
2025/05/28 02:09:23 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:23 INFO  : Bisync successful
2025/05/28 02:09:23 NOTICE: (04)  : test 1. run check-sync-only on a clean sync
2025/05/28 02:09:23 NOTICE: (05)  : bisync check-sync-only
2025/05/28 02:09:25 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:25 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:25 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:25 INFO  : Bisync successful
2025/05/28 02:09:25 NOTICE: (06)  : test 2. inject modified listings into the workdir
2025/05/28 02:09:25 NOTICE: (07)  : copy-as /tmp/020915hu/datadir/test_check_sync-pupakug7/_testdir_path1.._testdir_path2.path1.lst /tmp/020915hu/workdir/ TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path1..TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path2.path1.lst
2025/05/28 02:09:25 NOTICE: (08)  : copy-as /tmp/020915hu/datadir/test_check_sync-pupakug7/_testdir_path1.._testdir_path2.path2.lst /tmp/020915hu/workdir/ TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path1..TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path2.path2.lst
2025/05/28 02:09:25 NOTICE: (09)  : test 3. run check-sync-only on modified listings
2025/05/28 02:09:25 NOTICE: (10)  : bisync check-sync-only
2025/05/28 02:09:27 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09: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/05/28 02:09:27 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:27 ERROR : -          Path1 file not found in Path2      - file2.txt
2025/05/28 02:09:27 ERROR : -          Path2 file not found in Path1      - file1.txt
2025/05/28 02:09:27 ERROR : Bisync critical error: path1 and path2 are out of sync, run --resync to recover
2025/05/28 02:09:27 ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:09:27 NOTICE: Bisync error: bisync aborted
2025/05/28 02:09:27 NOTICE: (11)  : copy-listings check-sync-only
2025/05/28 02:09:27 NOTICE: (12)  : test 4. run normal sync to check that it aborts
2025/05/28 02:09:27 NOTICE: (13)  : bisync
2025/05/28 02:09:29 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:29 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:29 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:29 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/020915hu/workdir/TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path1..TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path2.path1.lst
Path2: /tmp/020915hu/workdir/TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path1..TestPutio_rclone-test-savocan1johu_020915hu_check_sync_path2.path2.lst
Try running this command to inspect the work dir: 
rclone lsl "/tmp/020915hu/workdir"
2025/05/28 02:09:29 ERROR : Bisync aborted. Must run --resync to recover.
2025/05/28 02:09:29 NOTICE: Bisync error: bisync aborted
2025/05/28 02:09:29 NOTICE: (14)  : test 5. prune failure listings after critical abort
2025/05/28 02:09:29 NOTICE: (15)  : delete-glob /tmp/020915hu/workdir/ *.lst
2025/05/28 02:09:29 NOTICE: (16)  : delete-glob /tmp/020915hu/workdir/ *.lst-err
2025/05/28 02:09:29 NOTICE: (17)  : delete-glob /tmp/020915hu/workdir/ *.lst-new
2025/05/28 02:09:29 NOTICE: (18)  : test 6. run resync
2025/05/28 02:09:29 NOTICE: (19)  : bisync resync
2025/05/28 02:09:30 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:30 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:30 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:30 INFO  : Copying Path2 files to Path1
2025/05/28 02:09:30 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:09:31 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:09:31 INFO  : Resync updating listings
2025/05/28 02:09:31 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:31 INFO  : Bisync successful
2025/05/28 02:09:31 NOTICE: (20)  : test 7. run normal sync with check-sync enabled (default)
2025/05/28 02:09:31 NOTICE: (21)  : bisync
2025/05/28 02:09:32 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:32 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:32 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:32 INFO  : Building Path1 and Path2 listings
2025/05/28 02:09:33 INFO  : Path1 checking for diffs
2025/05/28 02:09:33 INFO  : Path2 checking for diffs
2025/05/28 02:09:33 INFO  : No changes found
2025/05/28 02:09:33 INFO  : Updating listings
2025/05/28 02:09:33 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:33 INFO  : Bisync successful
2025/05/28 02:09:33 NOTICE: (22)  : test 8. run normal sync with no-check-sync
2025/05/28 02:09:33 NOTICE: (23)  : bisync no-check-sync
2025/05/28 02:09:34 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09:34 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:34 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/check_sync/path2/"
2025/05/28 02:09:34 INFO  : Building Path1 and Path2 listings
2025/05/28 02:09:34 INFO  : Path1 checking for diffs
2025/05/28 02:09:34 INFO  : Path2 checking for diffs
2025/05/28 02:09:34 INFO  : No changes found
2025/05/28 02:09:34 INFO  : Updating listings
2025/05/28 02:09:34 INFO  : Bisync successful
    bisync_test.go:560: TEST check_sync PASSED
=== RUN   TestBisyncRemoteRemote/ignorelistingchecksum
2025/05/28 02:09:36 ERROR : error listing: directory not found
2025/05/28 02:09:36 ERROR : error listing: directory not found
2025/05/28 02:09:36 NOTICE: checking initFs Local file system at /tmp/020915hu/initdir/test_ignorelistingchecksum-pohugit1
2025/05/28 02:09:38 NOTICE: checking Path1 Putio root 'rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1'
2025/05/28 02:09:39 ERROR : file1.copy1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s71.put.io/files/7eab944f3207fe1ffb3f015a69969dd58d5c35db
    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://s71.put.io/files/7eab944f3207fe1ffb3f015a69969dd58d5c35db
        	Test:       	TestBisyncRemoteRemote/ignorelistingchecksum
        	Messages:   	setting up path2
2025/05/28 02:09:40 NOTICE: checking path2 Putio root 'rclone-test-savocan1johu/020915hu/ignorelistingchecksum/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/ignorelistingchecksum
        	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.copy2.txt (0), file1.copy3.txt (0), file1.copy4.txt (0), file1.copy5.txt (0), file1.txt (0), subdir/file20.txt (0)
    fstest.go:197: Not found "file1.copy1.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  : 1
        	Test:       	TestBisyncRemoteRemote/ignorelistingchecksum
        	Messages:   	1 objects not found
2025/05/28 02:09:47 NOTICE: (01)  : test basic
2025/05/28 02:09:47 NOTICE: (02)  : test initial bisync
2025/05/28 02:09:47 NOTICE: (03)  : bisync resync
2025/05/28 02:09:49 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:09: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/05/28 02:09:49 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:49 INFO  : Copying Path2 files to Path1
2025/05/28 02:09:49 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:09:49 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:09:50 INFO  : file1.copy1.txt: Copied (server-side copy)
2025/05/28 02:09:50 INFO  : Resync updating listings
2025/05/28 02:09:50 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:50 INFO  : Bisync successful
2025/05/28 02:09:50 NOTICE: (04)  : bisync resync ignore-listing-checksum
2025/05/28 02:09:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:52 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:52 INFO  : Copying Path2 files to Path1
2025/05/28 02:09:52 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:09:52 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:09:52 INFO  : Resync updating listings
2025/05/28 02:09:52 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:52 INFO  : Bisync successful
2025/05/28 02:09:52 NOTICE: (05)  : test place newer files on both paths
2025/05/28 02:09:52 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/020915hu/datadir/test_ignorelistingchecksum-vasinil4/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/
2025/05/28 02:09:53 NOTICE: (07)  : copy-as /tmp/020915hu/datadir/test_ignorelistingchecksum-vasinil4/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/subdir file20.txt
2025/05/28 02:09:54 NOTICE: (08)  : test bisync run
2025/05/28 02:09:54 NOTICE: (09)  : bisync ignore-listing-checksum
2025/05/28 02:09:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:09:56 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:56 INFO  : Building Path1 and Path2 listings
2025/05/28 02:09:56 INFO  : Path1 checking for diffs
2025/05/28 02:09:56 INFO  : - Path1    File changed: size (larger), time (newer) - subdir/file20.txt
2025/05/28 02:09:56 INFO  : Path1:    1 changes:    0 new,    1 modified,    0 deleted
2025/05/28 02:09:56 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/05/28 02:09:56 INFO  : Path2 checking for diffs
2025/05/28 02:09:56 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/05/28 02:09:56 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/05/28 02:09:56 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/05/28 02:09:56 INFO  : Applying changes
2025/05/28 02:09:56 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/subdir/file20.txt
2025/05/28 02:09:56 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/file1.txt
2025/05/28 02:09:56 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:09:56 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:09:56 INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:09:57 INFO  : subdir/file20.txt: Copied (server-side copy)
2025/05/28 02:09:57 INFO  : Updating listings
2025/05/28 02:09:57 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/ignorelistingchecksum/path2/"
2025/05/28 02:09:57 INFO  : Bisync successful
    bisync_test.go:560: TEST ignorelistingchecksum PASSED
=== RUN   TestBisyncRemoteRemote/max_delete_path2_force
2025/05/28 02:09:58 ERROR : error listing: directory not found
2025/05/28 02:09:58 ERROR : error listing: directory not found
2025/05/28 02:09:58 NOTICE: checking initFs Local file system at /tmp/020915hu/initdir/test_max_delete_path2_force-wizocog4
2025/05/28 02:10:00 ERROR : file3.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s61.put.io/files/1fcfeac675db1106abd07134eaa23549a0ef868d
    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://s61.put.io/files/1fcfeac675db1106abd07134eaa23549a0ef868d
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	setting up path1
2025/05/28 02:10:01 NOTICE: checking Path1 Putio root 'rclone-test-savocan1johu/020915hu/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/05/28 02:10:10 ERROR : file1.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s92.put.io/files/5bb3fd043ee7b6b8286f49e7796dc8c348ed277c
2025/05/28 02:10:10 ERROR : file8.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s94.put.io/files/df3c7f11823539062c732e40b1dc362a092b4e21
2025/05/28 02:10:10 ERROR : file5.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s68.put.io/files/fd2c51b663b684cc21c5ec55f29ff39e8e3f67a7
    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://s68.put.io/files/fd2c51b663b684cc21c5ec55f29ff39e8e3f67a7
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	setting up path2
2025/05/28 02:10:11 NOTICE: checking path2 Putio root 'rclone-test-savocan1johu/020915hu/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:       	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
        	            	  file2.txt (0), file3.txt (0), file4.txt (0), file6.txt (0), file7.txt (0), file9.txt (109)
    fstest.go:197: Not found "file1.txt"
    fstest.go:197: Not found "file5.txt"
    fstest.go:197: Not found "file8.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  : 3
        	Test:       	TestBisyncRemoteRemote/max_delete_path2_force
        	Messages:   	3 objects not found
2025/05/28 02:10:18 NOTICE: (01)  : test max-delete-path2-force
2025/05/28 02:10:18 NOTICE: (02)  : test initial bisync
2025/05/28 02:10:18 NOTICE: (03)  : bisync resync
2025/05/28 02:10:20 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:10: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/05/28 02:10:20 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/"
2025/05/28 02:10:20 INFO  : Copying Path2 files to Path1
2025/05/28 02:10:20 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:10:21 INFO  : file3.txt: Copied (server-side copy)
2025/05/28 02:10:21 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:10:21 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:10:21 INFO  : file5.txt: Copied (server-side copy)
2025/05/28 02:10:21 INFO  : file8.txt: Copied (server-side copy)
2025/05/28 02:10:21 INFO  : Resync updating listings
2025/05/28 02:10:21 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/"
2025/05/28 02:10:21 INFO  : Bisync successful
2025/05/28 02:10:21 NOTICE: (04)  : test delete >50% of remote files
2025/05/28 02:10:21 NOTICE: (05)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/file1.txt
2025/05/28 02:10:22 NOTICE: (06)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/file2.txt
2025/05/28 02:10:22 NOTICE: (07)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/file3.txt
2025/05/28 02:10:22 NOTICE: (08)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/file4.txt
2025/05/28 02:10:22 NOTICE: (09)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/file5.txt
2025/05/28 02:10:22 NOTICE: (10)  : test sync should fail due to too many path2 deletes
2025/05/28 02:10:22 NOTICE: (11)  : bisync
2025/05/28 02:10:24 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:10:24 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:10:24 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/"
2025/05/28 02:10:24 INFO  : Building Path1 and Path2 listings
2025/05/28 02:10:24 INFO  : Path1 checking for diffs
2025/05/28 02:10:24 INFO  : Path2 checking for diffs
2025/05/28 02:10:24 INFO  : - Path2    File was deleted          - file1.txt
2025/05/28 02:10:24 INFO  : - Path2    File was deleted          - file2.txt
2025/05/28 02:10:24 INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:10:24 INFO  : - Path2    File was deleted          - file4.txt
2025/05/28 02:10:24 INFO  : - Path2    File was deleted          - file5.txt
2025/05/28 02:10:24 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/05/28 02:10:24 ERROR : Safety abort: too many deletes (>50%, 5 of 9) on Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/". Run with --force if desired.
2025/05/28 02:10:24 NOTICE: Bisync aborted. Please try again.
2025/05/28 02:10:24 NOTICE: Bisync error: too many deletes
2025/05/28 02:10:24 NOTICE: (12)  : copy-listings initial-fail
2025/05/28 02:10:24 NOTICE: (13)  : test apply force option. sync should run.
2025/05/28 02:10:24 NOTICE: (14)  : bisync force
2025/05/28 02:10:26 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:10:26 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:10:26 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/"
2025/05/28 02:10:26 INFO  : Building Path1 and Path2 listings
2025/05/28 02:10:26 INFO  : Path1 checking for diffs
2025/05/28 02:10:26 INFO  : Path2 checking for diffs
2025/05/28 02:10:26 INFO  : - Path2    File was deleted          - file1.txt
2025/05/28 02:10:26 INFO  : - Path2    File was deleted          - file2.txt
2025/05/28 02:10:26 INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:10:26 INFO  : - Path2    File was deleted          - file4.txt
2025/05/28 02:10:26 INFO  : - Path2    File was deleted          - file5.txt
2025/05/28 02:10:26 INFO  : Path2:    5 changes:    0 new,    0 modified,    5 deleted
2025/05/28 02:10:26 INFO  : Applying changes
2025/05/28 02:10:26 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/file1.txt
2025/05/28 02:10:26 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/file2.txt
2025/05/28 02:10:26 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/file3.txt
2025/05/28 02:10:26 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/file4.txt
2025/05/28 02:10:26 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/file5.txt
2025/05/28 02:10:26 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:10:26 INFO  : file1.txt: Deleted
2025/05/28 02:10:26 INFO  : file5.txt: Deleted
2025/05/28 02:10:27 INFO  : file2.txt: Deleted
2025/05/28 02:10:28 INFO  : file3.txt: Deleted
2025/05/28 02:10:29 INFO  : file4.txt: Deleted
2025/05/28 02:10:29 INFO  : Updating listings
2025/05/28 02:10:29 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/max_delete_path2_force/path2/"
2025/05/28 02:10:29 INFO  : Bisync successful
    bisync_test.go:560: TEST max_delete_path2_force PASSED
=== RUN   TestBisyncRemoteRemote/nomodtime
2025/05/28 02:10:31 ERROR : error listing: directory not found
2025/05/28 02:10:31 ERROR : error listing: directory not found
2025/05/28 02:10:31 NOTICE: checking initFs Local file system at /tmp/020915hu/initdir/test_nomodtime-fibemoz2
2025/05/28 02:10:33 NOTICE: checking Path1 Putio root 'rclone-test-savocan1johu/020915hu/nomodtime/path1'
2025/05/28 02:10:35 ERROR : file4.txt: Failed to copy: unexpected status code (404) response while doing PATCH to https://s78.put.io/files/f10531b159ac98256ec2010c7bad52fa0ea675e5
    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://s78.put.io/files/f10531b159ac98256ec2010c7bad52fa0ea675e5
        	Test:       	TestBisyncRemoteRemote/nomodtime
        	Messages:   	setting up path2
2025/05/28 02:10:35 NOTICE: checking path2 Putio root 'rclone-test-savocan1johu/020915hu/nomodtime/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/nomodtime
        	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), file2.txt (0), file3.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0)
    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  : 1
        	Test:       	TestBisyncRemoteRemote/nomodtime
        	Messages:   	1 objects not found
2025/05/28 02:10:43 NOTICE: (01)  : test changes
2025/05/28 02:10:43 NOTICE: (02)  : test initial bisync
2025/05/28 02:10:43 NOTICE: (03)  : bisync resync nomodtime
2025/05/28 02:10:45 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": false,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": true
}
2025/05/28 02:10:45 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/"
2025/05/28 02:10:45 INFO  : Copying Path2 files to Path1
2025/05/28 02:10:45 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:10:45 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:10:45 INFO  : file4.txt: Copied (server-side copy)
2025/05/28 02:10:45 INFO  : Resync updating listings
2025/05/28 02:10:45 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/"
2025/05/28 02:10:45 INFO  : Bisync successful
2025/05/28 02:10:45 NOTICE: (04)  : test make modifications on both paths
2025/05/28 02:10:45 NOTICE: (05)  : test new on path2 - file10
2025/05/28 02:10:45 NOTICE: (06)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file10.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/
2025/05/28 02:10:46 NOTICE: (07)  : test changed on path2 - file1
2025/05/28 02:10:46 NOTICE: (08)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/
2025/05/28 02:10:47 NOTICE: (09)  : test new on path1 - file11
2025/05/28 02:10:47 NOTICE: (10)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file11.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/
2025/05/28 02:10:48 NOTICE: (11)  : test changed on path1 - file2
2025/05/28 02:10:48 NOTICE: (12)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file2.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/
2025/05/28 02:10:49 NOTICE: (13)  : test deleted on path2 - file3
2025/05/28 02:10:49 NOTICE: (14)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file3.txt
2025/05/28 02:10:50 NOTICE: (15)  : test deleted on path1 - file4
2025/05/28 02:10:50 NOTICE: (16)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file4.txt
2025/05/28 02:10:50 NOTICE: (17)  : test deleted on both paths - file8
2025/05/28 02:10:50 NOTICE: (18)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file8.txt
2025/05/28 02:10:51 NOTICE: (19)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file8.txt
2025/05/28 02:10:51 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/05/28 02:10:51 NOTICE: (21)  : copy-as /tmp/020915hu/datadir/test_nomodtime-bijibop8/file5R.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/ file5.txt
2025/05/28 02:10:52 NOTICE: (22)  : copy-as /tmp/020915hu/datadir/test_nomodtime-bijibop8/file5L.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/ file5.txt
2025/05/28 02:10:53 NOTICE: (23)  : test changed on path2 and deleted on path1 - file6
2025/05/28 02:10:53 NOTICE: (24)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file6.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/
2025/05/28 02:10:54 NOTICE: (25)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file6.txt
2025/05/28 02:10:54 NOTICE: (26)  : test changed on path1 and deleted on path2 - file7
2025/05/28 02:10:54 NOTICE: (27)  : copy-file /tmp/020915hu/datadir/test_nomodtime-bijibop8/file7.txt TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/
2025/05/28 02:10:56 NOTICE: (28)  : delete-file TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file7.txt
2025/05/28 02:10:56 NOTICE: (29)  : test bisync run
2025/05/28 02:10:56 NOTICE: (30)  : bisync nomodtime
2025/05/28 02:10:58 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": false,
	"Size": true,
	"Checksum": true,
	"HashType1": 8,
	"HashType2": 8,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": true
}
2025/05/28 02:10:58 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/"
2025/05/28 02:10:58 INFO  : Building Path1 and Path2 listings
2025/05/28 02:10:58 INFO  : Path1 checking for diffs
2025/05/28 02:10:58 INFO  : - Path1    File changed: size (larger), hash - file2.txt
2025/05/28 02:10:58 INFO  : - Path1    File was deleted          - file4.txt
2025/05/28 02:10:58 INFO  : - Path1    File changed: size (larger), hash - file5.txt
2025/05/28 02:10:58 INFO  : - Path1    File was deleted          - file6.txt
2025/05/28 02:10:58 INFO  : - Path1    File changed: size (larger), hash - file7.txt
2025/05/28 02:10:58 INFO  : - Path1    File was deleted          - file8.txt
2025/05/28 02:10:58 INFO  : - Path1    File is new               - file11.txt
2025/05/28 02:10:58 INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/05/28 02:10:58 INFO  : (Modified:    3 larger,    0 smaller,    3 hash differs)
2025/05/28 02:10:58 INFO  : Path2 checking for diffs
2025/05/28 02:10:58 INFO  : - Path2    File changed: size (larger), hash - file1.txt
2025/05/28 02:10:58 INFO  : - Path2    File was deleted          - file3.txt
2025/05/28 02:10:58 INFO  : - Path2    File changed: size (larger), hash - file5.txt
2025/05/28 02:10:58 INFO  : - Path2    File changed: size (larger), hash - file6.txt
2025/05/28 02:10:58 INFO  : - Path2    File was deleted          - file7.txt
2025/05/28 02:10:58 INFO  : - Path2    File was deleted          - file8.txt
2025/05/28 02:10:58 INFO  : - Path2    File is new               - file10.txt
2025/05/28 02:10:58 INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/05/28 02:10:58 INFO  : (Modified:    3 larger,    0 smaller,    3 hash differs)
2025/05/28 02:10:58 INFO  : Applying changes
2025/05/28 02:10:58 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file11.txt
2025/05/28 02:10:58 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file2.txt
2025/05/28 02:10:58 INFO  : - Path2    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file4.txt
2025/05/28 02:10:58 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/05/28 02:10:58 NOTICE: - Path1    Renaming Path1 copy                - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file5.txt.conflict1
2025/05/28 02:10:58 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/05/28 02:10:58 NOTICE: - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file5.txt.conflict1
2025/05/28 02:10:58 NOTICE: - Path2    Renaming Path2 copy                - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file5.txt.conflict2
2025/05/28 02:10:58 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/05/28 02:10:58 NOTICE: - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file5.txt.conflict2
2025/05/28 02:10:58 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file6.txt
2025/05/28 02:10:58 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/file7.txt
2025/05/28 02:10:58 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file1.txt
2025/05/28 02:10:58 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file10.txt
2025/05/28 02:10:58 INFO  : - Path1    Queue delete              - TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/file3.txt
2025/05/28 02:10:58 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:10:59 INFO  : file10.txt: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file5.txt.conflict2: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file6.txt: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file3.txt: Deleted
2025/05/28 02:10:59 INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:10:59 INFO  : file11.txt: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file7.txt: Copied (server-side copy)
2025/05/28 02:10:59 INFO  : file2.txt: Copied (server-side copy)
2025/05/28 02:11:00 INFO  : file5.txt.conflict1: Copied (server-side copy)
2025/05/28 02:11:00 INFO  : file4.txt: Deleted
2025/05/28 02:11:00 INFO  : Updating listings
2025/05/28 02:11:00 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/nomodtime/path2/"
2025/05/28 02:11:00 INFO  : Bisync successful
    bisync_test.go:560: TEST nomodtime PASSED
=== RUN   TestBisyncRemoteRemote/normalization
2025/05/28 02:11:02 ERROR : error listing: directory not found
2025/05/28 02:11:02 ERROR : error listing: directory not found
2025/05/28 02:11:02 NOTICE: checking initFs Local file system at /tmp/020915hu/initdir/test_normalization-qumanoy1
2025/05/28 02:11:04 NOTICE: checking Path1 Putio root 'rclone-test-savocan1johu/020915hu/normalization/path1'
2025/05/28 02:11:06 NOTICE: checking path2 Putio root 'rclone-test-savocan1johu/020915hu/normalization/path2'
2025/05/28 02:11:06 NOTICE: (01)  : test normalization
2025/05/28 02:11:06 NOTICE: (02)  : touch-copy 2001-01-02 /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:07 NOTICE: (03)  : test initial bisync
2025/05/28 02:11:07 NOTICE: (04)  : bisync resync
2025/05/28 02:11:13 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:11:13 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:11:13 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:13 INFO  : Copying Path2 files to Path1
2025/05/28 02:11:13 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:11:13 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:11:13 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:11:13 INFO  : Resync updating listings
2025/05/28 02:11:13 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:13 INFO  : Bisync successful
2025/05/28 02:11:13 NOTICE: (05)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/05/28 02:11:15 NOTICE: (06)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/folder éééö.txt
2025/05/28 02:11:17 NOTICE: (07)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/folder HeLlO,wOrLd!.txt
2025/05/28 02:11:18 NOTICE: (08)  : touch-copy 2001-01-03 /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:19 NOTICE: (09)  : copy-as-NFD /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/folder éééö.txt
2025/05/28 02:11:21 NOTICE: (10)  : copy-as-NFD /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/folder hello,WORLD!.txt
2025/05/28 02:11:22 NOTICE: (11)  : test bisync run with fix-case
2025/05/28 02:11:22 NOTICE: (12)  : bisync fix-case
2025/05/28 02:11:27 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:11: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/05/28 02:11:27 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:27 INFO  : Building Path1 and Path2 listings
2025/05/28 02:11:27 INFO  : Path1 checking for diffs
2025/05/28 02:11:27 INFO  : - Path1    File is new               - folder/HeLlO,wOrLd!.txt
2025/05/28 02:11:27 INFO  : - Path1    File is new               - folder/éééö.txt
2025/05/28 02:11:27 INFO  : - Path1    File is new               - "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:11:27 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/05/28 02:11:27 INFO  : Path2 checking for diffs
2025/05/28 02:11:27 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/05/28 02:11:27 INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/05/28 02:11:27 INFO  : - Path2    File is new               - folder/éééö.txt
2025/05/28 02:11:27 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/05/28 02:11:27 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/05/28 02:11:27 INFO  : Applying changes
2025/05/28 02:11:27 INFO  : Checking potential conflicts...
2025/05/28 02:11:27 NOTICE: Putio root 'rclone-test-savocan1johu/020915hu/normalization/path2': 0 differences found
2025/05/28 02:11:27 NOTICE: Putio root 'rclone-test-savocan1johu/020915hu/normalization/path2': 2 matching files
2025/05/28 02:11:27 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/05/28 02:11:27 NOTICE: - WARNING  New or changed in both paths       - folder/HeLlO,wOrLd!.txt
2025/05/28 02:11:27 INFO  : folder/hello,WORLD!.txt: Files are equal but will copy anyway to fix case to folder/HeLlO,wOrLd!.txt
2025/05/28 02:11:27 NOTICE: - WARNING  New or changed in both paths       - folder/éééö.txt
2025/05/28 02:11:27 INFO  : folder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/05/28 02:11:27 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/folder/éééö.txt
2025/05/28 02:11:27 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:11:27 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/file1.txt
2025/05/28 02:11:27 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:11:27 INFO  : folder/éééö.txt: Updated modification time in destination
2025/05/28 02:11:27 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:11:27 INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:11:28 INFO  : folder/HeLlO,wOrLd!.txt: Updated modification time in destination
2025/05/28 02:11:28 INFO  : folder/hello,WORLD!.txt: Moved (server-side) to: folder/HeLlO,wOrLd!.txt
2025/05/28 02:11:28 INFO  : folder/hello,WORLD!.txt: Fixed case by renaming to: folder/HeLlO,wOrLd!.txt
2025/05/28 02:11:28 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy)
2025/05/28 02:11:28 INFO  : Updating listings
2025/05/28 02:11:28 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:28 INFO  : Bisync successful
2025/05/28 02:11:28 NOTICE: (13)  : purge-children TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/
2025/05/28 02:11:29 NOTICE: (14)  : purge-children TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:29 NOTICE: (15)  : touch-copy 2001-01-02 /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:30 NOTICE: (16)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/ file2.txt
2025/05/28 02:11:31 NOTICE: (17)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/ file3.txt
2025/05/28 02:11:32 NOTICE: (18)  : bisync resync
2025/05/28 02:11:37 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:11: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/05/28 02:11:37 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:37 INFO  : Copying Path2 files to Path1
2025/05/28 02:11:37 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:11:38 INFO  : file1.txt: Copied (server-side copy)
2025/05/28 02:11:38 INFO  : file2.txt: Copied (server-side copy)
2025/05/28 02:11:38 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:11:38 INFO  : file3.txt: Copied (server-side copy)
2025/05/28 02:11:38 INFO  : Resync updating listings
2025/05/28 02:11:38 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:38 INFO  : Bisync successful
2025/05/28 02:11:38 NOTICE: (19)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/05/28 02:11:40 NOTICE: (20)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder éééö.txt
2025/05/28 02:11:41 NOTICE: (21)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/05/28 02:11:42 NOTICE: (22)  : touch-copy 2001-01-03 /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:43 NOTICE: (23)  : copy-as-NFD /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/newfolder éééö.txt
2025/05/28 02:11:44 NOTICE: (24)  : copy-as-NFD /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/newfolder hello,WORLD!.txt
2025/05/28 02:11:46 NOTICE: (25)  : test bisync run with normalization
2025/05/28 02:11:46 NOTICE: (26)  : bisync norm force
2025/05/28 02:11:50 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:11: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/05/28 02:11:50 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:50 INFO  : Building Path1 and Path2 listings
2025/05/28 02:11:50 INFO  : Path1 checking for diffs
2025/05/28 02:11:50 INFO  : - Path1    File is new               - newfolder/HeLlO,wOrLd!.txt
2025/05/28 02:11:50 INFO  : - Path1    File is new               - newfolder/éééö.txt
2025/05/28 02:11:50 INFO  : - Path1    File is new               - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:11:50 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/05/28 02:11:50 INFO  : Path2 checking for diffs
2025/05/28 02:11:50 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/05/28 02:11:50 INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/05/28 02:11:50 INFO  : - Path2    File is new               - newfolder/éééö.txt
2025/05/28 02:11:50 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/05/28 02:11:50 INFO  : (Modified:    1 newer,    0 older)
2025/05/28 02:11:50 INFO  : Applying changes
2025/05/28 02:11:50 INFO  : Checking potential conflicts...
2025/05/28 02:11:50 NOTICE: Putio root 'rclone-test-savocan1johu/020915hu/normalization/path2': 0 differences found
2025/05/28 02:11:50 NOTICE: Putio root 'rclone-test-savocan1johu/020915hu/normalization/path2': 2 matching files
2025/05/28 02:11:50 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/05/28 02:11:50 NOTICE: - WARNING  New or changed in both paths       - newfolder/HeLlO,wOrLd!.txt
2025/05/28 02:11:50 INFO  : newfolder/HeLlO,wOrLd!.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/05/28 02:11:50 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder/HeLlO,wOrLd!.txt
2025/05/28 02:11:50 NOTICE: - WARNING  New or changed in both paths       - newfolder/éééö.txt
2025/05/28 02:11:50 INFO  : newfolder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/05/28 02:11:50 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder/éééö.txt
2025/05/28 02:11:50 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:11:50 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/file1.txt
2025/05/28 02:11:50 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:11:51 INFO  : file1.txt: Updated modification time in destination
2025/05/28 02:11:51 INFO  : newfolder/éééö.txt: Updated modification time in destination
2025/05/28 02:11:51 INFO  : newfolder/hello,WORLD!.txt: Updated modification time in destination
2025/05/28 02:11:51 INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:11:51 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy)
2025/05/28 02:11:51 INFO  : Updating listings
2025/05/28 02:11:51 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:51 INFO  : Bisync successful
2025/05/28 02:11:51 NOTICE: (27)  : test resync
2025/05/28 02:11:51 NOTICE: (28)  : bisync resync norm
2025/05/28 02:11:56 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:11:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:11:56 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:56 INFO  : Copying Path2 files to Path1
2025/05/28 02:11:56 INFO  : - Path2    Resync is copying files to         - Path1
2025/05/28 02:11:56 INFO  : - Path1    Resync is copying files to         - Path2
2025/05/28 02:11:57 INFO  : Resync updating listings
2025/05/28 02:11:57 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:11:57 INFO  : Bisync successful
2025/05/28 02:11:57 NOTICE: (29)  : test changed on one path
2025/05/28 02:11:57 NOTICE: (30)  : touch-copy 2001-01-05 /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/
2025/05/28 02:11:57 NOTICE: (31)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/05/28 02:11:58 NOTICE: (32)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder éééö.txt
2025/05/28 02:11:58 NOTICE: (33)  : copy-as-NFC /tmp/020915hu/datadir/test_normalization-nupiriq6/file1.txt TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/05/28 02:11:59 NOTICE: (34)  : bisync norm
2025/05/28 02:12:04 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/05/28 02:12:04 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/05/28 02:12:04 INFO  : Synching Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" with Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:12:04 INFO  : Building Path1 and Path2 listings
2025/05/28 02:12:05 INFO  : Path1 checking for diffs
2025/05/28 02:12:05 INFO  : - Path1    File changed: time (newer) - newfolder/HeLlO,wOrLd!.txt
2025/05/28 02:12:05 INFO  : - Path1    File changed: time (newer) - newfolder/éééö.txt
2025/05/28 02:12:05 INFO  : - Path1    File changed: time (newer) - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:12:05 INFO  : Path1:    3 changes:    0 new,    3 modified,    0 deleted
2025/05/28 02:12:05 INFO  : (Modified:    3 newer,    0 older)
2025/05/28 02:12:05 INFO  : Path2 checking for diffs
2025/05/28 02:12:05 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/05/28 02:12:05 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/05/28 02:12:05 INFO  : (Modified:    1 newer,    0 older)
2025/05/28 02:12:05 INFO  : Applying changes
2025/05/28 02:12:05 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/newfolder/hello,WORLD!.txt
2025/05/28 02:12:05 INFO  : - Path1    Queue copy to Path2       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/newfolder/éééö.txt
2025/05/28 02:12:05 INFO  : - Path1    Queue copy to Path2       - "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/05/28 02:12:05 INFO  : - Path2    Queue copy to Path1       - TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/file1.txt
2025/05/28 02:12:05 INFO  : - Path2    Do queued copies to                - Path1
2025/05/28 02:12:05 INFO  : file1.txt: Updated modification time in destination
2025/05/28 02:12:05 INFO  : - Path1    Do queued copies to                - Path2
2025/05/28 02:12:05 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Updated modification time in destination
2025/05/28 02:12:05 INFO  : newfolder/HeLlO,wOrLd!.txt: Updated modification time in destination
2025/05/28 02:12:05 INFO  : newfolder/éééö.txt: Updated modification time in destination
2025/05/28 02:12:05 INFO  : Updating listings
2025/05/28 02:12:05 INFO  : Validating listings for Path1 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path1/" vs Path2 "TestPutio:rclone-test-savocan1johu/020915hu/normalization/path2/"
2025/05/28 02:12:05 INFO  : Bisync successful
2025/05/28 02:12:05 NOTICE: ----------------------------------------------------------
2025/05/28 02:12:05 NOTICE: | MISCOMPARE  -Golden vs +Results for  test.log
2025/05/28 02:12:05 NOTICE: | @@ -48,0 +49 @@
2025/05/28 02:12:05 NOTICE: | +INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/05/28 02:12:05 NOTICE: | @@ -50 +50,0 @@
2025/05/28 02:12:05 NOTICE: | -INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/05/28 02:12:05 NOTICE: | @@ -61 +61,2 @@
2025/05/28 02:12:05 NOTICE: | -INFO  : folder/éééö.txt: Files are equal but will copy anyway to fix case to folder/éééö.txt
2025/05/28 02:12:05 NOTICE: | +INFO  : folder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/05/28 02:12:05 NOTICE: | +INFO  : - Path2    Queue copy to Path1       - {path1/}folder/éééö.txt
2025/05/28 02:12:05 NOTICE: | @@ -67 +67,0 @@
2025/05/28 02:12:05 NOTICE: | -INFO  : folder/éééö.txt: Fixed case by renaming to: folder/éééö.txt
2025/05/28 02:12:05 NOTICE: | @@ -120,0 +121 @@
2025/05/28 02:12:05 NOTICE: | +INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/05/28 02:12:05 NOTICE: | @@ -122 +122,0 @@
2025/05/28 02:12:05 NOTICE: | -INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/05/28 02:12:05 NOTICE: ----------------------------------------------------------
    bisync_test.go:560: TEST normalization FAILED - 1 MISCOMPARED FILES
--- FAIL: TestBisyncRemoteRemote (170.77s)
    --- PASS: TestBisyncRemoteRemote/check_sync (19.62s)
    --- FAIL: TestBisyncRemoteRemote/ignorelistingchecksum (22.74s)
    --- FAIL: TestBisyncRemoteRemote/max_delete_path2_force (32.12s)
    --- FAIL: TestBisyncRemoteRemote/nomodtime (31.25s)
    --- FAIL: TestBisyncRemoteRemote/normalization (64.60s)
FAIL
2025/05/28 02:12:06 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|volatile)$|^TestBisyncRemoteRemote$/^(check_sync|ignorelistingchecksum|max_delete_path2_force|nomodtime|normalization)$'" - Finished ERROR in 3m28.983847381s (try 5/5): exit status 1: Failed [TestBisyncLocalRemote/compare_all TestBisyncLocalRemote/volatile TestBisyncRemoteRemote/ignorelistingchecksum TestBisyncRemoteRemote/max_delete_path2_force TestBisyncRemoteRemote/nomodtime TestBisyncRemoteRemote/normalization]