"./bisync.test -test.v -test.timeout 1h0m0s -remote TestChunkerNometaLocal: -verbose -test.run '^(TestBisyncRemoteLocal|TestBisyncRemoteRemote)$/^(check_access|check_filename|extended_char_paths)$'" - Starting (try 5/5) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-mirukay7firowet6zihopos2" 2024/04/11 01:30:23 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-mirukay7firowet6zihopos2" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/rclone1741278738" === RUN TestBisyncRemoteLocal 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 remote: TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2 === RUN TestBisyncRemoteLocal/check_access 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li" 2024/04/11 01:30:23 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/check_access/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access/initial" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/initdir/test_check_access-zuzejib1" 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt.fujoxol0.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.ximetuv8.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_check_access-zuzejib1: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_check_access-zuzejib1: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt.rakayaj3.partial: renamed to: file2.txt 2024/04/11 01:30:23 DEBUG : file3.txt.cuqecuf3.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.culihoc4.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.vogaliz4.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST.gafipaz8.partial: renamed to: subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access/modfiles" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/datadir/test_check_access-vakehac7" 2024/04/11 01:30:23 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_check_access-vakehac7: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_check_access-vakehac7: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/11 01:30:23 DEBUG : hold.txt.xuvowam6.partial: renamed to: hold.txt 2024/04/11 01:30:23 INFO : hold.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-li/initdir/test_check_access-zuzejib1 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdoslx: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdosgo: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdostd: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosks: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdosb7: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1': Waiting for checks to finish 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdos34: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST.rclone_chunk.001_rdos0n: Moved (server-side) to: subdir/RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1' 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/check_access/path2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt.sapozel3.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file2.txt.kozimet4.partial: renamed to: file2.txt 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/check_access/path2: Waiting for transfers to finish 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file3.txt.padisiy8.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.xakumub2.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST.xomupac1.partial: renamed to: subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.tucujiq2.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.kiyuces1.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Local file system at /tmp/bs-013023-li/check_access/path2 2024/04/11 01:30:23 (01) : test check-access 2024/04/11 01:30:23 (02) : test initial bisync 2024/04/11 01:30:23 (03) : bisync resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos1s: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/" with Path2 "/tmp/bs-013023-li/check_access/path2/" 2024/04/11 01:30:23 INFO : Copying Path2 files to Path1 2024/04/11 01:30:23 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 01:30:23 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 01:30:23 INFO : Resync updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/" vs Path2 "/tmp/bs-013023-li/check_access/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (04) : test 1. see that check-access passes with the initial setup 2024/04/11 01:30:23 (05) : bisync check-access 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosd2: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/" with Path2 "/tmp/bs-013023-li/check_access/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 INFO : Found 2 matching "RCLONE_TEST" files on both paths 2024/04/11 01:30:23 INFO : No changes found 2024/04/11 01:30:23 INFO : Updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/" vs Path2 "/tmp/bs-013023-li/check_access/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (06) : test 2. delete the path2 subdir RCLONE_TEST and run sync. should fail critical. 2024/04/11 01:30:23 (07) : delete-file /tmp/bs-013023-li/check_access/path2/subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Deleted 2024/04/11 01:30:23 (08) : bisync check-access 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdospp: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/" with Path2 "/tmp/bs-013023-li/check_access/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : - Path2 File was deleted - subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 ERROR : Access test failed: Path1 count 2, Path2 count 1 - RCLONE_TEST 2024/04/11 01:30:23 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/RCLONE_TEST 2024/04/11 01:30:23 ERROR : Bisync critical error: check file check failed 2024/04/11 01:30:23 ERROR : Bisync aborted. Must run --resync to recover. 2024/04/11 01:30:23 Bisync error: bisync aborted 2024/04/11 01:30:23 (09) : copy-listings path2-missing 2024/04/11 01:30:23 (10) : test 3. put the path2 subdir RCLONE_TEST back, resync. 2024/04/11 01:30:23 (11) : copy-file TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_access/path1/subdir/RCLONE_TEST /tmp/bs-013023-li/check_access/path2/ bisync_test.go:474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:474 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:344 Error: test step failed Test: TestBisyncRemoteLocal/check_access Messages: step 11 failed: object not found === RUN TestBisyncRemoteLocal/check_filename 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/check_filename/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_filename/initial" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/initdir/test_check_filename-tojequd9" 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_check_filename-tojequd9: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_check_filename-tojequd9: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt.wifesob7.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file3.txt.giyamon1.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.suvulex4.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file2.txt.qihatoq4.partial: renamed to: file2.txt 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.zirebep9.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/.chk_file.dujobop8.partial: renamed to: subdir/.chk_file 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 DEBUG : .chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : .chk_file.takecat2.partial: renamed to: .chk_file 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_filename/modfiles" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/datadir/test_check_filename-gahudax2" 2024/04/11 01:30:23 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_check_filename-gahudax2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_check_filename-gahudax2: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/11 01:30:23 DEBUG : hold.txt.ceyokin0.partial: renamed to: hold.txt 2024/04/11 01:30:23 INFO : hold.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-li/initdir/test_check_filename-tojequd9 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 INFO : .chk_file.rclone_chunk.001_rdos8a: Moved (server-side) to: .chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdosz6: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdos2i: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdos86: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdosck: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosi4: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/.chk_file.rclone_chunk.001_rdos29: Moved (server-side) to: subdir/.chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1' 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : .chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt.xolumis1.partial: renamed to: file2.txt 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : .chk_file.xiyisob5.partial: renamed to: .chk_file 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 DEBUG : file1.txt.pabahun8.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file3.txt.curagam5.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/check_filename/path2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/check_filename/path2: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.weronev6.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/.chk_file.nojazag0.partial: renamed to: subdir/.chk_file 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.dahoqok1.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Local file system at /tmp/bs-013023-li/check_filename/path2 2024/04/11 01:30:23 (01) : test check-filename 2024/04/11 01:30:23 (02) : test initial bisync 2024/04/11 01:30:23 (03) : bisync resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos2a: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/" with Path2 "/tmp/bs-013023-li/check_filename/path2/" 2024/04/11 01:30:23 INFO : Copying Path2 files to Path1 2024/04/11 01:30:23 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 01:30:23 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 01:30:23 INFO : Resync updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/" vs Path2 "/tmp/bs-013023-li/check_filename/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (04) : test 1. see that check-access passes with the initial setup 2024/04/11 01:30:23 (05) : bisync check-access check-filename=.chk_file 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosjx: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/" with Path2 "/tmp/bs-013023-li/check_filename/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 INFO : Found 2 matching ".chk_file" files on both paths 2024/04/11 01:30:23 INFO : No changes found 2024/04/11 01:30:23 INFO : Updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/" vs Path2 "/tmp/bs-013023-li/check_filename/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (06) : copy-listings initial-pass 2024/04/11 01:30:23 (07) : test 2. delete the remote subdir .chk_file, run sync. should fail critical. 2024/04/11 01:30:23 (08) : delete-file /tmp/bs-013023-li/check_filename/path2/subdir/.chk_file 2024/04/11 01:30:23 INFO : .chk_file: Deleted 2024/04/11 01:30:23 (09) : bisync check-access check-filename=.chk_file 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosaw: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/" with Path2 "/tmp/bs-013023-li/check_filename/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : - Path2 File was deleted - subdir/.chk_file 2024/04/11 01:30:23 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 ERROR : Access test failed: Path1 count 2, Path2 count 1 - .chk_file 2024/04/11 01:30:23 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/.chk_file 2024/04/11 01:30:23 ERROR : Bisync critical error: check file check failed 2024/04/11 01:30:23 ERROR : Bisync aborted. Must run --resync to recover. 2024/04/11 01:30:23 Bisync error: bisync aborted 2024/04/11 01:30:23 (10) : move-listings path2-missing 2024/04/11 01:30:23 (11) : test 3. put the remote subdir .chk_file back, run resync. 2024/04/11 01:30:23 (12) : copy-file TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/check_filename/path1/subdir/.chk_file /tmp/bs-013023-li/check_filename/path2/subdir/ bisync_test.go:474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:474 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:344 Error: test step failed Test: TestBisyncRemoteLocal/check_filename Messages: step 12 failed: object not found === RUN TestBisyncRemoteLocal/extended_char_paths 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/extended_char_paths/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_char_paths/initial" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/initdir/test_extended_char_paths-sogulup3" 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt.caqaheb7.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_extended_char_paths-sogulup3: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/initdir/test_extended_char_paths-sogulup3: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : file1.txt.vesatod9.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt.cefacar3.partial: renamed to: filename_contains_ě_.txt 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.nolimem8.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt.zakafod5.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : Русский.txt.goburuk0.partial: renamed to: Русский.txt 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_check file.deyifib5.partial: renamed to: 測試_check file 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.nibixuc0.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.mifohuz1.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.tekiyad0.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_char_paths/modfiles" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-li/datadir/test_extended_char_paths-cijakob6" 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_extended_char_paths-cijakob6: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/datadir/test_extended_char_paths-cijakob6: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/11 01:30:23 DEBUG : file1.txt.foladuz7.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt.yujupob1.partial: renamed to: 測試_filtersfile.txt 2024/04/11 01:30:23 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-li/initdir/test_extended_char_paths-sogulup3 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdosw4: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt.rclone_chunk.001_rdosih: Moved (server-side) to: file_enconde_mañana_funcionará.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 INFO : Русский.txt.rclone_chunk.001_rdos95: Moved (server-side) to: Русский.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt.rclone_chunk.001_rdosmp: Moved (server-side) to: filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt.rclone_chunk.001_rdosxj: Moved (server-side) to: filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_check file.rclone_chunk.001_rdos00: Moved (server-side) to: 測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdos9j: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001_rdoshz: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001_rdosh4: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001_rdos3u: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1' 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 DEBUG : file1.txt.soqixob5.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/extended_char_paths/path2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-li/extended_char_paths/path2: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt.fuwacol1.partial: renamed to: filename_contains_ě_.txt 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.sicikid2.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt.gubicoq5.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : Русский.txt.xuwecac6.partial: renamed to: Русский.txt 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_check file.wimagig1.partial: renamed to: 測試_check file 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt.yubibuy3.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.lozogoc7.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.lufuguz9.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.dexiqec0.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Local file system at /tmp/bs-013023-li/extended_char_paths/path2 2024/04/11 01:30:23 (01) : test extended-char-paths 2024/04/11 01:30:23 (02) : fix-names TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-funajig8': Server side directory move failed: rename /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-funajig8: no such file or directory 2024/04/11 01:30:23 INFO : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-funajig8': error reading source root directory: directory not found 2024/04/11 01:30:23 (03) : fix-names /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 01:30:23 ERROR : Local file system at /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-boxoxah5: Server side directory move failed: rename /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_ _ _ě_áñ /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-boxoxah5: no such file or directory 2024/04/11 01:30:23 INFO : Local file system at /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_ _ _ě_áñ: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 01:30:23 ERROR : Local file system at /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-boxoxah5: error reading source root directory: directory not found 2024/04/11 01:30:23 (04) : fix-names TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (05) : fix-names /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (06) : fix-names TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 (07) : fix-names /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 (08) : fix-names TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_check{spc}file 2024/04/11 01:30:23 (09) : fix-names /tmp/bs-013023-li/extended_char_paths/path2/測試_check{spc}file 2024/04/11 01:30:23 (10) : fix-names TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (11) : fix-names /tmp/bs-013023-li/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (12) : test resync subdirs with extended chars 2024/04/11 01:30:23 (13) : bisync subdir=測試_Русский_{spc}_{spc}_ě_áñ resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosok: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001_rdoszc" 2024/04/11 01:30:23 INFO : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdoszc: Moved (server-side) to: ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdos43: Moved (server-side) to: ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001_rdoss4" 2024/04/11 01:30:23 INFO : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdoss4: Moved (server-side) to: ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdossh: Moved (server-side) to: ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/bs-013023-li/extended_char_paths/path2: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/bs-013023-li/extended_char_paths/path2: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) bisync_test.go:998: Fs is incapable of running test as the paths produce different results, skipping: extended_char_paths (path1: RCLONE_TESTRCLONE_TEST (BOTH) path2: 測試_Русский_ _ _ě_áñ測試_Русский_ _ _ě_áñ (測試_Русский_ _ _ě_áñ測試_Русский_ _ _ě_áñ)) (fs1: Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2/bs-013023-li/extended_char_paths/path1' fs2: Local file system at /tmp/bs-013023-li/extended_char_paths/path2) @@ -1 +1 @@ -RCLONE_TESTRCLONE_TEST+測試_Русский_ _ _ě_áñ測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/subdir/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_access/path1/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/file_enconde_mañana_funcionará.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/Русский.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/.chk_file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/subdir/.chk_file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge object "bs-013023-li/check_filename/path1/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/extended_char_paths/path1/測試_Русский_ _ _ě_áñ" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/extended_char_paths" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_filename/path1/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_filename" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_access/path1/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_access/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li/check_access" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "bs-013023-li" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-sewudug2warates1mudohiw2': Purge dir "" --- FAIL: TestBisyncRemoteLocal (0.17s) --- FAIL: TestBisyncRemoteLocal/check_access (0.05s) --- FAIL: TestBisyncRemoteLocal/check_filename (0.06s) --- SKIP: TestBisyncRemoteLocal/extended_char_paths (0.06s) === RUN TestBisyncRemoteRemote 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 remote: TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6 === RUN TestBisyncRemoteRemote/check_access 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za" 2024/04/11 01:30:23 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : path2: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/initdir/test_check_access-lanokof2" 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt.nekucet8.partial: renamed to: file2.txt 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_check_access-lanokof2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : file1.txt.visukad3.partial: renamed to: file1.txt 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_check_access-lanokof2: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file3.txt.kelanen0.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.merelaz8.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.yegiqos7.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.piqibij2.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST.suwojur9.partial: renamed to: subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/datadir/test_check_access-xupajub1" 2024/04/11 01:30:23 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_check_access-xupajub1: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_check_access-xupajub1: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/11 01:30:23 DEBUG : hold.txt.dofatuy9.partial: renamed to: hold.txt 2024/04/11 01:30:23 INFO : hold.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-za/initdir/test_check_access-lanokof2 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdoset: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdosjz: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosof: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdosla: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdoswd: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdosjw: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1': Waiting for checks to finish 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST.rclone_chunk.001_rdos5q: Moved (server-side) to: subdir/RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1' 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdos6y: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdosf6: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosod: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdostr: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdosyu: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdosdq: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST.rclone_chunk.001_rdoss7: Moved (server-side) to: subdir/RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2' 2024/04/11 01:30:23 (01) : test check-access 2024/04/11 01:30:23 (02) : test initial bisync 2024/04/11 01:30:23 (03) : bisync resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos4r: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosjm: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/" 2024/04/11 01:30:23 INFO : Copying Path2 files to Path1 2024/04/11 01:30:23 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 01:30:23 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 01:30:23 INFO : Resync updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/" vs Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (04) : test 1. see that check-access passes with the initial setup 2024/04/11 01:30:23 (05) : bisync check-access 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosn7: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosql: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 INFO : Found 2 matching "RCLONE_TEST" files on both paths 2024/04/11 01:30:23 INFO : No changes found 2024/04/11 01:30:23 INFO : Updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/" vs Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (06) : test 2. delete the path2 subdir RCLONE_TEST and run sync. should fail critical. 2024/04/11 01:30:23 (07) : delete-file TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Deleted 2024/04/11 01:30:23 (08) : bisync check-access 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos49: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosa4: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : - Path2 File was deleted - subdir/RCLONE_TEST 2024/04/11 01:30:23 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 ERROR : Access test failed: Path1 count 2, Path2 count 1 - RCLONE_TEST 2024/04/11 01:30:23 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/RCLONE_TEST 2024/04/11 01:30:23 ERROR : Bisync critical error: check file check failed 2024/04/11 01:30:23 ERROR : Bisync aborted. Must run --resync to recover. 2024/04/11 01:30:23 Bisync error: bisync aborted 2024/04/11 01:30:23 (09) : copy-listings path2-missing 2024/04/11 01:30:23 (10) : test 3. put the path2 subdir RCLONE_TEST back, resync. 2024/04/11 01:30:23 (11) : copy-file TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path1/subdir/RCLONE_TEST TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_access/path2/ bisync_test.go:474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:474 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:344 Error: test step failed Test: TestBisyncRemoteRemote/check_access Messages: step 11 failed: object not found === RUN TestBisyncRemoteRemote/check_filename 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : path2: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/initdir/test_check_filename-cofusuh0" 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt.gohodof0.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file2.txt.bisokig8.partial: renamed to: file2.txt 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file3.txt.zetodeh4.partial: renamed to: file3.txt 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_check_filename-cofusuh0: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_check_filename-cofusuh0: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file4.txt.sabexim8.partial: renamed to: file4.txt 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/file20.txt.narosep4.partial: renamed to: subdir/file20.txt 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : .chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : .chk_file.jesutaw8.partial: renamed to: .chk_file 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : subdir/.chk_file.rogumev0.partial: renamed to: subdir/.chk_file 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/datadir/test_check_filename-xaheket2" 2024/04/11 01:30:23 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_check_filename-xaheket2: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_check_filename-xaheket2: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/11 01:30:23 DEBUG : hold.txt.qerapud7.partial: renamed to: hold.txt 2024/04/11 01:30:23 INFO : hold.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-za/initdir/test_check_filename-cofusuh0 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdosjv: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdos7e: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : .chk_file.rclone_chunk.001_rdosfq: Moved (server-side) to: .chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdos69: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdos7p: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosmc: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/.chk_file.rclone_chunk.001_rdosps: Moved (server-side) to: subdir/.chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1' 2024/04/11 01:30:23 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir: Making directory with metadata 2024/04/11 01:30:23 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/11 01:30:23 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdos1y: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : .chk_file.rclone_chunk.001_rdos36: Moved (server-side) to: .chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : file3.txt.rclone_chunk.001_rdosls: Moved (server-side) to: file3.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file3.txt: Copied (new) 2024/04/11 01:30:23 INFO : .chk_file: Copied (new) 2024/04/11 01:30:23 INFO : file2.txt.rclone_chunk.001_rdosxw: Moved (server-side) to: file2.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file2.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/file20.txt.rclone_chunk.001_rdos6h: Moved (server-side) to: subdir/file20.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/file20.txt: Copied (new) 2024/04/11 01:30:23 INFO : file4.txt.rclone_chunk.001_rdoso6: Moved (server-side) to: file4.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file4.txt: Copied (new) 2024/04/11 01:30:23 INFO : subdir/.chk_file.rclone_chunk.001_rdosrm: Moved (server-side) to: subdir/.chk_file.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir/.chk_file: Copied (new) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2' 2024/04/11 01:30:23 (01) : test check-filename 2024/04/11 01:30:23 (02) : test initial bisync 2024/04/11 01:30:23 (03) : bisync resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosvf: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdoshm: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/" 2024/04/11 01:30:23 INFO : Copying Path2 files to Path1 2024/04/11 01:30:23 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 01:30:23 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 01:30:23 INFO : Resync updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/" vs Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (04) : test 1. see that check-access passes with the initial setup 2024/04/11 01:30:23 (05) : bisync check-access check-filename=.chk_file 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosxu: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos3g: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 INFO : Found 2 matching ".chk_file" files on both paths 2024/04/11 01:30:23 INFO : No changes found 2024/04/11 01:30:23 INFO : Updating listings 2024/04/11 01:30:23 INFO : Validating listings for Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/" vs Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/" 2024/04/11 01:30:23 INFO : Bisync successful 2024/04/11 01:30:23 (06) : copy-listings initial-pass 2024/04/11 01:30:23 (07) : test 2. delete the remote subdir .chk_file, run sync. should fail critical. 2024/04/11 01:30:23 (08) : delete-file TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/subdir/.chk_file 2024/04/11 01:30:23 INFO : .chk_file: Deleted 2024/04/11 01:30:23 (09) : bisync check-access check-filename=.chk_file 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdos5x: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosfa: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 INFO : Synching Path1 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/" with Path2 "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/" 2024/04/11 01:30:23 INFO : Building Path1 and Path2 listings 2024/04/11 01:30:23 INFO : Path1 checking for diffs 2024/04/11 01:30:23 INFO : Path2 checking for diffs 2024/04/11 01:30:23 INFO : - Path2 File was deleted - subdir/.chk_file 2024/04/11 01:30:23 INFO : Path2: 1 changes:  0 new,  0 modified,  1 deleted 2024/04/11 01:30:23 INFO : Checking access health 2024/04/11 01:30:23 ERROR : Access test failed: Path1 count 2, Path2 count 1 - .chk_file 2024/04/11 01:30:23 ERROR : -  Access test failed: Path1 file not found in Path2 - subdir/.chk_file 2024/04/11 01:30:23 ERROR : Bisync critical error: check file check failed 2024/04/11 01:30:23 ERROR : Bisync aborted. Must run --resync to recover. 2024/04/11 01:30:23 Bisync error: bisync aborted 2024/04/11 01:30:23 (10) : move-listings path2-missing 2024/04/11 01:30:23 (11) : test 3. put the remote subdir .chk_file back, run resync. 2024/04/11 01:30:23 (12) : copy-file TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path1/subdir/.chk_file TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/check_filename/path2/subdir/ bisync_test.go:474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:474 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:344 Error: test step failed Test: TestBisyncRemoteRemote/check_filename Messages: step 12 failed: object not found === RUN TestBisyncRemoteRemote/extended_char_paths 2024/04/11 01:30:23 DEBUG : path1: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : path2: Making directory 2024/04/11 01:30:23 DEBUG : Creating backend with remote "TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2.rclone_chunk.001" 2024/04/11 01:30:23 DEBUG : Reset feature "ListR" 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/initdir/test_extended_char_paths-wiwewid0" 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_extended_char_paths-wiwewid0: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/initdir/test_extended_char_paths-wiwewid0: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt.yaqivuk4.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : file1.txt.sudaxif2.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : RCLONE_TEST.doxulor0.partial: renamed to: RCLONE_TEST 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt.cevanaj3.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_check file.jobotiy6.partial: renamed to: 測試_check file 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : Русский.txt.niyobex0.partial: renamed to: Русский.txt 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.maqayoh3.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.xelasic5.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.yuyaguc4.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt.baxiluz1.partial: renamed to: filename_contains_ě_.txt 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 DEBUG : Creating backend with remote "/tmp/bs-013023-za/datadir/test_extended_char_paths-fidarag4" 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/11 01:30:23 DEBUG : file1.txt.fadoxiq7.partial: renamed to: file1.txt 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_extended_char_paths-fidarag4: Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Local file system at /tmp/bs-013023-za/datadir/test_extended_char_paths-fidarag4: Waiting for transfers to finish 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/11 01:30:23 DEBUG : 測試_filtersfile.txt.deyafiq9.partial: renamed to: 測試_filtersfile.txt 2024/04/11 01:30:23 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 checking initFs Local file system at /tmp/bs-013023-za/initdir/test_extended_char_paths-wiwewid0 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdose9: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdosun: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt.rclone_chunk.001_rdoso3: Moved (server-side) to: filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt.rclone_chunk.001_rdosoq: Moved (server-side) to: file_enconde_mañana_funcionará.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_check file.rclone_chunk.001_rdosi7: Moved (server-side) to: 測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : Русский.txt.rclone_chunk.001_rdos72: Moved (server-side) to: Русский.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1': Waiting for checks to finish 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt.rclone_chunk.001_rdoskp: Moved (server-side) to: filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001_rdosxp: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001_rdosvy: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001_rdosdk: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking Path1 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1' 2024/04/11 01:30:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 01:30:23 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt.rclone_chunk.001_rdosoz: Moved (server-side) to: file_enconde_mañana_funcionará.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 01:30:23 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 01:30:23 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 01:30:23 INFO : file1.txt.rclone_chunk.001_rdos73: Moved (server-side) to: file1.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : file1.txt: Copied (new) 2024/04/11 01:30:23 INFO : Русский.txt.rclone_chunk.001_rdoscn: Moved (server-side) to: Русский.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : Русский.txt: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt.rclone_chunk.001_rdosrh: Moved (server-side) to: filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2': Waiting for checks to finish 2024/04/11 01:30:23 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : RCLONE_TEST.rclone_chunk.001_rdosh3: Moved (server-side) to: RCLONE_TEST.rclone_chunk.001 2024/04/11 01:30:23 INFO : RCLONE_TEST: Copied (new) 2024/04/11 01:30:23 INFO : 測試_check file.rclone_chunk.001_rdoskg: Moved (server-side) to: 測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt.rclone_chunk.001_rdosiw: Moved (server-side) to: filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2': Waiting for transfers to finish 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001_rdosnf: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/測試_check file.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001_rdoslr: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001_rdosga: Moved (server-side) to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.rclone_chunk.001 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 01:30:23 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 01:30:23 checking path2 Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2' 2024/04/11 01:30:23 (01) : test extended-char-paths 2024/04/11 01:30:23 (02) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-huyerok5': Server side directory move failed: rename /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-huyerok5: no such file or directory 2024/04/11 01:30:23 INFO : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-huyerok5': error reading source root directory: directory not found 2024/04/11 01:30:23 (03) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-datiwen6': Server side directory move failed: rename /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-datiwen6: no such file or directory 2024/04/11 01:30:23 INFO : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 01:30:23 ERROR : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-datiwen6': error reading source root directory: directory not found 2024/04/11 01:30:23 (04) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (05) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (06) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 (07) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 01:30:23 (08) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_check{spc}file 2024/04/11 01:30:23 (09) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_check{spc}file 2024/04/11 01:30:23 (10) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (11) : fix-names TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 01:30:23 (12) : test resync subdirs with extended chars 2024/04/11 01:30:23 (13) : bisync subdir=測試_Русский_{spc}_{spc}_ě_áñ resync 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdoskr: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 INFO : modtime_write_test.rclone_chunk.001_rdosob: Moved (server-side) to: modtime_write_test.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001_rdosqg" 2024/04/11 01:30:23 INFO : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdosqg: Moved (server-side) to: ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdosqi: Moved (server-side) to: ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001_rdoszg" 2024/04/11 01:30:23 INFO : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdoszg: Moved (server-side) to: ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 NOTICE: Local file system at /tmp/chunker3/rclone-test-gihibab5nolutuf3fucumow6/bs-013023-za/extended_char_paths/path1: Replacing invalid UTF-8 characters in "ě\x81\xfe áñhࢺ_測試Рускийěáñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.rclone_chunk.001" 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001_rdosib: Moved (server-side) to: ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.rclone_chunk.001 2024/04/11 01:30:23 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 01:30:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 01:30:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2024/04/11 01:30:23 ERROR : /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck: error reading lock file: open /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck: file name too long 2024/04/11 01:30:23 ERROR : /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck: err: invalid argument 2024/04/11 01:30:23 ERROR : /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck: error closing file: invalid argument 2024/04/11 01:30:23 INFO : /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck: Valid lock file found. Expires at 2224-02-23 01:30:23.635628498 +0000 UTC. (1752000h0m0s from now) 2024/04/11 01:30:23 INFO : Lockfile info: { "Session": "/tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_check_filename_path1..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_check_filename_path2", "PID": "2320946", "TimeRenewed": "2024-04-11T01:30:23.635628348Z", "TimeExpires": "2224-02-23T01:30:23.635628498Z" } 2024/04/11 01:30:23 Bisync error: prior lock file found: /tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck Tip: this indicates that another bisync run (of these same paths) either is still running or was interrupted before completion. If you're SURE you want to override this safety feature, you can delete the lock file with the following command, then run bisync again: rclone deletefile "/tmp/bs-013023-za/workdir/TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path1_測試_Русский_____ě_áñ..TestChunkerNometaLocal_rclone-test-gihibab5nolutuf3fucumow6_bs-013023-za_extended_char_paths_path2_測試_Русский_____ě_áñ.lck" 2024/04/11 01:30:23 (14) : copy-listings resync bisync_test.go:474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:474 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:344 Error: test step failed Test: TestBisyncRemoteRemote/extended_char_paths Messages: step 14 failed: listings not found 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path2/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/.chk_file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path2/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/file_enconde_mañana_funcionará.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/Русский.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/subdir/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_access/path1/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/RCLONE_TEST" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/file_enconde_mañana_funcionará.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/Русский.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/.chk_file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/file1.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/file2.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/file3.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/file4.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/subdir/.chk_file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/check_filename/path1/subdir/file20.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge object "bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/測試_check file" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/path2" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/extended_char_paths/path2/測試_Русский_ _ _ě_áñ" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/extended_char_paths/path2" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/extended_char_paths/path1/測試_Русский_ _ _ě_áñ" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/extended_char_paths/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/extended_char_paths" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_filename/path2/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_filename/path2" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_filename/path1/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_filename/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_filename" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_access/path2/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_access/path2" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_access/path1/subdir" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_access/path1" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za/check_access" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "bs-013023-za" 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-gihibab5nolutuf3fucumow6': Purge dir "" --- FAIL: TestBisyncRemoteRemote (0.14s) --- FAIL: TestBisyncRemoteRemote/check_access (0.04s) --- FAIL: TestBisyncRemoteRemote/check_filename (0.04s) --- FAIL: TestBisyncRemoteRemote/extended_char_paths (0.06s) FAIL 2024/04/11 01:30:23 ERROR : : error listing: directory not found 2024/04/11 01:30:23 DEBUG : Chunked 'TestChunkerNometaLocal:rclone-test-mirukay7firowet6zihopos2': Purge dir "" 2024/04/11 01:30:23 purge failed to rmdir "": stat /tmp/chunker3/rclone-test-mirukay7firowet6zihopos2: no such file or directory 2024/04/11 01:30:23 purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestChunkerNometaLocal: -verbose -test.run '^(TestBisyncRemoteLocal|TestBisyncRemoteRemote)$/^(check_access|check_filename|extended_char_paths)$'" - Finished ERROR in 357.75716ms (try 5/5): exit status 1: Failed [TestBisyncRemoteLocal/check_access TestBisyncRemoteLocal/check_filename TestBisyncRemoteRemote/check_access TestBisyncRemoteRemote/check_filename TestBisyncRemoteRemote/extended_char_paths]