"./bisync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^TestBisyncRemoteRemote$/^extended_char_paths$'" - Starting (try 3/5) 2024/04/11 04:04:39 DEBUG : Creating backend with remote "TestHdfs:rclone-test-moqomeg9muxupih3zikutav8" 2024/04/11 04:04:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 04:04:39 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : Creating backend with remote "/tmp/rclone2416842437" === RUN TestBisyncRemoteRemote 2024/04/11 04:04:39 DEBUG : Creating backend with remote "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7" 2024/04/11 04:04:39 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 remote: TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7 === RUN TestBisyncRemoteRemote/extended_char_paths 2024/04/11 04:04:39 DEBUG : Creating backend with remote "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po" 2024/04/11 04:04:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 04:04:39 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : fs cache: renaming cache item "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po" to be canonical "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po" 2024/04/11 04:04:39 DEBUG : path1: Making directory 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po: mkdir [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/path1] 2024/04/11 04:04:39 DEBUG : Creating backend with remote "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1" 2024/04/11 04:04:39 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : fs cache: renaming cache item "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1" to be canonical "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1" 2024/04/11 04:04:39 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po" for canonical name "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po" 2024/04/11 04:04:39 DEBUG : path2: Making directory 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po: mkdir [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/path2] 2024/04/11 04:04:39 DEBUG : Creating backend with remote "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2" 2024/04/11 04:04:39 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2024/04/11 04:04:39 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2024/04/11 04:04:39 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2024/04/11 04:04:39 DEBUG : fs cache: renaming cache item "TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2" to be canonical "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2" 2024/04/11 04:04:39 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_char_paths/initial" 2024/04/11 04:04:39 DEBUG : Creating backend with remote "/tmp/bs-040439-po/initdir/test_extended_char_paths-manesow8" 2024/04/11 04:04:39 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/11 04:04:39 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/11 04:04:39 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : Local file system at /tmp/bs-040439-po/initdir/test_extended_char_paths-manesow8: Waiting for checks to finish 2024/04/11 04:04:39 DEBUG : Local file system at /tmp/bs-040439-po/initdir/test_extended_char_paths-manesow8: Waiting for transfers to finish 2024/04/11 04:04:39 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 04:04:39 DEBUG : file1.txt.hokopas4.partial: renamed to: file1.txt 2024/04/11 04:04:39 INFO : file1.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 04:04:39 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 04:04:39 DEBUG : file_enconde_mañana_funcionará.txt.zapijaf7.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/11 04:04:39 DEBUG : filename_contains_ě_.txt.joyujef0.partial: renamed to: filename_contains_ě_.txt 2024/04/11 04:04:39 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:39 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 04:04:39 DEBUG : Русский.txt.gewuqow0.partial: renamed to: Русский.txt 2024/04/11 04:04:39 INFO : Русский.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/11 04:04:39 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 04:04:39 DEBUG : RCLONE_TEST.dutefas3.partial: renamed to: RCLONE_TEST 2024/04/11 04:04:39 INFO : RCLONE_TEST: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 04:04:39 DEBUG : filename_contains_ࢺ_.txt.qulejok3.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/11 04:04:39 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_check file.qavizoz4.partial: renamed to: 測試_check file 2024/04/11 04:04:39 INFO : 測試_check file: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.kidawuk8.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 04:04:39 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.cepapip2.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2024/04/11 04:04:39 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.tejigid8.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2024/04/11 04:04:39 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:39 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/11 04:04:39 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_char_paths/modfiles" 2024/04/11 04:04:39 DEBUG : Creating backend with remote "/tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2" 2024/04/11 04:04:39 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : Local file system at /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2: Waiting for checks to finish 2024/04/11 04:04:39 DEBUG : Local file system at /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2: Waiting for transfers to finish 2024/04/11 04:04:39 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/11 04:04:39 DEBUG : file1.txt.cajeruy2.partial: renamed to: file1.txt 2024/04/11 04:04:39 INFO : file1.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/11 04:04:39 DEBUG : 測試_filtersfile.txt.hurodop4.partial: renamed to: 測試_filtersfile.txt 2024/04/11 04:04:39 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1] 2024/04/11 04:04:39 ERROR : : error listing: directory not found 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2] 2024/04/11 04:04:39 ERROR : : error listing: directory not found 2024/04/11 04:04:39 checking initFs Local file system at /tmp/bs-040439-po/initdir/test_extended_char_paths-manesow8 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1] 2024/04/11 04:04:39 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: mkdir [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ] 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/RCLONE_TEST] 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/file1.txt] 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/filename_contains_ě_.txt] 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/file_enconde_mañana_funcionará.txt] 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: Waiting for checks to finish 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: Waiting for transfers to finish 2024/04/11 04:04:39 INFO : file1.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/filename_contains_ࢺ_.txt] 2024/04/11 04:04:39 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/Русский.txt] 2024/04/11 04:04:39 INFO : Русский.txt: Copied (new) 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_check file] 2024/04/11 04:04:39 INFO : 測試_check file: Copied (new) 2024/04/11 04:04:39 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt] 2024/04/11 04:04:40 DEBUG : pacer: low level retry 1/10 (error create /rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/RCLONE_TEST: replication in progress) 2024/04/11 04:04:40 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/11 04:04:40 DEBUG : pacer: low level retry 1/10 (error create /rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: replication in progress) 2024/04/11 04:04:40 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/11 04:04:40 DEBUG : pacer: low level retry 1/10 (error create /rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/filename_contains_ě_.txt: replication in progress) 2024/04/11 04:04:40 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 120ms 2024/04/11 04:04:40 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt] 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 90ms 2024/04/11 04:04:40 INFO : RCLONE_TEST: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/測試_check file] 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 67.5ms 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 50.625ms 2024/04/11 04:04:40 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 37.96875ms 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : pacer: Reducing sleep to 28.476562ms 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 04:04:40 checking Path1 hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2] 2024/04/11 04:04:40 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: mkdir [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/file1.txt] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/RCLONE_TEST] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/file_enconde_mañana_funcionará.txt] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/filename_contains_ě_.txt] 2024/04/11 04:04:40 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: Waiting for checks to finish 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: Waiting for transfers to finish 2024/04/11 04:04:40 INFO : file1.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/filename_contains_ࢺ_.txt] 2024/04/11 04:04:40 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/Русский.txt] 2024/04/11 04:04:40 INFO : RCLONE_TEST: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_check file] 2024/04/11 04:04:40 INFO : Русский.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt] 2024/04/11 04:04:40 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt] 2024/04/11 04:04:40 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: update [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/測試_check file] 2024/04/11 04:04:40 INFO : 測試_check file: Copied (new) 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/11 04:04:40 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 04:04:40 checking path2 hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2] 2024/04/11 04:04:40 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2: list [/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ] 2024/04/11 04:04:40 (01) : test extended-char-paths 2024/04/11 04:04:40 (02) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 04:04:40 ERROR : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-bapiwir2: Server side directory move failed: rename /rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ: file does not exist 2024/04/11 04:04:40 INFO : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 04:04:40 ERROR : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ-rclone-move-bapiwir2: error reading source root directory: directory not found 2024/04/11 04:04:40 (03) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/ 2024/04/11 04:04:40 ERROR : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-soxawek2: Server side directory move failed: rename /rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ: file does not exist 2024/04/11 04:04:40 INFO : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 04:04:40 ERROR : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ-rclone-move-soxawek2: error reading source root directory: directory not found 2024/04/11 04:04:40 (04) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 04:04:40 (05) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 04:04:40 (06) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 04:04:40 (07) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/filename_contains_ě_.txt 2024/04/11 04:04:40 (08) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_check{spc}file 2024/04/11 04:04:40 (09) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_check{spc}file 2024/04/11 04:04:40 (10) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 04:04:40 (11) : fix-names TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 04:04:40 (12) : test resync subdirs with extended chars 2024/04/11 04:04:40 (13) : bisync subdir=測試_Русский_{spc}_{spc}_ě_áñ resync 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:41 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 04:04:41 INFO : /tmp/bs-040439-po/workdir/TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst: renaming to: /tmp/bs-040439-po/workdir/TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst 2024/04/11 04:04:41 INFO : /tmp/bs-040439-po/workdir/TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst: renaming to: /tmp/bs-040439-po/workdir/TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst 2024/04/11 04:04:41 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/" 2024/04/11 04:04:41 INFO : Copying Path2 files to Path1 2024/04/11 04:04:41 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 04:04:41 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 04:04:41 INFO : Resync updating listings 2024/04/11 04:04:41 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/" 2024/04/11 04:04:41 INFO : Bisync successful 2024/04/11 04:04:41 (14) : copy-listings resync 2024/04/11 04:04:41 (15) : test place new files with extended chars on each side 2024/04/11 04:04:41 (16) : touch-glob 2001-01-02 /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2/ file1.txt 2024/04/11 04:04:41 (17) : copy-as /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2/file1.txt TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ 測試_file1p1 2024/04/11 04:04:41 INFO : file1.txt: Copied (new) to: 測試_file1p1 2024/04/11 04:04:41 (18) : copy-as /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2/file1.txt TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_{spc}_{spc}_ě_áñ 測試_file1p2 2024/04/11 04:04:41 INFO : file1.txt: Copied (new) to: 測試_file1p2 2024/04/11 04:04:41 (19) : test normal sync of subdirs with extended chars 2024/04/11 04:04:41 (20) : bisync subdir=測試_Русский_{spc}_{spc}_ě_áñ 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:41 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 04:04:41 INFO : /tmp/bs-040439-po/workdir/TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst: renaming to: /tmp/bs-040439-po/workdir/TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst 2024/04/11 04:04:41 INFO : /tmp/bs-040439-po/workdir/TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst: renaming to: /tmp/bs-040439-po/workdir/TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst 2024/04/11 04:04:41 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/" 2024/04/11 04:04:41 INFO : Building Path1 and Path2 listings 2024/04/11 04:04:41 INFO : Path1 checking for diffs 2024/04/11 04:04:41 INFO : - Path1 File is new - 測試_file1p1 2024/04/11 04:04:41 INFO : Path1: 1 changes:  1 new,  0 modified,  0 deleted 2024/04/11 04:04:41 INFO : Path2 checking for diffs 2024/04/11 04:04:41 INFO : - Path2 File is new - 測試_file1p2 2024/04/11 04:04:41 INFO : Path2: 1 changes:  1 new,  0 modified,  0 deleted 2024/04/11 04:04:41 INFO : Applying changes 2024/04/11 04:04:41 INFO : - Path1 Queue copy to Path2 - TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/測試_file1p1 2024/04/11 04:04:41 INFO : - Path2 Queue copy to Path1 - TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/測試_file1p2 2024/04/11 04:04:41 INFO : - Path2 Do queued copies to - Path1 2024/04/11 04:04:41 INFO : 測試_file1p2: Copied (new) 2024/04/11 04:04:41 INFO : - Path1 Do queued copies to - Path2 2024/04/11 04:04:41 INFO : 測試_file1p1: Copied (new) 2024/04/11 04:04:41 INFO : Updating listings 2024/04/11 04:04:41 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_ _ _ě_áñ/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/測試_Русский_ _ _ě_áñ/" 2024/04/11 04:04:41 INFO : Bisync successful 2024/04/11 04:04:41 (21) : move-listings normal-sync 2024/04/11 04:04:41 (22) : test check-filename with extended chars. check should fail. 2024/04/11 04:04:41 (23) : bisync resync 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:41 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 04:04:41 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:41 INFO : Copying Path2 files to Path1 2024/04/11 04:04:41 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 04:04:41 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 04:04:41 INFO : Resync updating listings 2024/04/11 04:04:41 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:41 INFO : Bisync successful 2024/04/11 04:04:41 (24) : delete-file TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/測試_Русский_{spc}_{spc}_ě_áñ/測試_check{spc}file 2024/04/11 04:04:41 INFO : 測試_check file: Deleted 2024/04/11 04:04:41 (25) : bisync check-access check-filename=測試_check{spc}file 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:41 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 04:04:41 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:41 INFO : Building Path1 and Path2 listings 2024/04/11 04:04:41 INFO : Path1 checking for diffs 2024/04/11 04:04:41 INFO : - Path1 File was deleted - 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 04:04:41 INFO : Path1: 1 changes:  0 new,  0 modified,  1 deleted 2024/04/11 04:04:41 INFO : Path2 checking for diffs 2024/04/11 04:04:41 INFO : Checking access health 2024/04/11 04:04:41 ERROR : Access test failed: Path1 count 1, Path2 count 2 - 測試_check file 2024/04/11 04:04:41 ERROR : -  Access test failed: Path2 file not found in Path1 - 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/11 04:04:41 ERROR : Bisync critical error: check file check failed 2024/04/11 04:04:41 ERROR : Bisync aborted. Must run --resync to recover. 2024/04/11 04:04:41 Bisync error: bisync aborted 2024/04/11 04:04:41 (26) : copy-listings check-access-fail 2024/04/11 04:04:41 (27) : test check-filename with extended chars. check should pass. 2024/04/11 04:04:41 (28) : bisync resync 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:41 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:41 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 04:04:41 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:41 INFO : Copying Path2 files to Path1 2024/04/11 04:04:41 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 04:04:41 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/11 04:04:41 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 04:04:41 INFO : Resync updating listings 2024/04/11 04:04:41 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:41 INFO : Bisync successful 2024/04/11 04:04:41 (29) : bisync check-access check-filename=測試_check{spc}file 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:42 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 04:04:42 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Building Path1 and Path2 listings 2024/04/11 04:04:42 INFO : Path1 checking for diffs 2024/04/11 04:04:42 INFO : Path2 checking for diffs 2024/04/11 04:04:42 INFO : Checking access health 2024/04/11 04:04:42 INFO : Found 2 matching "測試_check file" files on both paths 2024/04/11 04:04:42 INFO : No changes found 2024/04/11 04:04:42 INFO : Updating listings 2024/04/11 04:04:42 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Bisync successful 2024/04/11 04:04:42 (30) : move-listings check-access-pass 2024/04/11 04:04:42 (31) : test filters-file path with extended chars - masks /fileZ.txt 2024/04/11 04:04:42 (32) : copy-file /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2/測試_filtersfile.txt /tmp/bs-040439-po/workdir/ 2024/04/11 04:04:42 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/11 04:04:42 (33) : bisync filters-file=/tmp/bs-040439-po/workdir/測試_filtersfile.txt resync 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:42 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 04:04:42 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Using filters file /tmp/bs-040439-po/workdir/測試_filtersfile.txt 2024/04/11 04:04:42 INFO : Storing filters file hash to /tmp/bs-040439-po/workdir/測試_filtersfile.txt.md5 2024/04/11 04:04:42 INFO : Copying Path2 files to Path1 2024/04/11 04:04:42 INFO : - Path2 Resync is copying files to - Path1 2024/04/11 04:04:42 INFO : - Path1 Resync is copying files to - Path2 2024/04/11 04:04:42 INFO : Resync updating listings 2024/04/11 04:04:42 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Bisync successful 2024/04/11 04:04:42 (34) : copy-as /tmp/bs-040439-po/datadir/test_extended_char_paths-sakejit2/file1.txt TestHdfs:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/ fileZ.txt 2024/04/11 04:04:42 INFO : file1.txt: Copied (new) to: fileZ.txt 2024/04/11 04:04:42 (35) : bisync filters-file=/tmp/bs-040439-po/workdir/測試_filtersfile.txt 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2024/04/11 04:04:42 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2024/04/11 04:04:42 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 04:04:42 INFO : Synching Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" with Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Using filters file /tmp/bs-040439-po/workdir/測試_filtersfile.txt 2024/04/11 04:04:42 INFO : Building Path1 and Path2 listings 2024/04/11 04:04:42 INFO : Path1 checking for diffs 2024/04/11 04:04:42 INFO : Path2 checking for diffs 2024/04/11 04:04:42 INFO : No changes found 2024/04/11 04:04:42 INFO : Updating listings 2024/04/11 04:04:42 INFO : Validating listings for Path1 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path1/" vs Path2 "TestHdfs{cNNQW}:rclone-test-piguvip3qawagiq2yikiviy7/bs-040439-po/extended_char_paths/path2/" 2024/04/11 04:04:42 INFO : Bisync successful 2024/04/11 04:04:42 ---------------------------------------------------------- 2024/04/11 04:04:42 | MISCOMPARE -Golden vs +Results for test.log 2024/04/11 04:04:42 | @@ -23,0 +24,2 @@ 2024/04/11 04:04:42 | +INFO : {workdir/}TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst: renaming to: {workdir/}TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst 2024/04/11 04:04:42 | +INFO : {workdir/}TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst: renaming to: {workdir/}TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst 2024/04/11 04:04:42 | @@ -47,0 +50,2 @@ 2024/04/11 04:04:42 | +INFO : {workdir/}TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst: renaming to: {workdir/}TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path1.lst 2024/04/11 04:04:42 | +INFO : {workdir/}TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs{cNNQW}_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst: renaming to: {workdir/}TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path1_測試_Русский_____ě_áñ..TestHdfs_rclone-test-piguvip3qawagiq2yikiviy7_bs-040439-po_extended_char_paths_path2_測試_Русский_____ě_áñ.path2.lst 2024/04/11 04:04:42 ---------------------------------------------------------- bisync_test.go:539: TEST extended_char_paths FAILED - 1 MISCOMPARED FILES 2024/04/11 04:04:42 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7: Purge remote 2024/04/11 04:04:42 DEBUG : hdfs://127.0.0.1:8020/rclone-test-piguvip3qawagiq2yikiviy7: purge [/rclone-test-piguvip3qawagiq2yikiviy7] --- FAIL: TestBisyncRemoteRemote (2.76s) --- FAIL: TestBisyncRemoteRemote/extended_char_paths (2.75s) FAIL 2024/04/11 04:04:42 DEBUG : hdfs://127.0.0.1:8020/rclone-test-moqomeg9muxupih3zikutav8: Purge remote 2024/04/11 04:04:42 DEBUG : hdfs://127.0.0.1:8020/rclone-test-moqomeg9muxupih3zikutav8: purge [/rclone-test-moqomeg9muxupih3zikutav8] 2024/04/11 04:04:42 purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^TestBisyncRemoteRemote$/^extended_char_paths$'" - Finished ERROR in 2.954106707s (try 3/5): exit status 1: Failed [TestBisyncRemoteRemote/extended_char_paths]