"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^resync$|^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5) 2025/12/27 05:45:29 DEBUG : Creating backend with remote "TestB2:rclone-test-jerojir1vubi" 2025/12/27 05:45:29 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/27 05:45:30 DEBUG : Creating backend with remote "/tmp/rclone607725688" === RUN TestBisyncLocalRemote 2025/12/27 05:45:30 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa" 2025/12/27 05:45:30 NOTICE: remote: TestB2:rclone-test-wabusip3wisa === RUN TestBisyncLocalRemote/resync 2025/12/27 05:45:30 DEBUG : Creating backend with remote "/tmp/054530na" 2025/12/27 05:45:30 DEBUG : Creating backend with remote "/tmp/054530na/resync/path1" 2025/12/27 05:45:30 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na" 2025/12/27 05:45:32 INFO : path2: Making directory 2025/12/27 05:45:32 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2" 2025/12/27 05:45:33 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2025/12/27 05:45:33 DEBUG : Creating backend with remote "/tmp/054530na/initdir/test_resync-totefew2" 2025/12/27 05:45:33 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : Local file system at /tmp/054530na/initdir/test_resync-totefew2: Waiting for checks to finish 2025/12/27 05:45:33 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:45:33 INFO : file1.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : Local file system at /tmp/054530na/initdir/test_resync-totefew2: Waiting for transfers to finish 2025/12/27 05:45:33 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/27 05:45:33 INFO : file3.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/27 05:45:33 INFO : file2.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/27 05:45:33 INFO : file5.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/27 05:45:33 INFO : file4.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/27 05:45:33 INFO : file6.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/27 05:45:33 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:45:33 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:33 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/27 05:45:33 INFO : file7.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:45:33 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:45:33 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:45:33 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2025/12/27 05:45:33 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9" 2025/12/27 05:45:33 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:33 DEBUG : Local file system at /tmp/054530na/datadir/test_resync-goyequt9: Waiting for checks to finish 2025/12/27 05:45:33 DEBUG : Local file system at /tmp/054530na/datadir/test_resync-goyequt9: Waiting for transfers to finish 2025/12/27 05:45:33 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK 2025/12/27 05:45:33 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:45:33 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2025/12/27 05:45:33 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK 2025/12/27 05:45:33 INFO : fileA.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:45:33 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2025/12/27 05:45:33 INFO : fileB.txt: Copied (new) 2025/12/27 05:45:33 DEBUG : Waiting for deletions to finish 2025/12/27 05:45:33 ERROR : error listing: directory not found 2025/12/27 05:45:33 ERROR : Local file system at /tmp/054530na/resync/path1: Failed to list "": directory not found 2025/12/27 05:45:33 DEBUG : removing 1 level 0 directories 2025/12/27 05:45:33 INFO : Local file system at /tmp/054530na/resync/path1: Removing directory 2025/12/27 05:45:33 ERROR : Failed to rmdir: stat /tmp/054530na/resync/path1: no such file or directory 2025/12/27 05:45:33 INFO : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: cleaning bucket "rclone-test-wabusip3wisa" of all files 2025/12/27 05:45:34 ERROR : error listing: directory not found 2025/12/27 05:45:34 NOTICE: checking initFs Local file system at /tmp/054530na/initdir/test_resync-totefew2 2025/12/27 05:45:34 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:34 DEBUG : Local file system at /tmp/054530na/resync/path1: Waiting for checks to finish 2025/12/27 05:45:34 DEBUG : Local file system at /tmp/054530na/resync/path1: Waiting for transfers to finish 2025/12/27 05:45:34 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:45:34 INFO : file1.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/27 05:45:34 INFO : file2.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/27 05:45:34 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:45:34 INFO : file3.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:45:34 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:45:34 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:45:34 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/27 05:45:34 INFO : file5.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/27 05:45:34 INFO : file6.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/27 05:45:34 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/27 05:45:34 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:45:34 INFO : file4.txt: Copied (new) 2025/12/27 05:45:34 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/27 05:45:34 INFO : file7.txt: Copied (new) 2025/12/27 05:45:34 NOTICE: checking Path1 Local file system at /tmp/054530na/resync/path1 2025/12/27 05:45:35 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:45:35 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Waiting for checks to finish 2025/12/27 05:45:35 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Waiting for transfers to finish 2025/12/27 05:45:35 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:45:35 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:35 INFO : file1.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file2.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : file4.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file4.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : file5.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file5.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : file3.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file3.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : file6.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file6.txt: Copied (new) 2025/12/27 05:45:36 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:45:36 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:45:36 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:45:36 DEBUG : file7.txt: size = 0 OK 2025/12/27 05:45:36 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:45:36 INFO : file7.txt: Copied (new) 2025/12/27 05:45:36 NOTICE: checking path2 B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2 2025/12/27 05:45:36 NOTICE: (01) : test resync 2025/12/27 05:45:36 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/12/27 05:45:36 NOTICE: (03) : purge-children /tmp/054530na/resync/path1/ 2025/12/27 05:45:36 DEBUG : file6.txt: Remove file 2025/12/27 05:45:36 DEBUG : file4.txt: Remove file 2025/12/27 05:45:36 DEBUG : file1.txt: Remove file 2025/12/27 05:45:36 DEBUG : file3.txt: Remove file 2025/12/27 05:45:36 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:45:36 DEBUG : file5.txt: Remove file 2025/12/27 05:45:36 DEBUG : file7.txt: Remove file 2025/12/27 05:45:36 DEBUG : file2.txt: Remove file 2025/12/27 05:45:36 NOTICE: (04) : bisync resync 2025/12/27 05:45:40 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:45:40 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:45:40 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/12/27 05:45:40 INFO : Synching Path1 "/tmp/054530na/resync/path1/" with Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:40 INFO : Copying Path2 files to Path1 2025/12/27 05:45:40 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:45:40 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:45:40 INFO : file1.txt: Copied (new) 2025/12/27 05:45:41 INFO : file2.txt: Copied (new) 2025/12/27 05:45:41 INFO : file4.txt: Copied (new) 2025/12/27 05:45:41 INFO : file3.txt: Copied (new) 2025/12/27 05:45:41 INFO : file5.txt: Copied (new) 2025/12/27 05:45:41 INFO : file6.txt: Copied (new) 2025/12/27 05:45:41 INFO : file7.txt: Copied (new) 2025/12/27 05:45:41 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:45:41 INFO : Resync updating listings 2025/12/27 05:45:41 INFO : Validating listings for Path1 "/tmp/054530na/resync/path1/" vs Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:41 INFO : Bisync successful 2025/12/27 05:45:41 NOTICE: (05) : move-listings empty-path1 2025/12/27 05:45:41 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/12/27 05:45:41 NOTICE: (07) : purge-children TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ 2025/12/27 05:45:41 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:45:41 DEBUG : file1.txt: Remove file 2025/12/27 05:45:42 DEBUG : file2.txt: Remove file 2025/12/27 05:45:42 DEBUG : file3.txt: Remove file 2025/12/27 05:45:42 DEBUG : file4.txt: Remove file 2025/12/27 05:45:42 DEBUG : file5.txt: Remove file 2025/12/27 05:45:42 DEBUG : file6.txt: Remove file 2025/12/27 05:45:43 DEBUG : file7.txt: Remove file 2025/12/27 05:45:43 NOTICE: (08) : bisync resync 2025/12/27 05:45:46 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:45:46 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:45:46 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/12/27 05:45:46 INFO : Synching Path1 "/tmp/054530na/resync/path1/" with Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:46 INFO : Copying Path2 files to Path1 2025/12/27 05:45:46 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:45:46 INFO : There was nothing to transfer 2025/12/27 05:45:46 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:45:47 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:45:47 INFO : file1.txt: Copied (new) 2025/12/27 05:45:47 INFO : file4.txt: Copied (new) 2025/12/27 05:45:47 INFO : file2.txt: Copied (new) 2025/12/27 05:45:47 INFO : file3.txt: Copied (new) 2025/12/27 05:45:48 INFO : file6.txt: Copied (new) 2025/12/27 05:45:48 INFO : file5.txt: Copied (new) 2025/12/27 05:45:48 INFO : file7.txt: Copied (new) 2025/12/27 05:45:48 INFO : Resync updating listings 2025/12/27 05:45:48 INFO : Validating listings for Path1 "/tmp/054530na/resync/path1/" vs Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:48 INFO : Bisync successful 2025/12/27 05:45:48 NOTICE: (09) : move-listings empty-path2 2025/12/27 05:45:48 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/12/27 05:45:48 NOTICE: (11) : touch-glob 2002-02-02 /tmp/054530na/datadir/test_resync-goyequt9/ fileA.txt 2025/12/27 05:45:48 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/" 2025/12/27 05:45:48 DEBUG : fs cache: renaming cache item "/tmp/054530na/datadir/test_resync-goyequt9/" to be canonical "/tmp/054530na/datadir/test_resync-goyequt9" 2025/12/27 05:45:48 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/12/27 05:45:48 NOTICE: (12) : touch-glob 1999-09-09 /tmp/054530na/datadir/test_resync-goyequt9/ fileB.txt 2025/12/27 05:45:48 DEBUG : fs cache: switching user supplied name "/tmp/054530na/datadir/test_resync-goyequt9/" for canonical name "/tmp/054530na/datadir/test_resync-goyequt9" 2025/12/27 05:45:48 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/12/27 05:45:48 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/12/27 05:45:48 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/12/27 05:45:48 NOTICE: (15) : delete-file TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/file1.txt 2025/12/27 05:45:48 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:49 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" to be canonical "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2" 2025/12/27 05:45:49 INFO : file1.txt: Deleted 2025/12/27 05:45:49 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/12/27 05:45:49 NOTICE: (17) : delete-file /tmp/054530na/resync/path1/file2.txt 2025/12/27 05:45:49 DEBUG : Creating backend with remote "/tmp/054530na/resync/path1/" 2025/12/27 05:45:49 DEBUG : fs cache: renaming cache item "/tmp/054530na/resync/path1/" to be canonical "/tmp/054530na/resync/path1" 2025/12/27 05:45:49 INFO : file2.txt: Deleted 2025/12/27 05:45:49 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/12/27 05:45:49 NOTICE: (19) : copy-as /tmp/054530na/datadir/test_resync-goyequt9/fileA.txt TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ file3.txt 2025/12/27 05:45:49 DEBUG : copyFile "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" to "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" as "file3.txt" 2025/12/27 05:45:49 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" 2025/12/27 05:45:49 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:50 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2" as "file3.txt" 2025/12/27 05:45:51 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054530na/datadir/test_resync-goyequt9) 2025/12/27 05:45:51 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2) 2025/12/27 05:45:51 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:45:52 DEBUG : file3.txt: size = 19 OK 2025/12/27 05:45:52 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:45:52 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/12/27 05:45:52 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/12/27 05:45:52 NOTICE: (21) : delete-file /tmp/054530na/resync/path1/file4.txt 2025/12/27 05:45:52 DEBUG : fs cache: switching user supplied name "/tmp/054530na/resync/path1/" for canonical name "/tmp/054530na/resync/path1" 2025/12/27 05:45:52 INFO : file4.txt: Deleted 2025/12/27 05:45:52 NOTICE: (22) : copy-as /tmp/054530na/datadir/test_resync-goyequt9/fileA.txt TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ file4.txt 2025/12/27 05:45:52 DEBUG : copyFile "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" to "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" as "file4.txt" 2025/12/27 05:45:52 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" 2025/12/27 05:45:52 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:53 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2" as "file4.txt" 2025/12/27 05:45:53 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054530na/datadir/test_resync-goyequt9) 2025/12/27 05:45:53 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2) 2025/12/27 05:45:53 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:45:55 DEBUG : file4.txt: size = 19 OK 2025/12/27 05:45:55 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:45:55 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/12/27 05:45:55 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/12/27 05:45:55 NOTICE: (24) : copy-as /tmp/054530na/datadir/test_resync-goyequt9/fileB.txt TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ file5.txt 2025/12/27 05:45:55 DEBUG : copyFile "/tmp/054530na/datadir/test_resync-goyequt9/fileB.txt" to "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" as "file5.txt" 2025/12/27 05:45:55 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/fileB.txt" 2025/12/27 05:45:55 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:56 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2" as "file5.txt" 2025/12/27 05:45:56 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/054530na/datadir/test_resync-goyequt9) 2025/12/27 05:45:56 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2) 2025/12/27 05:45:56 DEBUG : fileB.txt: Sizes differ 2025/12/27 05:45:58 DEBUG : file5.txt: size = 19 OK 2025/12/27 05:45:58 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:45:58 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/12/27 05:45:58 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/12/27 05:45:58 NOTICE: (26) : copy-as /tmp/054530na/datadir/test_resync-goyequt9/fileB.txt /tmp/054530na/resync/path1/ file6.txt 2025/12/27 05:45:58 DEBUG : copyFile "/tmp/054530na/datadir/test_resync-goyequt9/fileB.txt" to "/tmp/054530na/resync/path1/" as "file6.txt" 2025/12/27 05:45:58 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/fileB.txt" 2025/12/27 05:45:58 DEBUG : Creating backend with remote "/tmp/054530na/resync/path1/" 2025/12/27 05:45:58 DEBUG : operations.CopyFile "fileB.txt" to "Local file system at /tmp/054530na/resync/path1" as "file6.txt" 2025/12/27 05:45:58 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/054530na/datadir/test_resync-goyequt9) 2025/12/27 05:45:58 DEBUG : file6.txt: size = 0 (Local file system at /tmp/054530na/resync/path1) 2025/12/27 05:45:58 DEBUG : fileB.txt: Sizes differ 2025/12/27 05:45:58 DEBUG : file6.txt.237b502b.partial: size = 19 OK 2025/12/27 05:45:58 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:45:58 DEBUG : file6.txt.237b502b.partial: renamed to: file6.txt 2025/12/27 05:45:58 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/12/27 05:45:58 NOTICE: (27) : copy-as /tmp/054530na/datadir/test_resync-goyequt9/fileA.txt TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ file6.txt 2025/12/27 05:45:58 DEBUG : copyFile "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" to "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" as "file6.txt" 2025/12/27 05:45:58 DEBUG : Creating backend with remote "/tmp/054530na/datadir/test_resync-goyequt9/fileA.txt" 2025/12/27 05:45:58 DEBUG : Creating backend with remote "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:45:59 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2" as "file6.txt" 2025/12/27 05:45:59 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054530na/datadir/test_resync-goyequt9) 2025/12/27 05:45:59 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2) 2025/12/27 05:45:59 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:46:01 DEBUG : file6.txt: size = 19 OK 2025/12/27 05:46:01 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:46:01 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/12/27 05:46:01 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/12/27 05:46:01 NOTICE: (29) : test run bisync with resync 2025/12/27 05:46:01 NOTICE: (30) : bisync resync 2025/12/27 05:46:05 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:05 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:46:05 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/12/27 05:46:05 INFO : Synching Path1 "/tmp/054530na/resync/path1/" with Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:46:05 INFO : Copying Path2 files to Path1 2025/12/27 05:46:05 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:46:05 INFO : file4.txt: Copied (new) 2025/12/27 05:46:05 INFO : file2.txt: Copied (new) 2025/12/27 05:46:05 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:46:06 INFO : file6.txt: Updated modification time in destination 2025/12/27 05:46:06 INFO : file5.txt: Copied (replaced existing) 2025/12/27 05:46:06 INFO : file3.txt: Copied (replaced existing) 2025/12/27 05:46:06 INFO : file1.txt: Copied (new) 2025/12/27 05:46:06 INFO : Resync updating listings 2025/12/27 05:46:06 INFO : Validating listings for Path1 "/tmp/054530na/resync/path1/" vs Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:46:06 INFO : Bisync successful 2025/12/27 05:46:06 NOTICE: (31) : copy-listings mixed-diffs 2025/12/27 05:46:06 NOTICE: (32) : test run normal bisync 2025/12/27 05:46:06 NOTICE: (33) : bisync 2025/12/27 05:46:09 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:09 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:46:09 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/12/27 05:46:09 INFO : Synching Path1 "/tmp/054530na/resync/path1/" with Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:46:09 INFO : Building Path1 and Path2 listings 2025/12/27 05:46:10 INFO : Path1 checking for diffs 2025/12/27 05:46:10 INFO : Path2 checking for diffs 2025/12/27 05:46:10 INFO : No changes found 2025/12/27 05:46:10 INFO : Updating listings 2025/12/27 05:46:10 INFO : Validating listings for Path1 "/tmp/054530na/resync/path1/" vs Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:46:10 INFO : Bisync successful 2025/12/27 05:46:10 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/12/27 05:46:10 NOTICE: (35) : purge-children TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/ 2025/12/27 05:46:10 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:46:10 DEBUG : file1.txt: Remove file 2025/12/27 05:46:10 DEBUG : file2.txt: Remove file 2025/12/27 05:46:10 DEBUG : file3.txt: Remove file 2025/12/27 05:46:11 DEBUG : file4.txt: Remove file 2025/12/27 05:46:11 DEBUG : file5.txt: Remove file 2025/12/27 05:46:11 DEBUG : file6.txt: Remove file 2025/12/27 05:46:11 DEBUG : file7.txt: Remove file 2025/12/27 05:46:11 NOTICE: (36) : bisync 2025/12/27 05:46:15 DEBUG : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:15 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:46:15 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": true, "DownloadHash": false } 2025/12/27 05:46:15 INFO : Synching Path1 "/tmp/054530na/resync/path1/" with Path2 "TestB2:rclone-test-wabusip3wisa/054530na/resync/path2/" 2025/12/27 05:46:15 INFO : Building Path1 and Path2 listings 2025/12/27 05:46:15 INFO : Path1 checking for diffs 2025/12/27 05:46:15 INFO : Path2 checking for diffs 2025/12/27 05:46:15 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/054530na/workdir/tmp_054530na_resync_path1..TestB2_rclone-test-wabusip3wisa_054530na_resync_path2.path2.lst-new 2025/12/27 05:46:15 ERROR : Bisync critical error: empty current Path2 listing: /tmp/054530na/workdir/tmp_054530na_resync_path1..TestB2_rclone-test-wabusip3wisa_054530na_resync_path2.path2.lst-new 2025/12/27 05:46:15 ERROR : Bisync aborted. Must run --resync to recover. 2025/12/27 05:46:15 NOTICE: Bisync error: bisync aborted 2025/12/27 05:46:15 DEBUG : Waiting for deletions to finish 2025/12/27 05:46:15 INFO : RCLONE_TEST: Deleted 2025/12/27 05:46:15 INFO : file1.txt: Deleted 2025/12/27 05:46:15 INFO : file7.txt: Deleted 2025/12/27 05:46:15 INFO : file5.txt: Deleted 2025/12/27 05:46:15 INFO : file3.txt: Deleted 2025/12/27 05:46:15 INFO : file4.txt: Deleted 2025/12/27 05:46:15 INFO : file2.txt: Deleted 2025/12/27 05:46:15 INFO : file6.txt: Deleted 2025/12/27 05:46:15 DEBUG : removing 1 level 0 directories 2025/12/27 05:46:15 INFO : Local file system at /tmp/054530na/resync/path1: Removing directory 2025/12/27 05:46:15 INFO : B2 bucket rclone-test-wabusip3wisa path 054530na/resync/path2: cleaning bucket "rclone-test-wabusip3wisa" of all files 2025/12/27 05:46:16 DEBUG : RCLONE_TEST: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527177_d20251227_m054610_c001_v7007000_t0000_u01766814370412") 2025/12/27 05:46:16 DEBUG : RCLONE_TEST: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa63_d20251227_m054547_c001_v0001145_t0001_u01766814347192") 2025/12/27 05:46:16 DEBUG : RCLONE_TEST: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece925e_d20251227_m054541_c001_v7007000_t0000_u01766814341782") 2025/12/27 05:46:16 DEBUG : RCLONE_TEST: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f10973f1971c444b5_d20251227_m054536_c001_v0001167_t0053_u01766814336305") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e5352717a_d20251227_m054610_c001_v7007000_t0000_u01766814370594") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa93_d20251227_m054606_c001_v0001145_t0059_u01766814366190") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece92f1_d20251227_m054549_c001_v7007000_t0000_u01766814349746") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f10973f1971c445ab_d20251227_m054547_c001_v0001167_t0015_u01766814347544") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9263_d20251227_m054541_c001_v7007000_t0000_u01766814341967") 2025/12/27 05:46:16 DEBUG : file1.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa4d_d20251227_m054535_c001_v0001145_t0040_u01766814335727") 2025/12/27 05:46:16 DEBUG : file2.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e5352717d_d20251227_m054610_c001_v7007000_t0000_u01766814370776") 2025/12/27 05:46:16 DEBUG : file2.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92fd2d_d20251227_m054547_c001_v0001173_t0017_u01766814347565") 2025/12/27 05:46:16 DEBUG : file2.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9268_d20251227_m054542_c001_v7007000_t0000_u01766814342151") 2025/12/27 05:46:16 DEBUG : file2.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c41_d20251227_m054535_c001_v0001145_t0039_u01766814335898") 2025/12/27 05:46:16 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527180_d20251227_m054610_c001_v7007000_t0000_u01766814370957") 2025/12/27 05:46:16 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f10973f1971c446e8_d20251227_m054606_c001_v0001167_t0041_u01766814366184") 2025/12/27 05:46:16 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f10276b238bffaf07_d20251227_m054552_c001_v0001185_t0048_u01766814352555") 2025/12/27 05:46:16 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c60_d20251227_m054547_c001_v0001145_t0044_u01766814347624") 2025/12/27 05:46:16 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece926c_d20251227_m054542_c001_v7007000_t0000_u01766814342335") 2025/12/27 05:46:17 DEBUG : file3.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92fbe9_d20251227_m054536_c001_v0001173_t0043_u01766814336114") 2025/12/27 05:46:17 DEBUG : file4.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527183_d20251227_m054611_c001_v7007000_t0000_u01766814371139") 2025/12/27 05:46:17 DEBUG : file4.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f115c0b4131240c72_d20251227_m054555_c001_v0001100_t0055_u01766814355305") 2025/12/27 05:46:17 DEBUG : file4.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa65_d20251227_m054547_c001_v0001145_t0046_u01766814347628") 2025/12/27 05:46:17 DEBUG : file4.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9271_d20251227_m054542_c001_v7007000_t0000_u01766814342522") 2025/12/27 05:46:17 DEBUG : file4.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa4f_d20251227_m054535_c001_v0001145_t0037_u01766814335988") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527186_d20251227_m054611_c001_v7007000_t0000_u01766814371321") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92ff24_d20251227_m054606_c001_v0001173_t0057_u01766814366195") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f109e82d8e925d895_d20251227_m054558_c001_v0001100_t0017_u01766814358195") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f10973f1971c445c1_d20251227_m054547_c001_v0001167_t0031_u01766814347912") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9277_d20251227_m054542_c001_v7007000_t0000_u01766814342709") 2025/12/27 05:46:17 DEBUG : file5.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c43_d20251227_m054536_c001_v0001145_t0049_u01766814336153") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527189_d20251227_m054611_c001_v7007000_t0000_u01766814371502") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117084958b2ab5a5_d20251227_m054606_c001_v0001179_t0048_u01766814366016") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1179682348f8865f_d20251227_m054601_c001_v0001154_t0001_u01766814361175") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa67_d20251227_m054547_c001_v0001145_t0023_u01766814347966") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece927c_d20251227_m054542_c001_v7007000_t0000_u01766814342893") 2025/12/27 05:46:17 DEBUG : file6.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa51_d20251227_m054536_c001_v0001145_t0007_u01766814336241") 2025/12/27 05:46:17 DEBUG : file7.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e5352718c_d20251227_m054611_c001_v7007000_t0000_u01766814371686") 2025/12/27 05:46:17 DEBUG : file7.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92fd40_d20251227_m054547_c001_v0001173_t0046_u01766814347995") 2025/12/27 05:46:18 DEBUG : file7.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9283_d20251227_m054543_c001_v7007000_t0000_u01766814343123") 2025/12/27 05:46:18 DEBUG : file7.txt: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c47_d20251227_m054536_c001_v0001145_t0002_u01766814336491") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e535271c1_d20251227_m054615_c001_v7007000_t0000_u01766814375548") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f115a780f93151a71_d20251227_m054614_c001_v0001185_t0059_u01766814374257") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92ffcb_d20251227_m054612_c001_v0001173_t0018_u01766814372232") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527170_d20251227_m054609_c001_v7007000_t0000_u01766814369856") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f103a99c75265192f_d20251227_m054608_c001_v0001117_t0059_u01766814368170") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c85_d20251227_m054606_c001_v0001145_t0053_u01766814366708") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f409e9d4e53527133_d20251227_m054605_c001_v7007000_t0000_u01766814365021") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f11532627204bbe1e_d20251227_m054603_c001_v0001029_t0020_u01766814363653") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1004a64e61f54c80_d20251227_m054601_c001_v0001145_t0036_u01766814361804") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece92c0_d20251227_m054546_c001_v7007000_t0000_u01766814346607") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1047d9941a68f750_d20251227_m054545_c001_v0001092_t0025_u01766814345257") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1045e796fe13fa5e_d20251227_m054543_c001_v0001145_t0043_u01766814343706") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f4217ec34eece9244_d20251227_m054540_c001_v7007000_t0000_u01766814340266") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f1025d42b341de98a_d20251227_m054538_c001_v0001167_t0053_u01766814338714") 2025/12/27 05:46:18 DEBUG : modtime_write_test: Deleting (id "4_z6fc23d63507d5beb9fb80e1b_f117d55624a92fc07_d20251227_m054537_c001_v0001173_t0017_u01766814337063") bisync_test.go:608: TEST resync PASSED 2025/12/27 05:46:19 DEBUG : B2 bucket rclone-test-wabusip3wisa: Purge remote 2025/12/27 05:46:19 INFO : B2 bucket rclone-test-wabusip3wisa: cleaning bucket "rclone-test-wabusip3wisa" of all files --- PASS: TestBisyncLocalRemote (49.87s) --- PASS: TestBisyncLocalRemote/resync (48.25s) === RUN TestBisyncRemoteRemote 2025/12/27 05:46:20 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola" 2025/12/27 05:46:20 NOTICE: remote: TestB2:rclone-test-ketahil4lola === RUN TestBisyncRemoteRemote/resync 2025/12/27 05:46:20 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke" 2025/12/27 05:46:21 INFO : path1: Making directory 2025/12/27 05:46:22 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1" 2025/12/27 05:46:23 INFO : path2: Making directory 2025/12/27 05:46:23 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2" 2025/12/27 05:46:24 DEBUG : Creating backend with remote "/tmp/054620ke/initdir/test_resync-jusijug7" 2025/12/27 05:46:24 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : Local file system at /tmp/054620ke/initdir/test_resync-jusijug7: Waiting for checks to finish 2025/12/27 05:46:24 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : Local file system at /tmp/054620ke/initdir/test_resync-jusijug7: Waiting for transfers to finish 2025/12/27 05:46:24 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:46:24 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:46:24 INFO : file1.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/27 05:46:24 INFO : file2.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:46:24 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/27 05:46:24 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 INFO : file4.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:46:24 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:46:24 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/27 05:46:24 INFO : file3.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/27 05:46:24 INFO : file5.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/27 05:46:24 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:46:24 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/27 05:46:24 INFO : file6.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/27 05:46:24 INFO : file7.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1" 2025/12/27 05:46:24 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:24 DEBUG : Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1: Waiting for checks to finish 2025/12/27 05:46:24 DEBUG : Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1: Waiting for transfers to finish 2025/12/27 05:46:24 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK 2025/12/27 05:46:24 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:46:24 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK 2025/12/27 05:46:24 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:46:24 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2025/12/27 05:46:24 INFO : fileA.txt: Copied (new) 2025/12/27 05:46:24 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2025/12/27 05:46:24 INFO : fileB.txt: Copied (new) 2025/12/27 05:46:24 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:46:25 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:46:26 NOTICE: checking initFs Local file system at /tmp/054620ke/initdir/test_resync-jusijug7 2025/12/27 05:46:26 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:26 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Waiting for checks to finish 2025/12/27 05:46:26 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Waiting for transfers to finish 2025/12/27 05:46:27 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:46:27 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:27 INFO : file1.txt: Copied (new) 2025/12/27 05:46:27 DEBUG : file4.txt: size = 0 OK 2025/12/27 05:46:27 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:27 INFO : file4.txt: Copied (new) 2025/12/27 05:46:27 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:46:27 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:27 INFO : file2.txt: Copied (new) 2025/12/27 05:46:28 DEBUG : file5.txt: size = 0 OK 2025/12/27 05:46:28 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:28 INFO : file5.txt: Copied (new) 2025/12/27 05:46:28 DEBUG : file3.txt: size = 0 OK 2025/12/27 05:46:28 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:28 INFO : file3.txt: Copied (new) 2025/12/27 05:46:28 DEBUG : file7.txt: size = 0 OK 2025/12/27 05:46:28 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:28 INFO : file7.txt: Copied (new) 2025/12/27 05:46:28 DEBUG : file6.txt: size = 0 OK 2025/12/27 05:46:28 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:28 INFO : file6.txt: Copied (new) 2025/12/27 05:46:28 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:46:28 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:46:28 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:46:28 NOTICE: checking Path1 B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1 2025/12/27 05:46:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:46:28 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Waiting for checks to finish 2025/12/27 05:46:28 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Waiting for transfers to finish 2025/12/27 05:46:29 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:46:29 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:29 INFO : file1.txt: Copied (new) 2025/12/27 05:46:29 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:46:29 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:29 INFO : file2.txt: Copied (new) 2025/12/27 05:46:29 DEBUG : file4.txt: size = 0 OK 2025/12/27 05:46:29 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:29 INFO : file4.txt: Copied (new) 2025/12/27 05:46:30 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:46:30 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:46:30 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:46:30 DEBUG : file3.txt: size = 0 OK 2025/12/27 05:46:30 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:30 INFO : file3.txt: Copied (new) 2025/12/27 05:46:30 DEBUG : file7.txt: size = 0 OK 2025/12/27 05:46:30 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:30 INFO : file7.txt: Copied (new) 2025/12/27 05:46:30 DEBUG : file6.txt: size = 0 OK 2025/12/27 05:46:30 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:30 INFO : file6.txt: Copied (new) 2025/12/27 05:46:30 DEBUG : file5.txt: size = 0 OK 2025/12/27 05:46:30 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:46:30 INFO : file5.txt: Copied (new) 2025/12/27 05:46:30 NOTICE: checking path2 B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2 2025/12/27 05:46:30 NOTICE: (01) : test resync 2025/12/27 05:46:30 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/12/27 05:46:30 NOTICE: (03) : purge-children TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/ 2025/12/27 05:46:30 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:46:31 DEBUG : file1.txt: Remove file 2025/12/27 05:46:31 DEBUG : file2.txt: Remove file 2025/12/27 05:46:31 DEBUG : file3.txt: Remove file 2025/12/27 05:46:31 DEBUG : file4.txt: Remove file 2025/12/27 05:46:31 DEBUG : file5.txt: Remove file 2025/12/27 05:46:32 DEBUG : file6.txt: Remove file 2025/12/27 05:46:32 DEBUG : file7.txt: Remove file 2025/12/27 05:46:32 NOTICE: (04) : bisync resync 2025/12/27 05:46:40 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:40 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:40 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:46:40 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:46:40 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:40 INFO : Copying Path2 files to Path1 2025/12/27 05:46:40 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:46:41 INFO : file2.txt: Copied (server-side copy) 2025/12/27 05:46:41 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:46:41 INFO : RCLONE_TEST: Copied (server-side copy) 2025/12/27 05:46:41 INFO : file3.txt: Copied (server-side copy) 2025/12/27 05:46:41 INFO : file6.txt: Copied (server-side copy) 2025/12/27 05:46:41 INFO : file4.txt: Copied (server-side copy) 2025/12/27 05:46:41 INFO : file5.txt: Copied (server-side copy) 2025/12/27 05:46:42 INFO : file7.txt: Copied (server-side copy) 2025/12/27 05:46:42 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:46:42 INFO : Resync updating listings 2025/12/27 05:46:42 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:42 INFO : Bisync successful 2025/12/27 05:46:42 NOTICE: (05) : move-listings empty-path1 2025/12/27 05:46:42 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/12/27 05:46:42 NOTICE: (07) : purge-children TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ 2025/12/27 05:46:42 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:46:42 DEBUG : file1.txt: Remove file 2025/12/27 05:46:42 DEBUG : file2.txt: Remove file 2025/12/27 05:46:42 DEBUG : file3.txt: Remove file 2025/12/27 05:46:43 DEBUG : file4.txt: Remove file 2025/12/27 05:46:43 DEBUG : file5.txt: Remove file 2025/12/27 05:46:43 DEBUG : file6.txt: Remove file 2025/12/27 05:46:43 DEBUG : file7.txt: Remove file 2025/12/27 05:46:43 NOTICE: (08) : bisync resync 2025/12/27 05:46:52 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:52 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:46:52 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:46:52 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:46:52 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:52 INFO : Copying Path2 files to Path1 2025/12/27 05:46:52 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:46:52 INFO : There was nothing to transfer 2025/12/27 05:46:52 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:46:52 INFO : RCLONE_TEST: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file2.txt: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file5.txt: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file3.txt: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file4.txt: Copied (server-side copy) 2025/12/27 05:46:53 INFO : file6.txt: Copied (server-side copy) 2025/12/27 05:46:54 INFO : file7.txt: Copied (server-side copy) 2025/12/27 05:46:54 INFO : Resync updating listings 2025/12/27 05:46:54 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:54 INFO : Bisync successful 2025/12/27 05:46:54 NOTICE: (09) : move-listings empty-path2 2025/12/27 05:46:54 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/12/27 05:46:54 NOTICE: (11) : touch-glob 2002-02-02 /tmp/054620ke/datadir/test_resync-vaqowin1/ fileA.txt 2025/12/27 05:46:54 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/" 2025/12/27 05:46:54 DEBUG : fs cache: renaming cache item "/tmp/054620ke/datadir/test_resync-vaqowin1/" to be canonical "/tmp/054620ke/datadir/test_resync-vaqowin1" 2025/12/27 05:46:54 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/12/27 05:46:54 NOTICE: (12) : touch-glob 1999-09-09 /tmp/054620ke/datadir/test_resync-vaqowin1/ fileB.txt 2025/12/27 05:46:54 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync-vaqowin1/" for canonical name "/tmp/054620ke/datadir/test_resync-vaqowin1" 2025/12/27 05:46:54 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/12/27 05:46:54 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/12/27 05:46:54 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/12/27 05:46:54 NOTICE: (15) : delete-file TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/file1.txt 2025/12/27 05:46:54 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:55 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" to be canonical "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2" 2025/12/27 05:46:55 INFO : file1.txt: Deleted 2025/12/27 05:46:55 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/12/27 05:46:55 NOTICE: (17) : delete-file TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/file2.txt 2025/12/27 05:46:55 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" 2025/12/27 05:46:56 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" to be canonical "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1" 2025/12/27 05:46:58 INFO : file2.txt: Deleted 2025/12/27 05:46:58 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/12/27 05:46:58 NOTICE: (19) : copy-as /tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ file3.txt 2025/12/27 05:46:58 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" as "file3.txt" 2025/12/27 05:46:58 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" 2025/12/27 05:46:58 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:46:59 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2" as "file3.txt" 2025/12/27 05:46:59 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1) 2025/12/27 05:46:59 DEBUG : file3.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2) 2025/12/27 05:46:59 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:47:00 DEBUG : file3.txt: size = 19 OK 2025/12/27 05:47:00 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:47:00 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/12/27 05:47:00 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/12/27 05:47:00 NOTICE: (21) : delete-file TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/file4.txt 2025/12/27 05:47:00 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" for canonical name "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1" 2025/12/27 05:47:01 INFO : file4.txt: Deleted 2025/12/27 05:47:01 NOTICE: (22) : copy-as /tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ file4.txt 2025/12/27 05:47:01 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" as "file4.txt" 2025/12/27 05:47:01 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" 2025/12/27 05:47:01 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:02 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2" as "file4.txt" 2025/12/27 05:47:02 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1) 2025/12/27 05:47:02 DEBUG : file4.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2) 2025/12/27 05:47:02 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:47:04 DEBUG : file4.txt: size = 19 OK 2025/12/27 05:47:04 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:47:04 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/12/27 05:47:04 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/12/27 05:47:04 NOTICE: (24) : copy-as /tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ file5.txt 2025/12/27 05:47:04 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" as "file5.txt" 2025/12/27 05:47:04 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt" 2025/12/27 05:47:04 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:05 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2" as "file5.txt" 2025/12/27 05:47:05 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1) 2025/12/27 05:47:05 DEBUG : file5.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2) 2025/12/27 05:47:05 DEBUG : fileB.txt: Sizes differ 2025/12/27 05:47:07 DEBUG : file5.txt: size = 19 OK 2025/12/27 05:47:07 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:47:07 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/12/27 05:47:07 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/12/27 05:47:07 NOTICE: (26) : copy-as /tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/ file6.txt 2025/12/27 05:47:07 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" as "file6.txt" 2025/12/27 05:47:07 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/fileB.txt" 2025/12/27 05:47:07 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" 2025/12/27 05:47:08 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1" as "file6.txt" 2025/12/27 05:47:09 DEBUG : fileB.txt: size = 19 (Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1) 2025/12/27 05:47:09 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1) 2025/12/27 05:47:09 DEBUG : fileB.txt: Sizes differ 2025/12/27 05:47:10 DEBUG : file6.txt: size = 19 OK 2025/12/27 05:47:10 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:47:10 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/12/27 05:47:10 NOTICE: (27) : copy-as /tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ file6.txt 2025/12/27 05:47:10 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" as "file6.txt" 2025/12/27 05:47:10 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync-vaqowin1/fileA.txt" 2025/12/27 05:47:10 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:11 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2" as "file6.txt" 2025/12/27 05:47:12 DEBUG : fileA.txt: size = 19 (Local file system at /tmp/054620ke/datadir/test_resync-vaqowin1) 2025/12/27 05:47:12 DEBUG : file6.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2) 2025/12/27 05:47:12 DEBUG : fileA.txt: Sizes differ 2025/12/27 05:47:13 DEBUG : file6.txt: size = 19 OK 2025/12/27 05:47:13 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/12/27 05:47:13 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/12/27 05:47:13 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/12/27 05:47:13 NOTICE: (29) : test run bisync with resync 2025/12/27 05:47:13 NOTICE: (30) : bisync resync 2025/12/27 05:47:21 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:21 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:21 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:47:21 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:47:21 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:21 INFO : Copying Path2 files to Path1 2025/12/27 05:47:21 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:47:22 INFO : file2.txt: Copied (server-side copy) 2025/12/27 05:47:22 INFO : file4.txt: Copied (server-side copy) 2025/12/27 05:47:22 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:47:23 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:47:23 INFO : file5.txt: Copied (server-side copy) 2025/12/27 05:47:24 INFO : file3.txt: Copied (server-side copy) 2025/12/27 05:47:24 INFO : file6.txt: Updated modification time in destination 2025/12/27 05:47:24 INFO : Resync updating listings 2025/12/27 05:47:24 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:24 INFO : Bisync successful 2025/12/27 05:47:24 NOTICE: (31) : copy-listings mixed-diffs 2025/12/27 05:47:24 NOTICE: (32) : test run normal bisync 2025/12/27 05:47:24 NOTICE: (33) : bisync 2025/12/27 05:47:32 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:32 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:32 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:47:32 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:47:32 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:32 INFO : Building Path1 and Path2 listings 2025/12/27 05:47:32 INFO : Path1 checking for diffs 2025/12/27 05:47:32 INFO : Path2 checking for diffs 2025/12/27 05:47:32 INFO : No changes found 2025/12/27 05:47:32 INFO : Updating listings 2025/12/27 05:47:32 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:32 INFO : Bisync successful 2025/12/27 05:47:32 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/12/27 05:47:32 NOTICE: (35) : purge-children TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/ 2025/12/27 05:47:32 DEBUG : RCLONE_TEST: Remove file 2025/12/27 05:47:32 DEBUG : file1.txt: Remove file 2025/12/27 05:47:33 DEBUG : file2.txt: Remove file 2025/12/27 05:47:33 DEBUG : file3.txt: Remove file 2025/12/27 05:47:33 DEBUG : file4.txt: Remove file 2025/12/27 05:47:33 DEBUG : file5.txt: Remove file 2025/12/27 05:47:33 DEBUG : file6.txt: Remove file 2025/12/27 05:47:33 DEBUG : file7.txt: Remove file 2025/12/27 05:47:34 NOTICE: (36) : bisync 2025/12/27 05:47:42 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:42 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:47:42 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:47:42 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:47:42 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync/path2/" 2025/12/27 05:47:42 INFO : Building Path1 and Path2 listings 2025/12/27 05:47:42 INFO : Path1 checking for diffs 2025/12/27 05:47:42 INFO : Path2 checking for diffs 2025/12/27 05:47:42 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/054620ke/workdir/TestB2_rclone-test-ketahil4lola_054620ke_resync_path1..TestB2_rclone-test-ketahil4lola_054620ke_resync_path2.path2.lst-new 2025/12/27 05:47:42 ERROR : Bisync critical error: empty current Path2 listing: /tmp/054620ke/workdir/TestB2_rclone-test-ketahil4lola_054620ke_resync_path1..TestB2_rclone-test-ketahil4lola_054620ke_resync_path2.path2.lst-new 2025/12/27 05:47:42 ERROR : Bisync aborted. Must run --resync to recover. 2025/12/27 05:47:42 NOTICE: Bisync error: bisync aborted 2025/12/27 05:47:42 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:47:43 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104b1dbbce65a0bd_d20251227_m054640_c001_v0001167_t0015_u01766814400896") 2025/12/27 05:47:43 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d067_d20251227_m054631_c001_v7007000_t0000_u01766814391086") 2025/12/27 05:47:43 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11111503897e08c2_d20251227_m054628_c001_v0001099_t0051_u01766814388137") 2025/12/27 05:47:43 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f113990e62d7f7831_d20251227_m054641_c001_v0001182_t0022_u01766814401280") 2025/12/27 05:47:43 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d068_d20251227_m054631_c001_v7007000_t0000_u01766814391267") 2025/12/27 05:47:43 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111bf918ff02aba1_d20251227_m054627_c001_v0001183_t0031_u01766814387523") 2025/12/27 05:47:43 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f106fa333dfbafede_d20251227_m054722_c001_v0001185_t0046_u01766814442315") 2025/12/27 05:47:43 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f408e6ed2ce50b7de_d20251227_m054657_c001_v7007000_t0000_u01766814417939") 2025/12/27 05:47:43 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114aa897529825c3_d20251227_m054641_c001_v0001177_t0004_u01766814401277") 2025/12/27 05:47:43 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d069_d20251227_m054631_c001_v7007000_t0000_u01766814391448") 2025/12/27 05:47:43 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114cb19436b09c4c_d20251227_m054627_c001_v0001172_t0050_u01766814387763") 2025/12/27 05:47:43 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104a556ee74370b8_d20251227_m054641_c001_v0001173_t0020_u01766814401287") 2025/12/27 05:47:43 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d06a_d20251227_m054631_c001_v7007000_t0000_u01766814391673") 2025/12/27 05:47:43 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1042c11ad57f5395_d20251227_m054627_c001_v0001130_t0036_u01766814387950") 2025/12/27 05:47:43 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1037327a8c1aab92_d20251227_m054722_c001_v0001167_t0024_u01766814442533") 2025/12/27 05:47:43 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f408e6ed2ce50b7e9_d20251227_m054701_c001_v7007000_t0000_u01766814421206") 2025/12/27 05:47:43 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10059a61ed4adfb8_d20251227_m054641_c001_v0001137_t0054_u01766814401501") 2025/12/27 05:47:43 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d06b_d20251227_m054631_c001_v7007000_t0000_u01766814391855") 2025/12/27 05:47:43 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111bf918ff02aba3_d20251227_m054627_c001_v0001183_t0005_u01766814387766") 2025/12/27 05:47:43 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104e2a76f398f6ba_d20251227_m054641_c001_v0001101_t0034_u01766814401531") 2025/12/27 05:47:43 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d06c_d20251227_m054632_c001_v7007000_t0000_u01766814392036") 2025/12/27 05:47:43 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111bf918ff02aba7_d20251227_m054627_c001_v0001183_t0042_u01766814387971") 2025/12/27 05:47:43 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1137ec3a5ba0fe65_d20251227_m054710_c001_v0001185_t0038_u01766814430569") 2025/12/27 05:47:44 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108d54f537e5eabd_d20251227_m054641_c001_v0001185_t0023_u01766814401551") 2025/12/27 05:47:44 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d06d_d20251227_m054632_c001_v7007000_t0000_u01766814392222") 2025/12/27 05:47:44 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114cb19436b09c4e_d20251227_m054628_c001_v0001172_t0016_u01766814388074") 2025/12/27 05:47:44 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10383a3491b4fb7d_d20251227_m054641_c001_v0001173_t0042_u01766814401753") 2025/12/27 05:47:44 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d06e_d20251227_m054632_c001_v7007000_t0000_u01766814392403") 2025/12/27 05:47:44 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111bf918ff02aba9_d20251227_m054628_c001_v0001183_t0045_u01766814388182") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4186c3374abce5d8_d20251227_m054737_c001_v7007000_t0000_u01766814457988") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11553c43257de09d_d20251227_m054736_c001_v0001167_t0055_u01766814456529") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1042c11ad57f5420_d20251227_m054734_c001_v0001130_t0039_u01766814454640") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4186c3374abce5a5_d20251227_m054728_c001_v7007000_t0000_u01766814448219") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104a556ee743753a_d20251227_m054726_c001_v0001173_t0056_u01766814446738") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11111503897e08f9_d20251227_m054724_c001_v0001099_t0024_u01766814444796") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4186c3374abce59d_d20251227_m054717_c001_v7007000_t0000_u01766814437979") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104b1dbbce65a2e4_d20251227_m054716_c001_v0001167_t0034_u01766814436481") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114cb19436b09cba_d20251227_m054714_c001_v0001172_t0001_u01766814434289") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f408e6ed2ce50b7a1_d20251227_m054647_c001_v7007000_t0000_u01766814407673") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f102038bc8bb4b525_d20251227_m054646_c001_v0001109_t0026_u01766814406138") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111bf918ff02abd1_d20251227_m054644_c001_v0001183_t0033_u01766814404364") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d072_d20251227_m054635_c001_v7007000_t0000_u01766814395866") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1062431e3ab3f1f5_d20251227_m054634_c001_v0001043_t0044_u01766814394530") 2025/12/27 05:47:44 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1042c11ad57f539d_d20251227_m054632_c001_v0001130_t0008_u01766814392586") 2025/12/27 05:47:45 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:47:45 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aab9_d20251227_m054732_c001_v7007000_t0000_u01766814452785") 2025/12/27 05:47:45 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11717f180873d6ee_d20251227_m054652_c001_v0001098_t0006_u01766814412577") 2025/12/27 05:47:45 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d076_d20251227_m054642_c001_v7007000_t0000_u01766814402514") 2025/12/27 05:47:45 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11875f7eb3d9b5b4_d20251227_m054629_c001_v0001177_t0059_u01766814389951") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aaba_d20251227_m054732_c001_v7007000_t0000_u01766814452966") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f106a400790b2d84e_d20251227_m054723_c001_v0001179_t0059_u01766814443297") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f41958158be5fff71_d20251227_m054655_c001_v7007000_t0000_u01766814415753") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104a556ee74371e4_d20251227_m054652_c001_v0001173_t0049_u01766814412938") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d077_d20251227_m054642_c001_v7007000_t0000_u01766814402694") 2025/12/27 05:47:45 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1126f6e258453d5e_d20251227_m054629_c001_v0001185_t0007_u01766814389347") 2025/12/27 05:47:46 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aabb_d20251227_m054733_c001_v7007000_t0000_u01766814453148") 2025/12/27 05:47:46 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1098663c8ae290d4_d20251227_m054652_c001_v0001185_t0033_u01766814412941") 2025/12/27 05:47:46 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d078_d20251227_m054642_c001_v7007000_t0000_u01766814402875") 2025/12/27 05:47:46 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11209f70594747b7_d20251227_m054629_c001_v0001117_t0030_u01766814389576") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aabc_d20251227_m054733_c001_v7007000_t0000_u01766814453328") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11206071cf5a4559_d20251227_m054723_c001_v0001167_t0002_u01766814443659") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10326d02579797e9_d20251227_m054700_c001_v0001185_t0056_u01766814420717") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1129730be42bc7d3_d20251227_m054652_c001_v0001144_t0035_u01766814412969") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d079_d20251227_m054643_c001_v7007000_t0000_u01766814403056") 2025/12/27 05:47:46 DEBUG : file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1044ba3f6417ca20_d20251227_m054629_c001_v0001109_t0049_u01766814389764") 2025/12/27 05:47:46 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aabd_d20251227_m054733_c001_v7007000_t0000_u01766814453512") 2025/12/27 05:47:46 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1107b7c130d7e1d4_d20251227_m054704_c001_v0001131_t0013_u01766814424035") 2025/12/27 05:47:46 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108b5d17c425a0b0_d20251227_m054653_c001_v0001104_t0041_u01766814413076") 2025/12/27 05:47:46 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d07a_d20251227_m054643_c001_v7007000_t0000_u01766814403236") 2025/12/27 05:47:46 DEBUG : file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1126f6e258453d68_d20251227_m054629_c001_v0001185_t0019_u01766814389559") 2025/12/27 05:47:46 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aabf_d20251227_m054733_c001_v7007000_t0000_u01766814453692") 2025/12/27 05:47:46 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115a780f931524d1_d20251227_m054723_c001_v0001185_t0046_u01766814443663") 2025/12/27 05:47:47 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f105fdef1d1664418_d20251227_m054707_c001_v0001167_t0026_u01766814427453") 2025/12/27 05:47:47 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10059a61ed4adfc8_d20251227_m054653_c001_v0001137_t0001_u01766814413152") 2025/12/27 05:47:47 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d07b_d20251227_m054643_c001_v7007000_t0000_u01766814403418") 2025/12/27 05:47:47 DEBUG : file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11209f70594747b9_d20251227_m054630_c001_v0001117_t0026_u01766814390025") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aac0_d20251227_m054733_c001_v7007000_t0000_u01766814453873") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11776a1f0dde45ce_d20251227_m054723_c001_v0001116_t0049_u01766814443761") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1010fd43f2d47725_d20251227_m054713_c001_v0001172_t0013_u01766814433509") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11436a8e7d25a437_d20251227_m054653_c001_v0001173_t0056_u01766814413427") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d07d_d20251227_m054643_c001_v7007000_t0000_u01766814403599") 2025/12/27 05:47:47 DEBUG : file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1126f6e258453d72_d20251227_m054630_c001_v0001185_t0040_u01766814390039") 2025/12/27 05:47:47 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aac1_d20251227_m054734_c001_v7007000_t0000_u01766814454053") 2025/12/27 05:47:47 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f101b7b2fe64f7660_d20251227_m054653_c001_v0001037_t0042_u01766814413580") 2025/12/27 05:47:47 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d07e_d20251227_m054643_c001_v7007000_t0000_u01766814403780") 2025/12/27 05:47:47 DEBUG : file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11875f7eb3d9b5b6_d20251227_m054630_c001_v0001177_t0028_u01766814390158") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f41958158be6000bd_d20251227_m054742_c001_v7007000_t0000_u01766814462421") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f117ee1f2629e32e0_d20251227_m054741_c001_v0001131_t0037_u01766814461067") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1044ba3f6417ca74_d20251227_m054738_c001_v0001109_t0059_u01766814458571") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6aab7_d20251227_m054732_c001_v7007000_t0000_u01766814452225") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1044ac4950ddca8e_d20251227_m054730_c001_v0001157_t0041_u01766814450947") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11209f70594747da_d20251227_m054728_c001_v0001117_t0051_u01766814448803") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f406a94788040199b_d20251227_m054721_c001_v7007000_t0000_u01766814441837") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10326d0257979af0_d20251227_m054720_c001_v0001185_t0059_u01766814440650") 2025/12/27 05:47:47 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1126f6e25845437a_d20251227_m054718_c001_v0001185_t0021_u01766814438523") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f40284e022c0519b5_d20251227_m054651_c001_v7007000_t0000_u01766814411949") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1183884c925bd17b_d20251227_m054650_c001_v0001098_t0006_u01766814410387") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11875f7eb3d9b5ca_d20251227_m054648_c001_v0001177_t0043_u01766814408257") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f417a86844a27d075_d20251227_m054640_c001_v7007000_t0000_u01766814400507") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1130ae3f85de4651_d20251227_m054639_c001_v0001146_t0011_u01766814399004") 2025/12/27 05:47:48 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1044ba3f6417ca2a_d20251227_m054636_c001_v0001109_t0040_u01766814396452") bisync_test.go:608: TEST resync PASSED === RUN TestBisyncRemoteRemote/resync_modes 2025/12/27 05:47:48 INFO : path1: Making directory 2025/12/27 05:47:48 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1" 2025/12/27 05:47:49 INFO : path2: Making directory 2025/12/27 05:47:49 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2" 2025/12/27 05:47:51 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial" 2025/12/27 05:47:51 DEBUG : Creating backend with remote "/tmp/054620ke/initdir/test_resync_modes-wokixiq5" 2025/12/27 05:47:51 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : Local file system at /tmp/054620ke/initdir/test_resync_modes-wokixiq5: Waiting for checks to finish 2025/12/27 05:47:51 DEBUG : Local file system at /tmp/054620ke/initdir/test_resync_modes-wokixiq5: Waiting for transfers to finish 2025/12/27 05:47:51 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:47:51 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:47:51 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:47:51 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:47:51 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/27 05:47:51 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:47:51 INFO : file1.txt: Copied (new) 2025/12/27 05:47:51 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:47:51 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:47:51 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:47:51 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/27 05:47:51 INFO : file2.txt: Copied (new) 2025/12/27 05:47:51 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles" 2025/12/27 05:47:51 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:47:51 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:51 DEBUG : Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7: Waiting for checks to finish 2025/12/27 05:47:51 DEBUG : Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7: Waiting for transfers to finish 2025/12/27 05:47:51 DEBUG : file1R.txt.d467e63a.partial: size = 42 OK 2025/12/27 05:47:51 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK 2025/12/27 05:47:51 DEBUG : file1R.txt.d467e63a.partial: renamed to: file1R.txt 2025/12/27 05:47:51 INFO : file1R.txt: Copied (new) 2025/12/27 05:47:51 DEBUG : file2.txt.ac4156f2.partial: size = 37 OK 2025/12/27 05:47:51 DEBUG : file1L.txt.684d937d.partial: size = 33 OK 2025/12/27 05:47:51 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2025/12/27 05:47:51 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2025/12/27 05:47:51 DEBUG : file2.txt.ac4156f2.partial: renamed to: file2.txt 2025/12/27 05:47:51 INFO : file2.txt: Copied (new) 2025/12/27 05:47:51 DEBUG : file1L.txt.684d937d.partial: renamed to: file1L.txt 2025/12/27 05:47:51 INFO : file1L.txt: Copied (new) 2025/12/27 05:47:51 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:47:51 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:47:52 NOTICE: checking initFs Local file system at /tmp/054620ke/initdir/test_resync_modes-wokixiq5 2025/12/27 05:47:53 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:47:53 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:53 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:53 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Waiting for checks to finish 2025/12/27 05:47:53 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Waiting for transfers to finish 2025/12/27 05:47:53 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:47:53 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:47:53 INFO : file1.txt: Copied (new) 2025/12/27 05:47:54 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:47:54 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:47:54 INFO : file2.txt: Copied (new) 2025/12/27 05:47:54 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:47:54 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:47:54 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:47:54 NOTICE: checking Path1 B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1 2025/12/27 05:47:54 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:47:54 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:54 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:47:54 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Waiting for checks to finish 2025/12/27 05:47:54 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Waiting for transfers to finish 2025/12/27 05:47:55 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:47:55 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:47:55 INFO : file1.txt: Copied (new) 2025/12/27 05:47:55 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:47:55 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:47:55 INFO : file2.txt: Copied (new) 2025/12/27 05:47:55 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:47:55 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:47:55 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:47:55 NOTICE: checking path2 B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2 2025/12/27 05:47:56 NOTICE: (01) : test resync-mode 2025/12/27 05:47:56 NOTICE: (02) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:47:56 NOTICE: (03) : touch-glob 2001-01-02 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:47:56 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" 2025/12/27 05:47:56 DEBUG : fs cache: renaming cache item "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" to be canonical "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:47:56 DEBUG : file1R.txt: Set modification time 2001-01-02 2025/12/27 05:47:56 NOTICE: (04) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:47:56 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:47:56 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:47:56 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:47:57 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:47:57 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:47:57 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:47:57 DEBUG : file1R.txt: Sizes differ 2025/12/27 05:47:58 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:47:58 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:47:58 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:47:58 NOTICE: (05) : touch-glob 2001-03-04 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:47:58 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:47:58 DEBUG : file1L.txt: Set modification time 2001-03-04 2025/12/27 05:47:58 NOTICE: (06) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:47:58 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:47:58 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:47:58 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:48:00 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:48:00 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:48:00 DEBUG : file1.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1) 2025/12/27 05:48:00 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:48:01 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:48:01 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:48:01 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:48:01 NOTICE: (07) : test bisync run with --resync-mode=newer 2025/12/27 05:48:01 NOTICE: (08) : bisync resync resync-mode=newer 2025/12/27 05:48:10 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:10 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:10 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:48:10 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:48:10 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:10 INFO : Copying Path2 files to Path1 2025/12/27 05:48:10 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:48:10 INFO : There was nothing to transfer 2025/12/27 05:48:10 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:48:10 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:48:10 INFO : Resync updating listings 2025/12/27 05:48:10 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:10 INFO : Bisync successful 2025/12/27 05:48:10 NOTICE: (09) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:48:10 NOTICE: (10) : touch-glob 2001-07-23 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:48:10 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:10 DEBUG : file1R.txt: Set modification time 2001-07-23 2025/12/27 05:48:10 NOTICE: (11) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:48:10 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:48:10 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:48:10 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:11 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:48:12 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:48:12 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:48:12 DEBUG : file1R.txt: Sizes differ 2025/12/27 05:48:13 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:48:13 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:48:13 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:48:13 NOTICE: (12) : touch-glob 2001-08-26 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:48:13 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:13 DEBUG : file1L.txt: Set modification time 2001-08-26 2025/12/27 05:48:13 NOTICE: (13) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:48:13 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:48:13 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:48:13 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:48:14 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:48:15 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:48:15 DEBUG : file1L.txt: Modification times differ by -4200h0m0s: 2001-08-26 00:00:00 +0000 UTC, 2001-03-04 00:00:00 +0000 UTC 2025/12/27 05:48:15 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:48:16 INFO : file1L.txt: Updated modification time in destination 2025/12/27 05:48:16 DEBUG : file1L.txt: Unchanged skipping 2025/12/27 05:48:16 NOTICE: (14) : test bisync run with --resync-mode=path2 2025/12/27 05:48:16 NOTICE: (15) : bisync resync resync-mode=path2 2025/12/27 05:48:25 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:25 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:25 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:48: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/12/27 05:48:25 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:25 INFO : Copying Path2 files to Path1 2025/12/27 05:48:25 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:48:25 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:48:25 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:48:26 INFO : Resync updating listings 2025/12/27 05:48:26 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:26 INFO : Bisync successful 2025/12/27 05:48:26 NOTICE: (16) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:48:26 NOTICE: (17) : touch-glob 2002-07-23 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:48:26 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:26 DEBUG : file1R.txt: Set modification time 2002-07-23 2025/12/27 05:48:26 NOTICE: (18) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:48:26 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:48:26 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:48:26 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:27 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:48:27 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:48:27 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2002-07-23 00:00:00 +0000 UTC, 2001-07-23 00:00:00 +0000 UTC 2025/12/27 05:48:27 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:48:28 INFO : file1R.txt: Updated modification time in destination 2025/12/27 05:48:28 DEBUG : file1R.txt: Unchanged skipping 2025/12/27 05:48:28 NOTICE: (19) : touch-glob 2002-08-26 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:48:28 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:28 DEBUG : file1L.txt: Set modification time 2002-08-26 2025/12/27 05:48:28 NOTICE: (20) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:48:28 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:48:28 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:48:28 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:48:29 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:48:29 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:48:29 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1) 2025/12/27 05:48:29 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:48:31 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:48:31 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:48:31 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:48:31 NOTICE: (21) : test bisync run with --resync-mode=larger 2025/12/27 05:48:31 NOTICE: (22) : bisync resync resync-mode=larger 2025/12/27 05:48:39 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:39 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:39 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:48:39 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:48:39 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:39 INFO : Copying Path2 files to Path1 2025/12/27 05:48:39 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:48:40 INFO : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9 2025/12/27 05:48:40 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:48:40 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:48:40 INFO : Resync updating listings 2025/12/27 05:48:40 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:40 INFO : Bisync successful 2025/12/27 05:48:40 NOTICE: (23) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:48:40 NOTICE: (24) : touch-glob 2003-07-23 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:48:40 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:40 DEBUG : file1R.txt: Set modification time 2003-07-23 2025/12/27 05:48:40 NOTICE: (25) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:48:40 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:48:40 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:48:40 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:41 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:48:41 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:48:41 DEBUG : file1R.txt: Modification times differ by -8760h0m0s: 2003-07-23 00:00:00 +0000 UTC, 2002-07-23 00:00:00 +0000 UTC 2025/12/27 05:48:41 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:48:43 INFO : file1R.txt: Updated modification time in destination 2025/12/27 05:48:43 DEBUG : file1R.txt: Unchanged skipping 2025/12/27 05:48:43 NOTICE: (26) : touch-glob 2003-09-04 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:48:43 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:43 DEBUG : file1L.txt: Set modification time 2003-09-04 2025/12/27 05:48:43 NOTICE: (27) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:48:43 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:48:43 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:48:43 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:48:44 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:48:44 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:48:44 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1) 2025/12/27 05:48:44 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:48:46 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:48:46 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:48:46 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:48:46 NOTICE: (28) : test bisync run with --resync-mode=older 2025/12/27 05:48:46 NOTICE: (29) : bisync resync resync-mode=older 2025/12/27 05:48:55 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:55 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:48:55 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:48:55 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:48:55 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:55 INFO : Copying Path2 files to Path1 2025/12/27 05:48:55 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:48:55 INFO : file1.txt: Path2 is older. Path1: 2003-09-04 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 1032h0m0s 2025/12/27 05:48:56 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:48:56 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:48:56 INFO : Resync updating listings 2025/12/27 05:48:56 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:56 INFO : Bisync successful 2025/12/27 05:48:56 NOTICE: (30) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:48:56 NOTICE: (31) : touch-glob 2004-07-23 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:48:56 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:56 DEBUG : file1R.txt: Set modification time 2004-07-23 2025/12/27 05:48:56 NOTICE: (32) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:48:56 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:48:56 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:48:56 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:48:57 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:48:57 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:48:57 DEBUG : file1R.txt: Modification times differ by -8784h0m0s: 2004-07-23 00:00:00 +0000 UTC, 2003-07-23 00:00:00 +0000 UTC 2025/12/27 05:48:57 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:48:58 INFO : file1R.txt: Updated modification time in destination 2025/12/27 05:48:58 DEBUG : file1R.txt: Unchanged skipping 2025/12/27 05:48:58 NOTICE: (33) : touch-glob 2004-07-23 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:48:58 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:48:58 DEBUG : file1L.txt: Set modification time 2004-07-23 2025/12/27 05:48:58 NOTICE: (34) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:48:58 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:48:58 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:48:58 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:48:59 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:49:00 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:00 DEBUG : file1.txt: size = 42 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1) 2025/12/27 05:49:00 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:49:02 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:49:02 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:49:02 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:49:02 NOTICE: (35) : test bisync run with --resync-mode=smaller 2025/12/27 05:49:02 NOTICE: (36) : bisync resync resync-mode=smaller 2025/12/27 05:49:11 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:11 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:11 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:49:11 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:49:11 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:11 INFO : Copying Path2 files to Path1 2025/12/27 05:49:11 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:49:12 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/12/27 05:49:12 INFO : There was nothing to transfer 2025/12/27 05:49:12 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:49:12 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/12/27 05:49:12 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:49:12 INFO : Resync updating listings 2025/12/27 05:49:12 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:12 INFO : Bisync successful 2025/12/27 05:49:12 NOTICE: (37) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/12/27 05:49:12 NOTICE: (38) : touch-glob 2005-01-02 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:49:12 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:49:12 DEBUG : file1R.txt: Set modification time 2005-01-02 2025/12/27 05:49:12 NOTICE: (39) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:49:12 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:49:12 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:49:12 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:13 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:49:14 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:14 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:49:14 DEBUG : file1R.txt: Sizes differ 2025/12/27 05:49:15 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:49:15 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:49:15 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:49:15 NOTICE: (40) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file2.txt 2025/12/27 05:49:15 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file2.txt" 2025/12/27 05:49:15 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:49:15 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:49:17 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file2.txt" 2025/12/27 05:49:17 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:17 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1) 2025/12/27 05:49:17 DEBUG : file1R.txt: Sizes differ 2025/12/27 05:49:18 DEBUG : file2.txt: size = 42 OK 2025/12/27 05:49:18 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:49:18 INFO : file1R.txt: Copied (replaced existing) to: file2.txt 2025/12/27 05:49:18 NOTICE: (41) : touch-glob 2006-03-04 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:49:18 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:49:18 DEBUG : file1L.txt: Set modification time 2006-03-04 2025/12/27 05:49:18 NOTICE: (42) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:49:18 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:49:18 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:49:18 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:49:20 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:49:20 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:49:20 DEBUG : file1L.txt: Modification times differ by -14136h0m0s: 2006-03-04 00:00:00 +0000 UTC, 2004-07-23 00:00:00 +0000 UTC 2025/12/27 05:49:20 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:49:21 INFO : file1L.txt: Updated modification time in destination 2025/12/27 05:49:21 DEBUG : file1L.txt: Unchanged skipping 2025/12/27 05:49:21 NOTICE: (43) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file2.txt 2025/12/27 05:49:21 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file2.txt" 2025/12/27 05:49:21 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:49:21 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:22 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file2.txt" 2025/12/27 05:49:22 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:22 DEBUG : file2.txt: size = 0 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:49:22 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:49:24 DEBUG : file2.txt: size = 33 OK 2025/12/27 05:49:24 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:49:24 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/12/27 05:49:24 NOTICE: (44) : test bisync run with --resync-mode=path1 2025/12/27 05:49:24 NOTICE: (45) : bisync resync resync-mode=path1 2025/12/27 05:49:33 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:33 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:33 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:49: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/12/27 05:49:33 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:33 INFO : Copying Path2 files to Path1 2025/12/27 05:49:33 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:49:33 INFO : There was nothing to transfer 2025/12/27 05:49:33 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:49:33 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:49:34 INFO : file2.txt: Copied (server-side copy) 2025/12/27 05:49:34 INFO : Resync updating listings 2025/12/27 05:49:34 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:34 INFO : Bisync successful 2025/12/27 05:49:34 NOTICE: (46) : test no winner 2025/12/27 05:49:34 NOTICE: (47) : touch-glob 2022-02-22 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1R.txt 2025/12/27 05:49:34 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:49:34 DEBUG : file1R.txt: Set modification time 2022-02-22 2025/12/27 05:49:34 NOTICE: (48) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file1.txt 2025/12/27 05:49:34 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file1.txt" 2025/12/27 05:49:34 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:49:34 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:35 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file1.txt" 2025/12/27 05:49:35 DEBUG : file1R.txt: size = 42 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:35 DEBUG : file1.txt: size = 33 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:49:35 DEBUG : file1R.txt: Sizes differ 2025/12/27 05:49:37 DEBUG : file1.txt: size = 42 OK 2025/12/27 05:49:37 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:49:37 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/12/27 05:49:37 NOTICE: (49) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file2.txt 2025/12/27 05:49:37 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file2.txt" 2025/12/27 05:49:37 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1R.txt" 2025/12/27 05:49:37 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:49:38 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file2.txt" 2025/12/27 05:49:38 DEBUG : file2.txt: size = 42 OK 2025/12/27 05:49:38 DEBUG : file1R.txt: Modification times differ by -150240h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2005-01-02 00:00:00 +0000 UTC 2025/12/27 05:49:38 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/12/27 05:49:39 INFO : file1R.txt: Updated modification time in destination 2025/12/27 05:49:39 DEBUG : file1R.txt: Unchanged skipping 2025/12/27 05:49:39 NOTICE: (50) : touch-glob 2022-02-22 /tmp/054620ke/datadir/test_resync_modes-kequjat7/ file1L.txt 2025/12/27 05:49:39 DEBUG : fs cache: switching user supplied name "/tmp/054620ke/datadir/test_resync_modes-kequjat7/" for canonical name "/tmp/054620ke/datadir/test_resync_modes-kequjat7" 2025/12/27 05:49:39 DEBUG : file1L.txt: Set modification time 2022-02-22 2025/12/27 05:49:39 NOTICE: (51) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/ file1.txt 2025/12/27 05:49:39 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" as "file1.txt" 2025/12/27 05:49:39 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:49:39 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" 2025/12/27 05:49:41 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1" as "file1.txt" 2025/12/27 05:49:41 DEBUG : file1.txt: size = 33 OK 2025/12/27 05:49:41 DEBUG : file1L.txt: Modification times differ by -140016h0m0s: 2022-02-22 00:00:00 +0000 UTC, 2006-03-04 00:00:00 +0000 UTC 2025/12/27 05:49:41 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:49:42 INFO : file1L.txt: Updated modification time in destination 2025/12/27 05:49:42 DEBUG : file1L.txt: Unchanged skipping 2025/12/27 05:49:42 NOTICE: (52) : copy-as /tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/ file2.txt 2025/12/27 05:49:42 DEBUG : copyFile "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" to "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" as "file2.txt" 2025/12/27 05:49:42 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_resync_modes-kequjat7/file1L.txt" 2025/12/27 05:49:42 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:43 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2" as "file2.txt" 2025/12/27 05:49:43 DEBUG : file1L.txt: size = 33 (Local file system at /tmp/054620ke/datadir/test_resync_modes-kequjat7) 2025/12/27 05:49:43 DEBUG : file2.txt: size = 42 (B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2) 2025/12/27 05:49:43 DEBUG : file1L.txt: Sizes differ 2025/12/27 05:49:45 DEBUG : file2.txt: size = 33 OK 2025/12/27 05:49:45 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/12/27 05:49:45 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/12/27 05:49:45 NOTICE: (53) : test bisync run with --resync-mode=newer 2025/12/27 05:49:45 NOTICE: (54) : bisync resync resync-mode=newer 2025/12/27 05:49:54 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:54 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/12/27 05:49:54 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/12/27 05:49:54 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/12/27 05:49:54 INFO : Synching Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" with Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:54 INFO : Copying Path2 files to Path1 2025/12/27 05:49:54 INFO : - Path2 Resync is copying files to - Path1 2025/12/27 05:49:55 INFO : file1.txt: Copied (server-side copy) 2025/12/27 05:49:55 INFO : file2.txt: Copied (server-side copy) 2025/12/27 05:49:55 INFO : - Path1 Resync is copying files to - Path2 2025/12/27 05:49:55 INFO : Resync updating listings 2025/12/27 05:49:55 INFO : Validating listings for Path1 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path1/" vs Path2 "TestB2:rclone-test-ketahil4lola/054620ke/resync_modes/path2/" 2025/12/27 05:49:55 INFO : Bisync successful 2025/12/27 05:49:55 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:49:55 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108d54f537e5f389_d20251227_m054754_c001_v0001185_t0008_u01766814474089") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108a12335c8c8ef9_d20251227_m054954_c001_v0001167_t0011_u01766814594806") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1014b30dd6014b07_d20251227_m054942_c001_v0001173_t0012_u01766814582289") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1138a1da53514564_d20251227_m054921_c001_v0001145_t0004_u01766814561236") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111e9542f33dcc85_d20251227_m054901_c001_v0001167_t0027_u01766814541541") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f104b1dbbce65a9bd_d20251227_m054855_c001_v0001167_t0039_u01766814535661") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116a374f15911b90_d20251227_m054845_c001_v0001167_t0045_u01766814525895") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114aa89752982627_d20251227_m054840_c001_v0001177_t0017_u01766814520159") 2025/12/27 05:49:55 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1021a5a249240d4f_d20251227_m054831_c001_v0001044_t0055_u01766814511424") 2025/12/27 05:49:56 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111a6b7508409536_d20251227_m054825_c001_v0001185_t0004_u01766814505712") 2025/12/27 05:49:56 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f106f5b8629c83f84_d20251227_m054816_c001_v0001036_t0009_u01766814496128") 2025/12/27 05:49:56 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1165681dd2adcebc_d20251227_m054801_c001_v0001185_t0002_u01766814481621") 2025/12/27 05:49:56 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116d3067cfcabd4e_d20251227_m054753_c001_v0001043_t0059_u01766814473721") 2025/12/27 05:49:56 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f102e31ece77efe95_d20251227_m054955_c001_v0001098_t0022_u01766814595194") 2025/12/27 05:49:56 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f105f3ce2cd3f4b5f_d20251227_m054939_c001_v0001185_t0014_u01766814579874") 2025/12/27 05:49:56 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1025d42b341df8c1_d20251227_m054918_c001_v0001167_t0058_u01766814558581") 2025/12/27 05:49:56 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115c153dd4697da4_d20251227_m054753_c001_v0001179_t0011_u01766814473917") 2025/12/27 05:49:56 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f41292d31e7aff673_d20251227_m054950_c001_v7007000_t0000_u01766814590122") 2025/12/27 05:49:56 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10376e6e55267e92_d20251227_m054948_c001_v0001029_t0012_u01766814588667") 2025/12/27 05:49:56 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116d3067cfcabda0_d20251227_m054946_c001_v0001043_t0033_u01766814586275") 2025/12/27 05:49:56 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f40284e022c051ddc_d20251227_m054928_c001_v7007000_t0000_u01766814568628") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1065b8be791ab2dc_d20251227_m054927_c001_v0001173_t0050_u01766814567172") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108d54f537e5fd23_d20251227_m054925_c001_v0001185_t0006_u01766814565032") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4070f514cdc6acb6_d20251227_m054906_c001_v7007000_t0000_u01766814546087") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1092ae1e5943477d_d20251227_m054904_c001_v0001136_t0019_u01766814544741") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115c153dd4697e14_d20251227_m054902_c001_v0001179_t0058_u01766814542598") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f422c02464b140098_d20251227_m054850_c001_v7007000_t0000_u01766814530719") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f105fdef1d1664987_d20251227_m054849_c001_v0001167_t0046_u01766814529130") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116d3067cfcabd7b_d20251227_m054846_c001_v0001043_t0005_u01766814526784") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f415b2f92af5f5adb_d20251227_m054835_c001_v7007000_t0000_u01766814515558") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11961597054f063e_d20251227_m054834_c001_v0001185_t0055_u01766814514361") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108d54f537e5f740_d20251227_m054832_c001_v0001185_t0052_u01766814512251") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4236d929c4f166fd_d20251227_m054820_c001_v7007000_t0000_u01766814500650") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11553c43257de3d3_d20251227_m054819_c001_v0001167_t0015_u01766814499157") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115c153dd4697db6_d20251227_m054817_c001_v0001179_t0041_u01766814497021") 2025/12/27 05:49:57 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4131050d14290d37_d20251227_m054805_c001_v7007000_t0000_u01766814485837") 2025/12/27 05:49:58 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f108d54f537e5f49c_d20251227_m054804_c001_v0001185_t0040_u01766814484499") 2025/12/27 05:49:58 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116d3067cfcabd56_d20251227_m054802_c001_v0001043_t0050_u01766814482229") 2025/12/27 05:49:59 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/resync_modes/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:49:59 DEBUG : RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1065b8be791aa911_d20251227_m054755_c001_v0001173_t0045_u01766814475601") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f105acf21f797b07f_d20251227_m054937_c001_v0001117_t0001_u01766814577023") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11436a8e7d25b2a3_d20251227_m054933_c001_v0001173_t0046_u01766814573599") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10592de8cd630cfd_d20251227_m054915_c001_v0001173_t0038_u01766814555608") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1011a2b09459c3db_d20251227_m054912_c001_v0001145_t0021_u01766814552622") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115b0c97e527fc61_d20251227_m054858_c001_v0001173_t0055_u01766814538585") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f102f9da3ab916233_d20251227_m054842_c001_v0001173_t0045_u01766814522879") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10592de8cd630861_d20251227_m054828_c001_v0001173_t0015_u01766814508334") 2025/12/27 05:49:59 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111d0c444d209725_d20251227_m054813_c001_v0001145_t0057_u01766814493564") 2025/12/27 05:50:00 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1075af1ba6eea3fe_d20251227_m054810_c001_v0001178_t0023_u01766814490721") 2025/12/27 05:50:00 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1164d5746d47823d_d20251227_m054758_c001_v0001161_t0029_u01766814478791") 2025/12/27 05:50:00 DEBUG : file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e6a41_d20251227_m054755_c001_v0001173_t0028_u01766814475241") 2025/12/27 05:50:00 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f100d2bac98b4aa78_d20251227_m054945_c001_v0001167_t0053_u01766814585243") 2025/12/27 05:50:00 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f107d352af315e78f_d20251227_m054934_c001_v0001173_t0052_u01766814574032") 2025/12/27 05:50:00 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10830d5ca6c6942d_d20251227_m054924_c001_v0001098_t0044_u01766814564314") 2025/12/27 05:50:00 DEBUG : file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e6a49_d20251227_m054755_c001_v0001173_t0026_u01766814475447") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f40284e022c0529ae_d20251227_m054954_c001_v7007000_t0000_u01766814594409") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f100ee84dae6b8bef_d20251227_m054953_c001_v0001183_t0024_u01766814593207") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e7451_d20251227_m054950_c001_v0001173_t0020_u01766814590669") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f418cda27464af6d4_d20251227_m054933_c001_v7007000_t0000_u01766814573027") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10592de8cd630e5d_d20251227_m054931_c001_v0001173_t0028_u01766814571524") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1065b8be791ab30e_d20251227_m054929_c001_v0001173_t0030_u01766814569198") 2025/12/27 05:50:00 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4036db8a939f0055_d20251227_m054911_c001_v7007000_t0000_u01766814551574") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115b0c97e527fd22_d20251227_m054909_c001_v0001173_t0032_u01766814549750") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e7072_d20251227_m054906_c001_v0001173_t0003_u01766814546662") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4001f83a607143dd_d20251227_m054855_c001_v7007000_t0000_u01766814535209") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1025d42b341df752_d20251227_m054853_c001_v0001167_t0002_u01766814533753") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e6f31_d20251227_m054851_c001_v0001173_t0047_u01766814531285") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4217ec34eece975c_d20251227_m054839_c001_v7007000_t0000_u01766814519758") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10326d025797a5ba_d20251227_m054838_c001_v0001185_t0048_u01766814518532") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1065b8be791aad3b_d20251227_m054836_c001_v0001173_t0022_u01766814516095") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f4115f3993a198623_d20251227_m054825_c001_v7007000_t0000_u01766814505330") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f116a374f159119cb_d20251227_m054823_c001_v0001167_t0036_u01766814503611") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e6c82_d20251227_m054821_c001_v0001173_t0025_u01766814501214") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f41958158be6002a2_d20251227_m054810_c001_v7007000_t0000_u01766814490168") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f112646d5d60017b6_d20251227_m054808_c001_v0001173_t0014_u01766814488824") 2025/12/27 05:50:01 DEBUG : modtime_write_test: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1118f554079e6b39_d20251227_m054806_c001_v0001173_t0039_u01766814486398") bisync_test.go:608: TEST resync_modes PASSED === RUN TestBisyncRemoteRemote/rmdirs 2025/12/27 05:50:02 INFO : path1: Making directory 2025/12/27 05:50:02 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/rmdirs/path1" 2025/12/27 05:50:03 INFO : path2: Making directory 2025/12/27 05:50:03 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/rmdirs/path2" 2025/12/27 05:50:04 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial" 2025/12/27 05:50:04 DEBUG : Creating backend with remote "/tmp/054620ke/initdir/test_rmdirs-vafeluc5" 2025/12/27 05:50:04 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : subdir: Making directory with metadata 2025/12/27 05:50:04 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/12/27 05:50:04 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/12/27 05:50:04 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : Local file system at /tmp/054620ke/initdir/test_rmdirs-vafeluc5: Waiting for checks to finish 2025/12/27 05:50:04 DEBUG : Local file system at /tmp/054620ke/initdir/test_rmdirs-vafeluc5: Waiting for transfers to finish 2025/12/27 05:50:04 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt 2025/12/27 05:50:04 INFO : file1.copy1.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt 2025/12/27 05:50:04 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK 2025/12/27 05:50:04 INFO : file1.copy2.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt 2025/12/27 05:50:04 INFO : file1.copy3.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt 2025/12/27 05:50:04 INFO : file1.copy4.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2025/12/27 05:50:04 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:50:04 INFO : file1.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:50:04 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:04 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:50:04 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:50:04 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2025/12/27 05:50:04 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:04 INFO : subdir/file20.txt: Copied (new) 2025/12/27 05:50:04 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt 2025/12/27 05:50:04 INFO : file1.copy5.txt: Copied (new) 2025/12/27 05:50:04 INFO : subdir: Set directory modification time (using SetModTime) 2025/12/27 05:50:04 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles" 2025/12/27 05:50:04 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_rmdirs-fazomoc1" 2025/12/27 05:50:04 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:04 DEBUG : Local file system at /tmp/054620ke/datadir/test_rmdirs-fazomoc1: Waiting for checks to finish 2025/12/27 05:50:04 DEBUG : Local file system at /tmp/054620ke/datadir/test_rmdirs-fazomoc1: Waiting for transfers to finish 2025/12/27 05:50:04 DEBUG : file1.txt.f41fd5ee.partial: size = 19 OK 2025/12/27 05:50:04 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:04 DEBUG : file1.txt.f41fd5ee.partial: renamed to: file1.txt 2025/12/27 05:50:04 INFO : file1.txt: Copied (new) 2025/12/27 05:50:04 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:50:04 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:50:06 NOTICE: checking initFs Local file system at /tmp/054620ke/initdir/test_rmdirs-vafeluc5 2025/12/27 05:50:06 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 INFO : subdir: Making directory 2025/12/27 05:50:06 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:06 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path1: Waiting for checks to finish 2025/12/27 05:50:06 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path1: Waiting for transfers to finish 2025/12/27 05:50:07 DEBUG : file1.copy1.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.copy1.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : file1.copy4.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.copy4.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : file1.copy2.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.copy2.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : file1.copy5.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.copy5.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : file1.copy3.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.copy3.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : subdir/file20.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : subdir/file20.txt: Copied (new) 2025/12/27 05:50:07 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:50:07 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:50:07 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:07 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:50:07 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:07 INFO : file1.txt: Copied (new) 2025/12/27 05:50:07 NOTICE: checking Path1 B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path1 2025/12/27 05:50:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 INFO : subdir: Making directory 2025/12/27 05:50:08 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:08 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path2: Waiting for checks to finish 2025/12/27 05:50:08 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path2: Waiting for transfers to finish 2025/12/27 05:50:08 DEBUG : file1.copy1.txt: size = 0 OK 2025/12/27 05:50:08 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:08 INFO : file1.copy1.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : file1.copy3.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : file1.copy3.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : file1.copy4.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : file1.copy4.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : file1.copy2.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : file1.copy2.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : file1.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : file1.copy5.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : file1.copy5.txt: Copied (new) 2025/12/27 05:50:09 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:50:09 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:50:09 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:09 DEBUG : subdir/file20.txt: size = 0 OK 2025/12/27 05:50:09 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:09 INFO : subdir/file20.txt: Copied (new) 2025/12/27 05:50:09 NOTICE: checking path2 B2 bucket rclone-test-ketahil4lola path 054620ke/rmdirs/path2 2025/12/27 05:50:10 NOTICE: (01) : test rmdirs 2025/12/27 05:50:10 NOTICE: (02) : test initial bisync 2025/12/27 05:50:10 NOTICE: (03) : bisync resync bisync_test.go:1007: skipping test as remote does not support empty dirs === RUN TestBisyncRemoteRemote/volatile 2025/12/27 05:50:10 INFO : path1: Making directory 2025/12/27 05:50:10 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/volatile/path1" 2025/12/27 05:50:11 INFO : path2: Making directory 2025/12/27 05:50:11 DEBUG : Creating backend with remote "TestB2:rclone-test-ketahil4lola/054620ke/volatile/path2" 2025/12/27 05:50:12 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial" 2025/12/27 05:50:12 DEBUG : Creating backend with remote "/tmp/054620ke/initdir/test_volatile-zihocar8" 2025/12/27 05:50:12 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : Local file system at /tmp/054620ke/initdir/test_volatile-zihocar8: Waiting for checks to finish 2025/12/27 05:50:12 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2025/12/27 05:50:12 INFO : file1.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2025/12/27 05:50:12 DEBUG : Local file system at /tmp/054620ke/initdir/test_volatile-zihocar8: Waiting for transfers to finish 2025/12/27 05:50:12 INFO : file2.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2025/12/27 05:50:12 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2025/12/27 05:50:12 INFO : file4.txt: Copied (new) 2025/12/27 05:50:12 INFO : file3.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2025/12/27 05:50:12 INFO : file6.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2025/12/27 05:50:12 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 INFO : file7.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2025/12/27 05:50:12 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2025/12/27 05:50:12 INFO : file5.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2025/12/27 05:50:12 INFO : file8.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2025/12/27 05:50:12 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/12/27 05:50:12 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2025/12/27 05:50:12 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:12 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles" 2025/12/27 05:50:12 DEBUG : Creating backend with remote "/tmp/054620ke/datadir/test_volatile-fodezij1" 2025/12/27 05:50:12 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file10.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file11.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:12 DEBUG : dummy.txt.b3782999.partial: size = 0 OK 2025/12/27 05:50:12 DEBUG : Local file system at /tmp/054620ke/datadir/test_volatile-fodezij1: Waiting for checks to finish 2025/12/27 05:50:12 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/12/27 05:50:12 DEBUG : Local file system at /tmp/054620ke/datadir/test_volatile-fodezij1: Waiting for transfers to finish 2025/12/27 05:50:12 DEBUG : dummy.txt.b3782999.partial: renamed to: dummy.txt 2025/12/27 05:50:12 INFO : dummy.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file10.txt.bdde3bf8.partial: size = 19 OK 2025/12/27 05:50:12 DEBUG : file1.txt.be52b1c9.partial: size = 19 OK 2025/12/27 05:50:12 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:12 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:12 DEBUG : file10.txt.bdde3bf8.partial: renamed to: file10.txt 2025/12/27 05:50:12 INFO : file10.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file1.txt.be52b1c9.partial: renamed to: file1.txt 2025/12/27 05:50:12 INFO : file1.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file11.txt.d4a7309d.partial: size = 19 OK 2025/12/27 05:50:12 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:12 DEBUG : file11.txt.d4a7309d.partial: renamed to: file11.txt 2025/12/27 05:50:12 INFO : file11.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file2.txt.23ff1769.partial: size = 13 OK 2025/12/27 05:50:12 DEBUG : file5L.txt.8dd6541a.partial: size = 39 OK 2025/12/27 05:50:12 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2025/12/27 05:50:12 DEBUG : file5R.txt.ee3b9525.partial: size = 39 OK 2025/12/27 05:50:12 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2025/12/27 05:50:12 DEBUG : file2.txt.23ff1769.partial: renamed to: file2.txt 2025/12/27 05:50:12 INFO : file2.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2025/12/27 05:50:12 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt 2025/12/27 05:50:12 INFO : file5R.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt 2025/12/27 05:50:12 INFO : file5L.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file6.txt.7b4c87b3.partial: size = 19 OK 2025/12/27 05:50:12 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:12 DEBUG : file6.txt.7b4c87b3.partial: renamed to: file6.txt 2025/12/27 05:50:12 INFO : file6.txt: Copied (new) 2025/12/27 05:50:12 DEBUG : file7.txt.38c43fbf.partial: size = 19 OK 2025/12/27 05:50:12 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/12/27 05:50:12 DEBUG : file7.txt.38c43fbf.partial: renamed to: file7.txt 2025/12/27 05:50:12 INFO : file7.txt: Copied (new) 2025/12/27 05:50:12 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path1: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:50:13 INFO : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path2: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:50:14 NOTICE: checking initFs Local file system at /tmp/054620ke/initdir/test_volatile-zihocar8 2025/12/27 05:50:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:14 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path1: Waiting for checks to finish 2025/12/27 05:50:14 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path1: Waiting for transfers to finish 2025/12/27 05:50:15 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:50:15 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:15 INFO : file2.txt: Copied (new) 2025/12/27 05:50:15 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:50:15 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:15 INFO : file1.txt: Copied (new) 2025/12/27 05:50:15 DEBUG : file3.txt: size = 0 OK 2025/12/27 05:50:15 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:15 INFO : file3.txt: Copied (new) 2025/12/27 05:50:15 DEBUG : file4.txt: size = 0 OK 2025/12/27 05:50:15 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:15 INFO : file4.txt: Copied (new) 2025/12/27 05:50:15 DEBUG : file6.txt: size = 0 OK 2025/12/27 05:50:15 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:15 INFO : file6.txt: Copied (new) 2025/12/27 05:50:16 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:50:16 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:50:16 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:16 DEBUG : file8.txt: size = 0 OK 2025/12/27 05:50:16 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:16 INFO : file8.txt: Copied (new) 2025/12/27 05:50:16 DEBUG : file7.txt: size = 0 OK 2025/12/27 05:50:16 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:16 INFO : file7.txt: Copied (new) 2025/12/27 05:50:16 DEBUG : file5.txt: size = 0 OK 2025/12/27 05:50:16 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:16 INFO : file5.txt: Copied (new) 2025/12/27 05:50:16 NOTICE: checking Path1 B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path1 2025/12/27 05:50:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/12/27 05:50:16 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path2: Waiting for checks to finish 2025/12/27 05:50:16 DEBUG : B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path2: Waiting for transfers to finish 2025/12/27 05:50:17 DEBUG : file1.txt: size = 0 OK 2025/12/27 05:50:17 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:17 INFO : file1.txt: Copied (new) 2025/12/27 05:50:17 DEBUG : file2.txt: size = 0 OK 2025/12/27 05:50:17 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:17 INFO : file2.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : RCLONE_TEST: size = 109 OK 2025/12/27 05:50:18 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/12/27 05:50:18 INFO : RCLONE_TEST: Copied (new) 2025/12/27 05:50:18 DEBUG : file5.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file5.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : file3.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file3.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : file4.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file4.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : file6.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file6.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : file7.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file7.txt: Copied (new) 2025/12/27 05:50:18 DEBUG : file8.txt: size = 0 OK 2025/12/27 05:50:18 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/12/27 05:50:18 INFO : file8.txt: Copied (new) 2025/12/27 05:50:18 NOTICE: checking path2 B2 bucket rclone-test-ketahil4lola path 054620ke/volatile/path2 2025/12/27 05:50:18 NOTICE: (01) : test volatile 2025/12/27 05:50:18 NOTICE: (02) : test initial bisync 2025/12/27 05:50:18 NOTICE: (03) : bisync resync bisync_test.go:978: skipping 'volatile' test on non-local as it requires uploading 100 files 2025/12/27 05:50:18 DEBUG : B2 bucket rclone-test-ketahil4lola: Purge remote 2025/12/27 05:50:18 INFO : B2 bucket rclone-test-ketahil4lola: cleaning bucket "rclone-test-ketahil4lola" of all files 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1033b88aa1b0e634_d20251227_m055007_c001_v0001130_t0040_u01766814607485") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.copy1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115a68c51d080139_d20251227_m055006_c001_v0001183_t0009_u01766814606915") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.copy2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f103f8242e40eecdd_d20251227_m055007_c001_v0001099_t0022_u01766814607107") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.copy3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111a762d15b13510_d20251227_m055007_c001_v0001101_t0004_u01766814607296") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.copy4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115a68c51d08013b_d20251227_m055007_c001_v0001183_t0048_u01766814607147") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.copy5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115a68c51d08013d_d20251227_m055007_c001_v0001183_t0008_u01766814607360") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f103f8242e40eecdf_d20251227_m055007_c001_v0001099_t0027_u01766814607408") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path1/subdir/file20.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115a68c51d08013f_d20251227_m055007_c001_v0001183_t0030_u01766814607576") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path2/RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f110b69dc9e638b07_d20251227_m055009_c001_v0001172_t0020_u01766814609448") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path2/file1.copy1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111a6b750840a342_d20251227_m055008_c001_v0001185_t0034_u01766814608839") 2025/12/27 05:50:19 DEBUG : 054620ke/rmdirs/path2/file1.copy2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f113a60be39aa699e_d20251227_m055009_c001_v0001136_t0027_u01766814609264") 2025/12/27 05:50:20 DEBUG : 054620ke/rmdirs/path2/file1.copy3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114aa8975298268b_d20251227_m055009_c001_v0001177_t0018_u01766814609071") 2025/12/27 05:50:20 DEBUG : 054620ke/rmdirs/path2/file1.copy4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111a6b750840a350_d20251227_m055009_c001_v0001185_t0022_u01766814609058") 2025/12/27 05:50:20 DEBUG : 054620ke/rmdirs/path2/file1.copy5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f114aa8975298268d_d20251227_m055009_c001_v0001177_t0059_u01766814609348") 2025/12/27 05:50:20 DEBUG : 054620ke/rmdirs/path2/file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f111a6b750840a35a_d20251227_m055009_c001_v0001185_t0037_u01766814609378") 2025/12/27 05:50:20 DEBUG : 054620ke/rmdirs/path2/subdir/file20.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f113a60be39aa69a0_d20251227_m055009_c001_v0001136_t0006_u01766814609547") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10300a748c2e8a6f_d20251227_m055015_c001_v0001100_t0031_u01766814615644") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1104c9ae68596b6c_d20251227_m055015_c001_v0001173_t0011_u01766814615054") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1165681dd2adde36_d20251227_m055015_c001_v0001185_t0021_u01766814615246") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10939c30dc5e3109_d20251227_m055015_c001_v0001181_t0031_u01766814615456") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1165681dd2adde42_d20251227_m055015_c001_v0001185_t0031_u01766814615475") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1104c9ae68596b74_d20251227_m055015_c001_v0001173_t0009_u01766814615574") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10939c30dc5e310b_d20251227_m055015_c001_v0001181_t0049_u01766814615688") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1165681dd2adde54_d20251227_m055015_c001_v0001185_t0031_u01766814615782") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path1/file8.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f10939c30dc5e310d_d20251227_m055015_c001_v0001181_t0052_u01766814615905") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/RCLONE_TEST: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1069b67b4f1d02fb_d20251227_m055018_c001_v0001178_t0039_u01766814618036") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/file1.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115144416035b10f_d20251227_m055017_c001_v0001154_t0013_u01766814617474") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/file2.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11569f4f086f4c74_d20251227_m055017_c001_v0001172_t0006_u01766814617658") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/file3.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f109aa2e0ff6a2c6f_d20251227_m055017_c001_v0001171_t0036_u01766814617848") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/file4.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f115144416035b113_d20251227_m055017_c001_v0001154_t0002_u01766814617924") 2025/12/27 05:50:20 DEBUG : 054620ke/volatile/path2/file5.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11569f4f086f4c76_d20251227_m055017_c001_v0001172_t0040_u01766814617984") 2025/12/27 05:50:21 DEBUG : 054620ke/volatile/path2/file6.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f1069b67b4f1d02fd_d20251227_m055018_c001_v0001178_t0003_u01766814618252") 2025/12/27 05:50:21 DEBUG : 054620ke/volatile/path2/file7.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f11569f4f086f4c78_d20251227_m055018_c001_v0001172_t0031_u01766814618262") 2025/12/27 05:50:21 DEBUG : 054620ke/volatile/path2/file8.txt: Deleting (id "4_z6f12fd93507d5beb9fb80e1b_f109aa2e0ff6a2c71_d20251227_m055018_c001_v0001171_t0010_u01766814618272") --- PASS: TestBisyncRemoteRemote (241.62s) --- PASS: TestBisyncRemoteRemote/resync (88.01s) --- PASS: TestBisyncRemoteRemote/resync_modes (133.21s) --- SKIP: TestBisyncRemoteRemote/rmdirs (8.13s) --- SKIP: TestBisyncRemoteRemote/volatile (8.54s) PASS 2025/12/27 05:50:21 DEBUG : B2 bucket rclone-test-jerojir1vubi: Purge remote 2025/12/27 05:50:21 INFO : B2 bucket rclone-test-jerojir1vubi: cleaning bucket "rclone-test-jerojir1vubi" of all files 2025/12/27 05:50:22 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^resync$|^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Finished OK in 4m52.860879882s (try 2/5)