"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^resync$'" - Starting (try 3/5) 2026/04/27 05:18:29 DEBUG : Creating backend with remote "TestB2:rclone-test-wulizis6gawa" 2026/04/27 05:18:29 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/04/27 05:18:29 DEBUG : Creating backend with remote "/tmp/rclone3517622417" === RUN TestBisyncRemoteRemote 2026/04/27 05:18:29 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine" 2026/04/27 05:18:30 NOTICE: remote: TestB2:rclone-test-vepalor0dine === RUN TestBisyncRemoteRemote/resync 2026/04/27 05:18:30 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5" 2026/04/27 05:18:31 INFO : path1: Making directory 2026/04/27 05:18:32 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1" 2026/04/27 05:18:33 INFO : path2: Making directory 2026/04/27 05:18:33 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2" 2026/04/27 05:18:34 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2026/04/27 05:18:34 DEBUG : Creating backend with remote "/tmp/051830decehas5/initdir/test_resync-dopudab5" 2026/04/27 05:18:34 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/04/27 05:18:34 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/04/27 05:18:34 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/04/27 05:18:34 INFO : file2.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/04/27 05:18:34 INFO : RCLONE_TEST: Copied (new) 2026/04/27 05:18:34 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : Local file system at /tmp/051830decehas5/initdir/test_resync-dopudab5: Waiting for checks to finish 2026/04/27 05:18:34 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/04/27 05:18:34 INFO : file1.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : Local file system at /tmp/051830decehas5/initdir/test_resync-dopudab5: Waiting for transfers to finish 2026/04/27 05:18:34 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/04/27 05:18:34 INFO : file4.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/04/27 05:18:34 INFO : file5.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/04/27 05:18:34 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/04/27 05:18:34 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/04/27 05:18:34 INFO : file3.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/04/27 05:18:34 INFO : file6.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/04/27 05:18:34 INFO : file7.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2026/04/27 05:18:34 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8" 2026/04/27 05:18:34 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:34 DEBUG : Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8: Waiting for checks to finish 2026/04/27 05:18:34 DEBUG : Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8: Waiting for transfers to finish 2026/04/27 05:18:34 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK 2026/04/27 05:18:34 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK 2026/04/27 05:18:34 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/04/27 05:18:34 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/04/27 05:18:34 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2026/04/27 05:18:34 INFO : fileB.txt: Copied (new) 2026/04/27 05:18:34 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2026/04/27 05:18:34 INFO : fileA.txt: Copied (new) 2026/04/27 05:18:34 INFO : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: cleaning bucket "rclone-test-vepalor0dine" of all files 2026/04/27 05:18:35 INFO : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: cleaning bucket "rclone-test-vepalor0dine" of all files 2026/04/27 05:18:36 NOTICE: checking initFs Local file system at /tmp/051830decehas5/initdir/test_resync-dopudab5 2026/04/27 05:18:36 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:36 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Waiting for checks to finish 2026/04/27 05:18:36 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Waiting for transfers to finish 2026/04/27 05:18:37 DEBUG : RCLONE_TEST: size = 109 OK 2026/04/27 05:18:37 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2026/04/27 05:18:37 INFO : RCLONE_TEST: Copied (new) 2026/04/27 05:18:37 DEBUG : file2.txt: size = 0 OK 2026/04/27 05:18:37 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:37 INFO : file2.txt: Copied (new) 2026/04/27 05:18:37 DEBUG : file4.txt: size = 0 OK 2026/04/27 05:18:37 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:37 INFO : file4.txt: Copied (new) 2026/04/27 05:18:37 DEBUG : file3.txt: size = 0 OK 2026/04/27 05:18:37 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:37 INFO : file3.txt: Copied (new) 2026/04/27 05:18:37 DEBUG : file5.txt: size = 0 OK 2026/04/27 05:18:37 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:37 INFO : file5.txt: Copied (new) 2026/04/27 05:18:38 DEBUG : file6.txt: size = 0 OK 2026/04/27 05:18:38 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:38 INFO : file6.txt: Copied (new) 2026/04/27 05:18:38 DEBUG : file7.txt: size = 0 OK 2026/04/27 05:18:38 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:38 INFO : file7.txt: Copied (new) 2026/04/27 05:18:38 DEBUG : file1.txt: size = 0 OK 2026/04/27 05:18:38 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:38 INFO : file1.txt: Copied (new) 2026/04/27 05:18:38 NOTICE: checking Path1 B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1 2026/04/27 05:18:38 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/04/27 05:18:38 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Waiting for checks to finish 2026/04/27 05:18:38 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Waiting for transfers to finish 2026/04/27 05:18:39 DEBUG : file1.txt: size = 0 OK 2026/04/27 05:18:39 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:39 INFO : file1.txt: Copied (new) 2026/04/27 05:18:39 DEBUG : file2.txt: size = 0 OK 2026/04/27 05:18:39 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:39 INFO : file2.txt: Copied (new) 2026/04/27 05:18:40 DEBUG : RCLONE_TEST: size = 109 OK 2026/04/27 05:18:40 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2026/04/27 05:18:40 INFO : RCLONE_TEST: Copied (new) 2026/04/27 05:18:40 DEBUG : file5.txt: size = 0 OK 2026/04/27 05:18:40 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:40 INFO : file5.txt: Copied (new) 2026/04/27 05:18:40 DEBUG : file4.txt: size = 0 OK 2026/04/27 05:18:40 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:40 INFO : file4.txt: Copied (new) 2026/04/27 05:18:40 DEBUG : file3.txt: size = 0 OK 2026/04/27 05:18:40 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:40 INFO : file3.txt: Copied (new) 2026/04/27 05:18:40 DEBUG : file7.txt: size = 0 OK 2026/04/27 05:18:40 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:40 INFO : file7.txt: Copied (new) 2026/04/27 05:18:40 DEBUG : file6.txt: size = 0 OK 2026/04/27 05:18:40 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2026/04/27 05:18:40 INFO : file6.txt: Copied (new) 2026/04/27 05:18:40 NOTICE: checking path2 B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2 2026/04/27 05:18:40 NOTICE: (01) : test resync 2026/04/27 05:18:40 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2026/04/27 05:18:40 NOTICE: (03) : purge-children TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/ 2026/04/27 05:18:40 DEBUG : RCLONE_TEST: Remove file 2026/04/27 05:18:41 DEBUG : file1.txt: Remove file 2026/04/27 05:18:41 DEBUG : file2.txt: Remove file 2026/04/27 05:18:41 DEBUG : file3.txt: Remove file 2026/04/27 05:18:41 DEBUG : file4.txt: Remove file 2026/04/27 05:18:41 DEBUG : file5.txt: Remove file 2026/04/27 05:18:42 DEBUG : file6.txt: Remove file 2026/04/27 05:18:42 DEBUG : file7.txt: Remove file 2026/04/27 05:18:42 NOTICE: (04) : bisync resync 2026/04/27 05:18:50 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:18:50 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:18:50 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/04/27 05:18:50 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/04/27 05:18:50 INFO : Synching Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" with Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:18:50 INFO : Copying Path2 files to Path1 2026/04/27 05:18:50 INFO : - Path2 Resync is copying files to - Path1 2026/04/27 05:18:50 INFO : RCLONE_TEST: Copied (server-side copy) 2026/04/27 05:18:50 INFO : file2.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file1.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file4.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file6.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file3.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file5.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : file7.txt: Copied (server-side copy) 2026/04/27 05:18:51 INFO : - Path1 Resync is copying files to - Path2 2026/04/27 05:18:52 INFO : Resync updating listings 2026/04/27 05:18:52 INFO : Validating listings for Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" vs Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:18:52 INFO : Bisync successful 2026/04/27 05:18:52 NOTICE: (05) : move-listings empty-path1 2026/04/27 05:18:52 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2026/04/27 05:18:52 NOTICE: (07) : purge-children TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ 2026/04/27 05:18:52 DEBUG : RCLONE_TEST: Remove file 2026/04/27 05:18:52 DEBUG : file1.txt: Remove file 2026/04/27 05:18:52 DEBUG : file2.txt: Remove file 2026/04/27 05:18:52 DEBUG : file3.txt: Remove file 2026/04/27 05:18:52 DEBUG : file4.txt: Remove file 2026/04/27 05:18:53 DEBUG : file5.txt: Remove file 2026/04/27 05:18:53 DEBUG : file6.txt: Remove file 2026/04/27 05:18:53 DEBUG : file7.txt: Remove file 2026/04/27 05:18:53 NOTICE: (08) : bisync resync 2026/04/27 05:19:01 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:01 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:01 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/04/27 05:19:01 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/04/27 05:19:01 INFO : Synching Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" with Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:01 INFO : Copying Path2 files to Path1 2026/04/27 05:19:01 INFO : - Path2 Resync is copying files to - Path1 2026/04/27 05:19:02 INFO : There was nothing to transfer 2026/04/27 05:19:02 INFO : - Path1 Resync is copying files to - Path2 2026/04/27 05:19:02 INFO : RCLONE_TEST: Copied (server-side copy) 2026/04/27 05:19:02 INFO : file1.txt: Copied (server-side copy) 2026/04/27 05:19:02 INFO : file4.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : file2.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : file3.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : file5.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : file6.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : file7.txt: Copied (server-side copy) 2026/04/27 05:19:03 INFO : Resync updating listings 2026/04/27 05:19:03 INFO : Validating listings for Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" vs Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:03 INFO : Bisync successful 2026/04/27 05:19:03 NOTICE: (09) : move-listings empty-path2 2026/04/27 05:19:03 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2026/04/27 05:19:03 NOTICE: (11) : touch-glob 2002-02-02 /tmp/051830decehas5/datadir/test_resync-yopaceh8/ fileA.txt 2026/04/27 05:19:03 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/" 2026/04/27 05:19:03 DEBUG : fs cache: renaming cache item "/tmp/051830decehas5/datadir/test_resync-yopaceh8/" to be canonical "/tmp/051830decehas5/datadir/test_resync-yopaceh8" 2026/04/27 05:19:03 DEBUG : fileA.txt: Set modification time 2002-02-02 2026/04/27 05:19:03 NOTICE: (12) : touch-glob 1999-09-09 /tmp/051830decehas5/datadir/test_resync-yopaceh8/ fileB.txt 2026/04/27 05:19:03 DEBUG : fs cache: switching user supplied name "/tmp/051830decehas5/datadir/test_resync-yopaceh8/" for canonical name "/tmp/051830decehas5/datadir/test_resync-yopaceh8" 2026/04/27 05:19:03 DEBUG : fileB.txt: Set modification time 1999-09-09 2026/04/27 05:19:03 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2026/04/27 05:19:03 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2026/04/27 05:19:03 NOTICE: (15) : delete-file TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/file1.txt 2026/04/27 05:19:03 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:04 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" to be canonical "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2" 2026/04/27 05:19:04 INFO : file1.txt: Deleted 2026/04/27 05:19:04 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2026/04/27 05:19:04 NOTICE: (17) : delete-file TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/file2.txt 2026/04/27 05:19:04 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" 2026/04/27 05:19:05 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" to be canonical "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1" 2026/04/27 05:19:06 INFO : file2.txt: Deleted 2026/04/27 05:19:06 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2026/04/27 05:19:06 NOTICE: (19) : copy-as /tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ file3.txt 2026/04/27 05:19:06 DEBUG : copyFile "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" to "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" as "file3.txt" 2026/04/27 05:19:06 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" 2026/04/27 05:19:06 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:07 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2" as "file3.txt" 2026/04/27 05:19:07 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8) 2026/04/27 05:19:07 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2) 2026/04/27 05:19:07 DEBUG : fileA.txt: Sizes differ 2026/04/27 05:19:09 DEBUG : file3.txt: size = 19 OK 2026/04/27 05:19:09 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/04/27 05:19:09 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2026/04/27 05:19:09 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2026/04/27 05:19:09 NOTICE: (21) : delete-file TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/file4.txt 2026/04/27 05:19:09 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" for canonical name "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1" 2026/04/27 05:19:09 INFO : file4.txt: Deleted 2026/04/27 05:19:09 NOTICE: (22) : copy-as /tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ file4.txt 2026/04/27 05:19:09 DEBUG : copyFile "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" to "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" as "file4.txt" 2026/04/27 05:19:09 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" 2026/04/27 05:19:09 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:11 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2" as "file4.txt" 2026/04/27 05:19:11 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8) 2026/04/27 05:19:11 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2) 2026/04/27 05:19:11 DEBUG : fileA.txt: Sizes differ 2026/04/27 05:19:12 DEBUG : file4.txt: size = 19 OK 2026/04/27 05:19:12 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/04/27 05:19:12 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2026/04/27 05:19:12 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2026/04/27 05:19:12 NOTICE: (24) : copy-as /tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ file5.txt 2026/04/27 05:19:12 DEBUG : copyFile "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt" to "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" as "file5.txt" 2026/04/27 05:19:12 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt" 2026/04/27 05:19:12 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:13 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2" as "file5.txt" 2026/04/27 05:19:13 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8) 2026/04/27 05:19:13 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2) 2026/04/27 05:19:13 DEBUG : fileB.txt: Sizes differ 2026/04/27 05:19:15 DEBUG : file5.txt: size = 19 OK 2026/04/27 05:19:15 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/04/27 05:19:15 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2026/04/27 05:19:15 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2026/04/27 05:19:15 NOTICE: (26) : copy-as /tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/ file6.txt 2026/04/27 05:19:15 DEBUG : copyFile "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt" to "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" as "file6.txt" 2026/04/27 05:19:15 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileB.txt" 2026/04/27 05:19:15 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" 2026/04/27 05:19:16 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1" as "file6.txt" 2026/04/27 05:19:16 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8) 2026/04/27 05:19:16 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1) 2026/04/27 05:19:16 DEBUG : fileB.txt: Sizes differ 2026/04/27 05:19:18 DEBUG : file6.txt: size = 19 OK 2026/04/27 05:19:18 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/04/27 05:19:18 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2026/04/27 05:19:18 NOTICE: (27) : copy-as /tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ file6.txt 2026/04/27 05:19:18 DEBUG : copyFile "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" to "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" as "file6.txt" 2026/04/27 05:19:18 DEBUG : Creating backend with remote "/tmp/051830decehas5/datadir/test_resync-yopaceh8/fileA.txt" 2026/04/27 05:19:18 DEBUG : Creating backend with remote "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:19 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2" as "file6.txt" 2026/04/27 05:19:19 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/051830decehas5/datadir/test_resync-yopaceh8) 2026/04/27 05:19:19 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2) 2026/04/27 05:19:19 DEBUG : fileA.txt: Sizes differ 2026/04/27 05:19:21 DEBUG : file6.txt: size = 19 OK 2026/04/27 05:19:21 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2026/04/27 05:19:21 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2026/04/27 05:19:21 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2026/04/27 05:19:21 NOTICE: (29) : test run bisync with resync 2026/04/27 05:19:21 NOTICE: (30) : bisync resync 2026/04/27 05:19:29 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:29 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:29 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/04/27 05:19:29 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/04/27 05:19:29 INFO : Synching Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" with Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:29 INFO : Copying Path2 files to Path1 2026/04/27 05:19:29 INFO : - Path2 Resync is copying files to - Path1 2026/04/27 05:19:30 INFO : file4.txt: Copied (server-side copy) 2026/04/27 05:19:30 INFO : file2.txt: Copied (server-side copy) 2026/04/27 05:19:30 INFO : - Path1 Resync is copying files to - Path2 2026/04/27 05:19:31 INFO : file1.txt: Copied (server-side copy) 2026/04/27 05:19:31 INFO : file3.txt: Copied (server-side copy) 2026/04/27 05:19:31 INFO : file6.txt: Updated modification time in destination 2026/04/27 05:19:31 INFO : file5.txt: Copied (server-side copy) 2026/04/27 05:19:31 INFO : Resync updating listings 2026/04/27 05:19:31 INFO : Validating listings for Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" vs Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:31 INFO : Bisync successful 2026/04/27 05:19:31 NOTICE: (31) : copy-listings mixed-diffs 2026/04/27 05:19:31 NOTICE: (32) : test run normal bisync 2026/04/27 05:19:31 NOTICE: (33) : bisync 2026/04/27 05:19:40 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:40 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:40 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/04/27 05:19:40 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/04/27 05:19:40 INFO : Synching Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" with Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:40 INFO : Building Path1 and Path2 listings 2026/04/27 05:19:40 INFO : Path1 checking for diffs 2026/04/27 05:19:40 INFO : Path2 checking for diffs 2026/04/27 05:19:40 INFO : No changes found 2026/04/27 05:19:40 INFO : Updating listings 2026/04/27 05:19:40 INFO : Validating listings for Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" vs Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:40 INFO : Bisync successful 2026/04/27 05:19:40 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2026/04/27 05:19:40 NOTICE: (35) : purge-children TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/ 2026/04/27 05:19:40 DEBUG : RCLONE_TEST: Remove file 2026/04/27 05:19:40 DEBUG : file1.txt: Remove file 2026/04/27 05:19:41 DEBUG : file2.txt: Remove file 2026/04/27 05:19:41 DEBUG : file3.txt: Remove file 2026/04/27 05:19:41 DEBUG : file4.txt: Remove file 2026/04/27 05:19:41 DEBUG : file5.txt: Remove file 2026/04/27 05:19:41 DEBUG : file6.txt: Remove file 2026/04/27 05:19:42 DEBUG : file7.txt: Remove file 2026/04/27 05:19:42 NOTICE: (36) : bisync 2026/04/27 05:19:51 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:51 DEBUG : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2026/04/27 05:19:51 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2026/04/27 05:19:51 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2026/04/27 05:19:51 INFO : Synching Path1 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path1/" with Path2 "TestB2:rclone-test-vepalor0dine/051830decehas5/resync/path2/" 2026/04/27 05:19:51 INFO : Building Path1 and Path2 listings 2026/04/27 05:19:51 INFO : Path1 checking for diffs 2026/04/27 05:19:51 INFO : Path2 checking for diffs 2026/04/27 05:19:51 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/051830decehas5/workdir/TestB2_rclone-test-vepalor0dine_051830decehas5_resync_path1..TestB2_rclone-test-vepalor0dine_051830decehas5_resync_path2.path2.lst-new 2026/04/27 05:19:51 ERROR : Bisync critical error: empty current Path2 listing: /tmp/051830decehas5/workdir/TestB2_rclone-test-vepalor0dine_051830decehas5_resync_path1..TestB2_rclone-test-vepalor0dine_051830decehas5_resync_path2.path2.lst-new 2026/04/27 05:19:51 ERROR : Bisync aborted. Must run --resync to recover. 2026/04/27 05:19:51 NOTICE: Bisync error: bisync aborted 2026/04/27 05:19:51 INFO : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path1: cleaning bucket "rclone-test-vepalor0dine" of all files 2026/04/27 05:19:51 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f119122b1fba8d0b7_d20260427_m051850_c001_v0001171_t0034_u01777267130318") 2026/04/27 05:19:51 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d10_d20260427_m051841_c001_v7007000_t0000_u01777267121009") 2026/04/27 05:19:51 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1100748ef2c9e90c_d20260427_m051837_c001_v0001171_t0000_u01777267117233") 2026/04/27 05:19:51 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f10809432dd480ccc_d20260427_m051850_c001_v0001044_t0040_u01777267130681") 2026/04/27 05:19:51 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d11_d20260427_m051841_c001_v7007000_t0000_u01777267121194") 2026/04/27 05:19:51 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f104727c6db4fdcf4_d20260427_m051837_c001_v0001109_t0003_u01777267117412") 2026/04/27 05:19:51 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f105034f927f2a96b_d20260427_m051930_c001_v0001165_t0032_u01777267170326") 2026/04/27 05:19:51 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d1e_d20260427_m051906_c001_v7007000_t0000_u01777267146516") 2026/04/27 05:19:51 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1146176a495ad5c3_d20260427_m051850_c001_v0001183_t0032_u01777267130708") 2026/04/27 05:19:51 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d12_d20260427_m051841_c001_v7007000_t0000_u01777267121377") 2026/04/27 05:19:51 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11086f664b66f3ad_d20260427_m051837_c001_v0001177_t0015_u01777267117595") 2026/04/27 05:19:52 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1164f1b3ac33aed0_d20260427_m051850_c001_v0001109_t0026_u01777267130698") 2026/04/27 05:19:52 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d13_d20260427_m051841_c001_v7007000_t0000_u01777267121562") 2026/04/27 05:19:52 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11728c731c7e8899_d20260427_m051837_c001_v0001182_t0001_u01777267117782") 2026/04/27 05:19:52 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f106fa8570c38a4c4_d20260427_m051929_c001_v0001174_t0008_u01777267169947") 2026/04/27 05:19:52 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d3e_d20260427_m051909_c001_v7007000_t0000_u01777267149858") 2026/04/27 05:19:52 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1013e35ee9b49731_d20260427_m051850_c001_v0001146_t0038_u01777267130888") 2026/04/27 05:19:52 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d14_d20260427_m051841_c001_v7007000_t0000_u01777267121747") 2026/04/27 05:19:52 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1100748ef2c9e90e_d20260427_m051837_c001_v0001171_t0047_u01777267117527") 2026/04/27 05:19:52 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1147bd848ad526b2_d20260427_m051851_c001_v0001117_t0057_u01777267131061") 2026/04/27 05:19:52 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d15_d20260427_m051841_c001_v7007000_t0000_u01777267121931") 2026/04/27 05:19:52 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11086f664b66f3b1_d20260427_m051837_c001_v0001177_t0002_u01777267117804") 2026/04/27 05:19:52 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f112302216f1588f1_d20260427_m051918_c001_v0001102_t0005_u01777267158305") 2026/04/27 05:19:52 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f104c8501c33df9ce_d20260427_m051851_c001_v0001182_t0019_u01777267131309") 2026/04/27 05:19:52 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d16_d20260427_m051842_c001_v7007000_t0000_u01777267122135") 2026/04/27 05:19:52 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1100748ef2c9e912_d20260427_m051837_c001_v0001171_t0037_u01777267117816") 2026/04/27 05:19:52 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1135e68146334563_d20260427_m051851_c001_v0001040_t0044_u01777267131320") 2026/04/27 05:19:52 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d17_d20260427_m051842_c001_v7007000_t0000_u01777267122322") 2026/04/27 05:19:52 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11728c731c7e889b_d20260427_m051837_c001_v0001182_t0028_u01777267117985") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f41658c9415cfea2d_d20260427_m051946_c001_v7007000_t0000_u01777267186326") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f112c6b77ab8fe9fe_d20260427_m051944_c001_v0001042_t0057_u01777267184601") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11086f664b66f46b_d20260427_m051942_c001_v0001177_t0018_u01777267182815") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f41658c9415cfea2b_d20260427_m051936_c001_v7007000_t0000_u01777267176363") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118b968ff458e057_d20260427_m051934_c001_v0001146_t0017_u01777267174968") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f104727c6db4fdd8e_d20260427_m051932_c001_v0001109_t0009_u01777267172180") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f41658c9415cfea28_d20260427_m051925_c001_v7007000_t0000_u01777267165359") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f119a4327ae4e514e_d20260427_m051924_c001_v0001120_t0054_u01777267164006") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11728c731c7e897b_d20260427_m051921_c001_v0001182_t0052_u01777267161866") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d1b_d20260427_m051857_c001_v7007000_t0000_u01777267137422") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1031857397df6b72_d20260427_m051856_c001_v0001099_t0024_u01777267136058") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1100748ef2c9e940_d20260427_m051854_c001_v0001171_t0015_u01777267134173") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d18_d20260427_m051845_c001_v7007000_t0000_u01777267125622") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118883c75fe223e4_d20260427_m051844_c001_v0001173_t0056_u01777267124286") 2026/04/27 05:19:53 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11086f664b66f3c3_d20260427_m051842_c001_v0001177_t0059_u01777267122506") 2026/04/27 05:19:54 INFO : B2 bucket rclone-test-vepalor0dine path 051830decehas5/resync/path2: cleaning bucket "rclone-test-vepalor0dine" of all files 2026/04/27 05:19:54 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9ea9_d20260427_m051940_c001_v7007000_t0000_u01777267180807") 2026/04/27 05:19:54 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f109144fef3037c89_d20260427_m051902_c001_v0001150_t0038_u01777267142371") 2026/04/27 05:19:54 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e29_d20260427_m051852_c001_v7007000_t0000_u01777267132300") 2026/04/27 05:19:54 DEBUG : RCLONE_TEST: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118ffa4af93a3b58_d20260427_m051839_c001_v0001040_t0004_u01777267119720") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eaa_d20260427_m051941_c001_v7007000_t0000_u01777267181061") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f110bd2226a801892_d20260427_m051930_c001_v0001178_t0030_u01777267170911") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d1d_d20260427_m051904_c001_v7007000_t0000_u01777267144702") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1103cd030d1593ba_d20260427_m051902_c001_v0001185_t0022_u01777267142747") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2a_d20260427_m051852_c001_v7007000_t0000_u01777267132483") 2026/04/27 05:19:54 DEBUG : file1.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1196cca802e64ce8_d20260427_m051839_c001_v0001040_t0027_u01777267119357") 2026/04/27 05:19:54 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eab_d20260427_m051941_c001_v7007000_t0000_u01777267181245") 2026/04/27 05:19:54 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f103add118d4cbc12_d20260427_m051902_c001_v0001174_t0038_u01777267142731") 2026/04/27 05:19:54 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2b_d20260427_m051852_c001_v7007000_t0000_u01777267132667") 2026/04/27 05:19:54 DEBUG : file2.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1093ce8975bb832c_d20260427_m051839_c001_v0001043_t0000_u01777267119563") 2026/04/27 05:19:54 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eac_d20260427_m051941_c001_v7007000_t0000_u01777267181501") 2026/04/27 05:19:55 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118d1ba8b1f319fb_d20260427_m051931_c001_v0001134_t0008_u01777267171283") 2026/04/27 05:19:55 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f107c3953b7053def_d20260427_m051909_c001_v0001154_t0016_u01777267149349") 2026/04/27 05:19:55 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118080ff8dce0810_d20260427_m051902_c001_v0001036_t0053_u01777267142756") 2026/04/27 05:19:55 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2c_d20260427_m051852_c001_v7007000_t0000_u01777267132850") 2026/04/27 05:19:55 DEBUG : file3.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1170a6a1ecfac197_d20260427_m051839_c001_v0001131_t0017_u01777267119905") 2026/04/27 05:19:55 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9ead_d20260427_m051941_c001_v7007000_t0000_u01777267181700") 2026/04/27 05:19:55 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1125f5a316793b78_d20260427_m051912_c001_v0001185_t0047_u01777267152612") 2026/04/27 05:19:55 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1107a987d06c7aa0_d20260427_m051902_c001_v0001182_t0049_u01777267142830") 2026/04/27 05:19:55 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2d_d20260427_m051853_c001_v7007000_t0000_u01777267133034") 2026/04/27 05:19:55 DEBUG : file4.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1196cca802e64cea_d20260427_m051839_c001_v0001040_t0029_u01777267119846") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eae_d20260427_m051941_c001_v7007000_t0000_u01777267181882") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1000e290de6c600e_d20260427_m051931_c001_v0001042_t0031_u01777267171313") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f113beacfd1b3c0c2_d20260427_m051915_c001_v0001099_t0047_u01777267155409") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11024a9b849705a1_d20260427_m051903_c001_v0001174_t0017_u01777267143003") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2e_d20260427_m051853_c001_v7007000_t0000_u01777267133218") 2026/04/27 05:19:55 DEBUG : file5.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1093ce8975bb832e_d20260427_m051839_c001_v0001043_t0054_u01777267119904") 2026/04/27 05:19:55 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eaf_d20260427_m051942_c001_v7007000_t0000_u01777267182065") 2026/04/27 05:19:55 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f116e8155e7421c00_d20260427_m051931_c001_v0001106_t0050_u01777267171290") 2026/04/27 05:19:55 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f113beacfd1b3c0da_d20260427_m051921_c001_v0001099_t0002_u01777267161179") 2026/04/27 05:19:55 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f112bd1e6f6b3d787_d20260427_m051903_c001_v0001173_t0028_u01777267143066") 2026/04/27 05:19:56 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e2f_d20260427_m051853_c001_v7007000_t0000_u01777267133404") 2026/04/27 05:19:56 DEBUG : file6.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118ffa4af93a3b5c_d20260427_m051840_c001_v0001040_t0048_u01777267120233") 2026/04/27 05:19:56 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9eb0_d20260427_m051942_c001_v7007000_t0000_u01777267182250") 2026/04/27 05:19:56 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11948dbe0e48ed81_d20260427_m051903_c001_v0001165_t0008_u01777267143192") 2026/04/27 05:19:56 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e30_d20260427_m051853_c001_v7007000_t0000_u01777267133587") 2026/04/27 05:19:56 DEBUG : file7.txt: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1093ce8975bb8330_d20260427_m051840_c001_v0001043_t0047_u01777267120243") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f417d21066357095b_d20260427_m051951_c001_v7007000_t0000_u01777267191122") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1128294365df942f_d20260427_m051949_c001_v0001172_t0045_u01777267189710") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1196cca802e64d64_d20260427_m051946_c001_v0001040_t0019_u01777267186889") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9ea8_d20260427_m051940_c001_v7007000_t0000_u01777267180243") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1012d49708027395_d20260427_m051938_c001_v0001167_t0050_u01777267178950") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f118ffa4af93a3bbe_d20260427_m051936_c001_v0001040_t0036_u01777267176903") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f407b03d76eb7a015_d20260427_m051929_c001_v7007000_t0000_u01777267169564") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f11967601fe8d57b9_d20260427_m051928_c001_v0001174_t0056_u01777267168224") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1093ce8975bb8382_d20260427_m051925_c001_v0001043_t0002_u01777267165897") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f4178244d18323d1c_d20260427_m051901_c001_v7007000_t0000_u01777267141675") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1190d1d43c7ed4fe_d20260427_m051900_c001_v0001099_t0027_u01777267140254") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1170a6a1ecfac1c5_d20260427_m051858_c001_v0001131_t0045_u01777267138016") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f409ad6bb7c1d9e28_d20260427_m051849_c001_v7007000_t0000_u01777267129923") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f107d4bcb1798cbc4_d20260427_m051848_c001_v0001130_t0005_u01777267128573") 2026/04/27 05:19:56 DEBUG : modtime_write_test: Deleting (id "4_z2f02fd8350fdcbdb9fd80e1b_f1196cca802e64cf0_d20260427_m051846_c001_v0001040_t0051_u01777267126211") bisync_test.go:610: TEST resync PASSED 2026/04/27 05:19:57 DEBUG : B2 bucket rclone-test-vepalor0dine: Purge remote 2026/04/27 05:19:57 INFO : B2 bucket rclone-test-vepalor0dine: cleaning bucket "rclone-test-vepalor0dine" of all files --- PASS: TestBisyncRemoteRemote (88.72s) --- PASS: TestBisyncRemoteRemote/resync (87.01s) PASS 2026/04/27 05:19:58 DEBUG : B2 bucket rclone-test-wulizis6gawa: Purge remote 2026/04/27 05:19:58 INFO : B2 bucket rclone-test-wulizis6gawa: cleaning bucket "rclone-test-wulizis6gawa" of all files 2026/04/27 05:19:59 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 1m30.076944908s (try 3/5)