"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^rclone_args$'" - Starting (try 3/5) 2026/07/26 03:27:06 DEBUG : Creating backend with remote "TestB2:rclone-test-qixubat7gepu" 2026/07/26 03:27:06 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/07/26 03:27:07 DEBUG : Creating backend with remote "/tmp/rclone42811707" === RUN TestBisyncRemoteRemote 2026/07/26 03:27:07 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu" 2026/07/26 03:27:07 NOTICE: remote: TestB2:rclone-test-wofudaj7fiqu === RUN TestBisyncRemoteRemote/rclone_args 2026/07/26 03:27:07 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2" 2026/07/26 03:27:09 INFO : path1: Making directory 2026/07/26 03:27:09 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1" 2026/07/26 03:27:10 INFO : path2: Making directory 2026/07/26 03:27:10 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2" 2026/07/26 03:27:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2026/07/26 03:27:11 DEBUG : Creating backend with remote "/tmp/032707howacuh2/initdir/test_rclone_args-mukibot4" 2026/07/26 03:27:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : subdir: Making directory with metadata 2026/07/26 03:27:11 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/07/26 03:27:11 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/07/26 03:27:11 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/07/26 03:27:11 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2026/07/26 03:27:11 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/07/26 03:27:11 INFO : file1.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/07/26 03:27:11 INFO : RCLONE_TEST: Copied (new) 2026/07/26 03:27:11 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/07/26 03:27:11 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/07/26 03:27:11 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/07/26 03:27:11 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/26 03:27:11 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/07/26 03:27:11 INFO : file2.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/07/26 03:27:11 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/26 03:27:11 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/07/26 03:27:11 INFO : subdir/file20.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/07/26 03:27:11 DEBUG : Local file system at /tmp/032707howacuh2/initdir/test_rclone_args-mukibot4: Waiting for checks to finish 2026/07/26 03:27:11 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/26 03:27:11 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/07/26 03:27:11 INFO : subdir/file21.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : Local file system at /tmp/032707howacuh2/initdir/test_rclone_args-mukibot4: Waiting for transfers to finish 2026/07/26 03:27:11 INFO : subdir: Set directory modification time (using SetModTime) 2026/07/26 03:27:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2026/07/26 03:27:11 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5" 2026/07/26 03:27:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file20.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file21.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:11 DEBUG : file1.txt.8c06417f.partial: size = 19 OK 2026/07/26 03:27:11 DEBUG : file2.txt.d6677e1f.partial: size = 19 OK 2026/07/26 03:27:11 DEBUG : file21.txt.68f456b7.partial: size = 0 OK 2026/07/26 03:27:11 DEBUG : Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5: Waiting for checks to finish 2026/07/26 03:27:11 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/26 03:27:11 DEBUG : Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5: Waiting for transfers to finish 2026/07/26 03:27:11 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/07/26 03:27:11 DEBUG : file21.txt.68f456b7.partial: renamed to: file21.txt 2026/07/26 03:27:11 INFO : file21.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : file20.txt.fd848222.partial: size = 0 OK 2026/07/26 03:27:11 DEBUG : file2.txt.d6677e1f.partial: renamed to: file2.txt 2026/07/26 03:27:11 INFO : file2.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/26 03:27:11 DEBUG : file20.txt.fd848222.partial: renamed to: file20.txt 2026/07/26 03:27:11 INFO : file20.txt: Copied (new) 2026/07/26 03:27:11 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/07/26 03:27:11 DEBUG : file1.txt.8c06417f.partial: renamed to: file1.txt 2026/07/26 03:27:11 INFO : file1.txt: Copied (new) 2026/07/26 03:27:11 INFO : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: cleaning bucket "rclone-test-wofudaj7fiqu" of all files 2026/07/26 03:27:12 INFO : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: cleaning bucket "rclone-test-wofudaj7fiqu" of all files 2026/07/26 03:27:13 NOTICE: checking initFs Local file system at /tmp/032707howacuh2/initdir/test_rclone_args-mukibot4 2026/07/26 03:27:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/26 03:27:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:13 INFO : subdir: Making directory 2026/07/26 03:27:13 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:13 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:13 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Waiting for checks to finish 2026/07/26 03:27:13 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Waiting for transfers to finish 2026/07/26 03:27:14 DEBUG : RCLONE_TEST: size = 109 OK 2026/07/26 03:27:14 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2026/07/26 03:27:14 INFO : RCLONE_TEST: Copied (new) 2026/07/26 03:27:15 DEBUG : file2.txt: size = 0 OK 2026/07/26 03:27:15 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:15 INFO : file2.txt: Copied (new) 2026/07/26 03:27:15 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:27:15 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2026/07/26 03:27:15 INFO : file1.txt: Copied (new) 2026/07/26 03:27:15 DEBUG : subdir/file21.txt: size = 0 OK 2026/07/26 03:27:15 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:15 INFO : subdir/file21.txt: Copied (new) 2026/07/26 03:27:15 DEBUG : subdir/file20.txt: size = 0 OK 2026/07/26 03:27:15 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:15 INFO : subdir/file20.txt: Copied (new) 2026/07/26 03:27:15 NOTICE: checking Path1 B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1 2026/07/26 03:27:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/26 03:27:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:16 INFO : subdir: Making directory 2026/07/26 03:27:16 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:16 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/26 03:27:16 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Waiting for checks to finish 2026/07/26 03:27:16 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Waiting for transfers to finish 2026/07/26 03:27:16 DEBUG : RCLONE_TEST: size = 109 OK 2026/07/26 03:27:16 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2026/07/26 03:27:16 INFO : RCLONE_TEST: Copied (new) 2026/07/26 03:27:17 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:27:17 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2026/07/26 03:27:17 INFO : file1.txt: Copied (new) 2026/07/26 03:27:17 DEBUG : file2.txt: size = 0 OK 2026/07/26 03:27:17 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:17 INFO : file2.txt: Copied (new) 2026/07/26 03:27:17 DEBUG : subdir/file21.txt: size = 0 OK 2026/07/26 03:27:17 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:17 INFO : subdir/file21.txt: Copied (new) 2026/07/26 03:27:17 DEBUG : subdir/file20.txt: size = 0 OK 2026/07/26 03:27:17 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:17 INFO : subdir/file20.txt: Copied (new) 2026/07/26 03:27:17 NOTICE: checking path2 B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2 2026/07/26 03:27:17 NOTICE: (01) : test rclone-args 2026/07/26 03:27:17 NOTICE: (02) : touch-glob 2001-01-02 /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/ * 2026/07/26 03:27:17 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/" 2026/07/26 03:27:17 DEBUG : fs cache: renaming cache item "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/" to be canonical "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5" 2026/07/26 03:27:17 DEBUG : file21.txt: Set modification time 2001-01-02 2026/07/26 03:27:17 DEBUG : file1.txt: Set modification time 2001-01-02 2026/07/26 03:27:17 DEBUG : file2.txt: Set modification time 2001-01-02 2026/07/26 03:27:17 DEBUG : file20.txt: Set modification time 2001-01-02 2026/07/26 03:27:17 NOTICE: (03) : test initial bisync 2026/07/26 03:27:17 NOTICE: (04) : bisync resync checksum 2026/07/26 03:27:25 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:27:25 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:27:25 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2026/07/26 03:27:25 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:25 INFO : Copying Path2 files to Path1 2026/07/26 03:27:25 INFO : - Path2 Resync is copying files to - Path1 2026/07/26 03:27:25 INFO : There was nothing to transfer 2026/07/26 03:27:25 INFO : - Path1 Resync is copying files to - Path2 2026/07/26 03:27:26 INFO : There was nothing to transfer 2026/07/26 03:27:26 INFO : Resync updating listings 2026/07/26 03:27:26 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:26 INFO : Bisync successful 2026/07/26 03:27:26 NOTICE: (05) : test place newer files on both paths 2026/07/26 03:27:26 NOTICE: (06) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ 2026/07/26 03:27:26 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" as "" 2026/07/26 03:27:26 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" 2026/07/26 03:27:26 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" 2026/07/26 03:27:27 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1" as "file1.txt" 2026/07/26 03:27:27 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:27:27 DEBUG : file1.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2026/07/26 03:27:27 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c (Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5) 2026/07/26 03:27:27 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 (B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1) 2026/07/26 03:27:27 DEBUG : file1.txt: sha1 differ 2026/07/26 03:27:29 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:27:29 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:27:29 INFO : file1.txt: Copied (replaced existing) 2026/07/26 03:27:29 NOTICE: (07) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ 2026/07/26 03:27:29 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" as "" 2026/07/26 03:27:29 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" 2026/07/26 03:27:29 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:30 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2" as "file2.txt" 2026/07/26 03:27:30 DEBUG : file2.txt: size = 19 (Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5) 2026/07/26 03:27:30 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2) 2026/07/26 03:27:30 DEBUG : file2.txt: Sizes differ 2026/07/26 03:27:31 DEBUG : file2.txt: size = 19 OK 2026/07/26 03:27:31 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:27:31 INFO : file2.txt: Copied (replaced existing) 2026/07/26 03:27:31 NOTICE: (08) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir 2026/07/26 03:27:31 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" as "" 2026/07/26 03:27:31 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" 2026/07/26 03:27:31 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:27:32 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1/subdir" as "file20.txt" 2026/07/26 03:27:33 DEBUG : file20.txt: size = 0 OK 2026/07/26 03:27:33 DEBUG : file20.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2026/07/26 03:27:33 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:34 INFO : file20.txt: Updated modification time in destination 2026/07/26 03:27:34 DEBUG : file20.txt: Unchanged skipping 2026/07/26 03:27:34 NOTICE: (09) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir 2026/07/26 03:27:34 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" as "" 2026/07/26 03:27:34 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" 2026/07/26 03:27:34 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:27:35 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2/subdir" as "file21.txt" 2026/07/26 03:27:35 DEBUG : file21.txt: size = 0 OK 2026/07/26 03:27:35 DEBUG : file21.txt: Modification times differ by -8808h0m0s: 2001-01-02 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2026/07/26 03:27:35 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:27:37 INFO : file21.txt: Updated modification time in destination 2026/07/26 03:27:37 DEBUG : file21.txt: Unchanged skipping 2026/07/26 03:27:37 NOTICE: (10) : touch-glob 2001-01-02 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ file1.txt 2026/07/26 03:27:37 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" 2026/07/26 03:27:38 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" to be canonical "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1" 2026/07/26 03:27:38 DEBUG : file1.txt: Set modification time 2001-01-02 2026/07/26 03:27:39 NOTICE: (11) : touch-glob 2001-01-02 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file2.txt 2026/07/26 03:27:39 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:40 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" to be canonical "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2" 2026/07/26 03:27:41 DEBUG : file2.txt: Set modification time 2001-01-02 2026/07/26 03:27:42 NOTICE: (12) : touch-glob 2001-01-02 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/ file20.txt 2026/07/26 03:27:42 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/" 2026/07/26 03:27:43 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/" to be canonical "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:27:44 DEBUG : file20.txt: Set modification time 2001-01-02 2026/07/26 03:27:44 NOTICE: (13) : touch-glob 2001-01-02 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/ file21.txt 2026/07/26 03:27:44 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/" 2026/07/26 03:27:45 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/" to be canonical "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:27:46 DEBUG : file21.txt: Set modification time 2001-01-02 2026/07/26 03:27:46 NOTICE: (14) : test run bisync with custom options 2026/07/26 03:27:46 NOTICE: (15) : bisync checksum 2026/07/26 03:27:55 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:27:55 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:27:55 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2026/07/26 03:27:55 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:55 INFO : Building Path1 and Path2 listings 2026/07/26 03:27:55 INFO : Path1 checking for diffs 2026/07/26 03:27:55 INFO : - Path1 File changed: hash - file1.txt 2026/07/26 03:27:55 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2026/07/26 03:27:55 INFO : (Modified:  1 hash differs) 2026/07/26 03:27:55 INFO : Path2 checking for diffs 2026/07/26 03:27:55 INFO : - Path2 File changed: size (larger), hash - file2.txt 2026/07/26 03:27:55 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2026/07/26 03:27:55 INFO : (Modified:  1 larger,  0 smaller,  1 hash differs) 2026/07/26 03:27:55 INFO : Applying changes 2026/07/26 03:27:55 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/file1.txt 2026/07/26 03:27:55 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/file2.txt 2026/07/26 03:27:55 INFO : - Path2 Do queued copies to - Path1 2026/07/26 03:27:56 INFO : file2.txt: Copied (server-side copy) 2026/07/26 03:27:56 INFO : - Path1 Do queued copies to - Path2 2026/07/26 03:27:56 INFO : file1.txt: Copied (server-side copy) 2026/07/26 03:27:56 INFO : Updating listings 2026/07/26 03:27:56 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:27:56 INFO : Bisync successful 2026/07/26 03:27:56 NOTICE: (16) : touch-glob 2007-07-23 /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/ * 2026/07/26 03:27:56 DEBUG : fs cache: switching user supplied name "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/" for canonical name "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5" 2026/07/26 03:27:56 DEBUG : file21.txt: Set modification time 2007-07-23 2026/07/26 03:27:56 DEBUG : file1.txt: Set modification time 2007-07-23 2026/07/26 03:27:56 DEBUG : file2.txt: Set modification time 2007-07-23 2026/07/26 03:27:56 DEBUG : file20.txt: Set modification time 2007-07-23 2026/07/26 03:27:56 NOTICE: (17) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ 2026/07/26 03:27:56 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" as "" 2026/07/26 03:27:56 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" 2026/07/26 03:27:56 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" 2026/07/26 03:27:57 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1" as "file1.txt" 2026/07/26 03:27:58 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:27:58 DEBUG : file1.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2026/07/26 03:27:58 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:27:59 INFO : file1.txt: Updated modification time in destination 2026/07/26 03:27:59 DEBUG : file1.txt: Unchanged skipping 2026/07/26 03:27:59 NOTICE: (18) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ 2026/07/26 03:27:59 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" as "" 2026/07/26 03:27:59 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" 2026/07/26 03:27:59 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:00 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2" as "file2.txt" 2026/07/26 03:28:01 DEBUG : file2.txt: size = 19 OK 2026/07/26 03:28:01 DEBUG : file2.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2026/07/26 03:28:01 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:28:02 INFO : file2.txt: Updated modification time in destination 2026/07/26 03:28:02 DEBUG : file2.txt: Unchanged skipping 2026/07/26 03:28:02 NOTICE: (19) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir 2026/07/26 03:28:02 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" as "" 2026/07/26 03:28:02 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" 2026/07/26 03:28:02 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:28:03 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1/subdir" as "file20.txt" 2026/07/26 03:28:03 DEBUG : file20.txt: size = 0 OK 2026/07/26 03:28:03 DEBUG : file20.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2026/07/26 03:28:03 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:28:05 INFO : file20.txt: Updated modification time in destination 2026/07/26 03:28:05 DEBUG : file20.txt: Unchanged skipping 2026/07/26 03:28:05 NOTICE: (20) : copy-as /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file1.txt 2026/07/26 03:28:05 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" as "file1.txt" 2026/07/26 03:28:05 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" 2026/07/26 03:28:05 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:06 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2" as "file1.txt" 2026/07/26 03:28:06 DEBUG : file21.txt: size = 0 (Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5) 2026/07/26 03:28:06 DEBUG : file1.txt: size = 19 (B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2) 2026/07/26 03:28:06 DEBUG : file21.txt: Sizes differ 2026/07/26 03:28:08 DEBUG : file1.txt: size = 0 OK 2026/07/26 03:28:08 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:28:08 INFO : file21.txt: Copied (replaced existing) to: file1.txt 2026/07/26 03:28:08 NOTICE: (21) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ file1.txt 2026/07/26 03:28:08 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1" 2026/07/26 03:28:08 DEBUG : file1.txt: Set modification time 2007-07-23 2026/07/26 03:28:09 NOTICE: (22) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file2.txt 2026/07/26 03:28:09 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2" 2026/07/26 03:28:10 DEBUG : file2.txt: Set modification time 2007-07-23 2026/07/26 03:28:11 NOTICE: (23) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/ file20.txt 2026/07/26 03:28:11 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:28:11 DEBUG : file20.txt: Set modification time 2007-07-23 2026/07/26 03:28:12 NOTICE: (24) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/ file21.txt 2026/07/26 03:28:12 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:28:13 DEBUG : file21.txt: Set modification time 2007-07-23 2026/07/26 03:28:14 NOTICE: (25) : bisync size-only 2026/07/26 03:28:22 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:22 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:22 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/07/26 03:28:22 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/07/26 03:28:22 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:22 INFO : Building Path1 and Path2 listings 2026/07/26 03:28:23 INFO : Path1 checking for diffs 2026/07/26 03:28:23 INFO : Path2 checking for diffs 2026/07/26 03:28:23 INFO : - Path2 File changed: size (smaller) - file1.txt 2026/07/26 03:28:23 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2026/07/26 03:28:23 INFO : (Modified:  0 larger,  1 smaller) 2026/07/26 03:28:23 INFO : Applying changes 2026/07/26 03:28:23 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/file1.txt 2026/07/26 03:28:23 INFO : - Path2 Do queued copies to - Path1 2026/07/26 03:28:24 INFO : file1.txt: Copied (server-side copy) 2026/07/26 03:28:24 INFO : Updating listings 2026/07/26 03:28:24 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:24 INFO : Bisync successful 2026/07/26 03:28:24 NOTICE: (26) : bisync resync 2026/07/26 03:28:32 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:32 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:32 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/07/26 03:28:32 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/07/26 03:28:32 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:32 INFO : Copying Path2 files to Path1 2026/07/26 03:28:32 INFO : - Path2 Resync is copying files to - Path1 2026/07/26 03:28:32 INFO : There was nothing to transfer 2026/07/26 03:28:32 INFO : - Path1 Resync is copying files to - Path2 2026/07/26 03:28:33 INFO : file2.txt: Updated modification time in destination 2026/07/26 03:28:34 INFO : subdir/file21.txt: Updated modification time in destination 2026/07/26 03:28:34 INFO : subdir/file20.txt: Updated modification time in destination 2026/07/26 03:28:34 INFO : There was nothing to transfer 2026/07/26 03:28:34 INFO : Resync updating listings 2026/07/26 03:28:34 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:34 INFO : Bisync successful 2026/07/26 03:28:34 NOTICE: (27) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ 2026/07/26 03:28:34 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" as "" 2026/07/26 03:28:34 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" 2026/07/26 03:28:34 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" 2026/07/26 03:28:35 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1" as "file1.txt" 2026/07/26 03:28:35 DEBUG : file1.txt: size = 19 (Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5) 2026/07/26 03:28:35 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1) 2026/07/26 03:28:35 DEBUG : file1.txt: Sizes differ 2026/07/26 03:28:37 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:28:37 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:28:37 INFO : file1.txt: Copied (replaced existing) 2026/07/26 03:28:37 NOTICE: (28) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ 2026/07/26 03:28:37 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" as "" 2026/07/26 03:28:37 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file2.txt" 2026/07/26 03:28:37 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:38 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2" as "file2.txt" 2026/07/26 03:28:38 DEBUG : file2.txt: size = 19 OK 2026/07/26 03:28:38 DEBUG : file2.txt: Modification times differ by -57432h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2001-01-02 00:00:00 +0000 UTC 2026/07/26 03:28:38 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:28:40 INFO : file2.txt: Updated modification time in destination 2026/07/26 03:28:40 DEBUG : file2.txt: Unchanged skipping 2026/07/26 03:28:40 NOTICE: (29) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir 2026/07/26 03:28:40 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" as "" 2026/07/26 03:28:40 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" 2026/07/26 03:28:40 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:28:41 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1/subdir" as "file20.txt" 2026/07/26 03:28:41 DEBUG : file20.txt: size = 0 OK 2026/07/26 03:28:41 DEBUG : file20.txt: Size and modification time the same (differ by 0s, within tolerance 1ms) 2026/07/26 03:28:41 DEBUG : file20.txt: Unchanged skipping 2026/07/26 03:28:41 NOTICE: (30) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir 2026/07/26 03:28:41 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" as "" 2026/07/26 03:28:41 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" 2026/07/26 03:28:41 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:28:42 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2/subdir" as "file21.txt" 2026/07/26 03:28:42 DEBUG : file21.txt: size = 0 OK 2026/07/26 03:28:42 DEBUG : file21.txt: Modification times differ by -66240h0m0s: 2007-07-23 00:00:00 +0000 UTC, 2000-01-01 00:00:00 +0000 UTC 2026/07/26 03:28:42 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:28:44 INFO : file21.txt: Updated modification time in destination 2026/07/26 03:28:44 DEBUG : file21.txt: Unchanged skipping 2026/07/26 03:28:44 NOTICE: (31) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ file1.txt 2026/07/26 03:28:44 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1" 2026/07/26 03:28:45 DEBUG : file1.txt: Set modification time 2007-07-23 2026/07/26 03:28:45 NOTICE: (32) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file2.txt 2026/07/26 03:28:45 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2" 2026/07/26 03:28:46 DEBUG : file2.txt: Set modification time 2007-07-23 2026/07/26 03:28:46 NOTICE: (33) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/ file20.txt 2026/07/26 03:28:46 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:28:47 DEBUG : file20.txt: Set modification time 2007-07-23 2026/07/26 03:28:47 NOTICE: (34) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/ file21.txt 2026/07/26 03:28:47 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:28:48 DEBUG : file21.txt: Set modification time 2007-07-23 2026/07/26 03:28:49 NOTICE: (35) : bisync ignore-size 2026/07/26 03:28:57 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:57 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:28:57 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/07/26 03:28:57 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": false, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/07/26 03:28:57 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:57 INFO : Building Path1 and Path2 listings 2026/07/26 03:28:58 INFO : Path1 checking for diffs 2026/07/26 03:28:58 INFO : Path2 checking for diffs 2026/07/26 03:28:58 INFO : - Path2 File changed: time (newer) - file2.txt 2026/07/26 03:28:58 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2026/07/26 03:28:58 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2026/07/26 03:28:58 INFO : (Modified:  2 newer,  0 older) 2026/07/26 03:28:58 INFO : Applying changes 2026/07/26 03:28:58 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/file2.txt 2026/07/26 03:28:58 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/file21.txt 2026/07/26 03:28:58 INFO : - Path2 Do queued copies to - Path1 2026/07/26 03:28:59 INFO : file2.txt: Updated modification time in destination 2026/07/26 03:28:59 INFO : subdir/file21.txt: Updated modification time in destination 2026/07/26 03:28:59 INFO : There was nothing to transfer 2026/07/26 03:28:59 INFO : Updating listings 2026/07/26 03:28:59 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:28:59 INFO : Bisync successful 2026/07/26 03:28:59 NOTICE: (36) : bisync resync compare-all 2026/07/26 03:29:07 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:29:07 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:29:07 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2026/07/26 03:29:07 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:29:07 INFO : Copying Path2 files to Path1 2026/07/26 03:29:07 INFO : - Path2 Resync is copying files to - Path1 2026/07/26 03:29:08 INFO : There was nothing to transfer 2026/07/26 03:29:08 INFO : - Path1 Resync is copying files to - Path2 2026/07/26 03:29:09 INFO : file1.txt: Copied (server-side copy) 2026/07/26 03:29:09 INFO : Resync updating listings 2026/07/26 03:29:09 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:29:09 INFO : Bisync successful 2026/07/26 03:29:09 NOTICE: (37) : copy-as /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file2.txt 2026/07/26 03:29:09 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" as "file2.txt" 2026/07/26 03:29:09 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" 2026/07/26 03:29:09 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:29:10 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2" as "file2.txt" 2026/07/26 03:29:10 DEBUG : file21.txt: size = 0 (Local file system at /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5) 2026/07/26 03:29:10 DEBUG : file2.txt: size = 19 (B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2) 2026/07/26 03:29:10 DEBUG : file21.txt: Sizes differ 2026/07/26 03:29:12 DEBUG : file2.txt: size = 0 OK 2026/07/26 03:29:12 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:29:12 INFO : file21.txt: Copied (replaced existing) to: file2.txt 2026/07/26 03:29:12 NOTICE: (38) : touch-glob 2023-08-26 /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/ * 2026/07/26 03:29:12 DEBUG : fs cache: switching user supplied name "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/" for canonical name "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5" 2026/07/26 03:29:12 DEBUG : file21.txt: Set modification time 2023-08-26 2026/07/26 03:29:12 DEBUG : file1.txt: Set modification time 2023-08-26 2026/07/26 03:29:12 DEBUG : file2.txt: Set modification time 2023-08-26 2026/07/26 03:29:12 DEBUG : file20.txt: Set modification time 2023-08-26 2026/07/26 03:29:12 NOTICE: (39) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ 2026/07/26 03:29:12 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" as "" 2026/07/26 03:29:12 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file1.txt" 2026/07/26 03:29:12 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" 2026/07/26 03:29:13 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1" as "file1.txt" 2026/07/26 03:29:13 DEBUG : file1.txt: size = 19 OK 2026/07/26 03:29:13 DEBUG : file1.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2026/07/26 03:29:13 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/07/26 03:29:14 INFO : file1.txt: Updated modification time in destination 2026/07/26 03:29:14 DEBUG : file1.txt: Unchanged skipping 2026/07/26 03:29:14 NOTICE: (40) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir 2026/07/26 03:29:14 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" as "" 2026/07/26 03:29:14 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file20.txt" 2026/07/26 03:29:14 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:29:15 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1/subdir" as "file20.txt" 2026/07/26 03:29:15 DEBUG : file20.txt: size = 0 OK 2026/07/26 03:29:15 DEBUG : file20.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2026/07/26 03:29:15 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:29:17 INFO : file20.txt: Updated modification time in destination 2026/07/26 03:29:17 DEBUG : file20.txt: Unchanged skipping 2026/07/26 03:29:17 NOTICE: (41) : copy-file /tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir 2026/07/26 03:29:17 DEBUG : copyFile "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" to "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" as "" 2026/07/26 03:29:17 DEBUG : Creating backend with remote "/tmp/032707howacuh2/datadir/test_rclone_args-qobobor5/file21.txt" 2026/07/26 03:29:17 DEBUG : Creating backend with remote "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:29:18 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2/subdir" as "file21.txt" 2026/07/26 03:29:18 DEBUG : file21.txt: size = 0 OK 2026/07/26 03:29:18 DEBUG : file21.txt: Modification times differ by -141072h0m0s: 2023-08-26 00:00:00 +0000 UTC, 2007-07-23 00:00:00 +0000 UTC 2026/07/26 03:29:18 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/07/26 03:29:19 INFO : file21.txt: Updated modification time in destination 2026/07/26 03:29:19 DEBUG : file21.txt: Unchanged skipping 2026/07/26 03:29:19 NOTICE: (42) : touch-glob 2007-07-23 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/ file2.txt 2026/07/26 03:29:19 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2" 2026/07/26 03:29:19 DEBUG : file2.txt: Set modification time 2007-07-23 2026/07/26 03:29:20 NOTICE: (43) : touch-glob 2023-08-26 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/ file1.txt 2026/07/26 03:29:20 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1" 2026/07/26 03:29:20 DEBUG : file1.txt: Set modification time 2023-08-26 2026/07/26 03:29:21 NOTICE: (44) : touch-glob 2023-08-26 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/ file20.txt 2026/07/26 03:29:21 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir" 2026/07/26 03:29:22 DEBUG : file20.txt: Set modification time 2023-08-26 2026/07/26 03:29:23 NOTICE: (45) : touch-glob 2023-08-26 TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/ file21.txt 2026/07/26 03:29:23 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir" 2026/07/26 03:29:23 DEBUG : file21.txt: Set modification time 2023-08-26 2026/07/26 03:29:24 NOTICE: (46) : bisync compare-all 2026/07/26 03:29:33 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:29:33 DEBUG : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/07/26 03:29:33 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2026/07/26 03:29:33 INFO : Synching Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" with Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:29:33 INFO : Building Path1 and Path2 listings 2026/07/26 03:29:34 INFO : Path1 checking for diffs 2026/07/26 03:29:34 INFO : - Path1 File changed: time (newer) - file1.txt 2026/07/26 03:29:34 INFO : - Path1 File changed: time (newer) - subdir/file20.txt 2026/07/26 03:29:34 INFO : Path1: 2 changes:  0 new,  2 modified,  0 deleted 2026/07/26 03:29:34 INFO : (Modified:  2 newer,  0 older) 2026/07/26 03:29:34 INFO : Path2 checking for diffs 2026/07/26 03:29:34 INFO : - Path2 File changed: size (smaller), hash - file2.txt 2026/07/26 03:29:34 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2026/07/26 03:29:34 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2026/07/26 03:29:34 INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  1 hash differs) 2026/07/26 03:29:34 INFO : Applying changes 2026/07/26 03:29:34 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/file1.txt 2026/07/26 03:29:34 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/subdir/file20.txt 2026/07/26 03:29:34 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/file2.txt 2026/07/26 03:29:34 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/subdir/file21.txt 2026/07/26 03:29:34 INFO : - Path2 Do queued copies to - Path1 2026/07/26 03:29:35 INFO : file2.txt: Copied (server-side copy) 2026/07/26 03:29:35 INFO : subdir/file21.txt: Updated modification time in destination 2026/07/26 03:29:35 INFO : - Path1 Do queued copies to - Path2 2026/07/26 03:29:37 INFO : file1.txt: Updated modification time in destination 2026/07/26 03:29:37 INFO : subdir/file20.txt: Updated modification time in destination 2026/07/26 03:29:37 INFO : Updating listings 2026/07/26 03:29:37 INFO : Validating listings for Path1 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path1/" vs Path2 "TestB2:rclone-test-wofudaj7fiqu/032707howacuh2/rclone_args/path2/" 2026/07/26 03:29:37 INFO : Bisync successful 2026/07/26 03:29:37 INFO : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path1: cleaning bucket "rclone-test-wofudaj7fiqu" of all files 2026/07/26 03:29:37 DEBUG : RCLONE_TEST: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f104f119992867a37_d20260726_m032714_c001_v0001109_t0042_u01785036434609") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f102d9bc9222df82c_d20260726_m032921_c001_v0001180_t0051_u01785036561540") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f115370913d2bbb36_d20260726_m032914_c001_v0001177_t0017_u01785036554529") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1187b16cb5f388b4_d20260726_m032845_c001_v0001185_t0058_u01785036525795") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f106ae399810b79f8_d20260726_m032837_c001_v0001039_t0052_u01785036517197") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f117389a51eec2cec_d20260726_m032823_c001_v0001105_t0001_u01785036503557") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f114ea888ffc19ea6_d20260726_m032809_c001_v0001136_t0047_u01785036489271") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f109cbb319ac3e0f7_d20260726_m032759_c001_v0001100_t0015_u01785036479249") 2026/07/26 03:29:37 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1199a63651fec4af_d20260726_m032739_c001_v0001177_t0051_u01785036459316") 2026/07/26 03:29:38 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1121662f21c72223_d20260726_m032728_c001_v0001039_t0040_u01785036448814") 2026/07/26 03:29:38 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1127ab04c96cc436_d20260726_m032714_c001_v0001106_t0032_u01785036434787") 2026/07/26 03:29:38 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1168d24b683c21dc_d20260726_m032935_c001_v0001165_t0048_u01785036575243") 2026/07/26 03:29:38 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f11126e9102dc49cc_d20260726_m032858_c001_v0001103_t0027_u01785036538881") 2026/07/26 03:29:38 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f103170c85e9db13f_d20260726_m032756_c001_v0001176_t0037_u01785036476159") 2026/07/26 03:29:38 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f111b14012b83c2cb_d20260726_m032714_c001_v0001167_t0014_u01785036434978") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f400cc35119cdf312_d20260726_m032928_c001_v7007000_t0000_u01785036568935") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1060fa471d4acb06_d20260726_m032927_c001_v0001109_t0043_u01785036567419") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f104f119992867b5f_d20260726_m032925_c001_v0001109_t0040_u01785036565074") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f422046c13a648d94_d20260726_m032903_c001_v7007000_t0000_u01785036543053") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f108fe5fbf007891a_d20260726_m032901_c001_v0001137_t0010_u01785036541592") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1127ab04c96cc506_d20260726_m032859_c001_v0001106_t0016_u01785036539893") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f422046c13a648d50_d20260726_m032853_c001_v7007000_t0000_u01785036533838") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f110bb3a415002bf0_d20260726_m032852_c001_v0001117_t0018_u01785036532065") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f111b14012b83c546_d20260726_m032849_c001_v0001167_t0013_u01785036529864") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f4154f98efcc2a196_d20260726_m032828_c001_v7007000_t0000_u01785036508231") 2026/07/26 03:29:38 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f11747b2e4dc1047c_d20260726_m032826_c001_v0001103_t0019_u01785036506699") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10777a890a18318c_d20260726_m032824_c001_v0001157_t0001_u01785036504485") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f4154f98efcc2a18f_d20260726_m032818_c001_v7007000_t0000_u01785036498356") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f102b64c62814a956_d20260726_m032817_c001_v0001037_t0049_u01785036496999") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f104f119992867ad5_d20260726_m032814_c001_v0001109_t0016_u01785036494555") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f41609b788feca492_d20260726_m032751_c001_v7007000_t0000_u01785036471203") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1120fe4b069f9ceb_d20260726_m032749_c001_v0001154_t0017_u01785036469877") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1127ab04c96cc47a_d20260726_m032747_c001_v0001106_t0016_u01785036467275") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f417f9d998c71b231_d20260726_m032721_c001_v7007000_t0000_u01785036441439") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10097ba82abf3307_d20260726_m032719_c001_v0001131_t0018_u01785036439806") 2026/07/26 03:29:39 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f111b14012b83c2e3_d20260726_m032717_c001_v0001167_t0017_u01785036437973") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f107d5a3a93735ec1_d20260726_m032922_c001_v0001036_t0047_u01785036562888") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1125c7d7f7e4cedd_d20260726_m032917_c001_v0001174_t0003_u01785036557017") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10651ea1d52ceca7_d20260726_m032847_c001_v0001167_t0037_u01785036527663") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f115c00afda7759a5_d20260726_m032812_c001_v0001161_t0013_u01785036492165") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f109246c9abf22203_d20260726_m032804_c001_v0001036_t0012_u01785036484537") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f119790c6d4aee055_d20260726_m032744_c001_v0001183_t0043_u01785036464304") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1092738f16a1057f_d20260726_m032734_c001_v0001039_t0007_u01785036454106") 2026/07/26 03:29:39 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10777a890a183064_d20260726_m032715_c001_v0001157_t0023_u01785036435181") 2026/07/26 03:29:39 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f114ce1988af8bd53_d20260726_m032935_c001_v0001174_t0000_u01785036575784") 2026/07/26 03:29:39 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f107ad425b101da9b_d20260726_m032859_c001_v0001174_t0017_u01785036539213") 2026/07/26 03:29:39 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f104f119992867a39_d20260726_m032715_c001_v0001109_t0029_u01785036435061") 2026/07/26 03:29:40 INFO : B2 bucket rclone-test-wofudaj7fiqu path 032707howacuh2/rclone_args/path2: cleaning bucket "rclone-test-wofudaj7fiqu" of all files 2026/07/26 03:29:40 DEBUG : RCLONE_TEST: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1153d47af3b0df53_d20260726_m032716_c001_v0001173_t0012_u01785036436754") 2026/07/26 03:29:40 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f118fa5d5f329d5a0_d20260726_m032936_c001_v0001101_t0042_u01785036576884") 2026/07/26 03:29:40 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f109f7177569e4961_d20260726_m032908_c001_v0001032_t0027_u01785036548674") 2026/07/26 03:29:40 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1175d0095612bca5_d20260726_m032807_c001_v0001091_t0047_u01785036487879") 2026/07/26 03:29:40 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f11416dc1947cb382_d20260726_m032756_c001_v0001098_t0029_u01785036476568") 2026/07/26 03:29:40 DEBUG : file1.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10108a0901575c61_d20260726_m032716_c001_v0001103_t0014_u01785036436902") 2026/07/26 03:29:40 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f100663b1d0749100_d20260726_m032920_c001_v0001183_t0021_u01785036560574") 2026/07/26 03:29:40 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f11076aa6332d65a3_d20260726_m032911_c001_v0001101_t0038_u01785036551738") 2026/07/26 03:29:40 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10690d8ff5cb33a2_d20260726_m032846_c001_v0001184_t0023_u01785036526380") 2026/07/26 03:29:40 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f101f3742cae5c778_d20260726_m032839_c001_v0001091_t0018_u01785036519816") 2026/07/26 03:29:40 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f11333dd913104eb2_d20260726_m032833_c001_v0001104_t0015_u01785036513415") 2026/07/26 03:29:41 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f100e7dc33cca65ef_d20260726_m032810_c001_v0001154_t0012_u01785036490757") 2026/07/26 03:29:41 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f115ba03e744a2d81_d20260726_m032802_c001_v0001176_t0018_u01785036482122") 2026/07/26 03:29:41 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f111599314bb7ef34_d20260726_m032741_c001_v0001042_t0030_u01785036461758") 2026/07/26 03:29:41 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1183fdff990fbd8d_d20260726_m032731_c001_v0001180_t0029_u01785036451702") 2026/07/26 03:29:41 DEBUG : file2.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1179fdee976a21ac_d20260726_m032717_c001_v0001099_t0048_u01785036437151") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f4020872c6005b06a_d20260726_m032933_c001_v7007000_t0000_u01785036573800") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1181a1e2bb014a90_d20260726_m032931_c001_v0001098_t0020_u01785036571709") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1153d47af3b0e1e1_d20260726_m032929_c001_v0001173_t0016_u01785036569475") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f421046a48b1606a7_d20260726_m032907_c001_v7007000_t0000_u01785036547753") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f111a3bdfd82ae15a_d20260726_m032905_c001_v0001032_t0014_u01785036545860") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1179fdee976a22da_d20260726_m032903_c001_v0001099_t0004_u01785036543580") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f41609b788feca689_d20260726_m032857_c001_v7007000_t0000_u01785036537609") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f118cd011636e2716_d20260726_m032856_c001_v0001157_t0045_u01785036536269") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10108a0901575e27_d20260726_m032854_c001_v0001103_t0034_u01785036534395") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f404729e3fe2098a5_d20260726_m032832_c001_v7007000_t0000_u01785036512480") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f101594b9bf072e7f_d20260726_m032831_c001_v0001032_t0048_u01785036511037") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f113af5e7bafb10be_d20260726_m032828_c001_v0001099_t0011_u01785036508754") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f410a68a6d8a031dc_d20260726_m032822_c001_v7007000_t0000_u01785036502635") 2026/07/26 03:29:41 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1080189e69b54e70_d20260726_m032821_c001_v0001042_t0035_u01785036501307") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1153d47af3b0e0ad_d20260726_m032818_c001_v0001173_t0021_u01785036498882") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f41455061a17452cd_d20260726_m032755_c001_v7007000_t0000_u01785036475372") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f102be58319c07be0_d20260726_m032753_c001_v0001105_t0007_u01785036473914") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1179fdee976a2216_d20260726_m032751_c001_v0001099_t0058_u01785036471723") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f425cfe14b2d39164_d20260726_m032725_c001_v7007000_t0000_u01785036445316") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f118cee5411d08ef8_d20260726_m032723_c001_v0001174_t0058_u01785036443903") 2026/07/26 03:29:42 DEBUG : modtime_write_test: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10108a0901575c6f_d20260726_m032721_c001_v0001103_t0043_u01785036441612") 2026/07/26 03:29:42 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f113197614d972645_d20260726_m032937_c001_v0001103_t0054_u01785036577276") 2026/07/26 03:29:42 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1159093ba7fb778e_d20260726_m032833_c001_v0001157_t0030_u01785036513939") 2026/07/26 03:29:42 DEBUG : subdir/file20.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f113af5e7bafb100a_d20260726_m032717_c001_v0001099_t0016_u01785036437272") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f108b188cfff93923_d20260726_m032924_c001_v0001150_t0059_u01785036564345") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1043c6a5a224339c_d20260726_m032919_c001_v0001113_t0059_u01785036559526") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f119d6e6303499a32_d20260726_m032849_c001_v0001137_t0001_u01785036529071") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f109f2ba1090f9bd0_d20260726_m032844_c001_v0001167_t0045_u01785036524271") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f10217ac78e36caf0_d20260726_m032834_c001_v0001176_t0059_u01785036514001") 2026/07/26 03:29:42 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1123a4a654dec50a_d20260726_m032813_c001_v0001179_t0019_u01785036493883") 2026/07/26 03:29:43 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1065696f7a4d0494_d20260726_m032746_c001_v0001173_t0058_u01785036466527") 2026/07/26 03:29:43 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1050e86a2d65d6be_d20260726_m032736_c001_v0001167_t0049_u01785036456821") 2026/07/26 03:29:43 DEBUG : subdir/file21.txt: Deleting (id "4_zcf325d83706d9bcb9ff80e1b_f1153d47af3b0df57_d20260726_m032717_c001_v0001173_t0022_u01785036437072") bisync_test.go:610: TEST rclone_args PASSED 2026/07/26 03:29:43 DEBUG : B2 bucket rclone-test-wofudaj7fiqu: Purge remote 2026/07/26 03:29:43 INFO : B2 bucket rclone-test-wofudaj7fiqu: cleaning bucket "rclone-test-wofudaj7fiqu" of all files --- PASS: TestBisyncRemoteRemote (157.28s) --- PASS: TestBisyncRemoteRemote/rclone_args (155.63s) PASS 2026/07/26 03:29:44 DEBUG : B2 bucket rclone-test-qixubat7gepu: Purge remote 2026/07/26 03:29:44 INFO : B2 bucket rclone-test-qixubat7gepu: cleaning bucket "rclone-test-qixubat7gepu" of all files 2026/07/26 03:29:45 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^rclone_args$'" - Finished OK in 2m38.628300931s (try 3/5)