"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(normalization|rclone_args)$'" - Starting (try 3/5) 2025/11/05 03:09:52 DEBUG : Creating backend with remote "TestB2:rclone-test-yoneloq0dazo" 2025/11/05 03:09:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/05 03:09:52 DEBUG : Creating backend with remote "/tmp/rclone5809122" === RUN TestBisyncRemoteRemote 2025/11/05 03:09:52 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza" 2025/11/05 03:09:53 NOTICE: remote: TestB2:rclone-test-nisolol3hiza === RUN TestBisyncRemoteRemote/normalization 2025/11/05 03:09:53 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu" 2025/11/05 03:09:54 INFO : path1: Making directory 2025/11/05 03:09:55 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1" 2025/11/05 03:09:56 INFO : path2: Making directory 2025/11/05 03:09:56 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2" 2025/11/05 03:09:57 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/initial" 2025/11/05 03:09:57 DEBUG : Creating backend with remote "/tmp/030953zu/initdir/test_normalization-cicevug8" 2025/11/05 03:09:57 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2025/11/05 03:09:57 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z) 2025/11/05 03:09:57 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/11/05 03:09:57 DEBUG : Local file system at /tmp/030953zu/initdir/test_normalization-cicevug8: Waiting for checks to finish 2025/11/05 03:09:57 DEBUG : Local file system at /tmp/030953zu/initdir/test_normalization-cicevug8: Waiting for transfers to finish 2025/11/05 03:09:57 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: size = 272 OK 2025/11/05 03:09:57 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/11/05 03:09:57 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/11/05 03:09:57 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/11/05 03:09:57 INFO : file1.txt: Copied (new) 2025/11/05 03:09:57 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2025/11/05 03:09:57 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: size = 272 OK 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2025/11/05 03:09:57 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: size = 0 OK 2025/11/05 03:09:57 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:09:57 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2025/11/05 03:09:57 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2025/11/05 03:09:57 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2025/11/05 03:09:57 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/modfiles" 2025/11/05 03:09:57 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:09:57 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:57 DEBUG : Local file system at /tmp/030953zu/datadir/test_normalization-fofudup5: Waiting for checks to finish 2025/11/05 03:09:57 DEBUG : Local file system at /tmp/030953zu/datadir/test_normalization-fofudup5: Waiting for transfers to finish 2025/11/05 03:09:57 DEBUG : 測試_filtersfile.txt.3ada41b4.partial: size = 254 OK 2025/11/05 03:09:57 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2025/11/05 03:09:57 DEBUG : file1.txt.75b77f44.partial: size = 19 OK 2025/11/05 03:09:57 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/11/05 03:09:57 DEBUG : 測試_filtersfile.txt.3ada41b4.partial: renamed to: 測試_filtersfile.txt 2025/11/05 03:09:57 INFO : 測試_filtersfile.txt: Copied (new) 2025/11/05 03:09:57 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt 2025/11/05 03:09:57 INFO : file1.txt: Copied (new) 2025/11/05 03:09:57 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:09:58 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:09:59 NOTICE: checking initFs Local file system at /tmp/030953zu/initdir/test_normalization-cicevug8 2025/11/05 03:09:59 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:09:59 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:59 INFO : 測試_Русский_ _ _ě_áñ: Making directory 2025/11/05 03:09:59 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:59 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2025/11/05 03:09:59 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2025/11/05 03:09:59 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Waiting for checks to finish 2025/11/05 03:09:59 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Waiting for transfers to finish 2025/11/05 03:10:00 DEBUG : file1.txt: size = 0 OK 2025/11/05 03:10:00 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:00 INFO : file1.txt: Copied (new) 2025/11/05 03:10:00 DEBUG : RCLONE_TEST: size = 109 OK 2025/11/05 03:10:00 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/11/05 03:10:00 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:10:00 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: size = 272 OK 2025/11/05 03:10:00 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK 2025/11/05 03:10:00 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: size = 0 OK 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:01 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: size = 272 OK 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK 2025/11/05 03:10:01 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2025/11/05 03:10:01 NOTICE: checking Path1 B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1 2025/11/05 03:10:01 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:10:01 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:01 INFO : 測試_Русский_ _ _ě_áñ: Making directory 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:01 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2025/11/05 03:10:01 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Waiting for checks to finish 2025/11/05 03:10:01 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Waiting for transfers to finish 2025/11/05 03:10:02 DEBUG : file1.txt: size = 0 OK 2025/11/05 03:10:02 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:02 INFO : file1.txt: Copied (new) 2025/11/05 03:10:02 DEBUG : RCLONE_TEST: size = 109 OK 2025/11/05 03:10:02 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/11/05 03:10:02 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:10:02 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: size = 0 OK 2025/11/05 03:10:02 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:02 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2025/11/05 03:10:02 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: size = 272 OK 2025/11/05 03:10:02 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK 2025/11/05 03:10:02 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2025/11/05 03:10:03 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: size = 272 OK 2025/11/05 03:10:03 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: sha1 = 70063f4264b2f671d8a31fa59ff565147c6e51ce OK 2025/11/05 03:10:03 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2025/11/05 03:10:03 NOTICE: checking path2 B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2 2025/11/05 03:10:03 NOTICE: (01) : test normalization 2025/11/05 03:10:03 NOTICE: (02) : touch-copy 2001-01-02 /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:10:03 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/" 2025/11/05 03:10:03 DEBUG : fs cache: renaming cache item "/tmp/030953zu/datadir/test_normalization-fofudup5/" to be canonical "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:10:03 DEBUG : file1.txt: Set modification time 2001-01-02 2025/11/05 03:10:03 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "" 2025/11/05 03:10:03 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:03 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:05 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file1.txt" 2025/11/05 03:10:05 DEBUG : file1.txt: size = 19 (Local file system at /tmp/030953zu/datadir/test_normalization-fofudup5) 2025/11/05 03:10:05 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2) 2025/11/05 03:10:05 DEBUG : file1.txt: Sizes differ 2025/11/05 03:10:07 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:10:07 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:07 INFO : file1.txt: Copied (replaced existing) 2025/11/05 03:10:07 NOTICE: (03) : test initial bisync 2025/11/05 03:10:07 NOTICE: (04) : bisync resync 2025/11/05 03:10:15 DEBUG : Creating backend with remote "/tmp/030953zu" 2025/11/05 03:10:17 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:10:17 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:17 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:10:19 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:10:19 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:19 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:10:19 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:10:19 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:10:19 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:10:19 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:10:19 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:19 INFO : Copying Path2 files to Path1 2025/11/05 03:10:19 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:10:20 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:10:20 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:10:20 INFO : Resync updating listings 2025/11/05 03:10:20 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:20 INFO : Bisync successful 2025/11/05 03:10:20 NOTICE: (05) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt 2025/11/05 03:10:20 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:10:20 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:20 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" 2025/11/05 03:10:22 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:10:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:24 DEBUG : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: size = 19 OK 2025/11/05 03:10:24 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:24 INFO : file1.txt: Copied (new) to: 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt 2025/11/05 03:10:24 NOTICE: (06) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder éééö.txt 2025/11/05 03:10:24 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder" as "éééö.txt" 2025/11/05 03:10:24 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:24 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder" 2025/11/05 03:10:25 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/folder" as "éééö.txt" 2025/11/05 03:10:25 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:27 DEBUG : éééö.txt: size = 19 OK 2025/11/05 03:10:27 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:27 INFO : file1.txt: Copied (new) to: éééö.txt 2025/11/05 03:10:27 NOTICE: (07) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder HeLlO,wOrLd!.txt 2025/11/05 03:10:27 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:10:27 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:27 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/folder" 2025/11/05 03:10:28 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/folder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:10:28 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:30 DEBUG : HeLlO,wOrLd!.txt: size = 19 OK 2025/11/05 03:10:30 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:30 INFO : file1.txt: Copied (new) to: HeLlO,wOrLd!.txt 2025/11/05 03:10:30 NOTICE: (08) : touch-copy 2001-01-03 /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:10:30 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_normalization-fofudup5/" for canonical name "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:10:30 DEBUG : file1.txt: Set modification time 2001-01-03 2025/11/05 03:10:30 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "" 2025/11/05 03:10:30 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:30 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:31 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file1.txt" 2025/11/05 03:10:31 DEBUG : file1.txt: size = 19 (Local file system at /tmp/030953zu/datadir/test_normalization-fofudup5) 2025/11/05 03:10:31 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2) 2025/11/05 03:10:31 DEBUG : file1.txt: Sizes differ 2025/11/05 03:10:33 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:10:33 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:33 INFO : file1.txt: Copied (replaced existing) 2025/11/05 03:10:33 NOTICE: (09) : copy-as-NFD /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder éééö.txt 2025/11/05 03:10:33 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder" as "éééö.txt" 2025/11/05 03:10:33 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:33 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder" 2025/11/05 03:10:34 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2/folder" as "éééö.txt" 2025/11/05 03:10:34 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:36 DEBUG : éééö.txt: size = 19 OK 2025/11/05 03:10:36 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:36 INFO : file1.txt: Copied (new) to: éééö.txt 2025/11/05 03:10:36 NOTICE: (10) : copy-as-NFD /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder hello,WORLD!.txt 2025/11/05 03:10:36 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder" as "hello,WORLD!.txt" 2025/11/05 03:10:36 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:10:36 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/folder" 2025/11/05 03:10:37 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2/folder" as "hello,WORLD!.txt" 2025/11/05 03:10:37 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:10:39 DEBUG : hello,WORLD!.txt: size = 19 OK 2025/11/05 03:10:39 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:10:39 INFO : file1.txt: Copied (new) to: hello,WORLD!.txt 2025/11/05 03:10:39 NOTICE: (11) : test bisync run with fix-case 2025/11/05 03:10:39 NOTICE: (12) : bisync fix-case 2025/11/05 03:10:50 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:10:50 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:50 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:10:52 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:10:52 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:10:52 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:10:52 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:10:52 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:10:52 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:10:52 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:10:52 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:52 INFO : Building Path1 and Path2 listings 2025/11/05 03:10:54 INFO : Path1 checking for diffs 2025/11/05 03:10:54 INFO : - Path1 File is new - folder/HeLlO,wOrLd!.txt 2025/11/05 03:10:54 INFO : - Path1 File is new - folder/éééö.txt 2025/11/05 03:10:54 INFO : - Path1 File is new - "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:10:54 INFO : Path1: 3 changes:  3 new,  0 modified,  0 deleted 2025/11/05 03:10:54 INFO : Path2 checking for diffs 2025/11/05 03:10:54 INFO : - Path2 File changed: size (larger), time (newer) - file1.txt 2025/11/05 03:10:54 INFO : - Path2 File is new - folder/éééö.txt 2025/11/05 03:10:54 INFO : - Path2 File is new - folder/hello,WORLD!.txt 2025/11/05 03:10:54 INFO : Path2: 3 changes:  2 new,  1 modified,  0 deleted 2025/11/05 03:10:54 INFO : (Modified:  1 newer,  0 older,  1 larger,  0 smaller) 2025/11/05 03:10:54 INFO : Applying changes 2025/11/05 03:10:54 INFO : Checking potential conflicts... 2025/11/05 03:10:54 NOTICE: B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: 0 differences found 2025/11/05 03:10:54 NOTICE: B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: 2 matching files 2025/11/05 03:10:54 INFO : Finished checking the potential conflicts. %!s() 2025/11/05 03:10:54 NOTICE: - WARNING New or changed in both paths - folder/HeLlO,wOrLd!.txt 2025/11/05 03:10:54 INFO : folder/hello,WORLD!.txt: Files are equal but will copy anyway to fix case to folder/HeLlO,wOrLd!.txt 2025/11/05 03:10:54 NOTICE: - WARNING New or changed in both paths - folder/éééö.txt 2025/11/05 03:10:54 INFO : folder/éééö.txt: Files are equal but will copy anyway to fix case to folder/éééö.txt 2025/11/05 03:10:54 INFO : - Path1 Queue copy to Path2 - "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:10:54 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/file1.txt 2025/11/05 03:10:54 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:10:55 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:10:55 INFO : - Path1 Do queued copies to - Path2 2025/11/05 03:10:56 INFO : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy) 2025/11/05 03:10:56 INFO : folder/HeLlO,wOrLd!.txt: Updated modification time in destination 2025/11/05 03:10:56 INFO : folder/éééö.txt: Updated modification time in destination 2025/11/05 03:10:57 INFO : folder/hello,WORLD!.txt: Copied (server-side copy) to: folder/HeLlO,wOrLd!.txt 2025/11/05 03:10:57 INFO : folder/hello,WORLD!.txt: Deleted 2025/11/05 03:10:57 INFO : folder/hello,WORLD!.txt: Fixed case by renaming to: folder/HeLlO,wOrLd!.txt 2025/11/05 03:10:57 INFO : folder/éééö.txt: Copied (server-side copy) to: folder/éééö.txt 2025/11/05 03:10:57 INFO : folder/éééö.txt: Deleted 2025/11/05 03:10:57 INFO : folder/éééö.txt: Fixed case by renaming to: folder/éééö.txt 2025/11/05 03:10:57 INFO : Updating listings 2025/11/05 03:10:57 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:10:57 INFO : Bisync successful 2025/11/05 03:10:57 NOTICE: (13) : purge-children TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/ 2025/11/05 03:10:57 DEBUG : RCLONE_TEST: Remove file 2025/11/05 03:10:57 DEBUG : file1.txt: Remove file 2025/11/05 03:10:58 DEBUG : folder: Purge subdir 2025/11/05 03:10:58 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:10:58 DEBUG : folder/HeLlO,wOrLd!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11525e99df8dbbb8_d20251105_m031029_c001_v0001115_t0027_u01762312229726") 2025/11/05 03:10:58 DEBUG : folder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104e09a7b94f5b44_d20251105_m031026_c001_v0001102_t0052_u01762312226751") 2025/11/05 03:10:58 DEBUG : 測試_Русский_ _ _ě_áñ: Purge subdir 2025/11/05 03:10:58 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:10:58 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c1010_d20251105_m031000_c001_v0001037_t0056_u01762312200899") 2025/11/05 03:10:58 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4bcf_d20251105_m031000_c001_v0001165_t0032_u01762312200716") 2025/11/05 03:10:58 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734349_d20251105_m031000_c001_v0001146_t0023_u01762312200693") 2025/11/05 03:10:59 DEBUG : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Purge subdir 2025/11/05 03:10:59 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:11:00 DEBUG : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1183c507541611b1_d20251105_m031023_c001_v0001113_t0034_u01762312223570") 2025/11/05 03:11:00 NOTICE: (14) : purge-children TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:11:00 DEBUG : RCLONE_TEST: Remove file 2025/11/05 03:11:00 DEBUG : file1.txt: Remove file 2025/11/05 03:11:00 DEBUG : folder: Purge subdir 2025/11/05 03:11:00 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:11:00 DEBUG : folder/HeLlO,wOrLd!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1046b74bf21b6127_d20251105_m031056_c001_v0001130_t0035_u01762312256613") 2025/11/05 03:11:00 DEBUG : folder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece585_d20251105_m031057_c001_v7007000_t0000_u01762312257437") 2025/11/05 03:11:00 DEBUG : folder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10286526a704acde_d20251105_m031056_c001_v0001136_t0016_u01762312256297") 2025/11/05 03:11:00 DEBUG : folder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10067513ce328db7_d20251105_m031036_c001_v0001184_t0010_u01762312236214") 2025/11/05 03:11:00 DEBUG : folder/hello,WORLD!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4103089b7f351e7f_d20251105_m031057_c001_v7007000_t0000_u01762312257144") 2025/11/05 03:11:00 DEBUG : folder/hello,WORLD!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11390988f61fb9a8_d20251105_m031056_c001_v0001136_t0007_u01762312256220") 2025/11/05 03:11:00 DEBUG : folder/hello,WORLD!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1137ccdef48885ef_d20251105_m031038_c001_v0001165_t0005_u01762312238987") 2025/11/05 03:11:00 DEBUG : folder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1149696ce7dd3dd5_d20251105_m031056_c001_v0001115_t0045_u01762312256730") 2025/11/05 03:11:01 DEBUG : 測試_Русский_ _ _ě_áñ: Purge subdir 2025/11/05 03:11:01 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:11:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104940f99027b12e_d20251105_m031002_c001_v0001038_t0035_u01762312202599") 2025/11/05 03:11:01 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1126fa7a9673738f_d20251105_m031002_c001_v0001179_t0022_u01762312202784") 2025/11/05 03:11:01 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1062e6df32b6c046_d20251105_m031002_c001_v0001165_t0025_u01762312202547") 2025/11/05 03:11:01 DEBUG : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Purge subdir 2025/11/05 03:11:01 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:11:02 DEBUG : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1198e3ec6b62c3da_d20251105_m031055_c001_v0001137_t0019_u01762312255704") 2025/11/05 03:11:02 NOTICE: (15) : touch-copy 2001-01-02 /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:11:02 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_normalization-fofudup5/" for canonical name "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:11:02 DEBUG : file1.txt: Set modification time 2001-01-02 2025/11/05 03:11:02 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "" 2025/11/05 03:11:02 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:02 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:03 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file1.txt" 2025/11/05 03:11:03 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:05 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:11:05 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:05 INFO : file1.txt: Copied (new) 2025/11/05 03:11:05 NOTICE: (16) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ file2.txt 2025/11/05 03:11:05 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "file2.txt" 2025/11/05 03:11:05 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:05 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:06 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file2.txt" 2025/11/05 03:11:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:08 DEBUG : file2.txt: size = 19 OK 2025/11/05 03:11:08 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:08 INFO : file1.txt: Copied (new) to: file2.txt 2025/11/05 03:11:08 NOTICE: (17) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/ file3.txt 2025/11/05 03:11:08 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" as "file3.txt" 2025/11/05 03:11:08 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:08 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" 2025/11/05 03:11:09 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1" as "file3.txt" 2025/11/05 03:11:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:11 DEBUG : file3.txt: size = 19 OK 2025/11/05 03:11:11 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:11 INFO : file1.txt: Copied (new) to: file3.txt 2025/11/05 03:11:11 NOTICE: (18) : bisync resync 2025/11/05 03:11:21 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:11:21 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:11:21 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:11:22 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:11:22 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:11:22 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:11:23 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:11:23 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:11:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:11:23 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:11:23 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:23 INFO : Copying Path2 files to Path1 2025/11/05 03:11:23 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:11:23 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:11:24 INFO : file2.txt: Copied (server-side copy) 2025/11/05 03:11:24 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:11:24 INFO : file3.txt: Copied (server-side copy) 2025/11/05 03:11:24 INFO : Resync updating listings 2025/11/05 03:11:24 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:24 INFO : Bisync successful 2025/11/05 03:11:24 NOTICE: (19) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt 2025/11/05 03:11:24 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:11:24 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:24 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" 2025/11/05 03:11:26 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:11:26 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:27 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: size = 19 OK 2025/11/05 03:11:27 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:27 INFO : file1.txt: Copied (new) to: 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt 2025/11/05 03:11:27 NOTICE: (20) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder éééö.txt 2025/11/05 03:11:27 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" as "éééö.txt" 2025/11/05 03:11:27 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:27 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" 2025/11/05 03:11:29 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/newfolder" as "éééö.txt" 2025/11/05 03:11:29 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:30 DEBUG : éééö.txt: size = 19 OK 2025/11/05 03:11:30 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:30 INFO : file1.txt: Copied (new) to: éééö.txt 2025/11/05 03:11:30 NOTICE: (21) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder HeLlO,wOrLd!.txt 2025/11/05 03:11:30 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:11:30 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:30 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" 2025/11/05 03:11:31 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/newfolder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:11:32 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:33 DEBUG : HeLlO,wOrLd!.txt: size = 19 OK 2025/11/05 03:11:33 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:33 INFO : file1.txt: Copied (new) to: HeLlO,wOrLd!.txt 2025/11/05 03:11:33 NOTICE: (22) : touch-copy 2001-01-03 /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:11:33 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_normalization-fofudup5/" for canonical name "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:11:33 DEBUG : file1.txt: Set modification time 2001-01-03 2025/11/05 03:11:33 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "" 2025/11/05 03:11:33 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:33 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:34 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file1.txt" 2025/11/05 03:11:35 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:11:35 DEBUG : file1.txt: Modification times differ by -24h0m0s: 2001-01-03 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:11:35 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:36 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:11:36 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:11:36 NOTICE: (23) : copy-as-NFD /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder éééö.txt 2025/11/05 03:11:36 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder" as "éééö.txt" 2025/11/05 03:11:36 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:36 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder" 2025/11/05 03:11:37 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2/newfolder" as "éééö.txt" 2025/11/05 03:11:37 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:39 DEBUG : éééö.txt: size = 19 OK 2025/11/05 03:11:39 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:39 INFO : file1.txt: Copied (new) to: éééö.txt 2025/11/05 03:11:39 NOTICE: (24) : copy-as-NFD /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder hello,WORLD!.txt 2025/11/05 03:11:39 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder" as "hello,WORLD!.txt" 2025/11/05 03:11:39 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:11:39 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder" 2025/11/05 03:11:40 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2/newfolder" as "hello,WORLD!.txt" 2025/11/05 03:11:41 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:11:42 DEBUG : hello,WORLD!.txt: size = 19 OK 2025/11/05 03:11:42 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:11:42 INFO : file1.txt: Copied (new) to: hello,WORLD!.txt 2025/11/05 03:11:42 NOTICE: (25) : test bisync run with normalization 2025/11/05 03:11:42 NOTICE: (26) : bisync norm force 2025/11/05 03:11:52 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2025/11/05 03:11:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/05 03:11:52 DEBUG : pacer: Reducing sleep to 10ms 2025/11/05 03:11:53 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:11:53 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:11:53 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:11:55 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:11:55 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:11:55 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:11:56 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:11:56 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:11:56 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:11:56 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:11:56 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:56 INFO : Building Path1 and Path2 listings 2025/11/05 03:11:56 INFO : Path1 checking for diffs 2025/11/05 03:11:56 INFO : - Path1 File is new - newfolder/HeLlO,wOrLd!.txt 2025/11/05 03:11:56 INFO : - Path1 File is new - newfolder/éééö.txt 2025/11/05 03:11:56 INFO : - Path1 File is new - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:11:56 INFO : Path1: 3 changes:  3 new,  0 modified,  0 deleted 2025/11/05 03:11:56 INFO : Path2 checking for diffs 2025/11/05 03:11:56 INFO : - Path2 File changed: time (newer) - file1.txt 2025/11/05 03:11:56 INFO : - Path2 File is new - newfolder/éééö.txt 2025/11/05 03:11:56 INFO : - Path2 File is new - newfolder/hello,WORLD!.txt 2025/11/05 03:11:56 INFO : Path2: 3 changes:  2 new,  1 modified,  0 deleted 2025/11/05 03:11:56 INFO : (Modified:  1 newer,  0 older) 2025/11/05 03:11:56 INFO : Applying changes 2025/11/05 03:11:56 INFO : Checking potential conflicts... 2025/11/05 03:11:57 NOTICE: B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: 0 differences found 2025/11/05 03:11:57 NOTICE: B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: 2 matching files 2025/11/05 03:11:57 INFO : Finished checking the potential conflicts. %!s() 2025/11/05 03:11:57 NOTICE: - WARNING New or changed in both paths - newfolder/HeLlO,wOrLd!.txt 2025/11/05 03:11:57 INFO : newfolder/HeLlO,wOrLd!.txt: Files are equal but will copy anyway to update modtime (will not rename) 2025/11/05 03:11:57 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder/HeLlO,wOrLd!.txt 2025/11/05 03:11:57 NOTICE: - WARNING New or changed in both paths - newfolder/éééö.txt 2025/11/05 03:11:57 INFO : newfolder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename) 2025/11/05 03:11:57 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder/éééö.txt 2025/11/05 03:11:57 INFO : - Path1 Queue copy to Path2 - "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:11:57 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/file1.txt 2025/11/05 03:11:57 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:11:58 INFO : newfolder/éééö.txt: Updated modification time in destination 2025/11/05 03:11:58 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:11:58 INFO : newfolder/hello,WORLD!.txt: Updated modification time in destination 2025/11/05 03:11:58 INFO : - Path1 Do queued copies to - Path2 2025/11/05 03:11:59 INFO : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (server-side copy) 2025/11/05 03:11:59 INFO : Updating listings 2025/11/05 03:11:59 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:11:59 INFO : Bisync successful 2025/11/05 03:11:59 NOTICE: (27) : test resync 2025/11/05 03:11:59 NOTICE: (28) : bisync resync norm 2025/11/05 03:12:09 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2025/11/05 03:12:09 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/05 03:12:10 DEBUG : pacer: Reducing sleep to 10ms 2025/11/05 03:12:10 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:12:10 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:10 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:12:13 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:12:13 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:13 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:12:13 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:12:13 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:12:13 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:12:13 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:12:13 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:12:13 INFO : Copying Path2 files to Path1 2025/11/05 03:12:13 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:12:14 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:12:14 INFO : Resync updating listings 2025/11/05 03:12:15 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:12:15 INFO : Bisync successful 2025/11/05 03:12:15 NOTICE: (29) : test changed on one path 2025/11/05 03:12:15 NOTICE: (30) : touch-copy 2001-01-05 /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/ 2025/11/05 03:12:15 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_normalization-fofudup5/" for canonical name "/tmp/030953zu/datadir/test_normalization-fofudup5" 2025/11/05 03:12:15 DEBUG : file1.txt: Set modification time 2001-01-05 2025/11/05 03:12:15 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" as "" 2025/11/05 03:12:15 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:12:15 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:12:16 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2" as "file1.txt" 2025/11/05 03:12:16 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:12:16 DEBUG : file1.txt: Modification times differ by -48h0m0s: 2001-01-05 00:00:00 +0000 UTC, 2001-01-03 00:00:00 +0000 UTC 2025/11/05 03:12:16 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:12:17 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:12:17 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:12:17 NOTICE: (31) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt 2025/11/05 03:12:17 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:12:17 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:12:17 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" 2025/11/05 03:12:19 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö" as "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:12:19 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: size = 19 OK 2025/11/05 03:12:19 DEBUG : file1.txt: Modification times differ by -72h0m0s: 2001-01-05 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:12:19 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:12:20 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:12:20 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:12:20 NOTICE: (32) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder éééö.txt 2025/11/05 03:12:20 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" as "éééö.txt" 2025/11/05 03:12:20 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:12:20 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" 2025/11/05 03:12:21 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/newfolder" as "éééö.txt" 2025/11/05 03:12:21 DEBUG : éééö.txt: size = 19 OK 2025/11/05 03:12:21 DEBUG : file1.txt: Modification times differ by -48h0m0s: 2001-01-05 00:00:00 +0000 UTC, 2001-01-03 00:00:00 +0000 UTC 2025/11/05 03:12:21 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:12:23 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:12:23 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:12:23 NOTICE: (33) : copy-as-NFC /tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder HeLlO,wOrLd!.txt 2025/11/05 03:12:23 DEBUG : copyFile "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:12:23 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_normalization-fofudup5/file1.txt" 2025/11/05 03:12:23 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/newfolder" 2025/11/05 03:12:24 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1/newfolder" as "HeLlO,wOrLd!.txt" 2025/11/05 03:12:24 DEBUG : HeLlO,wOrLd!.txt: size = 19 OK 2025/11/05 03:12:24 DEBUG : file1.txt: Modification times differ by -48h0m0s: 2001-01-05 00:00:00 +0000 UTC, 2001-01-03 00:00:00 +0000 UTC 2025/11/05 03:12:24 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:12:25 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:12:25 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:12:25 NOTICE: (34) : bisync norm 2025/11/05 03:12:36 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:12:36 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:36 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:12:38 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: size = 0 OK 2025/11/05 03:12:38 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:38 INFO : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new) 2025/11/05 03:12:38 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:12:38 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:12:38 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:12:38 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:12:38 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:12:38 INFO : Building Path1 and Path2 listings 2025/11/05 03:12:38 INFO : Path1 checking for diffs 2025/11/05 03:12:38 INFO : - Path1 File changed: time (newer) - newfolder/HeLlO,wOrLd!.txt 2025/11/05 03:12:38 INFO : - Path1 File changed: time (newer) - newfolder/éééö.txt 2025/11/05 03:12:38 INFO : - Path1 File changed: time (newer) - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:12:38 INFO : Path1: 3 changes:  0 new,  3 modified,  0 deleted 2025/11/05 03:12:38 INFO : (Modified:  3 newer,  0 older) 2025/11/05 03:12:38 INFO : Path2 checking for diffs 2025/11/05 03:12:38 INFO : - Path2 File changed: time (newer) - file1.txt 2025/11/05 03:12:38 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/11/05 03:12:38 INFO : (Modified:  1 newer,  0 older) 2025/11/05 03:12:38 INFO : Applying changes 2025/11/05 03:12:38 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder/hello,WORLD!.txt 2025/11/05 03:12:38 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/newfolder/éééö.txt 2025/11/05 03:12:38 INFO : - Path1 Queue copy to Path2 - "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt" 2025/11/05 03:12:38 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/file1.txt 2025/11/05 03:12:38 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:12:40 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:12:40 INFO : - Path1 Do queued copies to - Path2 2025/11/05 03:12:41 INFO : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Updated modification time in destination 2025/11/05 03:12:41 INFO : newfolder/HeLlO,wOrLd!.txt: Updated modification time in destination 2025/11/05 03:12:41 INFO : newfolder/éééö.txt: Updated modification time in destination 2025/11/05 03:12:41 INFO : Updating listings 2025/11/05 03:12:41 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/normalization/path2/" 2025/11/05 03:12:41 INFO : Bisync successful 2025/11/05 03:12:41 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:12:42 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f40243b349f10382a_d20251105_m031057_c001_v7007000_t0000_u01762312257805") 2025/11/05 03:12:42 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848c91f_d20251105_m031000_c001_v0001134_t0056_u01762312200521") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece753_d20251105_m031236_c001_v7007000_t0000_u01762312356265") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734640_d20251105_m031234_c001_v0001146_t0015_u01762312354615") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a08142_d20251105_m031210_c001_v7007000_t0000_u01762312330808") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4e56_d20251105_m031209_c001_v0001165_t0000_u01762312329576") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d35c_d20251105_m031153_c001_v7007000_t0000_u01762312313538") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848ca70_d20251105_m031152_c001_v0001134_t0032_u01762312312147") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2dc16_d20251105_m031121_c001_v7007000_t0000_u01762312281205") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c1084_d20251105_m031119_c001_v0001037_t0045_u01762312279763") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a0424d_d20251105_m031050_c001_v7007000_t0000_u01762312250245") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734420_d20251105_m031048_c001_v0001146_t0000_u01762312248275") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f405701c368520860_d20251105_m031017_c001_v7007000_t0000_u01762312217337") 2025/11/05 03:12:42 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4c15_d20251105_m031016_c001_v0001165_t0025_u01762312216087") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece755_d20251105_m031236_c001_v7007000_t0000_u01762312356446") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c10fe_d20251105_m031235_c001_v0001037_t0050_u01762312355809") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a08143_d20251105_m031211_c001_v7007000_t0000_u01762312331012") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee073458a_d20251105_m031210_c001_v0001146_t0022_u01762312330476") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d35d_d20251105_m031153_c001_v7007000_t0000_u01762312313719") 2025/11/05 03:12:42 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4e0e_d20251105_m031153_c001_v0001165_t0017_u01762312313339") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2dc18_d20251105_m031121_c001_v7007000_t0000_u01762312281387") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848ca1c_d20251105_m031120_c001_v0001134_t0002_u01762312280891") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a0424e_d20251105_m031050_c001_v7007000_t0000_u01762312250427") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c105b_d20251105_m031049_c001_v0001037_t0015_u01762312249532") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f405701c368520861_d20251105_m031017_c001_v7007000_t0000_u01762312217532") 2025/11/05 03:12:43 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734398_d20251105_m031016_c001_v0001146_t0056_u01762312216890") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107a39cf93da9c1a_d20251105_m031239_c001_v0001113_t0055_u01762312359775") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1085ff892d6e0301_d20251105_m031157_c001_v0001161_t0059_u01762312317867") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1027f2672b53a78b_d20251105_m031123_c001_v0001099_t0023_u01762312283619") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f40243b349f10382c_d20251105_m031057_c001_v7007000_t0000_u01762312257986") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f117ae58888e62bb2_d20251105_m031054_c001_v0001171_t0058_u01762312254753") 2025/11/05 03:12:43 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734347_d20251105_m031000_c001_v0001146_t0057_u01762312200333") 2025/11/05 03:12:43 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1143d4e06e05298b_d20251105_m031123_c001_v0001032_t0049_u01762312283953") 2025/11/05 03:12:43 DEBUG : file3.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107d9c9af17927bf_d20251105_m031111_c001_v0001120_t0045_u01762312271016") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4103089b7f35201a_d20251105_m031229_c001_v7007000_t0000_u01762312349578") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f113a1d4b39fe496b_d20251105_m031228_c001_v0001182_t0046_u01762312348380") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4e94_d20251105_m031226_c001_v0001165_t0019_u01762312346244") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d39b_d20251105_m031204_c001_v7007000_t0000_u01762312324735") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1160093843cf23a2_d20251105_m031203_c001_v0001165_t0059_u01762312323531") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848ca86_d20251105_m031159_c001_v0001134_t0058_u01762312319698") 2025/11/05 03:12:43 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419b66f47bb8cf84_d20251105_m031147_c001_v7007000_t0000_u01762312307256") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1193bf25cb023bda_d20251105_m031145_c001_v0001154_t0002_u01762312305832") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c10ab_d20251105_m031143_c001_v0001037_t0043_u01762312303225") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2dc01_d20251105_m031115_c001_v7007000_t0000_u01762312275661") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11300b24062b0045_d20251105_m031114_c001_v0001171_t0034_u01762312274353") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734465_d20251105_m031111_c001_v0001146_t0039_u01762312271901") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece54b_d20251105_m031042_c001_v7007000_t0000_u01762312242971") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f100960c40c552e5a_d20251105_m031041_c001_v0001182_t0013_u01762312241771") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4ca4_d20251105_m031039_c001_v0001165_t0028_u01762312239571") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f405701c368520859_d20251105_m031011_c001_v7007000_t0000_u01762312211468") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f119f19039b27e1f5_d20251105_m031009_c001_v0001157_t0019_u01762312209929") 2025/11/05 03:12:44 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848c928_d20251105_m031007_c001_v0001134_t0040_u01762312207483") 2025/11/05 03:12:44 DEBUG : newfolder/HeLlO,wOrLd!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112adabc5a5e4284_d20251105_m031225_c001_v0001134_t0053_u01762312345490") 2025/11/05 03:12:44 DEBUG : newfolder/HeLlO,wOrLd!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f119e3d324947c782_d20251105_m031158_c001_v0001179_t0055_u01762312318294") 2025/11/05 03:12:44 DEBUG : newfolder/HeLlO,wOrLd!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1166b36751a72872_d20251105_m031133_c001_v0001040_t0054_u01762312293427") 2025/11/05 03:12:44 DEBUG : newfolder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107e18cbf472e0e3_d20251105_m031222_c001_v0001042_t0001_u01762312342856") 2025/11/05 03:12:44 DEBUG : newfolder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11833867ea281cbd_d20251105_m031158_c001_v0001182_t0016_u01762312318029") 2025/11/05 03:12:44 DEBUG : newfolder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1156e87ecbd7882d_d20251105_m031130_c001_v0001178_t0044_u01762312290665") 2025/11/05 03:12:44 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece762_d20251105_m031238_c001_v7007000_t0000_u01762312358105") 2025/11/05 03:12:44 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848cac9_d20251105_m031236_c001_v0001134_t0017_u01762312356991") 2025/11/05 03:12:44 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a0814f_d20251105_m031213_c001_v7007000_t0000_u01762312333239") 2025/11/05 03:12:44 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c10d8_d20251105_m031211_c001_v0001037_t0033_u01762312331557") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d368_d20251105_m031155_c001_v7007000_t0000_u01762312315826") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734513_d20251105_m031154_c001_v0001146_t0024_u01762312314264") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2dc20_d20251105_m031123_c001_v7007000_t0000_u01762312283048") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4d80_d20251105_m031121_c001_v0001165_t0023_u01762312281935") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a0425c_d20251105_m031052_c001_v7007000_t0000_u01762312252671") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848c9b8_d20251105_m031050_c001_v0001134_t0006_u01762312250971") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f405701c368520864_d20251105_m031019_c001_v7007000_t0000_u01762312219551") 2025/11/05 03:12:45 DEBUG : ě áñhࢺ_測試Рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c1034_d20251105_m031018_c001_v0001037_t0057_u01762312218081") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece766_d20251105_m031238_c001_v7007000_t0000_u01762312358286") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4ec5_d20251105_m031237_c001_v0001165_t0030_u01762312357907") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a08150_d20251105_m031213_c001_v7007000_t0000_u01762312333420") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848ca9d_d20251105_m031212_c001_v0001134_t0034_u01762312332680") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d36a_d20251105_m031156_c001_v7007000_t0000_u01762312316007") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114922753d5c10c2_d20251105_m031155_c001_v0001037_t0002_u01762312315177") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2dc21_d20251105_m031123_c001_v7007000_t0000_u01762312283230") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1115c1fee0734485_d20251105_m031122_c001_v0001146_t0017_u01762312282682") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a04645_d20251105_m031052_c001_v7007000_t0000_u01762312252854") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1083e011310a4ce4_d20251105_m031051_c001_v0001165_t0046_u01762312251895") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f405701c368520865_d20251105_m031019_c001_v7007000_t0000_u01762312219747") 2025/11/05 03:12:45 DEBUG : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f114957c7c848c950_d20251105_m031019_c001_v0001134_t0026_u01762312219227") 2025/11/05 03:12:45 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10286526a704ae2c_d20251105_m031220_c001_v0001136_t0025_u01762312340271") 2025/11/05 03:12:45 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10354e1ee647a20d_d20251105_m031127_c001_v0001113_t0037_u01762312287599") 2025/11/05 03:12:46 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/normalization/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:12:46 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece59c_d20251105_m031100_c001_v7007000_t0000_u01762312260518") 2025/11/05 03:12:46 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1144958ee5a2b4fb_d20251105_m031002_c001_v0001182_t0045_u01762312202420") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1102622d4820d90f_d20251105_m031217_c001_v0001102_t0045_u01762312337572") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f100646b10b8acfae_d20251105_m031136_c001_v0001032_t0056_u01762312296204") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1015a0569b88f1cc_d20251105_m031105_c001_v0001041_t0005_u01762312265028") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece5a0_d20251105_m031100_c001_v7007000_t0000_u01762312260698") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f116dbadbe44512c6_d20251105_m031033_c001_v0001029_t0039_u01762312233013") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1151c4b4ca772957_d20251105_m031020_c001_v0001181_t0023_u01762312220742") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107a39cf93da9af5_d20251105_m031006_c001_v0001113_t0025_u01762312206614") 2025/11/05 03:12:46 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1062e6df32b6c044_d20251105_m031002_c001_v0001165_t0025_u01762312202248") 2025/11/05 03:12:46 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f101d59bf17d7fa4c_d20251105_m031108_c001_v0001183_t0054_u01762312268141") 2025/11/05 03:12:47 DEBUG : file3.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1173a0966bf1d719_d20251105_m031124_c001_v0001184_t0043_u01762312284815") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f412fe48847ece747_d20251105_m031234_c001_v7007000_t0000_u01762312354078") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1140a4875f7584b3_d20251105_m031232_c001_v0001117_t0028_u01762312352325") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1062e6df32b6c282_d20251105_m031230_c001_v0001165_t0025_u01762312350121") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4222faa0dd7447a6_d20251105_m031209_c001_v7007000_t0000_u01762312329022") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1061bad1db246952_d20251105_m031207_c001_v0001101_t0037_u01762312327482") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1144958ee5a2bc53_d20251105_m031205_c001_v0001182_t0011_u01762312325289") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f419682f80445d34e_d20251105_m031151_c001_v7007000_t0000_u01762312311602") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f119fa7691caaed60_d20251105_m031150_c001_v0001146_t0031_u01762312310057") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104940f99027b1b6_d20251105_m031147_c001_v0001038_t0044_u01762312307805") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f423e001ce84caff0_d20251105_m031119_c001_v7007000_t0000_u01762312279217") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f100e0552004567ea_d20251105_m031117_c001_v0001150_t0055_u01762312277979") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1126fa7a967376c2_d20251105_m031116_c001_v0001179_t0016_u01762312276214") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4088b68768b48371_d20251105_m031047_c001_v7007000_t0000_u01762312247727") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10324384ecee377d_d20251105_m031045_c001_v0001104_t0024_u01762312245369") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1062e6df32b6c0fc_d20251105_m031043_c001_v0001165_t0047_u01762312243516") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f42167a6f23f56360_d20251105_m031015_c001_v7007000_t0000_u01762312215536") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f119dedb97e086c0f_d20251105_m031014_c001_v0001101_t0006_u01762312214150") 2025/11/05 03:12:47 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1144958ee5a2b56b_d20251105_m031012_c001_v0001182_t0027_u01762312212019") 2025/11/05 03:12:47 DEBUG : newfolder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1067e951e6c91739_d20251105_m031241_c001_v0001154_t0017_u01762312361384") 2025/11/05 03:12:47 DEBUG : newfolder/éééö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10314b2cefc86046_d20251105_m031139_c001_v0001136_t0038_u01762312299135") 2025/11/05 03:12:47 DEBUG : newfolder/hello,WORLD!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1155ff84e86db6b2_d20251105_m031241_c001_v0001183_t0015_u01762312361157") 2025/11/05 03:12:48 DEBUG : newfolder/hello,WORLD!.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1024e57ee8dfb766_d20251105_m031142_c001_v0001154_t0020_u01762312302481") 2025/11/05 03:12:48 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10708d3d78caf7b2_d20251105_m031241_c001_v0001182_t0043_u01762312361150") 2025/11/05 03:12:48 DEBUG : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10135652c2c54c9f_d20251105_m031158_c001_v0001172_t0040_u01762312318887") bisync_test.go:608: TEST normalization PASSED === RUN TestBisyncRemoteRemote/rclone_args 2025/11/05 03:12:48 INFO : path1: Making directory 2025/11/05 03:12:48 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1" 2025/11/05 03:12:49 INFO : path2: Making directory 2025/11/05 03:12:49 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2" 2025/11/05 03:12:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2025/11/05 03:12:50 DEBUG : Creating backend with remote "/tmp/030953zu/initdir/test_rclone_args-raliqok6" 2025/11/05 03:12:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : subdir: Making directory with metadata 2025/11/05 03:12:50 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/11/05 03:12:50 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/11/05 03:12:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/11/05 03:12:50 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:12:50 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/11/05 03:12:50 INFO : file2.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : Local file system at /tmp/030953zu/initdir/test_rclone_args-raliqok6: Waiting for checks to finish 2025/11/05 03:12:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2025/11/05 03:12:50 DEBUG : Local file system at /tmp/030953zu/initdir/test_rclone_args-raliqok6: Waiting for transfers to finish 2025/11/05 03:12:50 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:12:50 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2025/11/05 03:12:50 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:12:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2025/11/05 03:12:50 INFO : subdir/file20.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2025/11/05 03:12:50 INFO : subdir/file21.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/11/05 03:12:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/11/05 03:12:50 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/11/05 03:12:50 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:12:50 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2025/11/05 03:12:50 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2025/11/05 03:12:50 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2025/11/05 03:12:50 INFO : file1.txt: Copied (new) 2025/11/05 03:12:50 INFO : subdir: Set directory modification time (using SetModTime) 2025/11/05 03:12:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2025/11/05 03:12:50 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6" 2025/11/05 03:12:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file20.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : file21.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:50 DEBUG : Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6: Waiting for checks to finish 2025/11/05 03:12:50 DEBUG : file20.txt.fd848222.partial: size = 0 OK 2025/11/05 03:12:50 DEBUG : Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6: Waiting for transfers to finish 2025/11/05 03:12:50 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:12:50 DEBUG : file21.txt.68f456b7.partial: size = 0 OK 2025/11/05 03:12:50 DEBUG : file20.txt.fd848222.partial: renamed to: file20.txt 2025/11/05 03:12:50 INFO : file20.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/11/05 03:12:50 DEBUG : file21.txt.68f456b7.partial: renamed to: file21.txt 2025/11/05 03:12:50 INFO : file21.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : file2.txt.d6677e1f.partial: size = 19 OK 2025/11/05 03:12:50 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/11/05 03:12:50 DEBUG : file1.txt.8c06417f.partial: size = 19 OK 2025/11/05 03:12:50 DEBUG : file2.txt.d6677e1f.partial: renamed to: file2.txt 2025/11/05 03:12:50 INFO : file2.txt: Copied (new) 2025/11/05 03:12:50 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/11/05 03:12:50 DEBUG : file1.txt.8c06417f.partial: renamed to: file1.txt 2025/11/05 03:12:50 INFO : file1.txt: Copied (new) 2025/11/05 03:12:50 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:12:51 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:12:52 NOTICE: checking initFs Local file system at /tmp/030953zu/initdir/test_rclone_args-raliqok6 2025/11/05 03:12:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:12:52 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:52 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:52 INFO : subdir: Making directory 2025/11/05 03:12:52 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:52 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:52 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Waiting for checks to finish 2025/11/05 03:12:52 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Waiting for transfers to finish 2025/11/05 03:12:53 DEBUG : subdir/file20.txt: size = 0 OK 2025/11/05 03:12:53 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:53 INFO : subdir/file20.txt: Copied (new) 2025/11/05 03:12:53 DEBUG : subdir/file21.txt: size = 0 OK 2025/11/05 03:12:53 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:53 INFO : subdir/file21.txt: Copied (new) 2025/11/05 03:12:53 DEBUG : file2.txt: size = 0 OK 2025/11/05 03:12:53 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:53 INFO : file2.txt: Copied (new) 2025/11/05 03:12:54 DEBUG : RCLONE_TEST: size = 109 OK 2025/11/05 03:12:54 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/11/05 03:12:54 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:12:54 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:12:54 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2025/11/05 03:12:54 INFO : file1.txt: Copied (new) 2025/11/05 03:12:54 NOTICE: checking Path1 B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1 2025/11/05 03:12:54 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/11/05 03:12:54 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:54 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:54 INFO : subdir: Making directory 2025/11/05 03:12:54 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:54 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/11/05 03:12:54 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Waiting for checks to finish 2025/11/05 03:12:54 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Waiting for transfers to finish 2025/11/05 03:12:55 DEBUG : file2.txt: size = 0 OK 2025/11/05 03:12:55 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:55 INFO : file2.txt: Copied (new) 2025/11/05 03:12:55 DEBUG : RCLONE_TEST: size = 109 OK 2025/11/05 03:12:55 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/11/05 03:12:55 INFO : RCLONE_TEST: Copied (new) 2025/11/05 03:12:56 DEBUG : subdir/file21.txt: size = 0 OK 2025/11/05 03:12:56 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:56 INFO : subdir/file21.txt: Copied (new) 2025/11/05 03:12:56 DEBUG : subdir/file20.txt: size = 0 OK 2025/11/05 03:12:56 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:12:56 INFO : subdir/file20.txt: Copied (new) 2025/11/05 03:12:56 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:12:56 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2025/11/05 03:12:56 INFO : file1.txt: Copied (new) 2025/11/05 03:12:56 NOTICE: checking path2 B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2 2025/11/05 03:12:56 NOTICE: (01) : test rclone-args 2025/11/05 03:12:56 NOTICE: (02) : touch-glob 2001-01-02 /tmp/030953zu/datadir/test_rclone_args-nowokir6/ * 2025/11/05 03:12:56 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/" 2025/11/05 03:12:56 DEBUG : fs cache: renaming cache item "/tmp/030953zu/datadir/test_rclone_args-nowokir6/" to be canonical "/tmp/030953zu/datadir/test_rclone_args-nowokir6" 2025/11/05 03:12:56 DEBUG : file21.txt: Set modification time 2001-01-02 2025/11/05 03:12:56 DEBUG : file1.txt: Set modification time 2001-01-02 2025/11/05 03:12:56 DEBUG : file2.txt: Set modification time 2001-01-02 2025/11/05 03:12:56 DEBUG : file20.txt: Set modification time 2001-01-02 2025/11/05 03:12:56 NOTICE: (03) : test initial bisync 2025/11/05 03:12:56 NOTICE: (04) : bisync resync checksum 2025/11/05 03:13:03 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:13:03 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:13:03 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/11/05 03:13:03 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:03 INFO : Copying Path2 files to Path1 2025/11/05 03:13:03 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:13:03 INFO : There was nothing to transfer 2025/11/05 03:13:03 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:13:04 INFO : There was nothing to transfer 2025/11/05 03:13:04 INFO : Resync updating listings 2025/11/05 03:13:04 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:04 INFO : Bisync successful 2025/11/05 03:13:04 NOTICE: (05) : test place newer files on both paths 2025/11/05 03:13:04 NOTICE: (06) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ 2025/11/05 03:13:04 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" as "" 2025/11/05 03:13:04 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" 2025/11/05 03:13:04 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" 2025/11/05 03:13:05 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1" as "file1.txt" 2025/11/05 03:13:05 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:13:05 DEBUG : file1.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2025/11/05 03:13:05 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c (Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6) 2025/11/05 03:13:05 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 (B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1) 2025/11/05 03:13:05 DEBUG : file1.txt: sha1 differ 2025/11/05 03:13:07 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:13:07 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:13:07 INFO : file1.txt: Copied (replaced existing) 2025/11/05 03:13:07 NOTICE: (07) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ 2025/11/05 03:13:07 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" as "" 2025/11/05 03:13:07 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" 2025/11/05 03:13:07 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:08 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2" as "file2.txt" 2025/11/05 03:13:08 DEBUG : file2.txt: size = 19 (Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6) 2025/11/05 03:13:08 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2) 2025/11/05 03:13:08 DEBUG : file2.txt: Sizes differ 2025/11/05 03:13:10 DEBUG : file2.txt: size = 19 OK 2025/11/05 03:13:10 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:13:10 INFO : file2.txt: Copied (replaced existing) 2025/11/05 03:13:10 NOTICE: (08) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir 2025/11/05 03:13:10 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" as "" 2025/11/05 03:13:10 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" 2025/11/05 03:13:10 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:13:11 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1/subdir" as "file20.txt" 2025/11/05 03:13:11 DEBUG : file20.txt: size = 0 OK 2025/11/05 03:13:11 DEBUG : file20.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2025/11/05 03:13:11 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:13:13 INFO : file20.txt: Updated modification time in destination 2025/11/05 03:13:13 DEBUG : file20.txt: Unchanged skipping 2025/11/05 03:13:13 NOTICE: (09) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir 2025/11/05 03:13:13 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" as "" 2025/11/05 03:13:13 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" 2025/11/05 03:13:13 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:13:14 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2/subdir" as "file21.txt" 2025/11/05 03:13:14 DEBUG : file21.txt: size = 0 OK 2025/11/05 03:13:14 DEBUG : file21.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2025/11/05 03:13:14 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:13:15 INFO : file21.txt: Updated modification time in destination 2025/11/05 03:13:15 DEBUG : file21.txt: Unchanged skipping 2025/11/05 03:13:15 NOTICE: (10) : touch-glob 2001-01-02 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ file1.txt 2025/11/05 03:13:15 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" 2025/11/05 03:13:16 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" to be canonical "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1" 2025/11/05 03:13:17 DEBUG : file1.txt: Set modification time 2001-01-02 2025/11/05 03:13:19 NOTICE: (11) : touch-glob 2001-01-02 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file2.txt 2025/11/05 03:13:19 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:20 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" to be canonical "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2" 2025/11/05 03:13:20 DEBUG : file2.txt: Set modification time 2001-01-02 2025/11/05 03:13:21 NOTICE: (12) : touch-glob 2001-01-02 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/ file20.txt 2025/11/05 03:13:21 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/" 2025/11/05 03:13:22 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/" to be canonical "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:13:23 DEBUG : file20.txt: Set modification time 2001-01-02 2025/11/05 03:13:24 NOTICE: (13) : touch-glob 2001-01-02 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/ file21.txt 2025/11/05 03:13:24 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/" 2025/11/05 03:13:25 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/" to be canonical "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:13:26 DEBUG : file21.txt: Set modification time 2001-01-02 2025/11/05 03:13:27 NOTICE: (14) : test run bisync with custom options 2025/11/05 03:13:27 NOTICE: (15) : bisync checksum 2025/11/05 03:13:35 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:13:35 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:13:35 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/11/05 03:13:35 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:35 INFO : Building Path1 and Path2 listings 2025/11/05 03:13:36 INFO : Path1 checking for diffs 2025/11/05 03:13:36 INFO : - Path1 File changed: hash - file1.txt 2025/11/05 03:13:36 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2025/11/05 03:13:36 INFO : (Modified:  1 hash differs) 2025/11/05 03:13:36 INFO : Path2 checking for diffs 2025/11/05 03:13:36 INFO : - Path2 File changed: size (larger), hash - file2.txt 2025/11/05 03:13:36 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/11/05 03:13:36 INFO : (Modified:  1 larger,  0 smaller,  1 hash differs) 2025/11/05 03:13:36 INFO : Applying changes 2025/11/05 03:13:36 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/file1.txt 2025/11/05 03:13:36 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/file2.txt 2025/11/05 03:13:36 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:13:36 INFO : file2.txt: Copied (server-side copy) 2025/11/05 03:13:36 INFO : - Path1 Do queued copies to - Path2 2025/11/05 03:13:37 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:13:37 INFO : Updating listings 2025/11/05 03:13:37 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:37 INFO : Bisync successful 2025/11/05 03:13:37 NOTICE: (16) : touch-glob 2007-07-23 /tmp/030953zu/datadir/test_rclone_args-nowokir6/ * 2025/11/05 03:13:37 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_rclone_args-nowokir6/" for canonical name "/tmp/030953zu/datadir/test_rclone_args-nowokir6" 2025/11/05 03:13:37 DEBUG : file21.txt: Set modification time 2007-07-23 2025/11/05 03:13:37 DEBUG : file1.txt: Set modification time 2007-07-23 2025/11/05 03:13:37 DEBUG : file2.txt: Set modification time 2007-07-23 2025/11/05 03:13:37 DEBUG : file20.txt: Set modification time 2007-07-23 2025/11/05 03:13:37 NOTICE: (17) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ 2025/11/05 03:13:37 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" as "" 2025/11/05 03:13:37 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" 2025/11/05 03:13:37 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" 2025/11/05 03:13:38 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1" as "file1.txt" 2025/11/05 03:13:38 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:13:38 DEBUG : file1.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:13:38 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:13:39 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:13:39 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:13:39 NOTICE: (18) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ 2025/11/05 03:13:39 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" as "" 2025/11/05 03:13:39 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" 2025/11/05 03:13:39 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:40 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2" as "file2.txt" 2025/11/05 03:13:41 DEBUG : file2.txt: size = 19 OK 2025/11/05 03:13:41 DEBUG : file2.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:13:41 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:13:42 INFO : file2.txt: Updated modification time in destination 2025/11/05 03:13:42 DEBUG : file2.txt: Unchanged skipping 2025/11/05 03:13:42 NOTICE: (19) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir 2025/11/05 03:13:42 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" as "" 2025/11/05 03:13:42 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" 2025/11/05 03:13:42 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:13:43 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1/subdir" as "file20.txt" 2025/11/05 03:13:43 DEBUG : file20.txt: size = 0 OK 2025/11/05 03:13:43 DEBUG : file20.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:13:43 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:13:45 INFO : file20.txt: Updated modification time in destination 2025/11/05 03:13:45 DEBUG : file20.txt: Unchanged skipping 2025/11/05 03:13:45 NOTICE: (20) : copy-as /tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file1.txt 2025/11/05 03:13:45 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" as "file1.txt" 2025/11/05 03:13:45 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" 2025/11/05 03:13:45 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:13:46 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2" as "file1.txt" 2025/11/05 03:13:46 DEBUG : file21.txt: size = 0 (Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6) 2025/11/05 03:13:46 DEBUG : file1.txt: size = 19 (B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2) 2025/11/05 03:13:46 DEBUG : file21.txt: Sizes differ 2025/11/05 03:13:47 DEBUG : file1.txt: size = 0 OK 2025/11/05 03:13:47 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:13:47 INFO : file21.txt: Copied (replaced existing) to: file1.txt 2025/11/05 03:13:47 NOTICE: (21) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ file1.txt 2025/11/05 03:13:47 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1" 2025/11/05 03:13:48 DEBUG : file1.txt: Set modification time 2007-07-23 2025/11/05 03:13:49 NOTICE: (22) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file2.txt 2025/11/05 03:13:49 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2" 2025/11/05 03:13:50 DEBUG : file2.txt: Set modification time 2007-07-23 2025/11/05 03:13:50 NOTICE: (23) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/ file20.txt 2025/11/05 03:13:50 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:13:51 DEBUG : file20.txt: Set modification time 2007-07-23 2025/11/05 03:13:52 NOTICE: (24) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/ file21.txt 2025/11/05 03:13:52 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:13:52 DEBUG : file21.txt: Set modification time 2007-07-23 2025/11/05 03:13:53 NOTICE: (25) : bisync size-only 2025/11/05 03:14:02 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:02 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:02 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:14:02 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:14:02 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:02 INFO : Building Path1 and Path2 listings 2025/11/05 03:14:02 INFO : Path1 checking for diffs 2025/11/05 03:14:02 INFO : Path2 checking for diffs 2025/11/05 03:14:02 INFO : - Path2 File changed: size (smaller) - file1.txt 2025/11/05 03:14:02 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/11/05 03:14:02 INFO : (Modified:  0 larger,  1 smaller) 2025/11/05 03:14:02 INFO : Applying changes 2025/11/05 03:14:02 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/file1.txt 2025/11/05 03:14:02 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:14:03 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:14:03 INFO : Updating listings 2025/11/05 03:14:03 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:03 INFO : Bisync successful 2025/11/05 03:14:03 NOTICE: (26) : bisync resync 2025/11/05 03:14:11 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:11 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:11 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:14:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:14:11 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:11 INFO : Copying Path2 files to Path1 2025/11/05 03:14:11 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:14:11 INFO : There was nothing to transfer 2025/11/05 03:14:11 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:14:12 INFO : file2.txt: Updated modification time in destination 2025/11/05 03:14:12 INFO : subdir/file21.txt: Updated modification time in destination 2025/11/05 03:14:13 INFO : subdir/file20.txt: Updated modification time in destination 2025/11/05 03:14:13 INFO : There was nothing to transfer 2025/11/05 03:14:13 INFO : Resync updating listings 2025/11/05 03:14:13 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:13 INFO : Bisync successful 2025/11/05 03:14:13 NOTICE: (27) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ 2025/11/05 03:14:13 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" as "" 2025/11/05 03:14:13 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" 2025/11/05 03:14:13 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" 2025/11/05 03:14:14 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1" as "file1.txt" 2025/11/05 03:14:14 DEBUG : file1.txt: size = 19 (Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6) 2025/11/05 03:14:14 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1) 2025/11/05 03:14:14 DEBUG : file1.txt: Sizes differ 2025/11/05 03:14:15 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:14:15 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:14:15 INFO : file1.txt: Copied (replaced existing) 2025/11/05 03:14:15 NOTICE: (28) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ 2025/11/05 03:14:15 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" as "" 2025/11/05 03:14:15 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file2.txt" 2025/11/05 03:14:15 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:17 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2" as "file2.txt" 2025/11/05 03:14:17 DEBUG : file2.txt: size = 19 OK 2025/11/05 03:14:17 DEBUG : file2.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2025/11/05 03:14:17 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:14:18 INFO : file2.txt: Updated modification time in destination 2025/11/05 03:14:18 DEBUG : file2.txt: Unchanged skipping 2025/11/05 03:14:18 NOTICE: (29) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir 2025/11/05 03:14:18 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" as "" 2025/11/05 03:14:18 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" 2025/11/05 03:14:18 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:14:19 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1/subdir" as "file20.txt" 2025/11/05 03:14:19 DEBUG : file20.txt: size = 0 OK 2025/11/05 03:14:19 DEBUG : file20.txt: Size and modification time the same (differ by 0s, within tolerance 1ms) 2025/11/05 03:14:19 DEBUG : file20.txt: Unchanged skipping 2025/11/05 03:14:19 NOTICE: (30) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir 2025/11/05 03:14:19 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" as "" 2025/11/05 03:14:19 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" 2025/11/05 03:14:19 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:14:20 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2/subdir" as "file21.txt" 2025/11/05 03:14:21 DEBUG : file21.txt: size = 0 OK 2025/11/05 03:14:21 DEBUG : file21.txt: Modification times differ by -66240h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2025/11/05 03:14:21 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:14:22 INFO : file21.txt: Updated modification time in destination 2025/11/05 03:14:22 DEBUG : file21.txt: Unchanged skipping 2025/11/05 03:14:22 NOTICE: (31) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ file1.txt 2025/11/05 03:14:22 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1" 2025/11/05 03:14:23 DEBUG : file1.txt: Set modification time 2007-07-23 2025/11/05 03:14:25 NOTICE: (32) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file2.txt 2025/11/05 03:14:25 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2" 2025/11/05 03:14:26 DEBUG : file2.txt: Set modification time 2007-07-23 2025/11/05 03:14:26 NOTICE: (33) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/ file20.txt 2025/11/05 03:14:26 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:14:27 DEBUG : file20.txt: Set modification time 2007-07-23 2025/11/05 03:14:28 NOTICE: (34) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/ file21.txt 2025/11/05 03:14:28 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:14:28 DEBUG : file21.txt: Set modification time 2007-07-23 2025/11/05 03:14:29 NOTICE: (35) : bisync ignore-size 2025/11/05 03:14:37 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:37 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:37 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/11/05 03:14:37 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": false, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/11/05 03:14:37 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:37 INFO : Building Path1 and Path2 listings 2025/11/05 03:14:38 INFO : Path1 checking for diffs 2025/11/05 03:14:38 INFO : Path2 checking for diffs 2025/11/05 03:14:38 INFO : - Path2 File changed: time (newer) - file2.txt 2025/11/05 03:14:38 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2025/11/05 03:14:38 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2025/11/05 03:14:38 INFO : (Modified:  2 newer,  0 older) 2025/11/05 03:14:38 INFO : Applying changes 2025/11/05 03:14:38 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/file2.txt 2025/11/05 03:14:38 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/file21.txt 2025/11/05 03:14:38 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:14:39 INFO : file2.txt: Updated modification time in destination 2025/11/05 03:14:40 INFO : subdir/file21.txt: Updated modification time in destination 2025/11/05 03:14:40 INFO : There was nothing to transfer 2025/11/05 03:14:40 INFO : Updating listings 2025/11/05 03:14:40 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:40 INFO : Bisync successful 2025/11/05 03:14:40 NOTICE: (36) : bisync resync compare-all 2025/11/05 03:14:48 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:48 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:14:48 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/11/05 03:14:48 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:48 INFO : Copying Path2 files to Path1 2025/11/05 03:14:48 INFO : - Path2 Resync is copying files to - Path1 2025/11/05 03:14:48 INFO : There was nothing to transfer 2025/11/05 03:14:48 INFO : - Path1 Resync is copying files to - Path2 2025/11/05 03:14:49 INFO : file1.txt: Copied (server-side copy) 2025/11/05 03:14:49 INFO : Resync updating listings 2025/11/05 03:14:49 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:49 INFO : Bisync successful 2025/11/05 03:14:49 NOTICE: (37) : copy-as /tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file2.txt 2025/11/05 03:14:49 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" as "file2.txt" 2025/11/05 03:14:49 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" 2025/11/05 03:14:49 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:14:50 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2" as "file2.txt" 2025/11/05 03:14:50 DEBUG : file21.txt: size = 0 (Local file system at /tmp/030953zu/datadir/test_rclone_args-nowokir6) 2025/11/05 03:14:50 DEBUG : file2.txt: size = 19 (B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2) 2025/11/05 03:14:50 DEBUG : file21.txt: Sizes differ 2025/11/05 03:14:52 DEBUG : file2.txt: size = 0 OK 2025/11/05 03:14:52 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:14:52 INFO : file21.txt: Copied (replaced existing) to: file2.txt 2025/11/05 03:14:52 NOTICE: (38) : touch-glob 2023-08-26 /tmp/030953zu/datadir/test_rclone_args-nowokir6/ * 2025/11/05 03:14:52 DEBUG : fs cache: switching user supplied name "/tmp/030953zu/datadir/test_rclone_args-nowokir6/" for canonical name "/tmp/030953zu/datadir/test_rclone_args-nowokir6" 2025/11/05 03:14:52 DEBUG : file21.txt: Set modification time 2023-08-26 2025/11/05 03:14:52 DEBUG : file1.txt: Set modification time 2023-08-26 2025/11/05 03:14:52 DEBUG : file2.txt: Set modification time 2023-08-26 2025/11/05 03:14:52 DEBUG : file20.txt: Set modification time 2023-08-26 2025/11/05 03:14:52 NOTICE: (39) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ 2025/11/05 03:14:52 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" as "" 2025/11/05 03:14:52 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file1.txt" 2025/11/05 03:14:52 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" 2025/11/05 03:14:53 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1" as "file1.txt" 2025/11/05 03:14:53 DEBUG : file1.txt: size = 19 OK 2025/11/05 03:14:53 DEBUG : file1.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2025/11/05 03:14:53 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/11/05 03:14:54 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:14:54 DEBUG : file1.txt: Unchanged skipping 2025/11/05 03:14:54 NOTICE: (40) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir 2025/11/05 03:14:54 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" as "" 2025/11/05 03:14:54 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file20.txt" 2025/11/05 03:14:54 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:14:56 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1/subdir" as "file20.txt" 2025/11/05 03:14:56 DEBUG : file20.txt: size = 0 OK 2025/11/05 03:14:56 DEBUG : file20.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2025/11/05 03:14:56 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:14:57 INFO : file20.txt: Updated modification time in destination 2025/11/05 03:14:57 DEBUG : file20.txt: Unchanged skipping 2025/11/05 03:14:57 NOTICE: (41) : copy-file /tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir 2025/11/05 03:14:57 DEBUG : copyFile "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" to "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" as "" 2025/11/05 03:14:57 DEBUG : Creating backend with remote "/tmp/030953zu/datadir/test_rclone_args-nowokir6/file21.txt" 2025/11/05 03:14:57 DEBUG : Creating backend with remote "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:14:58 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2/subdir" as "file21.txt" 2025/11/05 03:14:58 DEBUG : file21.txt: size = 0 OK 2025/11/05 03:14:58 DEBUG : file21.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2025/11/05 03:14:58 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/11/05 03:15:00 INFO : file21.txt: Updated modification time in destination 2025/11/05 03:15:00 DEBUG : file21.txt: Unchanged skipping 2025/11/05 03:15:00 NOTICE: (42) : touch-glob 2007-07-23 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/ file2.txt 2025/11/05 03:15:00 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2" 2025/11/05 03:15:00 DEBUG : file2.txt: Set modification time 2007-07-23 2025/11/05 03:15:01 NOTICE: (43) : touch-glob 2023-08-26 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/ file1.txt 2025/11/05 03:15:01 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1" 2025/11/05 03:15:02 DEBUG : file1.txt: Set modification time 2023-08-26 2025/11/05 03:15:03 NOTICE: (44) : touch-glob 2023-08-26 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/ file20.txt 2025/11/05 03:15:03 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir" 2025/11/05 03:15:03 DEBUG : file20.txt: Set modification time 2023-08-26 2025/11/05 03:15:04 NOTICE: (45) : touch-glob 2023-08-26 TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/ file21.txt 2025/11/05 03:15:04 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir" 2025/11/05 03:15:05 DEBUG : file21.txt: Set modification time 2023-08-26 2025/11/05 03:15:06 NOTICE: (46) : bisync compare-all 2025/11/05 03:15:16 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:15:16 DEBUG : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/11/05 03:15:16 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/11/05 03:15:16 INFO : Synching Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" with Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:15:16 INFO : Building Path1 and Path2 listings 2025/11/05 03:15:17 INFO : Path1 checking for diffs 2025/11/05 03:15:17 INFO : - Path1 File changed: time (newer) - file1.txt 2025/11/05 03:15:17 INFO : - Path1 File changed: time (newer) - subdir/file20.txt 2025/11/05 03:15:17 INFO : Path1: 2 changes:  0 new,  2 modified,  0 deleted 2025/11/05 03:15:17 INFO : (Modified:  2 newer,  0 older) 2025/11/05 03:15:17 INFO : Path2 checking for diffs 2025/11/05 03:15:17 INFO : - Path2 File changed: size (smaller), hash - file2.txt 2025/11/05 03:15:17 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2025/11/05 03:15:17 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2025/11/05 03:15:17 INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  1 hash differs) 2025/11/05 03:15:17 INFO : Applying changes 2025/11/05 03:15:17 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/file1.txt 2025/11/05 03:15:17 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/subdir/file20.txt 2025/11/05 03:15:17 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/file2.txt 2025/11/05 03:15:17 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/subdir/file21.txt 2025/11/05 03:15:17 INFO : - Path2 Do queued copies to - Path1 2025/11/05 03:15:18 INFO : file2.txt: Copied (server-side copy) 2025/11/05 03:15:19 INFO : subdir/file21.txt: Updated modification time in destination 2025/11/05 03:15:19 INFO : - Path1 Do queued copies to - Path2 2025/11/05 03:15:20 INFO : file1.txt: Updated modification time in destination 2025/11/05 03:15:22 INFO : subdir/file20.txt: Updated modification time in destination 2025/11/05 03:15:22 INFO : Updating listings 2025/11/05 03:15:22 INFO : Validating listings for Path1 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path1/" vs Path2 "TestB2:rclone-test-nisolol3hiza/030953zu/rclone_args/path2/" 2025/11/05 03:15:22 INFO : Bisync successful 2025/11/05 03:15:22 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path1: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:15:22 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107c7724bb2d2df0_d20251105_m031254_c001_v0001165_t0019_u01762312374056") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1065eb93cc5fbcfa_d20251105_m031502_c001_v0001044_t0021_u01762312502750") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112adabc5a5e43eb_d20251105_m031454_c001_v0001134_t0000_u01762312494747") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10312b253aa831b2_d20251105_m031425_c001_v0001182_t0057_u01762312465793") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1057f95acdb7bda1_d20251105_m031415_c001_v0001183_t0003_u01762312455770") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1128965c84ca39a7_d20251105_m031402_c001_v0001113_t0019_u01762312442976") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f102667a235b9783d_d20251105_m031349_c001_v0001117_t0000_u01762312429101") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1010b38ea3b54e28_d20251105_m031339_c001_v0001177_t0022_u01762312419613") 2025/11/05 03:15:22 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1175bad97e837fb5_d20251105_m031317_c001_v0001150_t0034_u01762312397967") 2025/11/05 03:15:23 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1189ed6796b90dc3_d20251105_m031307_c001_v0001137_t0036_u01762312387059") 2025/11/05 03:15:23 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f110db776357f282f_d20251105_m031253_c001_v0001116_t0033_u01762312373873") 2025/11/05 03:15:23 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10877e9b0dd217f9_d20251105_m031517_c001_v0001172_t0009_u01762312517980") 2025/11/05 03:15:23 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1000335508b161ca_d20251105_m031439_c001_v0001042_t0045_u01762312479107") 2025/11/05 03:15:23 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f118dafeae5965cbb_d20251105_m031336_c001_v0001181_t0054_u01762312416424") 2025/11/05 03:15:23 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112aae0420091c98_d20251105_m031253_c001_v0001153_t0008_u01762312373677") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4116d128e0981240_d20251105_m031509_c001_v7007000_t0000_u01762312509984") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f108ac3925b632cc1_d20251105_m031508_c001_v0001171_t0010_u01762312508675") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107c7724bb2d2f9d_d20251105_m031506_c001_v0001165_t0054_u01762312506489") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f415a39794fea8153_d20251105_m031443_c001_v7007000_t0000_u01762312483637") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10648cf57417cd9f_d20251105_m031442_c001_v0001179_t0001_u01762312482281") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112aae0420091d1f_d20251105_m031440_c001_v0001153_t0010_u01762312480679") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4064ce604708a8e7_d20251105_m031433_c001_v7007000_t0000_u01762312473830") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f116f1bdef340c15f_d20251105_m031432_c001_v0001136_t0037_u01762312472432") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f111cecf6e6e0f59a_d20251105_m031430_c001_v0001176_t0037_u01762312470226") 2025/11/05 03:15:23 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4116d128e0981143_d20251105_m031407_c001_v7007000_t0000_u01762312447068") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11945e0f0a2c7bcf_d20251105_m031405_c001_v0001178_t0045_u01762312445853") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f110db776357f2893_d20251105_m031403_c001_v0001116_t0016_u01762312443657") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4116d128e098111e_d20251105_m031357_c001_v7007000_t0000_u01762312437713") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f108709d3b7a5ea5d_d20251105_m031356_c001_v0001091_t0010_u01762312436299") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107c7724bb2d2ea5_d20251105_m031354_c001_v0001165_t0009_u01762312434118") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f420343d706a2e09f_d20251105_m031331_c001_v7007000_t0000_u01762312411441") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11249bf3940e7cd6_d20251105_m031330_c001_v0001136_t0027_u01762312410113") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112aae0420091cb5_d20251105_m031327_c001_v0001153_t0022_u01762312407595") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f40243b349f1039ff_d20251105_m031259_c001_v7007000_t0000_u01762312379560") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1144958ee5a2bf70_d20251105_m031258_c001_v0001182_t0019_u01762312378354") 2025/11/05 03:15:24 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f111cecf6e6e0f149_d20251105_m031256_c001_v0001176_t0020_u01762312376569") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f111364b7ec0e8277_d20251105_m031504_c001_v0001177_t0013_u01762312504342") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f105db22766b31f34_d20251105_m031457_c001_v0001179_t0023_u01762312497243") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1164393b51887be0_d20251105_m031427_c001_v0001091_t0054_u01762312467879") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11743c9f0a31fb9a_d20251105_m031352_c001_v0001181_t0039_u01762312432188") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1149696ce7dd3ecf_d20251105_m031344_c001_v0001115_t0003_u01762312424646") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11791b9c6df1f6f2_d20251105_m031324_c001_v0001040_t0018_u01762312404016") 2025/11/05 03:15:24 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1111e7e6d8b7d00a_d20251105_m031312_c001_v0001165_t0006_u01762312392935") 2025/11/05 03:15:25 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f111cecf6e6e0f123_d20251105_m031253_c001_v0001176_t0029_u01762312373486") 2025/11/05 03:15:25 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112e953265e8eac7_d20251105_m031518_c001_v0001104_t0022_u01762312518534") 2025/11/05 03:15:25 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1135a636cbdf66b4_d20251105_m031439_c001_v0001144_t0017_u01762312479643") 2025/11/05 03:15:25 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f111cecf6e6e0f129_d20251105_m031253_c001_v0001176_t0009_u01762312373712") 2025/11/05 03:15:25 INFO : B2 bucket rclone-test-nisolol3hiza path 030953zu/rclone_args/path2: cleaning bucket "rclone-test-nisolol3hiza" of all files 2025/11/05 03:15:26 DEBUG : RCLONE_TEST: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11569295af85c48c_d20251105_m031255_c001_v0001172_t0056_u01762312375811") 2025/11/05 03:15:26 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f113e166f6587963c_d20251105_m031520_c001_v0001090_t0052_u01762312520112") 2025/11/05 03:15:26 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f109ebb97ff06bd9d_d20251105_m031448_c001_v0001102_t0010_u01762312488933") 2025/11/05 03:15:26 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10247355ba50d281_d20251105_m031347_c001_v0001181_t0043_u01762312427765") 2025/11/05 03:15:26 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11924da00ba7af81_d20251105_m031337_c001_v0001183_t0018_u01762312417067") 2025/11/05 03:15:26 DEBUG : file1.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f106eea24b158eb85_d20251105_m031256_c001_v0001171_t0003_u01762312375999") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11478d965584c599_d20251105_m031500_c001_v0001157_t0007_u01762312500929") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11900dbfa29b3d09_d20251105_m031451_c001_v0001117_t0052_u01762312491995") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104dbc205f453dcd_d20251105_m031426_c001_v0001101_t0036_u01762312466394") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11872414e59ebd28_d20251105_m031418_c001_v0001090_t0001_u01762312458258") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1009f5276ea9f9c6_d20251105_m031412_c001_v0001136_t0059_u01762312452259") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10035c23f57d48b2_d20251105_m031350_c001_v0001172_t0017_u01762312430669") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1184dc856f1a5478_d20251105_m031342_c001_v0001177_t0005_u01762312422058") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f100592eed8c5d306_d20251105_m031321_c001_v0001037_t0019_u01762312401334") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1150b65d85e61514_d20251105_m031310_c001_v0001144_t0041_u01762312390074") 2025/11/05 03:15:26 DEBUG : file2.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1013f1beb3585795_d20251105_m031255_c001_v0001092_t0002_u01762312375421") 2025/11/05 03:15:26 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4164ff5c8cd66f47_d20251105_m031516_c001_v7007000_t0000_u01762312516684") 2025/11/05 03:15:26 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f102f2f0f27784f04_d20251105_m031515_c001_v0001100_t0034_u01762312515033") 2025/11/05 03:15:26 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f102388deda304a9a_d20251105_m031510_c001_v0001032_t0055_u01762312510539") 2025/11/05 03:15:26 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f409b81d624a08c88_d20251105_m031447_c001_v7007000_t0000_u01762312487989") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10638203e380523c_d20251105_m031446_c001_v0001100_t0000_u01762312486680") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1013f1beb3585819_d20251105_m031444_c001_v0001092_t0032_u01762312484183") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f41400e9a7e4fe8e3_d20251105_m031437_c001_v7007000_t0000_u01762312477772") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10396508b73d487c_d20251105_m031436_c001_v0001179_t0004_u01762312476553") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11569295af85c62a_d20251105_m031434_c001_v0001172_t0015_u01762312474406") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f40243b349f103b20_d20251105_m031411_c001_v7007000_t0000_u01762312451237") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f106d13fe513ead41_d20251105_m031409_c001_v0001032_t0029_u01762312449837") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f106eea24b158eccd_d20251105_m031407_c001_v0001171_t0038_u01762312447625") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f4222faa0dd74496d_d20251105_m031402_c001_v7007000_t0000_u01762312442204") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104df9af71de8368_d20251105_m031400_c001_v0001092_t0015_u01762312440828") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f102388deda3049db_d20251105_m031358_c001_v0001032_t0042_u01762312438263") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f41769bf18d55a14a_d20251105_m031335_c001_v7007000_t0000_u01762312415635") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1145edffa1a0be09_d20251105_m031334_c001_v0001178_t0052_u01762312414308") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1013f1beb35857bc_d20251105_m031331_c001_v0001092_t0000_u01762312411986") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f423e001ce84cb19f_d20251105_m031303_c001_v7007000_t0000_u01762312383382") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1107f948d256907e_d20251105_m031302_c001_v0001120_t0053_u01762312382022") 2025/11/05 03:15:27 DEBUG : modtime_write_test: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11569295af85c4a2_d20251105_m031259_c001_v0001172_t0007_u01762312379743") 2025/11/05 03:15:27 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f104e0963f80c0f1a_d20251105_m031522_c001_v0001178_t0024_u01762312522461") 2025/11/05 03:15:27 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f112d6a6da92e4b3a_d20251105_m031412_c001_v0001044_t0019_u01762312452726") 2025/11/05 03:15:28 DEBUG : subdir/file20.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f102388deda304943_d20251105_m031255_c001_v0001032_t0017_u01762312375618") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11243cc44b72dc1c_d20251105_m031505_c001_v0001040_t0001_u01762312505678") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f105e80f3525a85a1_d20251105_m031459_c001_v0001102_t0041_u01762312499710") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f119b19b0f0d9aa5c_d20251105_m031429_c001_v0001172_t0020_u01762312469369") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f101cd1de86d6d2a7_d20251105_m031422_c001_v0001120_t0048_u01762312462154") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f107c7724bb2d2eed_d20251105_m031412_c001_v0001165_t0015_u01762312452765") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f10964f70c75bf605_d20251105_m031353_c001_v0001165_t0031_u01762312433549") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f11258b03cb9d7dbb_d20251105_m031326_c001_v0001100_t0024_u01762312406801") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f108c9ceb5972c912_d20251105_m031315_c001_v0001146_t0026_u01762312395436") 2025/11/05 03:15:28 DEBUG : subdir/file21.txt: Deleting (id "4_zbf320db3f0ed5b1b9fa80e1b_f1013f1beb3585797_d20251105_m031255_c001_v0001092_t0015_u01762312375871") bisync_test.go:608: TEST rclone_args PASSED 2025/11/05 03:15:28 DEBUG : B2 bucket rclone-test-nisolol3hiza: Purge remote 2025/11/05 03:15:28 INFO : B2 bucket rclone-test-nisolol3hiza: cleaning bucket "rclone-test-nisolol3hiza" of all files --- PASS: TestBisyncRemoteRemote (337.18s) --- PASS: TestBisyncRemoteRemote/normalization (175.18s) --- PASS: TestBisyncRemoteRemote/rclone_args (160.34s) PASS 2025/11/05 03:15:30 DEBUG : B2 bucket rclone-test-yoneloq0dazo: Purge remote 2025/11/05 03:15:30 INFO : B2 bucket rclone-test-yoneloq0dazo: cleaning bucket "rclone-test-yoneloq0dazo" of all files 2025/11/05 03:15:30 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(normalization|rclone_args)$'" - Finished OK in 5m38.59588808s (try 3/5)