"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^resync$'" - Starting (try 3/5) 2025/10/14 05:38:02 DEBUG : Creating backend with remote "TestB2:rclone-test-diholon7ciqa" 2025/10/14 05:38:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/14 05:38:02 DEBUG : Creating backend with remote "/tmp/rclone939139513" === RUN TestBisyncRemoteRemote 2025/10/14 05:38:02 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa" 2025/10/14 05:38:03 NOTICE: remote: TestB2:rclone-test-seqegak4yipa === RUN TestBisyncRemoteRemote/resync 2025/10/14 05:38:03 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re" 2025/10/14 05:38:04 INFO : path1: Making directory 2025/10/14 05:38:05 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1" 2025/10/14 05:38:06 INFO : path2: Making directory 2025/10/14 05:38:06 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2" 2025/10/14 05:38:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2025/10/14 05:38:07 DEBUG : Creating backend with remote "/tmp/053803re/initdir/test_resync-rupubuc7" 2025/10/14 05:38:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : Local file system at /tmp/053803re/initdir/test_resync-rupubuc7: Waiting for checks to finish 2025/10/14 05:38:07 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/10/14 05:38:07 INFO : file3.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/10/14 05:38:07 INFO : file2.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : Local file system at /tmp/053803re/initdir/test_resync-rupubuc7: Waiting for transfers to finish 2025/10/14 05:38:07 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/10/14 05:38:07 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 INFO : file1.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/10/14 05:38:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/10/14 05:38:07 INFO : file4.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/10/14 05:38:07 INFO : RCLONE_TEST: Copied (new) 2025/10/14 05:38:07 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/10/14 05:38:07 INFO : file5.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/10/14 05:38:07 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/10/14 05:38:07 INFO : file6.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/10/14 05:38:07 INFO : file7.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2025/10/14 05:38:07 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5" 2025/10/14 05:38:07 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:07 DEBUG : Local file system at /tmp/053803re/datadir/test_resync-zehageg5: Waiting for checks to finish 2025/10/14 05:38:07 DEBUG : Local file system at /tmp/053803re/datadir/test_resync-zehageg5: Waiting for transfers to finish 2025/10/14 05:38:07 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/14 05:38:07 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/10/14 05:38:07 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2025/10/14 05:38:07 INFO : fileA.txt: Copied (new) 2025/10/14 05:38:07 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2025/10/14 05:38:07 INFO : fileB.txt: Copied (new) 2025/10/14 05:38:07 INFO : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: cleaning bucket "rclone-test-seqegak4yipa" of all files 2025/10/14 05:38:08 INFO : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: cleaning bucket "rclone-test-seqegak4yipa" of all files 2025/10/14 05:38:09 NOTICE: checking initFs Local file system at /tmp/053803re/initdir/test_resync-rupubuc7 2025/10/14 05:38:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:09 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Waiting for checks to finish 2025/10/14 05:38:09 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Waiting for transfers to finish 2025/10/14 05:38:10 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file2.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file1.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file4.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file5.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file6.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:10 INFO : file7.txt: Copied (new) 2025/10/14 05:38:10 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/14 05:38:10 INFO : RCLONE_TEST: Copied (new) 2025/10/14 05:38:11 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:11 INFO : file3.txt: Copied (new) 2025/10/14 05:38:11 NOTICE: checking Path1 B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1 2025/10/14 05:38:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/10/14 05:38:11 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Waiting for checks to finish 2025/10/14 05:38:11 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Waiting for transfers to finish 2025/10/14 05:38:12 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file1.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file2.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file5.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file4.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file3.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file6.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/10/14 05:38:12 INFO : file7.txt: Copied (new) 2025/10/14 05:38:12 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/10/14 05:38:12 INFO : RCLONE_TEST: Copied (new) 2025/10/14 05:38:12 NOTICE: checking path2 B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2 2025/10/14 05:38:13 NOTICE: (01) : test resync 2025/10/14 05:38:13 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/10/14 05:38:13 NOTICE: (03) : purge-children TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/ 2025/10/14 05:38:13 DEBUG : RCLONE_TEST: Remove file 2025/10/14 05:38:13 DEBUG : file1.txt: Remove file 2025/10/14 05:38:13 DEBUG : file2.txt: Remove file 2025/10/14 05:38:13 DEBUG : file3.txt: Remove file 2025/10/14 05:38:14 DEBUG : file4.txt: Remove file 2025/10/14 05:38:14 DEBUG : file5.txt: Remove file 2025/10/14 05:38:14 DEBUG : file6.txt: Remove file 2025/10/14 05:38:14 DEBUG : file7.txt: Remove file 2025/10/14 05:38:14 NOTICE: (04) : bisync resync 2025/10/14 05:38:22 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:38:22 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:38:22 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/14 05:38:22 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/14 05:38:22 INFO : Synching Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" with Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:22 INFO : Copying Path2 files to Path1 2025/10/14 05:38:22 INFO : - Path2 Resync is copying files to - Path1 2025/10/14 05:38:22 INFO : RCLONE_TEST: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file3.txt: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file2.txt: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file1.txt: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file5.txt: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file4.txt: Copied (server-side copy) 2025/10/14 05:38:23 INFO : file6.txt: Copied (server-side copy) 2025/10/14 05:38:24 INFO : file7.txt: Copied (server-side copy) 2025/10/14 05:38:24 INFO : - Path1 Resync is copying files to - Path2 2025/10/14 05:38:24 INFO : Resync updating listings 2025/10/14 05:38:24 INFO : Validating listings for Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" vs Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:24 INFO : Bisync successful 2025/10/14 05:38:24 NOTICE: (05) : move-listings empty-path1 2025/10/14 05:38:24 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/10/14 05:38:24 NOTICE: (07) : purge-children TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ 2025/10/14 05:38:24 DEBUG : RCLONE_TEST: Remove file 2025/10/14 05:38:24 DEBUG : file1.txt: Remove file 2025/10/14 05:38:24 DEBUG : file2.txt: Remove file 2025/10/14 05:38:25 DEBUG : file3.txt: Remove file 2025/10/14 05:38:25 DEBUG : file4.txt: Remove file 2025/10/14 05:38:25 DEBUG : file5.txt: Remove file 2025/10/14 05:38:25 DEBUG : file6.txt: Remove file 2025/10/14 05:38:25 DEBUG : file7.txt: Remove file 2025/10/14 05:38:25 NOTICE: (08) : bisync resync 2025/10/14 05:38:33 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:38:33 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:38:33 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/14 05:38:33 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/14 05:38:33 INFO : Synching Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" with Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:33 INFO : Copying Path2 files to Path1 2025/10/14 05:38:33 INFO : - Path2 Resync is copying files to - Path1 2025/10/14 05:38:33 INFO : There was nothing to transfer 2025/10/14 05:38:33 INFO : - Path1 Resync is copying files to - Path2 2025/10/14 05:38:34 INFO : RCLONE_TEST: Copied (server-side copy) 2025/10/14 05:38:34 INFO : file3.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file4.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file2.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file1.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file5.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file6.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : file7.txt: Copied (server-side copy) 2025/10/14 05:38:35 INFO : Resync updating listings 2025/10/14 05:38:35 INFO : Validating listings for Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" vs Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:35 INFO : Bisync successful 2025/10/14 05:38:35 NOTICE: (09) : move-listings empty-path2 2025/10/14 05:38:35 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/10/14 05:38:35 NOTICE: (11) : touch-glob 2002-02-02 /tmp/053803re/datadir/test_resync-zehageg5/ fileA.txt 2025/10/14 05:38:35 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/" 2025/10/14 05:38:35 DEBUG : fs cache: renaming cache item "/tmp/053803re/datadir/test_resync-zehageg5/" to be canonical "/tmp/053803re/datadir/test_resync-zehageg5" 2025/10/14 05:38:35 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/10/14 05:38:35 NOTICE: (12) : touch-glob 1999-09-09 /tmp/053803re/datadir/test_resync-zehageg5/ fileB.txt 2025/10/14 05:38:35 DEBUG : fs cache: switching user supplied name "/tmp/053803re/datadir/test_resync-zehageg5/" for canonical name "/tmp/053803re/datadir/test_resync-zehageg5" 2025/10/14 05:38:35 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/10/14 05:38:35 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/10/14 05:38:35 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/10/14 05:38:35 NOTICE: (15) : delete-file TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/file1.txt 2025/10/14 05:38:35 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:36 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" to be canonical "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2" 2025/10/14 05:38:36 INFO : file1.txt: Deleted 2025/10/14 05:38:36 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/10/14 05:38:36 NOTICE: (17) : delete-file TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/file2.txt 2025/10/14 05:38:36 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" 2025/10/14 05:38:38 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" to be canonical "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1" 2025/10/14 05:38:38 INFO : file2.txt: Deleted 2025/10/14 05:38:38 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/10/14 05:38:38 NOTICE: (19) : copy-as /tmp/053803re/datadir/test_resync-zehageg5/fileA.txt TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ file3.txt 2025/10/14 05:38:38 DEBUG : copyFile "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" to "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" as "file3.txt" 2025/10/14 05:38:38 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" 2025/10/14 05:38:38 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:39 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2" as "file3.txt" 2025/10/14 05:38:40 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/14 05:38:41 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/14 05:38:41 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/10/14 05:38:41 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/10/14 05:38:41 NOTICE: (21) : delete-file TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/file4.txt 2025/10/14 05:38:41 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" for canonical name "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1" 2025/10/14 05:38:42 INFO : file4.txt: Deleted 2025/10/14 05:38:42 NOTICE: (22) : copy-as /tmp/053803re/datadir/test_resync-zehageg5/fileA.txt TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ file4.txt 2025/10/14 05:38:42 DEBUG : copyFile "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" to "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" as "file4.txt" 2025/10/14 05:38:42 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" 2025/10/14 05:38:42 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:43 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2" as "file4.txt" 2025/10/14 05:38:43 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/14 05:38:45 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/14 05:38:45 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/10/14 05:38:45 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/10/14 05:38:45 NOTICE: (24) : copy-as /tmp/053803re/datadir/test_resync-zehageg5/fileB.txt TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ file5.txt 2025/10/14 05:38:45 DEBUG : copyFile "/tmp/053803re/datadir/test_resync-zehageg5/fileB.txt" to "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" as "file5.txt" 2025/10/14 05:38:45 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/fileB.txt" 2025/10/14 05:38:45 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:46 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2" as "file5.txt" 2025/10/14 05:38:46 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/10/14 05:38:48 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/14 05:38:48 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/10/14 05:38:48 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/10/14 05:38:48 NOTICE: (26) : copy-as /tmp/053803re/datadir/test_resync-zehageg5/fileB.txt TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/ file6.txt 2025/10/14 05:38:48 DEBUG : copyFile "/tmp/053803re/datadir/test_resync-zehageg5/fileB.txt" to "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" as "file6.txt" 2025/10/14 05:38:48 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/fileB.txt" 2025/10/14 05:38:48 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" 2025/10/14 05:38:50 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1" as "file6.txt" 2025/10/14 05:38:50 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/10/14 05:38:51 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/14 05:38:51 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/10/14 05:38:51 NOTICE: (27) : copy-as /tmp/053803re/datadir/test_resync-zehageg5/fileA.txt TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ file6.txt 2025/10/14 05:38:51 DEBUG : copyFile "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" to "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" as "file6.txt" 2025/10/14 05:38:51 DEBUG : Creating backend with remote "/tmp/053803re/datadir/test_resync-zehageg5/fileA.txt" 2025/10/14 05:38:51 DEBUG : Creating backend with remote "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:38:53 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2" as "file6.txt" 2025/10/14 05:38:53 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/10/14 05:38:54 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/10/14 05:38:54 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/10/14 05:38:54 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/10/14 05:38:54 NOTICE: (29) : test run bisync with resync 2025/10/14 05:38:54 NOTICE: (30) : bisync resync 2025/10/14 05:39:02 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:02 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:02 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/14 05:39:02 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/14 05:39:02 INFO : Synching Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" with Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:39:02 INFO : Copying Path2 files to Path1 2025/10/14 05:39:02 INFO : - Path2 Resync is copying files to - Path1 2025/10/14 05:39:03 INFO : file4.txt: Copied (server-side copy) 2025/10/14 05:39:04 INFO : file2.txt: Copied (server-side copy) 2025/10/14 05:39:04 INFO : - Path1 Resync is copying files to - Path2 2025/10/14 05:39:04 INFO : file1.txt: Copied (server-side copy) 2025/10/14 05:39:04 INFO : file5.txt: Copied (server-side copy) 2025/10/14 05:39:05 INFO : file3.txt: Copied (server-side copy) 2025/10/14 05:39:07 INFO : file6.txt: Updated modification time in destination 2025/10/14 05:39:07 INFO : Resync updating listings 2025/10/14 05:39:07 INFO : Validating listings for Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" vs Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:39:07 INFO : Bisync successful 2025/10/14 05:39:07 NOTICE: (31) : copy-listings mixed-diffs 2025/10/14 05:39:07 NOTICE: (32) : test run normal bisync 2025/10/14 05:39:07 NOTICE: (33) : bisync 2025/10/14 05:39:15 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:15 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:15 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/14 05:39:15 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/14 05:39:15 INFO : Synching Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" with Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:39:15 INFO : Building Path1 and Path2 listings 2025/10/14 05:39:15 INFO : Path1 checking for diffs 2025/10/14 05:39:15 INFO : Path2 checking for diffs 2025/10/14 05:39:15 INFO : No changes found 2025/10/14 05:39:15 INFO : Updating listings 2025/10/14 05:39:15 INFO : Validating listings for Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" vs Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:39:15 INFO : Bisync successful 2025/10/14 05:39:15 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/10/14 05:39:15 NOTICE: (35) : purge-children TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/ 2025/10/14 05:39:15 DEBUG : RCLONE_TEST: Remove file 2025/10/14 05:39:15 DEBUG : file1.txt: Remove file 2025/10/14 05:39:16 DEBUG : file2.txt: Remove file 2025/10/14 05:39:16 DEBUG : file3.txt: Remove file 2025/10/14 05:39:16 DEBUG : file4.txt: Remove file 2025/10/14 05:39:16 DEBUG : file5.txt: Remove file 2025/10/14 05:39:16 DEBUG : file6.txt: Remove file 2025/10/14 05:39:16 DEBUG : file7.txt: Remove file 2025/10/14 05:39:17 NOTICE: (36) : bisync 2025/10/14 05:39:25 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:25 DEBUG : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/10/14 05:39:25 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/10/14 05:39:25 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/14 05:39:25 INFO : Synching Path1 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path1/" with Path2 "TestB2:rclone-test-seqegak4yipa/053803re/resync/path2/" 2025/10/14 05:39:25 INFO : Building Path1 and Path2 listings 2025/10/14 05:39:25 INFO : Path1 checking for diffs 2025/10/14 05:39:25 INFO : Path2 checking for diffs 2025/10/14 05:39:25 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/053803re/workdir/TestB2_rclone-test-seqegak4yipa_053803re_resync_path1..TestB2_rclone-test-seqegak4yipa_053803re_resync_path2.path2.lst-new 2025/10/14 05:39:25 ERROR : Bisync critical error: empty current Path2 listing: /tmp/053803re/workdir/TestB2_rclone-test-seqegak4yipa_053803re_resync_path1..TestB2_rclone-test-seqegak4yipa_053803re_resync_path2.path2.lst-new 2025/10/14 05:39:25 ERROR : Bisync aborted. Must run --resync to recover. 2025/10/14 05:39:25 NOTICE: Bisync error: bisync aborted 2025/10/14 05:39:25 INFO : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path1: cleaning bucket "rclone-test-seqegak4yipa" of all files 2025/10/14 05:39:26 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f119deb639215d802_d20251014_m053822_c001_v0001181_t0038_u01760420302649") 2025/10/14 05:39:26 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbe9_d20251014_m053813_c001_v7007000_t0000_u01760420293368") 2025/10/14 05:39:26 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1174fdb1c31ebef1_d20251014_m053810_c001_v0001036_t0022_u01760420290691") 2025/10/14 05:39:26 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f10329c836837357f_d20251014_m053822_c001_v0001130_t0032_u01760420302914") 2025/10/14 05:39:26 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbea_d20251014_m053813_c001_v7007000_t0000_u01760420293556") 2025/10/14 05:39:26 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11976588759d43f7_d20251014_m053810_c001_v0001177_t0058_u01760420290308") 2025/10/14 05:39:26 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1096b85f085336f1_d20251014_m053903_c001_v0001117_t0017_u01760420343290") 2025/10/14 05:39:26 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cc37_d20251014_m053838_c001_v7007000_t0000_u01760420318715") 2025/10/14 05:39:26 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1143a8f6660fac9d_d20251014_m053823_c001_v0001102_t0028_u01760420303019") 2025/10/14 05:39:26 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbec_d20251014_m053813_c001_v7007000_t0000_u01760420293740") 2025/10/14 05:39:26 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103925195ee96c6b_d20251014_m053810_c001_v0001180_t0042_u01760420290127") 2025/10/14 05:39:26 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f104504f9c84eeba6_d20251014_m053823_c001_v0001150_t0024_u01760420303022") 2025/10/14 05:39:26 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbed_d20251014_m053813_c001_v7007000_t0000_u01760420293922") 2025/10/14 05:39:26 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f116a20bf7854c5e5_d20251014_m053810_c001_v0001117_t0042_u01760420290502") 2025/10/14 05:39:26 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f106b2b5a64e373cb_d20251014_m053903_c001_v0001165_t0048_u01760420343679") 2025/10/14 05:39:26 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cc44_d20251014_m053842_c001_v7007000_t0000_u01760420322148") 2025/10/14 05:39:26 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f118112ae2bf7e691_d20251014_m053823_c001_v0001038_t0036_u01760420303038") 2025/10/14 05:39:26 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbee_d20251014_m053814_c001_v7007000_t0000_u01760420294106") 2025/10/14 05:39:26 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103925195ee96c71_d20251014_m053810_c001_v0001180_t0037_u01760420290382") 2025/10/14 05:39:27 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f112fb623eabaf0ad_d20251014_m053823_c001_v0001130_t0023_u01760420303338") 2025/10/14 05:39:27 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbf0_d20251014_m053814_c001_v7007000_t0000_u01760420294288") 2025/10/14 05:39:27 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11976588759d43f9_d20251014_m053810_c001_v0001177_t0005_u01760420290513") 2025/10/14 05:39:27 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f112e5529116b2a7a_d20251014_m053851_c001_v0001136_t0028_u01760420331592") 2025/10/14 05:39:27 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103e620e323ce022_d20251014_m053823_c001_v0001098_t0008_u01760420303545") 2025/10/14 05:39:27 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbf1_d20251014_m053814_c001_v7007000_t0000_u01760420294469") 2025/10/14 05:39:27 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103925195ee96c75_d20251014_m053810_c001_v0001180_t0027_u01760420290602") 2025/10/14 05:39:27 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f117f4035cdfd4f46_d20251014_m053823_c001_v0001104_t0033_u01760420303648") 2025/10/14 05:39:27 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbf2_d20251014_m053814_c001_v7007000_t0000_u01760420294656") 2025/10/14 05:39:27 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11976588759d43ff_d20251014_m053810_c001_v0001177_t0021_u01760420290739") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f40290cfc92869b95_d20251014_m053920_c001_v7007000_t0000_u01760420360760") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1141bea1fef078a6_d20251014_m053919_c001_v0001146_t0048_u01760420359408") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103925195ee96e76_d20251014_m053917_c001_v0001180_t0035_u01760420357639") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f40290cfc92869b85_d20251014_m053911_c001_v7007000_t0000_u01760420351565") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f111120222a6b5271_d20251014_m053910_c001_v0001183_t0036_u01760420350315") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f116a20bf7854c6cf_d20251014_m053907_c001_v0001117_t0042_u01760420347596") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f40917ca080c95352_d20251014_m053858_c001_v7007000_t0000_u01760420338560") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f119a2b46b7255d18_d20251014_m053857_c001_v0001178_t0025_u01760420337339") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1174fdb1c31ebf65_d20251014_m053855_c001_v0001036_t0021_u01760420335373") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cc10_d20251014_m053829_c001_v7007000_t0000_u01760420309594") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f104e2ead984ee9d5_d20251014_m053828_c001_v0001092_t0058_u01760420308255") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11976588759d445f_d20251014_m053826_c001_v0001177_t0006_u01760420306430") 2025/10/14 05:39:27 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cbfa_d20251014_m053817_c001_v7007000_t0000_u01760420297856") 2025/10/14 05:39:28 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f104d6c695fbc685d_d20251014_m053816_c001_v0001181_t0059_u01760420296646") 2025/10/14 05:39:28 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103925195ee96c93_d20251014_m053814_c001_v0001180_t0034_u01760420294840") 2025/10/14 05:39:28 INFO : B2 bucket rclone-test-seqegak4yipa path 053803re/resync/path2: cleaning bucket "rclone-test-seqegak4yipa" of all files 2025/10/14 05:39:28 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3611_d20251014_m053915_c001_v7007000_t0000_u01760420355795") 2025/10/14 05:39:28 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f113a557ff56dea75_d20251014_m053834_c001_v0001181_t0024_u01760420314244") 2025/10/14 05:39:28 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684450_d20251014_m053824_c001_v7007000_t0000_u01760420304592") 2025/10/14 05:39:28 DEBUG : RCLONE_TEST: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f104fac5af2383c13_d20251014_m053812_c001_v0001102_t0039_u01760420292616") 2025/10/14 05:39:28 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3612_d20251014_m053915_c001_v7007000_t0000_u01760420355980") 2025/10/14 05:39:28 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f10987d0b179b7bdf_d20251014_m053904_c001_v0001150_t0040_u01760420344442") 2025/10/14 05:39:28 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f40290cfc92869b57_d20251014_m053836_c001_v7007000_t0000_u01760420316888") 2025/10/14 05:39:28 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11551165e9dd3766_d20251014_m053834_c001_v0001104_t0052_u01760420314485") 2025/10/14 05:39:28 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684452_d20251014_m053824_c001_v7007000_t0000_u01760420304775") 2025/10/14 05:39:29 DEBUG : file1.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1181c145634d00ce_d20251014_m053812_c001_v0001100_t0001_u01760420292057") 2025/10/14 05:39:29 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3613_d20251014_m053916_c001_v7007000_t0000_u01760420356163") 2025/10/14 05:39:29 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f10232f3233740735_d20251014_m053834_c001_v0001043_t0030_u01760420314620") 2025/10/14 05:39:29 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684455_d20251014_m053824_c001_v7007000_t0000_u01760420304957") 2025/10/14 05:39:29 DEBUG : file2.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11057c18e7993bb9_d20251014_m053812_c001_v0001181_t0026_u01760420292232") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3614_d20251014_m053916_c001_v7007000_t0000_u01760420356345") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1085ab288c1576b3_d20251014_m053904_c001_v0001154_t0000_u01760420344837") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f112c577fad36d843_d20251014_m053841_c001_v0001105_t0030_u01760420321512") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f101fb5bf2200f44b_d20251014_m053834_c001_v0001183_t0042_u01760420314630") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684459_d20251014_m053825_c001_v7007000_t0000_u01760420305140") 2025/10/14 05:39:29 DEBUG : file3.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1059249a31c4b2a9_d20251014_m053812_c001_v0001043_t0057_u01760420292427") 2025/10/14 05:39:29 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3615_d20251014_m053916_c001_v7007000_t0000_u01760420356529") 2025/10/14 05:39:29 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f101c92a263cd3821_d20251014_m053844_c001_v0001157_t0022_u01760420324905") 2025/10/14 05:39:29 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f118b2bffaa50f441_d20251014_m053834_c001_v0001104_t0022_u01760420314634") 2025/10/14 05:39:30 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a68445c_d20251014_m053825_c001_v7007000_t0000_u01760420305322") 2025/10/14 05:39:30 DEBUG : file4.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1181c145634d00d0_d20251014_m053812_c001_v0001100_t0049_u01760420292380") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3616_d20251014_m053916_c001_v7007000_t0000_u01760420356712") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f10242ba400848025_d20251014_m053904_c001_v0001183_t0009_u01760420344847") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1077433f8c0a3da0_d20251014_m053847_c001_v0001044_t0037_u01760420327968") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103cc91a817bf3c4_d20251014_m053834_c001_v0001036_t0030_u01760420314854") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a68445e_d20251014_m053825_c001_v7007000_t0000_u01760420305507") 2025/10/14 05:39:30 DEBUG : file5.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11057c18e7993bbb_d20251014_m053812_c001_v0001181_t0025_u01760420292440") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3617_d20251014_m053916_c001_v7007000_t0000_u01760420356896") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f108641f2597cc907_d20251014_m053906_c001_v0001137_t0052_u01760420346919") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1137207e7ad4da01_d20251014_m053854_c001_v0001038_t0016_u01760420334572") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11233bbfb485164f_d20251014_m053835_c001_v0001146_t0010_u01760420315181") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684461_d20251014_m053825_c001_v7007000_t0000_u01760420305691") 2025/10/14 05:39:30 DEBUG : file6.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11057c18e7993bbd_d20251014_m053812_c001_v0001181_t0023_u01760420292646") 2025/10/14 05:39:30 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3618_d20251014_m053917_c001_v7007000_t0000_u01760420357078") 2025/10/14 05:39:30 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f103286ec01f55ecc_d20251014_m053835_c001_v0001038_t0025_u01760420315188") 2025/10/14 05:39:30 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684463_d20251014_m053825_c001_v7007000_t0000_u01760420305876") 2025/10/14 05:39:30 DEBUG : file7.txt: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1181c145634d00d4_d20251014_m053812_c001_v0001100_t0045_u01760420292680") 2025/10/14 05:39:30 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4165fb729366cc60_d20251014_m053925_c001_v7007000_t0000_u01760420365455") 2025/10/14 05:39:30 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1184dddcbe04560c_d20251014_m053923_c001_v0001037_t0047_u01760420363894") 2025/10/14 05:39:30 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1059249a31c4b4cd_d20251014_m053921_c001_v0001043_t0015_u01760420361307") 2025/10/14 05:39:30 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f4103909a693a3610_d20251014_m053915_c001_v7007000_t0000_u01760420355238") 2025/10/14 05:39:30 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1079b12a6055ef19_d20251014_m053914_c001_v0001182_t0055_u01760420354023") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f104fac5af2383d9b_d20251014_m053912_c001_v0001102_t0015_u01760420352115") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f406528ccdacbbcb4_d20251014_m053902_c001_v7007000_t0000_u01760420342899") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f107fb64657cacbc4_d20251014_m053901_c001_v0001144_t0038_u01760420341075") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1181c145634d01da_d20251014_m053859_c001_v0001100_t0043_u01760420339103") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f409a344462b24400_d20251014_m053833_c001_v7007000_t0000_u01760420313631") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f114fddbc87acba6f_d20251014_m053832_c001_v0001171_t0002_u01760420312287") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f11057c18e7993c31_d20251014_m053830_c001_v0001181_t0048_u01760420310138") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f418b4b763a684440_d20251014_m053822_c001_v7007000_t0000_u01760420302253") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1042387fc08cbf81_d20251014_m053820_c001_v0001105_t0041_u01760420300777") 2025/10/14 05:39:31 DEBUG : modtime_write_test: Deleting (id "4_z0f72cda3309deb1b9f980e1b_f1059249a31c4b2d4_d20251014_m053818_c001_v0001043_t0015_u01760420298394") bisync_test.go:608: TEST resync PASSED 2025/10/14 05:39:31 DEBUG : B2 bucket rclone-test-seqegak4yipa: Purge remote 2025/10/14 05:39:31 INFO : B2 bucket rclone-test-seqegak4yipa: cleaning bucket "rclone-test-seqegak4yipa" of all files --- PASS: TestBisyncRemoteRemote (90.25s) --- PASS: TestBisyncRemoteRemote/resync (88.54s) PASS 2025/10/14 05:39:33 DEBUG : B2 bucket rclone-test-diholon7ciqa: Purge remote 2025/10/14 05:39:33 INFO : B2 bucket rclone-test-diholon7ciqa: cleaning bucket "rclone-test-diholon7ciqa" of all files 2025/10/14 05:39:33 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 1m31.59708515s (try 3/5)