"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^rclone_args$'" - Starting (try 3/5) 2025/10/12 04:36:07 DEBUG : Creating backend with remote "TestB2:rclone-test-vunices9suye" 2025/10/12 04:36:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/12 04:36:07 DEBUG : Creating backend with remote "/tmp/rclone3761120087" === RUN TestBisyncRemoteRemote 2025/10/12 04:36:07 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta" 2025/10/12 04:36:08 NOTICE: remote: TestB2:rclone-test-towovuy0deta === RUN TestBisyncRemoteRemote/rclone_args 2025/10/12 04:36:08 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko" 2025/10/12 04:36:09 INFO : path1: Making directory 2025/10/12 04:36:10 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1" 2025/10/12 04:36:11 INFO : path2: Making directory 2025/10/12 04:36:11 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2" 2025/10/12 04:36:12 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2025/10/12 04:36:12 DEBUG : Creating backend with remote "/tmp/043608ko/initdir/test_rclone_args-cocaxum2" 2025/10/12 04:36:12 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : subdir: Making directory with metadata 2025/10/12 04:36:12 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/10/12 04:36:12 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/10/12 04:36:12 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2025/10/12 04:36:12 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2025/10/12 04:36:12 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/12 04:36:12 DEBUG : Local file system at /tmp/043608ko/initdir/test_rclone_args-cocaxum2: Waiting for checks to finish 2025/10/12 04:36:12 DEBUG : Local file system at /tmp/043608ko/initdir/test_rclone_args-cocaxum2: Waiting for transfers to finish 2025/10/12 04:36:12 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/12 04:36:12 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/10/12 04:36:12 INFO : file2.txt: Copied (new) 2025/10/12 04:36:12 INFO : file1.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/12 04:36:12 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2025/10/12 04:36:12 INFO : subdir/file20.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2025/10/12 04:36:12 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/10/12 04:36:12 INFO : subdir/file21.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/10/12 04:36:12 INFO : RCLONE_TEST: Copied (new) 2025/10/12 04:36:12 INFO : subdir: Set directory modification time (using SetModTime) 2025/10/12 04:36:12 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2025/10/12 04:36:12 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8" 2025/10/12 04:36:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file20.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file21.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:12 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/12 04:36:12 DEBUG : Local file system at /tmp/043608ko/datadir/test_rclone_args-ridenob8: Waiting for checks to finish 2025/10/12 04:36:12 DEBUG : Local file system at /tmp/043608ko/datadir/test_rclone_args-ridenob8: Waiting for transfers to finish 2025/10/12 04:36:12 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/12 04:36:12 DEBUG : file21.txt.68f456b7.partial: renamed to: file21.txt 2025/10/12 04:36:12 INFO : file21.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : file20.txt.fd848222.partial: renamed to: file20.txt 2025/10/12 04:36:12 INFO : file20.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/12 04:36:12 DEBUG : file2.txt.d6677e1f.partial: renamed to: file2.txt 2025/10/12 04:36:12 INFO : file2.txt: Copied (new) 2025/10/12 04:36:12 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/12 04:36:12 DEBUG : file1.txt.8c06417f.partial: renamed to: file1.txt 2025/10/12 04:36:12 INFO : file1.txt: Copied (new) 2025/10/12 04:36:12 INFO : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: cleaning bucket "rclone-test-towovuy0deta" of all files 2025/10/12 04:36:13 INFO : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: cleaning bucket "rclone-test-towovuy0deta" of all files 2025/10/12 04:36:14 NOTICE: checking initFs Local file system at /tmp/043608ko/initdir/test_rclone_args-cocaxum2 2025/10/12 04:36:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/12 04:36:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:14 INFO : subdir: Making directory 2025/10/12 04:36:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:14 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:14 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Waiting for checks to finish 2025/10/12 04:36:14 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Waiting for transfers to finish 2025/10/12 04:36:15 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:15 INFO : file2.txt: Copied (new) 2025/10/12 04:36:15 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:15 INFO : subdir/file21.txt: Copied (new) 2025/10/12 04:36:15 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/12 04:36:15 INFO : RCLONE_TEST: Copied (new) 2025/10/12 04:36:15 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2025/10/12 04:36:15 INFO : file1.txt: Copied (new) 2025/10/12 04:36:16 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:16 INFO : subdir/file20.txt: Copied (new) 2025/10/12 04:36:16 NOTICE: checking Path1 B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1 2025/10/12 04:36:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/12 04:36:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:16 INFO : subdir: Making directory 2025/10/12 04:36:16 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:16 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2025/10/12 04:36:16 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Waiting for checks to finish 2025/10/12 04:36:16 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Waiting for transfers to finish 2025/10/12 04:36:17 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:17 INFO : file2.txt: Copied (new) 2025/10/12 04:36:17 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:17 INFO : subdir/file20.txt: Copied (new) 2025/10/12 04:36:17 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:17 INFO : subdir/file21.txt: Copied (new) 2025/10/12 04:36:17 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/12 04:36:17 INFO : RCLONE_TEST: Copied (new) 2025/10/12 04:36:17 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK 2025/10/12 04:36:17 INFO : file1.txt: Copied (new) 2025/10/12 04:36:17 NOTICE: checking path2 B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2 2025/10/12 04:36:18 NOTICE: (01) : test rclone-args 2025/10/12 04:36:18 NOTICE: (02) : touch-glob 2001-01-02 /tmp/043608ko/datadir/test_rclone_args-ridenob8/ * 2025/10/12 04:36:18 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/" 2025/10/12 04:36:18 DEBUG : fs cache: renaming cache item "/tmp/043608ko/datadir/test_rclone_args-ridenob8/" to be canonical "/tmp/043608ko/datadir/test_rclone_args-ridenob8" 2025/10/12 04:36:18 DEBUG : file21.txt: Set modification time 2001-01-02 2025/10/12 04:36:18 DEBUG : file1.txt: Set modification time 2001-01-02 2025/10/12 04:36:18 DEBUG : file2.txt: Set modification time 2001-01-02 2025/10/12 04:36:18 DEBUG : file20.txt: Set modification time 2001-01-02 2025/10/12 04:36:18 NOTICE: (03) : test initial bisync 2025/10/12 04:36:18 NOTICE: (04) : bisync resync checksum 2025/10/12 04:36:25 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:36:25 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:36:25 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/10/12 04:36:25 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:25 INFO : Copying Path2 files to Path1 2025/10/12 04:36:25 INFO : - Path2 Resync is copying files to - Path1 2025/10/12 04:36:25 INFO : There was nothing to transfer 2025/10/12 04:36:25 INFO : - Path1 Resync is copying files to - Path2 2025/10/12 04:36:25 INFO : There was nothing to transfer 2025/10/12 04:36:25 INFO : Resync updating listings 2025/10/12 04:36:25 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:25 INFO : Bisync successful 2025/10/12 04:36:25 NOTICE: (05) : test place newer files on both paths 2025/10/12 04:36:25 NOTICE: (06) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ 2025/10/12 04:36:25 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" as "" 2025/10/12 04:36:25 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" 2025/10/12 04:36:25 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" 2025/10/12 04:36:26 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1" as "file1.txt" 2025/10/12 04:36: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 2025/10/12 04:36:27 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c (Local file system at /tmp/043608ko/datadir/test_rclone_args-ridenob8) 2025/10/12 04:36:27 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 (B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1) 2025/10/12 04:36:27 DEBUG : file1.txt: sha1 differ 2025/10/12 04:36:28 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:36:28 INFO : file1.txt: Copied (replaced existing) 2025/10/12 04:36:28 NOTICE: (07) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ 2025/10/12 04:36:28 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" as "" 2025/10/12 04:36:28 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" 2025/10/12 04:36:28 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:30 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2" as "file2.txt" 2025/10/12 04:36:30 DEBUG : file2.txt: Sizes differ (src 19 vs dst 0) 2025/10/12 04:36:31 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:36:31 INFO : file2.txt: Copied (replaced existing) 2025/10/12 04:36:31 NOTICE: (08) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir 2025/10/12 04:36:31 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" as "" 2025/10/12 04:36:31 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" 2025/10/12 04:36:31 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:36:32 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1/subdir" as "file20.txt" 2025/10/12 04:36: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 2025/10/12 04:36:33 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:34 INFO : file20.txt: Updated modification time in destination 2025/10/12 04:36:34 DEBUG : file20.txt: Unchanged skipping 2025/10/12 04:36:34 NOTICE: (09) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir 2025/10/12 04:36:34 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" as "" 2025/10/12 04:36:34 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" 2025/10/12 04:36:34 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:36:35 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2/subdir" as "file21.txt" 2025/10/12 04:36: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 2025/10/12 04:36:35 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:36:37 INFO : file21.txt: Updated modification time in destination 2025/10/12 04:36:37 DEBUG : file21.txt: Unchanged skipping 2025/10/12 04:36:37 NOTICE: (10) : touch-glob 2001-01-02 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ file1.txt 2025/10/12 04:36:37 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" 2025/10/12 04:36:38 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" to be canonical "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1" 2025/10/12 04:36:38 DEBUG : file1.txt: Set modification time 2001-01-02 2025/10/12 04:36:39 NOTICE: (11) : touch-glob 2001-01-02 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file2.txt 2025/10/12 04:36:39 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:40 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" to be canonical "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2" 2025/10/12 04:36:41 DEBUG : file2.txt: Set modification time 2001-01-02 2025/10/12 04:36:42 NOTICE: (12) : touch-glob 2001-01-02 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/ file20.txt 2025/10/12 04:36:42 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/" 2025/10/12 04:36:43 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/" to be canonical "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:36:44 DEBUG : file20.txt: Set modification time 2001-01-02 2025/10/12 04:36:44 NOTICE: (13) : touch-glob 2001-01-02 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/ file21.txt 2025/10/12 04:36:44 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/" 2025/10/12 04:36:45 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/" to be canonical "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:36:46 DEBUG : file21.txt: Set modification time 2001-01-02 2025/10/12 04:36:47 NOTICE: (14) : test run bisync with custom options 2025/10/12 04:36:47 NOTICE: (15) : bisync checksum 2025/10/12 04:36:55 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:36:55 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:36:55 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/10/12 04:36:55 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:55 INFO : Building Path1 and Path2 listings 2025/10/12 04:36:55 INFO : Path1 checking for diffs 2025/10/12 04:36:55 INFO : - Path1 File changed: hash - file1.txt 2025/10/12 04:36:55 INFO : Path1: 1 changes:  0 new,  1 modified,  0 deleted 2025/10/12 04:36:55 INFO : (Modified:  1 hash differs) 2025/10/12 04:36:55 INFO : Path2 checking for diffs 2025/10/12 04:36:55 INFO : - Path2 File changed: size (larger), hash - file2.txt 2025/10/12 04:36:55 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/10/12 04:36:55 INFO : (Modified:  1 larger,  0 smaller,  1 hash differs) 2025/10/12 04:36:55 INFO : Applying changes 2025/10/12 04:36:55 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/file1.txt 2025/10/12 04:36:55 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/file2.txt 2025/10/12 04:36:55 INFO : - Path2 Do queued copies to - Path1 2025/10/12 04:36:56 INFO : file2.txt: Copied (server-side copy) 2025/10/12 04:36:56 INFO : - Path1 Do queued copies to - Path2 2025/10/12 04:36:57 INFO : file1.txt: Copied (server-side copy) 2025/10/12 04:36:57 INFO : Updating listings 2025/10/12 04:36:57 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:36:57 INFO : Bisync successful 2025/10/12 04:36:57 NOTICE: (16) : touch-glob 2007-07-23 /tmp/043608ko/datadir/test_rclone_args-ridenob8/ * 2025/10/12 04:36:57 DEBUG : fs cache: switching user supplied name "/tmp/043608ko/datadir/test_rclone_args-ridenob8/" for canonical name "/tmp/043608ko/datadir/test_rclone_args-ridenob8" 2025/10/12 04:36:57 DEBUG : file21.txt: Set modification time 2007-07-23 2025/10/12 04:36:57 DEBUG : file1.txt: Set modification time 2007-07-23 2025/10/12 04:36:57 DEBUG : file2.txt: Set modification time 2007-07-23 2025/10/12 04:36:57 DEBUG : file20.txt: Set modification time 2007-07-23 2025/10/12 04:36:57 NOTICE: (17) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ 2025/10/12 04:36:57 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" as "" 2025/10/12 04:36:57 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" 2025/10/12 04:36:57 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" 2025/10/12 04:36:58 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1" as "file1.txt" 2025/10/12 04:36: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 2025/10/12 04:36:58 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:37:00 INFO : file1.txt: Updated modification time in destination 2025/10/12 04:37:00 DEBUG : file1.txt: Unchanged skipping 2025/10/12 04:37:00 NOTICE: (18) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ 2025/10/12 04:37:00 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" as "" 2025/10/12 04:37:00 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" 2025/10/12 04:37:00 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:01 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2" as "file2.txt" 2025/10/12 04:37: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 2025/10/12 04:37:01 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:37:03 INFO : file2.txt: Updated modification time in destination 2025/10/12 04:37:03 DEBUG : file2.txt: Unchanged skipping 2025/10/12 04:37:03 NOTICE: (19) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir 2025/10/12 04:37:03 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" as "" 2025/10/12 04:37:03 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" 2025/10/12 04:37:03 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:37:04 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1/subdir" as "file20.txt" 2025/10/12 04:37:04 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/10/12 04:37:04 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:37:05 INFO : file20.txt: Updated modification time in destination 2025/10/12 04:37:05 DEBUG : file20.txt: Unchanged skipping 2025/10/12 04:37:05 NOTICE: (20) : copy-as /tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file1.txt 2025/10/12 04:37:05 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" as "file1.txt" 2025/10/12 04:37:05 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" 2025/10/12 04:37:05 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:07 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2" as "file1.txt" 2025/10/12 04:37:07 DEBUG : file21.txt: Sizes differ (src 0 vs dst 19) 2025/10/12 04:37:08 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:37:08 INFO : file21.txt: Copied (replaced existing) to: file1.txt 2025/10/12 04:37:08 NOTICE: (21) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ file1.txt 2025/10/12 04:37:08 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1" 2025/10/12 04:37:09 DEBUG : file1.txt: Set modification time 2007-07-23 2025/10/12 04:37:10 NOTICE: (22) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file2.txt 2025/10/12 04:37:10 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2" 2025/10/12 04:37:11 DEBUG : file2.txt: Set modification time 2007-07-23 2025/10/12 04:37:11 NOTICE: (23) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/ file20.txt 2025/10/12 04:37:11 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:37:12 DEBUG : file20.txt: Set modification time 2007-07-23 2025/10/12 04:37:13 NOTICE: (24) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/ file21.txt 2025/10/12 04:37:13 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:37:14 DEBUG : file21.txt: Set modification time 2007-07-23 2025/10/12 04:37:14 NOTICE: (25) : bisync size-only 2025/10/12 04:37:23 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:37:23 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:37:23 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/12 04:37:23 INFO : Bisyncing with Comparison Settings: { "Modtime": false, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/10/12 04:37:23 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:23 INFO : Building Path1 and Path2 listings 2025/10/12 04:37:23 INFO : Path1 checking for diffs 2025/10/12 04:37:23 INFO : Path2 checking for diffs 2025/10/12 04:37:23 INFO : - Path2 File changed: size (smaller) - file1.txt 2025/10/12 04:37:23 INFO : Path2: 1 changes:  0 new,  1 modified,  0 deleted 2025/10/12 04:37:23 INFO : (Modified:  0 larger,  1 smaller) 2025/10/12 04:37:23 INFO : Applying changes 2025/10/12 04:37:23 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/file1.txt 2025/10/12 04:37:23 INFO : - Path2 Do queued copies to - Path1 2025/10/12 04:37:24 INFO : file1.txt: Copied (server-side copy) 2025/10/12 04:37:24 INFO : Updating listings 2025/10/12 04:37:24 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:24 INFO : Bisync successful 2025/10/12 04:37:24 NOTICE: (26) : bisync resync 2025/10/12 04:37:34 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:37:34 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:37:34 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/12 04:37:34 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/10/12 04:37:34 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:34 INFO : Copying Path2 files to Path1 2025/10/12 04:37:34 INFO : - Path2 Resync is copying files to - Path1 2025/10/12 04:37:35 INFO : There was nothing to transfer 2025/10/12 04:37:35 INFO : - Path1 Resync is copying files to - Path2 2025/10/12 04:37:36 INFO : subdir/file21.txt: Updated modification time in destination 2025/10/12 04:37:36 INFO : file2.txt: Updated modification time in destination 2025/10/12 04:37:37 INFO : subdir/file20.txt: Updated modification time in destination 2025/10/12 04:37:37 INFO : There was nothing to transfer 2025/10/12 04:37:37 INFO : Resync updating listings 2025/10/12 04:37:37 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:37 INFO : Bisync successful 2025/10/12 04:37:37 NOTICE: (27) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ 2025/10/12 04:37:37 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" as "" 2025/10/12 04:37:37 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" 2025/10/12 04:37:37 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" 2025/10/12 04:37:38 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1" as "file1.txt" 2025/10/12 04:37:38 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0) 2025/10/12 04:37:40 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:37:40 INFO : file1.txt: Copied (replaced existing) 2025/10/12 04:37:40 NOTICE: (28) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ 2025/10/12 04:37:40 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" as "" 2025/10/12 04:37:40 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file2.txt" 2025/10/12 04:37:40 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:37:42 DEBUG : operations.CopyFile "file2.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2" as "file2.txt" 2025/10/12 04:37:42 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/10/12 04:37:42 DEBUG : file2.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:37:43 INFO : file2.txt: Updated modification time in destination 2025/10/12 04:37:43 DEBUG : file2.txt: Unchanged skipping 2025/10/12 04:37:43 NOTICE: (29) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir 2025/10/12 04:37:43 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" as "" 2025/10/12 04:37:43 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" 2025/10/12 04:37:43 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:37:44 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1/subdir" as "file20.txt" 2025/10/12 04:37:44 DEBUG : file20.txt: Size and modification time the same (differ by 0s, within tolerance 1ms) 2025/10/12 04:37:44 DEBUG : file20.txt: Unchanged skipping 2025/10/12 04:37:44 NOTICE: (30) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir 2025/10/12 04:37:44 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" as "" 2025/10/12 04:37:44 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" 2025/10/12 04:37:44 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:37:45 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2/subdir" as "file21.txt" 2025/10/12 04:37:46 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/10/12 04:37:46 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:37:47 INFO : file21.txt: Updated modification time in destination 2025/10/12 04:37:47 DEBUG : file21.txt: Unchanged skipping 2025/10/12 04:37:47 NOTICE: (31) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ file1.txt 2025/10/12 04:37:47 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1" 2025/10/12 04:37:47 DEBUG : file1.txt: Set modification time 2007-07-23 2025/10/12 04:37:48 NOTICE: (32) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file2.txt 2025/10/12 04:37:48 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2" 2025/10/12 04:37:48 DEBUG : file2.txt: Set modification time 2007-07-23 2025/10/12 04:37:49 NOTICE: (33) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/ file20.txt 2025/10/12 04:37:49 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:37:50 DEBUG : file20.txt: Set modification time 2007-07-23 2025/10/12 04:37:51 NOTICE: (34) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/ file21.txt 2025/10/12 04:37:51 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:37:51 DEBUG : file21.txt: Set modification time 2007-07-23 2025/10/12 04:37:52 NOTICE: (35) : bisync ignore-size 2025/10/12 04:38:02 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:02 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:02 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/12 04:38:02 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": false, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/10/12 04:38:02 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:02 INFO : Building Path1 and Path2 listings 2025/10/12 04:38:02 INFO : Path1 checking for diffs 2025/10/12 04:38:02 INFO : Path2 checking for diffs 2025/10/12 04:38:02 INFO : - Path2 File changed: time (newer) - file2.txt 2025/10/12 04:38:02 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2025/10/12 04:38:02 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2025/10/12 04:38:02 INFO : (Modified:  2 newer,  0 older) 2025/10/12 04:38:02 INFO : Applying changes 2025/10/12 04:38:02 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/file2.txt 2025/10/12 04:38:02 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/file21.txt 2025/10/12 04:38:02 INFO : - Path2 Do queued copies to - Path1 2025/10/12 04:38:03 INFO : file2.txt: Updated modification time in destination 2025/10/12 04:38:04 INFO : subdir/file21.txt: Updated modification time in destination 2025/10/12 04:38:04 INFO : There was nothing to transfer 2025/10/12 04:38:04 INFO : Updating listings 2025/10/12 04:38:04 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:04 INFO : Bisync successful 2025/10/12 04:38:04 NOTICE: (36) : bisync resync compare-all 2025/10/12 04:38:11 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:11 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/10/12 04:38:11 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:11 INFO : Copying Path2 files to Path1 2025/10/12 04:38:11 INFO : - Path2 Resync is copying files to - Path1 2025/10/12 04:38:12 INFO : There was nothing to transfer 2025/10/12 04:38:12 INFO : - Path1 Resync is copying files to - Path2 2025/10/12 04:38:12 INFO : file1.txt: Copied (server-side copy) 2025/10/12 04:38:12 INFO : Resync updating listings 2025/10/12 04:38:12 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:12 INFO : Bisync successful 2025/10/12 04:38:12 NOTICE: (37) : copy-as /tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file2.txt 2025/10/12 04:38:12 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" as "file2.txt" 2025/10/12 04:38:12 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" 2025/10/12 04:38:12 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:13 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2" as "file2.txt" 2025/10/12 04:38:14 DEBUG : file21.txt: Sizes differ (src 0 vs dst 19) 2025/10/12 04:38:15 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:38:15 INFO : file21.txt: Copied (replaced existing) to: file2.txt 2025/10/12 04:38:15 NOTICE: (38) : touch-glob 2023-08-26 /tmp/043608ko/datadir/test_rclone_args-ridenob8/ * 2025/10/12 04:38:15 DEBUG : fs cache: switching user supplied name "/tmp/043608ko/datadir/test_rclone_args-ridenob8/" for canonical name "/tmp/043608ko/datadir/test_rclone_args-ridenob8" 2025/10/12 04:38:15 DEBUG : file21.txt: Set modification time 2023-08-26 2025/10/12 04:38:15 DEBUG : file1.txt: Set modification time 2023-08-26 2025/10/12 04:38:15 DEBUG : file2.txt: Set modification time 2023-08-26 2025/10/12 04:38:15 DEBUG : file20.txt: Set modification time 2023-08-26 2025/10/12 04:38:15 NOTICE: (39) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ 2025/10/12 04:38:15 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" as "" 2025/10/12 04:38:15 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file1.txt" 2025/10/12 04:38:15 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" 2025/10/12 04:38:16 DEBUG : operations.CopyFile "file1.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1" as "file1.txt" 2025/10/12 04:38:16 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/10/12 04:38:16 DEBUG : file1.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/12 04:38:18 INFO : file1.txt: Updated modification time in destination 2025/10/12 04:38:18 DEBUG : file1.txt: Unchanged skipping 2025/10/12 04:38:18 NOTICE: (40) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir 2025/10/12 04:38:18 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" as "" 2025/10/12 04:38:18 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file20.txt" 2025/10/12 04:38:18 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:38:19 DEBUG : operations.CopyFile "file20.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1/subdir" as "file20.txt" 2025/10/12 04:38:19 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/10/12 04:38:19 DEBUG : file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:38:21 INFO : file20.txt: Updated modification time in destination 2025/10/12 04:38:21 DEBUG : file20.txt: Unchanged skipping 2025/10/12 04:38:21 NOTICE: (41) : copy-file /tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir 2025/10/12 04:38:21 DEBUG : copyFile "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" to "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" as "" 2025/10/12 04:38:21 DEBUG : Creating backend with remote "/tmp/043608ko/datadir/test_rclone_args-ridenob8/file21.txt" 2025/10/12 04:38:21 DEBUG : Creating backend with remote "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:38:22 DEBUG : operations.CopyFile "file21.txt" to "B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2/subdir" as "file21.txt" 2025/10/12 04:38:22 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/10/12 04:38:22 DEBUG : file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/12 04:38:23 INFO : file21.txt: Updated modification time in destination 2025/10/12 04:38:23 DEBUG : file21.txt: Unchanged skipping 2025/10/12 04:38:23 NOTICE: (42) : touch-glob 2007-07-23 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/ file2.txt 2025/10/12 04:38:23 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2" 2025/10/12 04:38:24 DEBUG : file2.txt: Set modification time 2007-07-23 2025/10/12 04:38:25 NOTICE: (43) : touch-glob 2023-08-26 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/ file1.txt 2025/10/12 04:38:25 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1" 2025/10/12 04:38:25 DEBUG : file1.txt: Set modification time 2023-08-26 2025/10/12 04:38:26 NOTICE: (44) : touch-glob 2023-08-26 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/ file20.txt 2025/10/12 04:38:26 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir" 2025/10/12 04:38:27 DEBUG : file20.txt: Set modification time 2023-08-26 2025/10/12 04:38:27 NOTICE: (45) : touch-glob 2023-08-26 TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/ file21.txt 2025/10/12 04:38:27 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/" for canonical name "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir" 2025/10/12 04:38:28 DEBUG : file21.txt: Set modification time 2023-08-26 2025/10/12 04:38:29 NOTICE: (46) : bisync compare-all 2025/10/12 04:38:37 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:37 DEBUG : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/12 04:38:37 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": true, "HashType1": 2, "HashType2": 2, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": true } 2025/10/12 04:38:37 INFO : Synching Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" with Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:37 INFO : Building Path1 and Path2 listings 2025/10/12 04:38:38 INFO : Path1 checking for diffs 2025/10/12 04:38:38 INFO : - Path1 File changed: time (newer) - file1.txt 2025/10/12 04:38:38 INFO : - Path1 File changed: time (newer) - subdir/file20.txt 2025/10/12 04:38:38 INFO : Path1: 2 changes:  0 new,  2 modified,  0 deleted 2025/10/12 04:38:38 INFO : (Modified:  2 newer,  0 older) 2025/10/12 04:38:38 INFO : Path2 checking for diffs 2025/10/12 04:38:38 INFO : - Path2 File changed: size (smaller), hash - file2.txt 2025/10/12 04:38:38 INFO : - Path2 File changed: time (newer) - subdir/file21.txt 2025/10/12 04:38:38 INFO : Path2: 2 changes:  0 new,  2 modified,  0 deleted 2025/10/12 04:38:38 INFO : (Modified:  1 newer,  0 older,  0 larger,  1 smaller,  1 hash differs) 2025/10/12 04:38:38 INFO : Applying changes 2025/10/12 04:38:38 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/file1.txt 2025/10/12 04:38:38 INFO : - Path1 Queue copy to Path2 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/subdir/file20.txt 2025/10/12 04:38:38 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/file2.txt 2025/10/12 04:38:38 INFO : - Path2 Queue copy to Path1 - TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/subdir/file21.txt 2025/10/12 04:38:38 INFO : - Path2 Do queued copies to - Path1 2025/10/12 04:38:39 INFO : file2.txt: Copied (server-side copy) 2025/10/12 04:38:41 INFO : subdir/file21.txt: Updated modification time in destination 2025/10/12 04:38:41 INFO : - Path1 Do queued copies to - Path2 2025/10/12 04:38:42 INFO : file1.txt: Updated modification time in destination 2025/10/12 04:38:43 INFO : subdir/file20.txt: Updated modification time in destination 2025/10/12 04:38:43 INFO : Updating listings 2025/10/12 04:38:43 INFO : Validating listings for Path1 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path1/" vs Path2 "TestB2:rclone-test-towovuy0deta/043608ko/rclone_args/path2/" 2025/10/12 04:38:43 INFO : Bisync successful 2025/10/12 04:38:43 INFO : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path1: cleaning bucket "rclone-test-towovuy0deta" of all files 2025/10/12 04:38:43 DEBUG : RCLONE_TEST: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11873fa2d281d69c_d20251012_m043615_c001_v0001183_t0039_u01760243775564") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11224b32ab85f6ee_d20251012_m043826_c001_v0001184_t0050_u01760243906351") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f113bf3ec736d0b51_d20251012_m043818_c001_v0001117_t0001_u01760243898045") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f116dbfc30428479c_d20251012_m043748_c001_v0001032_t0034_u01760243868431") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f112d0b5af6d169a3_d20251012_m043740_c001_v0001116_t0007_u01760243860329") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11873fa2d281d814_d20251012_m043724_c001_v0001183_t0056_u01760243844157") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1183e7d8965e2b7e_d20251012_m043710_c001_v0001116_t0012_u01760243830019") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f108643dba3442797_d20251012_m043659_c001_v0001098_t0056_u01760243819924") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f10192b1e9d2b0722_d20251012_m043639_c001_v0001093_t0032_u01760243799339") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1034faa70a8ad8c5_d20251012_m043628_c001_v0001043_t0050_u01760243788592") 2025/10/12 04:38:43 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f110fb14abe1d2481_d20251012_m043615_c001_v0001101_t0002_u01760243775380") 2025/10/12 04:38:43 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11156a42a6d16bb8_d20251012_m043838_c001_v0001146_t0046_u01760243918763") 2025/10/12 04:38:43 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1038b8df9856c6ac_d20251012_m043803_c001_v0001144_t0056_u01760243883297") 2025/10/12 04:38:44 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118dea2735a5ed92_d20251012_m043655_c001_v0001115_t0010_u01760243815982") 2025/10/12 04:38:44 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118552e4b7640138_d20251012_m043615_c001_v0001184_t0050_u01760243775189") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f420744ac74609182_d20251012_m043833_c001_v7007000_t0000_u01760243913520") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f108f07bb76c8e739_d20251012_m043832_c001_v0001165_t0041_u01760243912294") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f110fb14abe1d267a_d20251012_m043829_c001_v0001101_t0015_u01760243909843") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f401d37430abd8e43_d20251012_m043807_c001_v7007000_t0000_u01760243887267") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f111bd208dbfccde3_d20251012_m043806_c001_v0001182_t0020_u01760243886057") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11873fa2d281d91e_d20251012_m043804_c001_v0001183_t0050_u01760243884633") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f4192e54f0f91d9d9_d20251012_m043757_c001_v7007000_t0000_u01760243877221") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1196ce7482d4a41f_d20251012_m043755_c001_v0001144_t0006_u01760243875344") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118552e4b76403f4_d20251012_m043753_c001_v0001184_t0021_u01760243873207") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f4149afcae7b3d09f_d20251012_m043728_c001_v7007000_t0000_u01760243848363") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f112403c611e7f635_d20251012_m043727_c001_v0001120_t0033_u01760243847035") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f102f90884a15589c_d20251012_m043724_c001_v0001029_t0015_u01760243844920") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f4149afcae7b3d097_d20251012_m043719_c001_v7007000_t0000_u01760243839118") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f113cc33bf03dcb17_d20251012_m043717_c001_v0001113_t0039_u01760243837834") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f110fb14abe1d2586_d20251012_m043715_c001_v0001101_t0013_u01760243835266") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f401d37430abd8923_d20251012_m043651_c001_v7007000_t0000_u01760243811105") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f10294ff1e1928137_d20251012_m043649_c001_v0001120_t0002_u01760243809775") 2025/10/12 04:38:44 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11873fa2d281d73f_d20251012_m043647_c001_v0001183_t0041_u01760243807631") 2025/10/12 04:38:45 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f41185a1fa5c1b7d3_d20251012_m043621_c001_v7007000_t0000_u01760243781275") 2025/10/12 04:38:45 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1038198e8b715a3e_d20251012_m043620_c001_v0001165_t0043_u01760243780013") 2025/10/12 04:38:45 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118552e4b764014c_d20251012_m043618_c001_v0001184_t0059_u01760243778203") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1101e0186fa3bb48_d20251012_m043827_c001_v0001180_t0053_u01760243907680") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f112ef26667c1e46c_d20251012_m043820_c001_v0001100_t0035_u01760243900825") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1191923b97832446_d20251012_m043750_c001_v0001150_t0009_u01760243870962") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1177eb447ef14bbb_d20251012_m043713_c001_v0001109_t0023_u01760243833030") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f111be6070e8573a8_d20251012_m043705_c001_v0001177_t0025_u01760243825755") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1124f8f1caaf76e2_d20251012_m043644_c001_v0001182_t0052_u01760243804496") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f108a5a7fb207abdf_d20251012_m043634_c001_v0001171_t0055_u01760243794263") 2025/10/12 04:38:45 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f102f90884a1557f2_d20251012_m043615_c001_v0001029_t0015_u01760243775758") 2025/10/12 04:38:45 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115435ed6e0da2a4_d20251012_m043841_c001_v0001090_t0046_u01760243921376") 2025/10/12 04:38:45 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1178423c6038f91d_d20251012_m043803_c001_v0001137_t0048_u01760243883787") 2025/10/12 04:38:45 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118552e4b764013c_d20251012_m043615_c001_v0001184_t0026_u01760243775428") 2025/10/12 04:38:46 INFO : B2 bucket rclone-test-towovuy0deta path 043608ko/rclone_args/path2: cleaning bucket "rclone-test-towovuy0deta" of all files 2025/10/12 04:38:46 DEBUG : RCLONE_TEST: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115598e7f0521369_d20251012_m043617_c001_v0001181_t0027_u01760243777507") 2025/10/12 04:38:46 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1040c7fcb4830bb7_d20251012_m043842_c001_v0001146_t0040_u01760243922489") 2025/10/12 04:38:46 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f102fed8b6da36d21_d20251012_m043812_c001_v0001115_t0050_u01760243892351") 2025/10/12 04:38:46 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115598e7f05214f8_d20251012_m043708_c001_v0001181_t0048_u01760243828655") 2025/10/12 04:38:46 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1014a32d5cc76ab4_d20251012_m043657_c001_v0001040_t0021_u01760243817176") 2025/10/12 04:38:46 DEBUG : file1.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118582544fa6c6a5_d20251012_m043617_c001_v0001101_t0029_u01760243777698") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1181926bff7c04d0_d20251012_m043825_c001_v0001165_t0055_u01760243905012") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11289e597082cbbe_d20251012_m043815_c001_v0001165_t0002_u01760243895533") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f111747232c1883a8_d20251012_m043749_c001_v0001176_t0037_u01760243869636") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f112b0593a91b2cf1_d20251012_m043743_c001_v0001137_t0029_u01760243863272") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1155fee9097482e7_d20251012_m043736_c001_v0001146_t0046_u01760243856648") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f101c8f0c2034c544_d20251012_m043711_c001_v0001184_t0050_u01760243831709") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f107fb64657c5a63e_d20251012_m043702_c001_v0001144_t0054_u01760243822714") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f106b57b7413d374f_d20251012_m043641_c001_v0001109_t0004_u01760243801918") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f102899017955c1ec_d20251012_m043631_c001_v0001041_t0043_u01760243791591") 2025/10/12 04:38:46 DEBUG : file2.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118dc17522a514e6_d20251012_m043617_c001_v0001150_t0030_u01760243777119") 2025/10/12 04:38:46 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f41185a1fa5c1be4d_d20251012_m043837_c001_v7007000_t0000_u01760243917821") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f117402bff0598aec_d20251012_m043836_c001_v0001044_t0001_u01760243916206") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115598e7f0521761_d20251012_m043834_c001_v0001181_t0003_u01760243914068") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f42182d912048c61c_d20251012_m043811_c001_v7007000_t0000_u01760243891604") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1152521679c9009f_d20251012_m043810_c001_v0001153_t0023_u01760243890266") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118dc17522a51610_d20251012_m043807_c001_v0001150_t0013_u01760243887809") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f4131931c2e3fa12d_d20251012_m043801_c001_v7007000_t0000_u01760243881946") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f10829bf658daf3f6_d20251012_m043800_c001_v0001100_t0003_u01760243880493") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f117126d8ba6e71dd_d20251012_m043757_c001_v0001102_t0005_u01760243877773") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f42182d912048c4e5_d20251012_m043734_c001_v7007000_t0000_u01760243854511") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f116ce409741efdbe_d20251012_m043733_c001_v0001042_t0000_u01760243853176") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118582544fa6c793_d20251012_m043728_c001_v0001101_t0051_u01760243848909") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f406528ccdab66631_d20251012_m043723_c001_v7007000_t0000_u01760243843402") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f11876330e9fba9d3_d20251012_m043721_c001_v0001109_t0007_u01760243841820") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115598e7f052155c_d20251012_m043719_c001_v0001181_t0016_u01760243839673") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f400166412b81a04b_d20251012_m043655_c001_v7007000_t0000_u01760243815141") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f115a3396213fd087_d20251012_m043653_c001_v0001150_t0050_u01760243813873") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118dc17522a5153e_d20251012_m043651_c001_v0001150_t0002_u01760243811656") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f4103909a69227a0e_d20251012_m043625_c001_v7007000_t0000_u01760243785065") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f106a2b306904aa69_d20251012_m043623_c001_v0001134_t0057_u01760243783764") 2025/10/12 04:38:47 DEBUG : modtime_write_test: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f117126d8ba6e708a_d20251012_m043621_c001_v0001102_t0053_u01760243781460") 2025/10/12 04:38:48 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118fafff875e6064_d20251012_m043842_c001_v0001153_t0019_u01760243922834") 2025/10/12 04:38:48 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1177906a1e49ef6b_d20251012_m043736_c001_v0001117_t0056_u01760243856733") 2025/10/12 04:38:48 DEBUG : subdir/file20.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f117126d8ba6e7078_d20251012_m043617_c001_v0001102_t0005_u01760243777315") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1161cb6586af50e9_d20251012_m043829_c001_v0001157_t0052_u01760243909025") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f116e64df41fde5be_d20251012_m043823_c001_v0001146_t0051_u01760243903494") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f1177216ee64a8457_d20251012_m043752_c001_v0001136_t0038_u01760243872525") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f113256d0f023decd_d20251012_m043747_c001_v0001184_t0038_u01760243867113") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f101c92a263c53893_d20251012_m043736_c001_v0001157_t0007_u01760243856348") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f10242ba4007790ce_d20251012_m043714_c001_v0001183_t0051_u01760243834681") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f10493f185bfe9c88_d20251012_m043646_c001_v0001130_t0006_u01760243806845") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f108643dba344275f_d20251012_m043636_c001_v0001098_t0049_u01760243796759") 2025/10/12 04:38:48 DEBUG : subdir/file21.txt: Deleting (id "4_zdfe26d13b04ddb6b9f980e1b_f118dc17522a514eb_d20251012_m043617_c001_v0001150_t0040_u01760243777442") bisync_test.go:608: TEST rclone_args PASSED 2025/10/12 04:38:49 DEBUG : B2 bucket rclone-test-towovuy0deta: Purge remote 2025/10/12 04:38:49 INFO : B2 bucket rclone-test-towovuy0deta: cleaning bucket "rclone-test-towovuy0deta" of all files --- PASS: TestBisyncRemoteRemote (162.64s) --- PASS: TestBisyncRemoteRemote/rclone_args (160.78s) PASS 2025/10/12 04:38:50 DEBUG : B2 bucket rclone-test-vunices9suye: Purge remote 2025/10/12 04:38:50 INFO : B2 bucket rclone-test-vunices9suye: cleaning bucket "rclone-test-vunices9suye" of all files 2025/10/12 04:38:51 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 2m43.987537495s (try 3/5)