"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^resync$'" - Starting (try 3/5) 2025/10/01 04:11:46 DEBUG : Creating backend with remote "TestB2:rclone-test-yuxucem4cezo" 2025/10/01 04:11:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/01 04:11:46 DEBUG : Creating backend with remote "/tmp/rclone1506116559" === RUN TestBisyncRemoteRemote 2025/10/01 04:11:46 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo" 2025/10/01 04:11:47 NOTICE: remote: TestB2:rclone-test-cowezic8wopo === RUN TestBisyncRemoteRemote/resync 2025/10/01 04:11:47 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de" 2025/10/01 04:11:48 INFO : path1: Making directory 2025/10/01 04:11:49 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1" 2025/10/01 04:11:50 INFO : path2: Making directory 2025/10/01 04:11:50 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2" 2025/10/01 04:11:51 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2025/10/01 04:11:51 DEBUG : Creating backend with remote "/tmp/041147de/initdir/test_resync-yowabos2" 2025/10/01 04:11:51 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/10/01 04:11:51 INFO : file1.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/10/01 04:11:51 INFO : file2.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/10/01 04:11:51 INFO : file3.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/10/01 04:11:51 INFO : file4.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : Local file system at /tmp/041147de/initdir/test_resync-yowabos2: Waiting for checks to finish 2025/10/01 04:11:51 DEBUG : Local file system at /tmp/041147de/initdir/test_resync-yowabos2: Waiting for transfers to finish 2025/10/01 04:11:51 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/10/01 04:11:51 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/10/01 04:11:51 INFO : RCLONE_TEST: Copied (new) 2025/10/01 04:11:51 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/10/01 04:11:51 INFO : file7.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/10/01 04:11:51 INFO : file5.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/01 04:11:51 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/10/01 04:11:51 INFO : file6.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2025/10/01 04:11:51 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7" 2025/10/01 04:11:51 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:51 DEBUG : Local file system at /tmp/041147de/datadir/test_resync-pumapib7: Waiting for checks to finish 2025/10/01 04:11:51 DEBUG : Local file system at /tmp/041147de/datadir/test_resync-pumapib7: Waiting for transfers to finish 2025/10/01 04:11:51 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/01 04:11:51 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/01 04:11:51 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2025/10/01 04:11:51 INFO : fileB.txt: Copied (new) 2025/10/01 04:11:51 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2025/10/01 04:11:51 INFO : fileA.txt: Copied (new) 2025/10/01 04:11:51 INFO : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: cleaning bucket "rclone-test-cowezic8wopo" of all files 2025/10/01 04:11:52 INFO : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: cleaning bucket "rclone-test-cowezic8wopo" of all files 2025/10/01 04:11:53 NOTICE: checking initFs Local file system at /tmp/041147de/initdir/test_resync-yowabos2 2025/10/01 04:11:53 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:53 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Waiting for checks to finish 2025/10/01 04:11:53 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Waiting for transfers to finish 2025/10/01 04:11:54 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:54 INFO : file1.txt: Copied (new) 2025/10/01 04:11:54 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:54 INFO : file3.txt: Copied (new) 2025/10/01 04:11:54 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:54 INFO : file2.txt: Copied (new) 2025/10/01 04:11:55 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/01 04:11:55 INFO : RCLONE_TEST: Copied (new) 2025/10/01 04:11:55 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:55 INFO : file4.txt: Copied (new) 2025/10/01 04:11:55 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:55 INFO : file5.txt: Copied (new) 2025/10/01 04:11:55 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:55 INFO : file6.txt: Copied (new) 2025/10/01 04:11:55 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:55 INFO : file7.txt: Copied (new) 2025/10/01 04:11:55 NOTICE: checking Path1 B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1 2025/10/01 04:11:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/01 04:11:55 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Waiting for checks to finish 2025/10/01 04:11:55 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Waiting for transfers to finish 2025/10/01 04:11:57 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file1.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file2.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file3.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file5.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/01 04:11:57 INFO : RCLONE_TEST: Copied (new) 2025/10/01 04:11:57 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file7.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file4.txt: Copied (new) 2025/10/01 04:11:57 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/01 04:11:57 INFO : file6.txt: Copied (new) 2025/10/01 04:11:57 NOTICE: checking path2 B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2 2025/10/01 04:11:58 NOTICE: (01) : test resync 2025/10/01 04:11:58 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/10/01 04:11:58 NOTICE: (03) : purge-children TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/ 2025/10/01 04:11:58 DEBUG : RCLONE_TEST: Remove file 2025/10/01 04:11:58 DEBUG : file1.txt: Remove file 2025/10/01 04:11:58 DEBUG : file2.txt: Remove file 2025/10/01 04:11:58 DEBUG : file3.txt: Remove file 2025/10/01 04:11:58 DEBUG : file4.txt: Remove file 2025/10/01 04:11:59 DEBUG : file5.txt: Remove file 2025/10/01 04:11:59 DEBUG : file6.txt: Remove file 2025/10/01 04:11:59 DEBUG : file7.txt: Remove file 2025/10/01 04:11:59 NOTICE: (04) : bisync resync 2025/10/01 04:12:07 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:07 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:07 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/01 04:12:07 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/01 04:12:07 INFO : Synching Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" with Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:07 INFO : Copying Path2 files to Path1 2025/10/01 04:12:07 INFO : - Path2 Resync is copying files to - Path1 2025/10/01 04:12:08 INFO : RCLONE_TEST: Copied (server-side copy) 2025/10/01 04:12:08 INFO : file2.txt: Copied (server-side copy) 2025/10/01 04:12:08 INFO : file4.txt: Copied (server-side copy) 2025/10/01 04:12:08 INFO : file3.txt: Copied (server-side copy) 2025/10/01 04:12:09 INFO : file1.txt: Copied (server-side copy) 2025/10/01 04:12:09 INFO : file7.txt: Copied (server-side copy) 2025/10/01 04:12:09 INFO : file5.txt: Copied (server-side copy) 2025/10/01 04:12:09 INFO : file6.txt: Copied (server-side copy) 2025/10/01 04:12:09 INFO : - Path1 Resync is copying files to - Path2 2025/10/01 04:12:09 INFO : Resync updating listings 2025/10/01 04:12:09 INFO : Validating listings for Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" vs Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:09 INFO : Bisync successful 2025/10/01 04:12:09 NOTICE: (05) : move-listings empty-path1 2025/10/01 04:12:09 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/10/01 04:12:09 NOTICE: (07) : purge-children TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ 2025/10/01 04:12:10 DEBUG : RCLONE_TEST: Remove file 2025/10/01 04:12:10 DEBUG : file1.txt: Remove file 2025/10/01 04:12:10 DEBUG : file2.txt: Remove file 2025/10/01 04:12:10 DEBUG : file3.txt: Remove file 2025/10/01 04:12:10 DEBUG : file4.txt: Remove file 2025/10/01 04:12:10 DEBUG : file5.txt: Remove file 2025/10/01 04:12:11 DEBUG : file6.txt: Remove file 2025/10/01 04:12:11 DEBUG : file7.txt: Remove file 2025/10/01 04:12:11 NOTICE: (08) : bisync resync 2025/10/01 04:12:20 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:20 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:20 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/01 04:12:20 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/01 04:12:20 INFO : Synching Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" with Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:20 INFO : Copying Path2 files to Path1 2025/10/01 04:12:20 INFO : - Path2 Resync is copying files to - Path1 2025/10/01 04:12:20 INFO : There was nothing to transfer 2025/10/01 04:12:20 INFO : - Path1 Resync is copying files to - Path2 2025/10/01 04:12:21 INFO : RCLONE_TEST: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file3.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file2.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file1.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file7.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file4.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file6.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : file5.txt: Copied (server-side copy) 2025/10/01 04:12:21 INFO : Resync updating listings 2025/10/01 04:12:21 INFO : Validating listings for Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" vs Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:21 INFO : Bisync successful 2025/10/01 04:12:21 NOTICE: (09) : move-listings empty-path2 2025/10/01 04:12:21 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/10/01 04:12:21 NOTICE: (11) : touch-glob 2002-02-02 /tmp/041147de/datadir/test_resync-pumapib7/ fileA.txt 2025/10/01 04:12:21 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/" 2025/10/01 04:12:21 DEBUG : fs cache: renaming cache item "/tmp/041147de/datadir/test_resync-pumapib7/" to be canonical "/tmp/041147de/datadir/test_resync-pumapib7" 2025/10/01 04:12:21 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/10/01 04:12:21 NOTICE: (12) : touch-glob 1999-09-09 /tmp/041147de/datadir/test_resync-pumapib7/ fileB.txt 2025/10/01 04:12:21 DEBUG : fs cache: switching user supplied name "/tmp/041147de/datadir/test_resync-pumapib7/" for canonical name "/tmp/041147de/datadir/test_resync-pumapib7" 2025/10/01 04:12:21 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/10/01 04:12:21 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/10/01 04:12:21 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/10/01 04:12:21 NOTICE: (15) : delete-file TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/file1.txt 2025/10/01 04:12:21 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:22 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" to be canonical "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2" 2025/10/01 04:12:23 INFO : file1.txt: Deleted 2025/10/01 04:12:23 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/10/01 04:12:23 NOTICE: (17) : delete-file TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/file2.txt 2025/10/01 04:12:23 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" 2025/10/01 04:12:24 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" to be canonical "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1" 2025/10/01 04:12:24 INFO : file2.txt: Deleted 2025/10/01 04:12:24 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/10/01 04:12:24 NOTICE: (19) : copy-as /tmp/041147de/datadir/test_resync-pumapib7/fileA.txt TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ file3.txt 2025/10/01 04:12:24 DEBUG : copyFile "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" to "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" as "file3.txt" 2025/10/01 04:12:24 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" 2025/10/01 04:12:24 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:26 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2" as "file3.txt" 2025/10/01 04:12:26 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/01 04:12:28 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/01 04:12:28 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/10/01 04:12:28 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/10/01 04:12:28 NOTICE: (21) : delete-file TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/file4.txt 2025/10/01 04:12:28 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" for canonical name "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1" 2025/10/01 04:12:28 INFO : file4.txt: Deleted 2025/10/01 04:12:28 NOTICE: (22) : copy-as /tmp/041147de/datadir/test_resync-pumapib7/fileA.txt TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ file4.txt 2025/10/01 04:12:28 DEBUG : copyFile "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" to "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" as "file4.txt" 2025/10/01 04:12:28 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" 2025/10/01 04:12:28 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:29 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2" as "file4.txt" 2025/10/01 04:12:29 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/01 04:12:31 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/01 04:12:31 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/10/01 04:12:31 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/10/01 04:12:31 NOTICE: (24) : copy-as /tmp/041147de/datadir/test_resync-pumapib7/fileB.txt TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ file5.txt 2025/10/01 04:12:31 DEBUG : copyFile "/tmp/041147de/datadir/test_resync-pumapib7/fileB.txt" to "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" as "file5.txt" 2025/10/01 04:12:31 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/fileB.txt" 2025/10/01 04:12:31 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:32 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2" as "file5.txt" 2025/10/01 04:12:32 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/10/01 04:12:34 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/01 04:12:34 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/10/01 04:12:34 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/10/01 04:12:34 NOTICE: (26) : copy-as /tmp/041147de/datadir/test_resync-pumapib7/fileB.txt TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/ file6.txt 2025/10/01 04:12:34 DEBUG : copyFile "/tmp/041147de/datadir/test_resync-pumapib7/fileB.txt" to "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" as "file6.txt" 2025/10/01 04:12:34 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/fileB.txt" 2025/10/01 04:12:34 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" 2025/10/01 04:12:35 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1" as "file6.txt" 2025/10/01 04:12:35 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/10/01 04:12:37 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/01 04:12:37 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/10/01 04:12:37 NOTICE: (27) : copy-as /tmp/041147de/datadir/test_resync-pumapib7/fileA.txt TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ file6.txt 2025/10/01 04:12:37 DEBUG : copyFile "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" to "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" as "file6.txt" 2025/10/01 04:12:37 DEBUG : Creating backend with remote "/tmp/041147de/datadir/test_resync-pumapib7/fileA.txt" 2025/10/01 04:12:37 DEBUG : Creating backend with remote "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:38 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2" as "file6.txt" 2025/10/01 04:12:39 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/01 04:12:40 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/01 04:12:40 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/10/01 04:12:40 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/10/01 04:12:40 NOTICE: (29) : test run bisync with resync 2025/10/01 04:12:40 NOTICE: (30) : bisync resync 2025/10/01 04:12:51 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:51 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:12:51 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/01 04:12:51 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/01 04:12:51 INFO : Synching Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" with Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:51 INFO : Copying Path2 files to Path1 2025/10/01 04:12:51 INFO : - Path2 Resync is copying files to - Path1 2025/10/01 04:12:51 INFO : file4.txt: Copied (server-side copy) 2025/10/01 04:12:52 INFO : file2.txt: Copied (server-side copy) 2025/10/01 04:12:52 INFO : - Path1 Resync is copying files to - Path2 2025/10/01 04:12:53 INFO : file3.txt: Copied (server-side copy) 2025/10/01 04:12:53 INFO : file1.txt: Copied (server-side copy) 2025/10/01 04:12:53 INFO : file5.txt: Copied (server-side copy) 2025/10/01 04:12:53 INFO : file6.txt: Updated modification time in destination 2025/10/01 04:12:53 INFO : Resync updating listings 2025/10/01 04:12:53 INFO : Validating listings for Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" vs Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:12:53 INFO : Bisync successful 2025/10/01 04:12:53 NOTICE: (31) : copy-listings mixed-diffs 2025/10/01 04:12:53 NOTICE: (32) : test run normal bisync 2025/10/01 04:12:53 NOTICE: (33) : bisync 2025/10/01 04:13:03 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:13:03 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:13:03 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/01 04:13:03 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/01 04:13:03 INFO : Synching Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" with Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:13:03 INFO : Building Path1 and Path2 listings 2025/10/01 04:13:03 INFO : Path1 checking for diffs 2025/10/01 04:13:03 INFO : Path2 checking for diffs 2025/10/01 04:13:03 INFO : No changes found 2025/10/01 04:13:03 INFO : Updating listings 2025/10/01 04:13:03 INFO : Validating listings for Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" vs Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:13:03 INFO : Bisync successful 2025/10/01 04:13:03 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/10/01 04:13:03 NOTICE: (35) : purge-children TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/ 2025/10/01 04:13:04 DEBUG : RCLONE_TEST: Remove file 2025/10/01 04:13:04 DEBUG : file1.txt: Remove file 2025/10/01 04:13:04 DEBUG : file2.txt: Remove file 2025/10/01 04:13:04 DEBUG : file3.txt: Remove file 2025/10/01 04:13:04 DEBUG : file4.txt: Remove file 2025/10/01 04:13:04 DEBUG : file5.txt: Remove file 2025/10/01 04:13:05 DEBUG : file6.txt: Remove file 2025/10/01 04:13:05 DEBUG : file7.txt: Remove file 2025/10/01 04:13:05 NOTICE: (36) : bisync 2025/10/01 04:13:13 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:13:13 DEBUG : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/01 04:13:13 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/01 04:13:13 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/10/01 04:13:13 INFO : Synching Path1 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path1/" with Path2 "TestB2:rclone-test-cowezic8wopo/041147de/resync/path2/" 2025/10/01 04:13:13 INFO : Building Path1 and Path2 listings 2025/10/01 04:13:13 INFO : Path1 checking for diffs 2025/10/01 04:13:13 INFO : Path2 checking for diffs 2025/10/01 04:13:13 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/041147de/workdir/TestB2_rclone-test-cowezic8wopo_041147de_resync_path1..TestB2_rclone-test-cowezic8wopo_041147de_resync_path2.path2.lst-new 2025/10/01 04:13:13 ERROR : Bisync critical error: empty current Path2 listing: /tmp/041147de/workdir/TestB2_rclone-test-cowezic8wopo_041147de_resync_path1..TestB2_rclone-test-cowezic8wopo_041147de_resync_path2.path2.lst-new 2025/10/01 04:13:13 ERROR : Bisync aborted. Must run --resync to recover. 2025/10/01 04:13:13 NOTICE: Bisync error: bisync aborted 2025/10/01 04:13:14 INFO : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path1: cleaning bucket "rclone-test-cowezic8wopo" of all files 2025/10/01 04:13:14 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10853a11f3a17f7c_d20251001_m041208_c001_v0001161_t0024_u01759291928230") 2025/10/01 04:13:14 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf00_d20251001_m041158_c001_v7007000_t0000_u01759291918288") 2025/10/01 04:13:14 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f111fdd60ce9da658_d20251001_m041154_c001_v0001098_t0047_u01759291914746") 2025/10/01 04:13:14 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f111b20ca89f6f4ae_d20251001_m041208_c001_v0001144_t0031_u01759291928600") 2025/10/01 04:13:14 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf03_d20251001_m041158_c001_v7007000_t0000_u01759291918471") 2025/10/01 04:13:14 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d070_d20251001_m041154_c001_v0001042_t0013_u01759291914184") 2025/10/01 04:13:14 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11762012ef75f927_d20251001_m041252_c001_v0001041_t0056_u01759291972065") 2025/10/01 04:13:14 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf24_d20251001_m041224_c001_v7007000_t0000_u01759291944795") 2025/10/01 04:13:14 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10364ee0790c4947_d20251001_m041208_c001_v0001179_t0028_u01759291928616") 2025/10/01 04:13:14 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf06_d20251001_m041158_c001_v7007000_t0000_u01759291918655") 2025/10/01 04:13:14 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119a381a9d1b7283_d20251001_m041154_c001_v0001040_t0050_u01759291914540") 2025/10/01 04:13:14 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1184fdeb306439a6_d20251001_m041208_c001_v0001172_t0013_u01759291928616") 2025/10/01 04:13:14 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf09_d20251001_m041158_c001_v7007000_t0000_u01759291918837") 2025/10/01 04:13:14 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f112ec2e3b69ec13c_d20251001_m041154_c001_v0001101_t0009_u01759291914352") 2025/10/01 04:13:14 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10120a20eed295b3_d20251001_m041251_c001_v0001184_t0032_u01759291971789") 2025/10/01 04:13:15 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf29_d20251001_m041228_c001_v7007000_t0000_u01759291948338") 2025/10/01 04:13:15 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1071aa82e21f1885_d20251001_m041208_c001_v0001098_t0058_u01759291928614") 2025/10/01 04:13:15 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf0c_d20251001_m041159_c001_v7007000_t0000_u01759291919022") 2025/10/01 04:13:15 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d074_d20251001_m041154_c001_v0001042_t0055_u01759291914631") 2025/10/01 04:13:15 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f114275bb72e0096c_d20251001_m041208_c001_v0001134_t0047_u01759291928929") 2025/10/01 04:13:15 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf0d_d20251001_m041159_c001_v7007000_t0000_u01759291919205") 2025/10/01 04:13:15 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f112ec2e3b69ec142_d20251001_m041154_c001_v0001101_t0000_u01759291914982") 2025/10/01 04:13:15 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1164655b3b4bf9cd_d20251001_m041237_c001_v0001105_t0031_u01759291957302") 2025/10/01 04:13:15 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f111b20ca89f6f4b0_d20251001_m041208_c001_v0001144_t0036_u01759291928960") 2025/10/01 04:13:15 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf0e_d20251001_m041159_c001_v7007000_t0000_u01759291919387") 2025/10/01 04:13:15 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119a381a9d1b7285_d20251001_m041155_c001_v0001040_t0029_u01759291915041") 2025/10/01 04:13:15 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f117243ccecbb1aae_d20251001_m041209_c001_v0001106_t0057_u01759291929066") 2025/10/01 04:13:15 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf0f_d20251001_m041159_c001_v7007000_t0000_u01759291919570") 2025/10/01 04:13:15 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f111fdd60ce9da65a_d20251001_m041155_c001_v0001098_t0017_u01759291915245") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f4169d19576df98f2_d20251001_m041309_c001_v7007000_t0000_u01759291989268") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11698b687540cdd8_d20251001_m041307_c001_v0001183_t0015_u01759291987953") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d159_d20251001_m041306_c001_v0001042_t0024_u01759291986013") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf4f_d20251001_m041257_c001_v7007000_t0000_u01759291977344") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f103924afe7f3b88d_d20251001_m041256_c001_v0001183_t0025_u01759291976133") 2025/10/01 04:13:15 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f111fdd60ce9da749_d20251001_m041254_c001_v0001098_t0035_u01759291974032") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f4059676cc17ffc1e_d20251001_m041244_c001_v7007000_t0000_u01759291964890") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f102c6c698a3d305f_d20251001_m041243_c001_v0001171_t0040_u01759291963347") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119a381a9d1b7383_d20251001_m041240_c001_v0001040_t0047_u01759291960971") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf22_d20251001_m041215_c001_v7007000_t0000_u01759291935531") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f113b2d775b49cd3c_d20251001_m041214_c001_v0001172_t0026_u01759291934268") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f112ec2e3b69ec1b8_d20251001_m041211_c001_v0001101_t0023_u01759291931967") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40838f7c6d67cf13_d20251001_m041203_c001_v7007000_t0000_u01759291923465") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f115b5d4b3bc5892b_d20251001_m041202_c001_v0001092_t0015_u01759291922034") 2025/10/01 04:13:16 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d088_d20251001_m041159_c001_v0001042_t0058_u01759291919757") 2025/10/01 04:13:16 INFO : B2 bucket rclone-test-cowezic8wopo path 041147de/resync/path2: cleaning bucket "rclone-test-cowezic8wopo" of all files 2025/10/01 04:13:17 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e143_d20251001_m041304_c001_v7007000_t0000_u01759291984164") 2025/10/01 04:13:17 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f105d196e43420417_d20251001_m041220_c001_v0001144_t0037_u01759291940611") 2025/10/01 04:13:17 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d2_d20251001_m041210_c001_v7007000_t0000_u01759291930146") 2025/10/01 04:13:17 DEBUG : RCLONE_TEST: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f113fa9714d2cf9a3_d20251001_m041157_c001_v0001038_t0012_u01759291917187") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e144_d20251001_m041304_c001_v7007000_t0000_u01759291984348") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1038afd6af6f2bc8_d20251001_m041252_c001_v0001157_t0012_u01759291972760") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f406aa5ac2214ae3b_d20251001_m041222_c001_v7007000_t0000_u01759291942969") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f108f5e6bbe790595_d20251001_m041220_c001_v0001176_t0056_u01759291940993") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d3_d20251001_m041210_c001_v7007000_t0000_u01759291930327") 2025/10/01 04:13:17 DEBUG : file1.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d080_d20251001_m041156_c001_v0001042_t0000_u01759291916610") 2025/10/01 04:13:17 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e145_d20251001_m041304_c001_v7007000_t0000_u01759291984535") 2025/10/01 04:13:17 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10120a20eed2938a_d20251001_m041220_c001_v0001184_t0056_u01759291940984") 2025/10/01 04:13:17 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d4_d20251001_m041210_c001_v7007000_t0000_u01759291930509") 2025/10/01 04:13:17 DEBUG : file2.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119c269027a5002c_d20251001_m041156_c001_v0001171_t0046_u01759291916781") 2025/10/01 04:13:17 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e147_d20251001_m041304_c001_v7007000_t0000_u01759291984715") 2025/10/01 04:13:17 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f106ec0f9c673b628_d20251001_m041253_c001_v0001183_t0015_u01759291973029") 2025/10/01 04:13:17 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f114f06a0b2f0f8ba_d20251001_m041227_c001_v0001104_t0036_u01759291947627") 2025/10/01 04:13:17 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f109c509728be3e3e_d20251001_m041220_c001_v0001184_t0001_u01759291940997") 2025/10/01 04:13:17 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d6_d20251001_m041210_c001_v7007000_t0000_u01759291930691") 2025/10/01 04:13:18 DEBUG : file3.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f116bf52739a129bb_d20251001_m041156_c001_v0001040_t0055_u01759291916987") 2025/10/01 04:13:18 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e148_d20251001_m041304_c001_v7007000_t0000_u01759291984897") 2025/10/01 04:13:18 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119a381a9d1b7341_d20251001_m041231_c001_v0001040_t0034_u01759291951113") 2025/10/01 04:13:18 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10609b5a850fd8d6_d20251001_m041221_c001_v0001171_t0032_u01759291941206") 2025/10/01 04:13:18 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d8_d20251001_m041210_c001_v7007000_t0000_u01759291930873") 2025/10/01 04:13:18 DEBUG : file4.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d082_d20251001_m041157_c001_v0001042_t0047_u01759291917117") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e149_d20251001_m041305_c001_v7007000_t0000_u01759291985078") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10837e61d647015b_d20251001_m041253_c001_v0001105_t0046_u01759291973034") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1162cbaa5c29daad_d20251001_m041234_c001_v0001102_t0015_u01759291954169") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10322fe6aa060132_d20251001_m041221_c001_v0001113_t0011_u01759291941223") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50d9_d20251001_m041211_c001_v7007000_t0000_u01759291931056") 2025/10/01 04:13:18 DEBUG : file5.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119c269027a50030_d20251001_m041157_c001_v0001171_t0003_u01759291917127") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e14a_d20251001_m041305_c001_v7007000_t0000_u01759291985262") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f106e328558a475c8_d20251001_m041253_c001_v0001099_t0027_u01759291973270") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10846b7ae18f50d9_d20251001_m041240_c001_v0001183_t0030_u01759291960390") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f118f470424718f07_d20251001_m041221_c001_v0001099_t0000_u01759291941227") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50da_d20251001_m041211_c001_v7007000_t0000_u01759291931237") 2025/10/01 04:13:18 DEBUG : file6.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f116bf52739a129bf_d20251001_m041157_c001_v0001040_t0024_u01759291917420") 2025/10/01 04:13:18 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e14b_d20251001_m041305_c001_v7007000_t0000_u01759291985445") 2025/10/01 04:13:18 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f104394d703b9ee41_d20251001_m041221_c001_v0001182_t0011_u01759291941252") 2025/10/01 04:13:19 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50db_d20251001_m041211_c001_v7007000_t0000_u01759291931420") 2025/10/01 04:13:19 DEBUG : file7.txt: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119c269027a50036_d20251001_m041157_c001_v0001171_t0011_u01759291917444") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f4095ea60f374f5d1_d20251001_m041313_c001_v7007000_t0000_u01759291993654") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119360e46d1811eb_d20251001_m041312_c001_v0001134_t0024_u01759291992346") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f113fa9714d2cfa4a_d20251001_m041309_c001_v0001038_t0058_u01759291989830") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f407bccd38723e141_d20251001_m041303_c001_v7007000_t0000_u01759291983592") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f116aeb37281891f0_d20251001_m041301_c001_v0001104_t0046_u01759291981940") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f116bf52739a12a4b_d20251001_m041257_c001_v0001040_t0059_u01759291977910") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f403c2324b25f1789_d20251001_m041251_c001_v7007000_t0000_u01759291971017") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f10846b7ae18f5154_d20251001_m041249_c001_v0001183_t0021_u01759291969797") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f11757f88bcd0d11d_d20251001_m041245_c001_v0001042_t0032_u01759291965464") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f418913363c6ab938_d20251001_m041219_c001_v7007000_t0000_u01759291939981") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f112a3a00e4fa640d_d20251001_m041218_c001_v0001106_t0047_u01759291938440") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f119c269027a5013a_d20251001_m041216_c001_v0001171_t0030_u01759291936099") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f40170caf826e50cf_d20251001_m041207_c001_v7007000_t0000_u01759291927815") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f1136b01085ae4460_d20251001_m041206_c001_v0001180_t0024_u01759291926522") 2025/10/01 04:13:19 DEBUG : modtime_write_test: Deleting (id "4_zffd22d23f08d9bdb9f980e1b_f113fa9714d2cf9b8_d20251001_m041204_c001_v0001038_t0042_u01759291924023") bisync_test.go:608: TEST resync PASSED 2025/10/01 04:13:20 DEBUG : B2 bucket rclone-test-cowezic8wopo: Purge remote 2025/10/01 04:13:20 INFO : B2 bucket rclone-test-cowezic8wopo: cleaning bucket "rclone-test-cowezic8wopo" of all files --- PASS: TestBisyncRemoteRemote (94.72s) --- PASS: TestBisyncRemoteRemote/resync (92.90s) PASS 2025/10/01 04:13:21 DEBUG : B2 bucket rclone-test-yuxucem4cezo: Purge remote 2025/10/01 04:13:21 INFO : B2 bucket rclone-test-yuxucem4cezo: cleaning bucket "rclone-test-yuxucem4cezo" of all files 2025/10/01 04:13:22 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^resync$'" - Finished OK in 1m36.415129496s (try 3/5)