"./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5) 2025/08/22 04:40:45 DEBUG : Creating backend with remote "TestB2:rclone-test-rirepib6poge" 2025/08/22 04:40:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/22 04:40:45 DEBUG : Creating backend with remote "/tmp/rclone2578962133" === RUN TestBisyncRemoteRemote 2025/08/22 04:40:45 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho" 2025/08/22 04:40:46 NOTICE: remote: TestB2:rclone-test-nawuzim6miho === RUN TestBisyncRemoteRemote/resync 2025/08/22 04:40:46 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye" 2025/08/22 04:40:47 INFO : path1: Making directory 2025/08/22 04:40:51 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1" 2025/08/22 04:40:52 INFO : path2: Making directory 2025/08/22 04:40:52 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2" 2025/08/22 04:40:53 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2025/08/22 04:40:53 DEBUG : Creating backend with remote "/tmp/044046ye/initdir/test_resync-gubavay2" 2025/08/22 04:40:53 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : Local file system at /tmp/044046ye/initdir/test_resync-gubavay2: Waiting for checks to finish 2025/08/22 04:40:53 DEBUG : Local file system at /tmp/044046ye/initdir/test_resync-gubavay2: Waiting for transfers to finish 2025/08/22 04:40:53 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/22 04:40:53 INFO : file2.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/22 04:40:53 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/22 04:40:53 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 INFO : file1.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/22 04:40:53 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:40:53 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/08/22 04:40:53 INFO : file3.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/08/22 04:40:53 INFO : file6.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/08/22 04:40:53 INFO : file5.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:40:53 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/08/22 04:40:53 INFO : file4.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/08/22 04:40:53 INFO : file7.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2025/08/22 04:40:53 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5" 2025/08/22 04:40:53 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:53 DEBUG : Local file system at /tmp/044046ye/datadir/test_resync-wurupuh5: Waiting for checks to finish 2025/08/22 04:40:53 DEBUG : Local file system at /tmp/044046ye/datadir/test_resync-wurupuh5: Waiting for transfers to finish 2025/08/22 04:40:53 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:40:53 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:40:53 DEBUG : fileA.txt.16ee54da.partial: renamed to: fileA.txt 2025/08/22 04:40:53 INFO : fileA.txt: Copied (new) 2025/08/22 04:40:53 DEBUG : fileB.txt.f0a2c6af.partial: renamed to: fileB.txt 2025/08/22 04:40:53 INFO : fileB.txt: Copied (new) 2025/08/22 04:40:53 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:40:54 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:40:55 NOTICE: checking initFs Local file system at /tmp/044046ye/initdir/test_resync-gubavay2 2025/08/22 04:40:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:55 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Waiting for checks to finish 2025/08/22 04:40:55 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Waiting for transfers to finish 2025/08/22 04:40:56 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file1.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file2.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file4.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file6.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file5.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file3.txt: Copied (new) 2025/08/22 04:40:56 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:40:56 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:40:56 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:56 INFO : file7.txt: Copied (new) 2025/08/22 04:40:56 NOTICE: checking Path1 B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1 2025/08/22 04:40:57 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:40:57 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Waiting for checks to finish 2025/08/22 04:40:57 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Waiting for transfers to finish 2025/08/22 04:40:58 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file1.txt: Copied (new) 2025/08/22 04:40:58 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file2.txt: Copied (new) 2025/08/22 04:40:58 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:40:58 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:40:58 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file3.txt: Copied (new) 2025/08/22 04:40:58 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file5.txt: Copied (new) 2025/08/22 04:40:58 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file4.txt: Copied (new) 2025/08/22 04:40:58 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:58 INFO : file6.txt: Copied (new) 2025/08/22 04:40:59 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:40:59 INFO : file7.txt: Copied (new) 2025/08/22 04:40:59 NOTICE: checking path2 B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2 2025/08/22 04:40:59 NOTICE: (01) : test resync 2025/08/22 04:40:59 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2025/08/22 04:40:59 NOTICE: (03) : purge-children TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/ 2025/08/22 04:40:59 DEBUG : RCLONE_TEST: Remove file 2025/08/22 04:40:59 DEBUG : file1.txt: Remove file 2025/08/22 04:40:59 DEBUG : file2.txt: Remove file 2025/08/22 04:40:59 DEBUG : file3.txt: Remove file 2025/08/22 04:41:00 DEBUG : file4.txt: Remove file 2025/08/22 04:41:00 DEBUG : file5.txt: Remove file 2025/08/22 04:41:00 DEBUG : file6.txt: Remove file 2025/08/22 04:41:00 DEBUG : file7.txt: Remove file 2025/08/22 04:41:00 NOTICE: (04) : bisync resync 2025/08/22 04:41:08 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:08 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:08 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:41:08 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:41:08 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:08 INFO : Copying Path2 files to Path1 2025/08/22 04:41:08 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:41:09 INFO : RCLONE_TEST: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file3.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file2.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file6.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file7.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file5.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : file4.txt: Copied (server-side copy) 2025/08/22 04:41:09 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:41:10 INFO : Resync updating listings 2025/08/22 04:41:10 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:10 INFO : Bisync successful 2025/08/22 04:41:10 NOTICE: (05) : move-listings empty-path1 2025/08/22 04:41:10 NOTICE: (06) : test 2. resync with empty path2, resulting in syncing all content to path2. 2025/08/22 04:41:10 NOTICE: (07) : purge-children TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ 2025/08/22 04:41:10 DEBUG : RCLONE_TEST: Remove file 2025/08/22 04:41:10 DEBUG : file1.txt: Remove file 2025/08/22 04:41:10 DEBUG : file2.txt: Remove file 2025/08/22 04:41:10 DEBUG : file3.txt: Remove file 2025/08/22 04:41:11 DEBUG : file4.txt: Remove file 2025/08/22 04:41:11 DEBUG : file5.txt: Remove file 2025/08/22 04:41:11 DEBUG : file6.txt: Remove file 2025/08/22 04:41:11 DEBUG : file7.txt: Remove file 2025/08/22 04:41:11 NOTICE: (08) : bisync resync 2025/08/22 04:41:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:20 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:41:20 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:41:20 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:20 INFO : Copying Path2 files to Path1 2025/08/22 04:41:20 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:41:20 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:41:20 INFO : RCLONE_TEST: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file2.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file3.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file4.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file6.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file7.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : file5.txt: Copied (server-side copy) 2025/08/22 04:41:21 INFO : Resync updating listings 2025/08/22 04:41:21 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:21 INFO : Bisync successful 2025/08/22 04:41:21 NOTICE: (09) : move-listings empty-path2 2025/08/22 04:41:21 NOTICE: (10) : test 3. exercise all of the various file difference scenarios during a resync. 2025/08/22 04:41:21 NOTICE: (11) : touch-glob 2002-02-02 /tmp/044046ye/datadir/test_resync-wurupuh5/ fileA.txt 2025/08/22 04:41:21 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/" 2025/08/22 04:41:21 DEBUG : Config file has changed externally - reloading 2025/08/22 04:41:21 DEBUG : fs cache: renaming cache item "/tmp/044046ye/datadir/test_resync-wurupuh5/" to be canonical "/tmp/044046ye/datadir/test_resync-wurupuh5" 2025/08/22 04:41:21 DEBUG : fileA.txt: Set modification time 2002-02-02 2025/08/22 04:41:21 NOTICE: (12) : touch-glob 1999-09-09 /tmp/044046ye/datadir/test_resync-wurupuh5/ fileB.txt 2025/08/22 04:41:21 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync-wurupuh5/" for canonical name "/tmp/044046ye/datadir/test_resync-wurupuh5" 2025/08/22 04:41:21 DEBUG : fileB.txt: Set modification time 1999-09-09 2025/08/22 04:41:21 NOTICE: (13) : test = file - path1 - path2 - expected action - who wins 2025/08/22 04:41:21 NOTICE: (14) : test - file1.txt - exists - missing - sync path1 > path2 - path1 2025/08/22 04:41:21 NOTICE: (15) : delete-file TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/file1.txt 2025/08/22 04:41:21 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:22 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" to be canonical "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2" 2025/08/22 04:41:23 INFO : file1.txt: Deleted 2025/08/22 04:41:23 NOTICE: (16) : test - file2.txt - missing - exists - copy path2 > path1 - path2 2025/08/22 04:41:23 NOTICE: (17) : delete-file TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/file2.txt 2025/08/22 04:41:23 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" 2025/08/22 04:41:24 DEBUG : fs cache: renaming cache item "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" to be canonical "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1" 2025/08/22 04:41:25 INFO : file2.txt: Deleted 2025/08/22 04:41:25 NOTICE: (18) : test - file3.txt - exists - newer date - sync path1 > path2 - path1 2025/08/22 04:41:25 NOTICE: (19) : copy-as /tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ file3.txt 2025/08/22 04:41:25 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" as "file3.txt" 2025/08/22 04:41:25 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" 2025/08/22 04:41:25 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:26 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2" as "file3.txt" 2025/08/22 04:41:26 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/08/22 04:41:28 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/08/22 04:41:28 INFO : fileA.txt: Copied (replaced existing) to: file3.txt 2025/08/22 04:41:28 NOTICE: (20) : test - file4.txt - missing - newer date - copy path2 > path1 - path2 2025/08/22 04:41:28 NOTICE: (21) : delete-file TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/file4.txt 2025/08/22 04:41:28 DEBUG : fs cache: switching user supplied name "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" for canonical name "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1" 2025/08/22 04:41:28 INFO : file4.txt: Deleted 2025/08/22 04:41:28 NOTICE: (22) : copy-as /tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ file4.txt 2025/08/22 04:41:28 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" as "file4.txt" 2025/08/22 04:41:28 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" 2025/08/22 04:41:28 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:29 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2" as "file4.txt" 2025/08/22 04:41:29 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/08/22 04:41:31 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/08/22 04:41:31 INFO : fileA.txt: Copied (replaced existing) to: file4.txt 2025/08/22 04:41:31 NOTICE: (23) : test - file5.txt - exists - older date - sync path1 > path2 - path1 2025/08/22 04:41:31 NOTICE: (24) : copy-as /tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ file5.txt 2025/08/22 04:41:31 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" as "file5.txt" 2025/08/22 04:41:31 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt" 2025/08/22 04:41:31 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:32 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2" as "file5.txt" 2025/08/22 04:41:32 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/08/22 04:41:34 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/08/22 04:41:34 INFO : fileB.txt: Copied (replaced existing) to: file5.txt 2025/08/22 04:41:34 NOTICE: (25) : test - file6.txt - older date - newer date - sync path1 > path2 - path1 2025/08/22 04:41:34 NOTICE: (26) : copy-as /tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/ file6.txt 2025/08/22 04:41:34 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" as "file6.txt" 2025/08/22 04:41:34 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/fileB.txt" 2025/08/22 04:41:34 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" 2025/08/22 04:41:35 DEBUG : operations.CopyFile "fileB.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1" as "file6.txt" 2025/08/22 04:41:35 DEBUG : fileB.txt: Sizes differ (src 19 vs dst 0) 2025/08/22 04:41:37 DEBUG : fileB.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/08/22 04:41:37 INFO : fileB.txt: Copied (replaced existing) to: file6.txt 2025/08/22 04:41:37 NOTICE: (27) : copy-as /tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ file6.txt 2025/08/22 04:41:37 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" as "file6.txt" 2025/08/22 04:41:37 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync-wurupuh5/fileA.txt" 2025/08/22 04:41:37 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:38 DEBUG : operations.CopyFile "fileA.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2" as "file6.txt" 2025/08/22 04:41:38 DEBUG : fileA.txt: Sizes differ (src 19 vs dst 0) 2025/08/22 04:41:40 DEBUG : fileA.txt: sha1 = be91a3d4ae9841cfe52de8379de8d1d248201b9c OK 2025/08/22 04:41:40 INFO : fileA.txt: Copied (replaced existing) to: file6.txt 2025/08/22 04:41:40 NOTICE: (28) : test - file7.txt - exists - exists (same) - none - same 2025/08/22 04:41:40 NOTICE: (29) : test run bisync with resync 2025/08/22 04:41:40 NOTICE: (30) : bisync resync 2025/08/22 04:41:47 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:47 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:47 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:41:47 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:41:47 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:47 INFO : Copying Path2 files to Path1 2025/08/22 04:41:47 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:41:49 INFO : file4.txt: Copied (server-side copy) 2025/08/22 04:41:49 INFO : file2.txt: Copied (server-side copy) 2025/08/22 04:41:49 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:41:49 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:41:50 INFO : file5.txt: Copied (server-side copy) 2025/08/22 04:41:50 INFO : file3.txt: Copied (server-side copy) 2025/08/22 04:41:50 INFO : file6.txt: Updated modification time in destination 2025/08/22 04:41:50 INFO : Resync updating listings 2025/08/22 04:41:50 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:50 INFO : Bisync successful 2025/08/22 04:41:50 NOTICE: (31) : copy-listings mixed-diffs 2025/08/22 04:41:50 NOTICE: (32) : test run normal bisync 2025/08/22 04:41:50 NOTICE: (33) : bisync 2025/08/22 04:41:58 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:58 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:41:58 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:41:58 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:41:58 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:58 INFO : Building Path1 and Path2 listings 2025/08/22 04:41:58 INFO : Path1 checking for diffs 2025/08/22 04:41:58 INFO : Path2 checking for diffs 2025/08/22 04:41:58 INFO : No changes found 2025/08/22 04:41:58 INFO : Updating listings 2025/08/22 04:41:58 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:41:58 INFO : Bisync successful 2025/08/22 04:41:58 NOTICE: (34) : test 4. confirm critical error on normal sync of empty path. 2025/08/22 04:41:58 NOTICE: (35) : purge-children TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/ 2025/08/22 04:41:58 DEBUG : RCLONE_TEST: Remove file 2025/08/22 04:41:58 DEBUG : file1.txt: Remove file 2025/08/22 04:41:58 DEBUG : file2.txt: Remove file 2025/08/22 04:41:59 DEBUG : file3.txt: Remove file 2025/08/22 04:41:59 DEBUG : file4.txt: Remove file 2025/08/22 04:41:59 DEBUG : file5.txt: Remove file 2025/08/22 04:41:59 DEBUG : file6.txt: Remove file 2025/08/22 04:41:59 DEBUG : file7.txt: Remove file 2025/08/22 04:42:00 NOTICE: (36) : bisync 2025/08/22 04:42:07 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:07 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:07 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:42:07 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:42:07 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync/path2/" 2025/08/22 04:42:07 INFO : Building Path1 and Path2 listings 2025/08/22 04:42:08 INFO : Path1 checking for diffs 2025/08/22 04:42:08 INFO : Path2 checking for diffs 2025/08/22 04:42:08 ERROR : Empty current Path2 listing. Cannot sync to an empty directory: /tmp/044046ye/workdir/TestB2_rclone-test-nawuzim6miho_044046ye_resync_path1..TestB2_rclone-test-nawuzim6miho_044046ye_resync_path2.path2.lst-new 2025/08/22 04:42:08 ERROR : Bisync critical error: empty current Path2 listing: /tmp/044046ye/workdir/TestB2_rclone-test-nawuzim6miho_044046ye_resync_path1..TestB2_rclone-test-nawuzim6miho_044046ye_resync_path2.path2.lst-new 2025/08/22 04:42:08 ERROR : Bisync aborted. Must run --resync to recover. 2025/08/22 04:42:08 NOTICE: Bisync error: bisync aborted 2025/08/22 04:42:08 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:42:08 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1095f5e5ed8f5dd9_d20250822_m044108_c001_v0001099_t0019_u01755837668799") 2025/08/22 04:42:08 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e650738b_d20250822_m044059_c001_v7007000_t0000_u01755837659513") 2025/08/22 04:42:08 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1024879ded0ccbac_d20250822_m044056_c001_v0001183_t0059_u01755837656633") 2025/08/22 04:42:08 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1009dbeac65e8fdd_d20250822_m044109_c001_v0001171_t0037_u01755837669188") 2025/08/22 04:42:08 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e650738c_d20250822_m044059_c001_v7007000_t0000_u01755837659719") 2025/08/22 04:42:08 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101812a231a0716e_d20250822_m044056_c001_v0001183_t0001_u01755837656060") 2025/08/22 04:42:08 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1066cab78e00fd61_d20250822_m044148_c001_v0001157_t0049_u01755837708617") 2025/08/22 04:42:08 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcc7c_d20250822_m044125_c001_v7007000_t0000_u01755837685001") 2025/08/22 04:42:08 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1085f6a670190fbb_d20250822_m044109_c001_v0001181_t0020_u01755837669198") 2025/08/22 04:42:08 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e650738d_d20250822_m044059_c001_v7007000_t0000_u01755837659903") 2025/08/22 04:42:08 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109fde4d775ddb72_d20250822_m044056_c001_v0001180_t0029_u01755837656257") 2025/08/22 04:42:08 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1042fdd9de9d5c08_d20250822_m044109_c001_v0001176_t0024_u01755837669213") 2025/08/22 04:42:08 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e650738e_d20250822_m044100_c001_v7007000_t0000_u01755837660089") 2025/08/22 04:42:08 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10562423b3c71951_d20250822_m044056_c001_v0001038_t0038_u01755837656445") 2025/08/22 04:42:08 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10580c95b5fdd5bf_d20250822_m044148_c001_v0001104_t0014_u01755837708255") 2025/08/22 04:42:09 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcc80_d20250822_m044128_c001_v7007000_t0000_u01755837688392") 2025/08/22 04:42:09 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f114f7bf04b72ca84_d20250822_m044109_c001_v0001115_t0047_u01755837669205") 2025/08/22 04:42:09 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e6507390_d20250822_m044100_c001_v7007000_t0000_u01755837660275") 2025/08/22 04:42:09 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101812a231a07174_d20250822_m044056_c001_v0001183_t0006_u01755837656281") 2025/08/22 04:42:09 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f117ac7088e189328_d20250822_m044109_c001_v0001131_t0023_u01755837669444") 2025/08/22 04:42:09 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e6507391_d20250822_m044100_c001_v7007000_t0000_u01755837660464") 2025/08/22 04:42:09 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109fde4d775ddb74_d20250822_m044056_c001_v0001180_t0043_u01755837656464") 2025/08/22 04:42:09 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10184c9b5cfd90c3_d20250822_m044137_c001_v0001179_t0027_u01755837697391") 2025/08/22 04:42:09 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f116eeb544ea87063_d20250822_m044109_c001_v0001165_t0000_u01755837669487") 2025/08/22 04:42:09 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e6507392_d20250822_m044100_c001_v7007000_t0000_u01755837660651") 2025/08/22 04:42:09 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101812a231a07178_d20250822_m044056_c001_v0001183_t0002_u01755837656476") 2025/08/22 04:42:09 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f117f3b63c33c4474_d20250822_m044109_c001_v0001179_t0025_u01755837669510") 2025/08/22 04:42:09 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e6507393_d20250822_m044100_c001_v7007000_t0000_u01755837660836") 2025/08/22 04:42:09 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101812a231a0717c_d20250822_m044056_c001_v0001183_t0025_u01755837656678") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcca5_d20250822_m044203_c001_v7007000_t0000_u01755837723599") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10079b563b8c3532_d20250822_m044202_c001_v0001131_t0015_u01755837722257") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109fde4d775ddce6_d20250822_m044200_c001_v0001180_t0028_u01755837720482") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcca3_d20250822_m044154_c001_v7007000_t0000_u01755837714153") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1095f5e5ed8f5e5e_d20250822_m044152_c001_v0001099_t0017_u01755837712626") 2025/08/22 04:42:09 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101812a231a073a5_d20250822_m044150_c001_v0001183_t0007_u01755837710849") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f407a47d19c5c003d_d20250822_m044144_c001_v7007000_t0000_u01755837704065") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f112d0af5cd7dfe0e_d20250822_m044142_c001_v0001172_t0038_u01755837702650") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1024879ded0ccd48_d20250822_m044140_c001_v0001183_t0000_u01755837700883") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcc70_d20250822_m044115_c001_v7007000_t0000_u01755837675610") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1179c8d7e0298381_d20250822_m044114_c001_v0001102_t0010_u01755837674287") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10562423b3c71967_d20250822_m044112_c001_v0001038_t0009_u01755837672249") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f418897f1e6507395_d20250822_m044104_c001_v7007000_t0000_u01755837664176") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f104ffc1fd98941a8_d20250822_m044102_c001_v0001120_t0056_u01755837662796") 2025/08/22 04:42:10 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109fde4d775ddb88_d20250822_m044101_c001_v0001180_t0029_u01755837661024") 2025/08/22 04:42:10 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:42:11 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e3_d20250822_m044158_c001_v7007000_t0000_u01755837718635") 2025/08/22 04:42:11 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f106638dcacd11d34_d20250822_m044120_c001_v0001183_t0004_u01755837680637") 2025/08/22 04:42:11 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ce5_d20250822_m044110_c001_v7007000_t0000_u01755837670400") 2025/08/22 04:42:11 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111f0567c9153e8e_d20250822_m044058_c001_v0001136_t0033_u01755837658193") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e4_d20250822_m044158_c001_v7007000_t0000_u01755837718820") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1017f34584fc2176_d20250822_m044149_c001_v0001105_t0017_u01755837709508") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f404f5cb368323a4b_d20250822_m044123_c001_v7007000_t0000_u01755837683177") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101554ad3fd35275_d20250822_m044120_c001_v0001161_t0052_u01755837680858") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ce6_d20250822_m044110_c001_v7007000_t0000_u01755837670585") 2025/08/22 04:42:11 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f115d5c7c863294ac_d20250822_m044057_c001_v0001116_t0052_u01755837657814") 2025/08/22 04:42:11 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e5_d20250822_m044159_c001_v7007000_t0000_u01755837719006") 2025/08/22 04:42:11 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f117495276b26d7e1_d20250822_m044121_c001_v0001176_t0016_u01755837681012") 2025/08/22 04:42:11 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ce7_d20250822_m044110_c001_v7007000_t0000_u01755837670771") 2025/08/22 04:42:11 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107b243e9459cbdf_d20250822_m044058_c001_v0001043_t0007_u01755837658002") 2025/08/22 04:42:11 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e6_d20250822_m044159_c001_v7007000_t0000_u01755837719192") 2025/08/22 04:42:12 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1167f1abf9080671_d20250822_m044149_c001_v0001116_t0045_u01755837709782") 2025/08/22 04:42:12 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f117cac4aa498d452_d20250822_m044127_c001_v0001037_t0016_u01755837687789") 2025/08/22 04:42:12 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f103a8e525f924782_d20250822_m044121_c001_v0001131_t0033_u01755837681033") 2025/08/22 04:42:12 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ce9_d20250822_m044110_c001_v7007000_t0000_u01755837670958") 2025/08/22 04:42:12 DEBUG : file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101acd9ddd1b04c2_d20250822_m044058_c001_v0001136_t0025_u01755837658387") 2025/08/22 04:42:12 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e7_d20250822_m044159_c001_v7007000_t0000_u01755837719377") 2025/08/22 04:42:12 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f103510d73574188c_d20250822_m044131_c001_v0001146_t0020_u01755837691162") 2025/08/22 04:42:12 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11573640661a2140_d20250822_m044121_c001_v0001100_t0025_u01755837681057") 2025/08/22 04:42:12 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ceb_d20250822_m044111_c001_v7007000_t0000_u01755837671144") 2025/08/22 04:42:12 DEBUG : file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f115d5c7c863294ae_d20250822_m044058_c001_v0001116_t0029_u01755837658418") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e8_d20250822_m044159_c001_v7007000_t0000_u01755837719563") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f104e1601d7a61fe7_d20250822_m044149_c001_v0001171_t0034_u01755837709893") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107565e42eaee614_d20250822_m044134_c001_v0001042_t0013_u01755837694140") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1018507696c8c4fd_d20250822_m044121_c001_v0001116_t0012_u01755837681231") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525cec_d20250822_m044111_c001_v7007000_t0000_u01755837671330") 2025/08/22 04:42:12 DEBUG : file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107b243e9459cbe1_d20250822_m044058_c001_v0001043_t0029_u01755837658462") 2025/08/22 04:42:12 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0ea_d20250822_m044159_c001_v7007000_t0000_u01755837719749") 2025/08/22 04:42:12 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10748ec412623c25_d20250822_m044149_c001_v0001106_t0047_u01755837709913") 2025/08/22 04:42:12 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101554ad3fd352ee_d20250822_m044140_c001_v0001161_t0051_u01755837700218") 2025/08/22 04:42:12 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f113d3103fd1ff14f_d20250822_m044121_c001_v0001099_t0057_u01755837681245") 2025/08/22 04:42:13 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525ced_d20250822_m044111_c001_v7007000_t0000_u01755837671514") 2025/08/22 04:42:13 DEBUG : file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111f0567c9153e90_d20250822_m044058_c001_v0001136_t0059_u01755837658499") 2025/08/22 04:42:13 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0eb_d20250822_m044159_c001_v7007000_t0000_u01755837719934") 2025/08/22 04:42:13 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f106d59cc9a4fbd7e_d20250822_m044121_c001_v0001044_t0047_u01755837681407") 2025/08/22 04:42:13 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525cee_d20250822_m044111_c001_v7007000_t0000_u01755837671699") 2025/08/22 04:42:13 DEBUG : file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101acd9ddd1b04c6_d20250822_m044058_c001_v0001136_t0014_u01755837658692") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f407a47d19c5c0046_d20250822_m044207_c001_v7007000_t0000_u01755837727805") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f103779752cbf9bdc_d20250822_m044206_c001_v0001176_t0022_u01755837726503") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107b243e9459cc65_d20250822_m044204_c001_v0001043_t0006_u01755837724165") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b0e2_d20250822_m044158_c001_v7007000_t0000_u01755837718060") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1096ecf03b5e88d9_d20250822_m044156_c001_v0001098_t0047_u01755837716762") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f101acd9ddd1b05d8_d20250822_m044154_c001_v0001136_t0030_u01755837714717") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4167ba517f1dbf0f_d20250822_m044147_c001_v7007000_t0000_u01755837707854") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1080ee5289883ec2_d20250822_m044146_c001_v0001171_t0003_u01755837706514") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111f0567c9153f82_d20250822_m044144_c001_v0001136_t0025_u01755837704614") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f404f5cb368323a3c_d20250822_m044120_c001_v7007000_t0000_u01755837680043") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119045c79cbe6275_d20250822_m044118_c001_v0001041_t0006_u01755837678629") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f115d5c7c863294ea_d20250822_m044116_c001_v0001116_t0032_u01755837676160") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4174a87bfb525cda_d20250822_m044108_c001_v7007000_t0000_u01755837668407") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10435d4445db7c23_d20250822_m044107_c001_v0001184_t0015_u01755837667179") 2025/08/22 04:42:13 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107b243e9459cbed_d20250822_m044104_c001_v0001043_t0049_u01755837664734") bisync_test.go:596: TEST resync PASSED === RUN TestBisyncRemoteRemote/resync_modes 2025/08/22 04:42:14 INFO : path1: Making directory 2025/08/22 04:42:14 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1" 2025/08/22 04:42:15 INFO : path2: Making directory 2025/08/22 04:42:15 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2" 2025/08/22 04:42:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial" 2025/08/22 04:42:16 DEBUG : Creating backend with remote "/tmp/044046ye/initdir/test_resync_modes-jeronid6" 2025/08/22 04:42:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : Local file system at /tmp/044046ye/initdir/test_resync_modes-jeronid6: Waiting for checks to finish 2025/08/22 04:42:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:42:16 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/22 04:42:16 INFO : file1.txt: Copied (new) 2025/08/22 04:42:16 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:42:16 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/22 04:42:16 INFO : file2.txt: Copied (new) 2025/08/22 04:42:16 DEBUG : Local file system at /tmp/044046ye/initdir/test_resync_modes-jeronid6: Waiting for transfers to finish 2025/08/22 04:42:16 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/22 04:42:16 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/22 04:42:16 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:42:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles" 2025/08/22 04:42:16 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:16 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:16 DEBUG : Local file system at /tmp/044046ye/datadir/test_resync_modes-semepaz5: Waiting for checks to finish 2025/08/22 04:42:16 DEBUG : Local file system at /tmp/044046ye/datadir/test_resync_modes-semepaz5: Waiting for transfers to finish 2025/08/22 04:42:16 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2025/08/22 04:42:16 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK 2025/08/22 04:42:16 DEBUG : file2.txt.7cc9b07.partial: renamed to: file2.txt 2025/08/22 04:42:16 INFO : file2.txt: Copied (new) 2025/08/22 04:42:16 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2025/08/22 04:42:16 DEBUG : file1R.txt.cb75035e.partial: renamed to: file1R.txt 2025/08/22 04:42:16 INFO : file1R.txt: Copied (new) 2025/08/22 04:42:16 DEBUG : file1L.txt.7d07f91a.partial: renamed to: file1L.txt 2025/08/22 04:42:16 INFO : file1L.txt: Copied (new) 2025/08/22 04:42:16 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:42:17 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:42:18 NOTICE: checking initFs Local file system at /tmp/044046ye/initdir/test_resync_modes-jeronid6 2025/08/22 04:42:18 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:42:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:18 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Waiting for checks to finish 2025/08/22 04:42:18 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Waiting for transfers to finish 2025/08/22 04:42:19 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:42:19 INFO : file2.txt: Copied (new) 2025/08/22 04:42:19 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:42:19 INFO : file1.txt: Copied (new) 2025/08/22 04:42:19 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:42:19 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:42:19 NOTICE: checking Path1 B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1 2025/08/22 04:42:20 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:42:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:20 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:42:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Waiting for checks to finish 2025/08/22 04:42:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Waiting for transfers to finish 2025/08/22 04:42:21 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:42:21 INFO : file1.txt: Copied (new) 2025/08/22 04:42:21 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:42:21 INFO : file2.txt: Copied (new) 2025/08/22 04:42:21 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:42:21 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:42:21 NOTICE: checking path2 B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2 2025/08/22 04:42:21 NOTICE: (01) : test resync-mode 2025/08/22 04:42:21 NOTICE: (02) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:42:21 NOTICE: (03) : touch-glob 2001-01-02 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:42:21 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" 2025/08/22 04:42:21 DEBUG : fs cache: renaming cache item "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" to be canonical "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:21 DEBUG : file1R.txt: Set modification time 2001-01-02 2025/08/22 04:42:21 NOTICE: (04) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:42:21 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:42:21 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:42:21 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:22 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:42:23 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 0) 2025/08/22 04:42:25 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:42:25 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:42:25 NOTICE: (05) : touch-glob 2001-03-04 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:42:25 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:25 DEBUG : file1L.txt: Set modification time 2001-03-04 2025/08/22 04:42:25 NOTICE: (06) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:42:25 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:42:25 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:42:25 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:42:26 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:42:26 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 0) 2025/08/22 04:42:28 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:42:28 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:42:28 NOTICE: (07) : test bisync run with --resync-mode=newer 2025/08/22 04:42:28 NOTICE: (08) : bisync resync resync-mode=newer 2025/08/22 04:42:36 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:36 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:36 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:42:36 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:42:36 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:36 INFO : Copying Path2 files to Path1 2025/08/22 04:42:36 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:42:36 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:42:37 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:42:37 INFO : Resync updating listings 2025/08/22 04:42:37 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:37 INFO : Bisync successful 2025/08/22 04:42:37 NOTICE: (09) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:42:37 NOTICE: (10) : touch-glob 2001-07-23 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:42:37 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:37 DEBUG : file1R.txt: Set modification time 2001-07-23 2025/08/22 04:42:37 NOTICE: (11) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:42:37 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:42:37 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:42:37 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:38 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:42:38 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 33) 2025/08/22 04:42:40 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:42:40 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:42:40 NOTICE: (12) : touch-glob 2001-08-26 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:42:40 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:40 DEBUG : file1L.txt: Set modification time 2001-08-26 2025/08/22 04:42:40 NOTICE: (13) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:42:40 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:42:40 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:42:40 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:42:41 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:42:41 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/08/22 04:42:41 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:42:42 INFO : file1L.txt: Updated modification time in destination 2025/08/22 04:42:42 DEBUG : file1L.txt: Unchanged skipping 2025/08/22 04:42:42 NOTICE: (14) : test bisync run with --resync-mode=path2 2025/08/22 04:42:42 NOTICE: (15) : bisync resync resync-mode=path2 2025/08/22 04:42:51 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:51 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:42:51 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:42:51 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:42:51 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:51 INFO : Copying Path2 files to Path1 2025/08/22 04:42:51 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:42:51 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:42:51 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:42:51 INFO : Resync updating listings 2025/08/22 04:42:51 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:51 INFO : Bisync successful 2025/08/22 04:42:51 NOTICE: (16) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:42:51 NOTICE: (17) : touch-glob 2002-07-23 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:42:51 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:51 DEBUG : file1R.txt: Set modification time 2002-07-23 2025/08/22 04:42:51 NOTICE: (18) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:42:51 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:42:51 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:42:51 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:42:53 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:42:53 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/08/22 04:42:53 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:42:54 INFO : file1R.txt: Updated modification time in destination 2025/08/22 04:42:54 DEBUG : file1R.txt: Unchanged skipping 2025/08/22 04:42:54 NOTICE: (19) : touch-glob 2002-08-26 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:42:54 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:42:54 DEBUG : file1L.txt: Set modification time 2002-08-26 2025/08/22 04:42:54 NOTICE: (20) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:42:54 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:42:54 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:42:54 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:42:55 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:42:55 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42) 2025/08/22 04:42:57 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:42:57 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:42:57 NOTICE: (21) : test bisync run with --resync-mode=larger 2025/08/22 04:42:57 NOTICE: (22) : bisync resync resync-mode=larger 2025/08/22 04:43:05 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:05 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:05 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:43:05 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:43:05 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:05 INFO : Copying Path2 files to Path1 2025/08/22 04:43:05 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:43:05 INFO : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9 2025/08/22 04:43:06 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:43:06 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:43:06 INFO : Resync updating listings 2025/08/22 04:43:06 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:06 INFO : Bisync successful 2025/08/22 04:43:06 NOTICE: (23) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:43:06 NOTICE: (24) : touch-glob 2003-07-23 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:43:06 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:06 DEBUG : file1R.txt: Set modification time 2003-07-23 2025/08/22 04:43:06 NOTICE: (25) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:43:06 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:43:06 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:43:06 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:08 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:43:08 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/08/22 04:43:08 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:43:09 INFO : file1R.txt: Updated modification time in destination 2025/08/22 04:43:09 DEBUG : file1R.txt: Unchanged skipping 2025/08/22 04:43:09 NOTICE: (26) : touch-glob 2003-09-04 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:43:09 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:09 DEBUG : file1L.txt: Set modification time 2003-09-04 2025/08/22 04:43:09 NOTICE: (27) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:43:09 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:43:09 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:43:09 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:43:10 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:43:10 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42) 2025/08/22 04:43:12 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:43:12 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:43:12 NOTICE: (28) : test bisync run with --resync-mode=older 2025/08/22 04:43:12 NOTICE: (29) : bisync resync resync-mode=older 2025/08/22 04:43:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:20 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:20 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:43:20 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:43:20 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:20 INFO : Copying Path2 files to Path1 2025/08/22 04:43:20 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:43:20 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/08/22 04:43:20 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:43:20 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:43:21 INFO : Resync updating listings 2025/08/22 04:43:21 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:21 INFO : Bisync successful 2025/08/22 04:43:21 NOTICE: (30) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:43:21 NOTICE: (31) : touch-glob 2004-07-23 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:43:21 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:21 DEBUG : file1R.txt: Set modification time 2004-07-23 2025/08/22 04:43:21 NOTICE: (32) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:43:21 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:43:21 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:43:21 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:22 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:43:22 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/08/22 04:43:22 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:43:23 INFO : file1R.txt: Updated modification time in destination 2025/08/22 04:43:23 DEBUG : file1R.txt: Unchanged skipping 2025/08/22 04:43:23 NOTICE: (33) : touch-glob 2004-07-23 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:43:23 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:23 DEBUG : file1L.txt: Set modification time 2004-07-23 2025/08/22 04:43:23 NOTICE: (34) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:43:23 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:43:23 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:43:23 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:43:24 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:43:24 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42) 2025/08/22 04:43:26 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:43:26 INFO : file1L.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:43:26 NOTICE: (35) : test bisync run with --resync-mode=smaller 2025/08/22 04:43:26 NOTICE: (36) : bisync resync resync-mode=smaller 2025/08/22 04:43:35 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:35 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:35 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:43:35 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:43:35 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:35 INFO : Copying Path2 files to Path1 2025/08/22 04:43:35 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:43:35 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/08/22 04:43:35 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:43:35 INFO : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9 2025/08/22 04:43:36 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:43:36 INFO : Resync updating listings 2025/08/22 04:43:36 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:36 INFO : Bisync successful 2025/08/22 04:43:36 NOTICE: (37) : test changed on both paths and NOT identical - file1 (file1R, file1L) 2025/08/22 04:43:36 NOTICE: (38) : touch-glob 2005-01-02 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:43:36 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:36 DEBUG : file1R.txt: Set modification time 2005-01-02 2025/08/22 04:43:36 NOTICE: (39) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:43:36 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:43:36 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:43:36 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:37 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:43:37 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 33) 2025/08/22 04:43:38 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:43:38 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:43:38 NOTICE: (40) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file2.txt 2025/08/22 04:43:38 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file2.txt" 2025/08/22 04:43:38 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:43:38 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:43:39 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file2.txt" 2025/08/22 04:43:40 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 0) 2025/08/22 04:43:41 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:43:41 INFO : file1R.txt: Copied (replaced existing) to: file2.txt 2025/08/22 04:43:41 NOTICE: (41) : touch-glob 2006-03-04 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:43:41 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:41 DEBUG : file1L.txt: Set modification time 2006-03-04 2025/08/22 04:43:41 NOTICE: (42) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:43:41 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:43:41 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:43:41 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:43:43 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:43:43 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/08/22 04:43:43 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:43:44 INFO : file1L.txt: Updated modification time in destination 2025/08/22 04:43:44 DEBUG : file1L.txt: Unchanged skipping 2025/08/22 04:43:44 NOTICE: (43) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file2.txt 2025/08/22 04:43:44 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file2.txt" 2025/08/22 04:43:44 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:43:44 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:45 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file2.txt" 2025/08/22 04:43:45 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 0) 2025/08/22 04:43:47 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:43:47 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/08/22 04:43:47 NOTICE: (44) : test bisync run with --resync-mode=path1 2025/08/22 04:43:47 NOTICE: (45) : bisync resync resync-mode=path1 2025/08/22 04:43:56 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:56 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:43:56 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:43:56 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:43:56 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:56 INFO : Copying Path2 files to Path1 2025/08/22 04:43:56 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:43:56 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:43:57 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:43:57 INFO : file2.txt: Copied (server-side copy) 2025/08/22 04:43:57 INFO : Resync updating listings 2025/08/22 04:43:57 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:57 INFO : Bisync successful 2025/08/22 04:43:57 NOTICE: (46) : test no winner 2025/08/22 04:43:57 NOTICE: (47) : touch-glob 2022-02-22 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1R.txt 2025/08/22 04:43:57 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:43:57 DEBUG : file1R.txt: Set modification time 2022-02-22 2025/08/22 04:43:57 NOTICE: (48) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file1.txt 2025/08/22 04:43:57 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file1.txt" 2025/08/22 04:43:57 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:43:57 DEBUG : Config file has changed externally - reloading 2025/08/22 04:43:57 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:43:58 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file1.txt" 2025/08/22 04:43:58 DEBUG : file1R.txt: Sizes differ (src 42 vs dst 33) 2025/08/22 04:44:00 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:44:00 INFO : file1R.txt: Copied (replaced existing) to: file1.txt 2025/08/22 04:44:00 NOTICE: (49) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file2.txt 2025/08/22 04:44:00 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file2.txt" 2025/08/22 04:44:00 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1R.txt" 2025/08/22 04:44:00 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:44:01 DEBUG : operations.CopyFile "file1R.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file2.txt" 2025/08/22 04:44:01 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/08/22 04:44:01 DEBUG : file1R.txt: sha1 = 2618b868824bd0a3b40f52a600bdf9f1a11b6752 OK 2025/08/22 04:44:02 INFO : file1R.txt: Updated modification time in destination 2025/08/22 04:44:02 DEBUG : file1R.txt: Unchanged skipping 2025/08/22 04:44:02 NOTICE: (50) : touch-glob 2022-02-22 /tmp/044046ye/datadir/test_resync_modes-semepaz5/ file1L.txt 2025/08/22 04:44:02 DEBUG : fs cache: switching user supplied name "/tmp/044046ye/datadir/test_resync_modes-semepaz5/" for canonical name "/tmp/044046ye/datadir/test_resync_modes-semepaz5" 2025/08/22 04:44:02 DEBUG : file1L.txt: Set modification time 2022-02-22 2025/08/22 04:44:02 NOTICE: (51) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/ file1.txt 2025/08/22 04:44:02 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" as "file1.txt" 2025/08/22 04:44:02 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:44:02 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" 2025/08/22 04:44:04 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1" as "file1.txt" 2025/08/22 04:44:04 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/08/22 04:44:04 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:44:05 INFO : file1L.txt: Updated modification time in destination 2025/08/22 04:44:05 DEBUG : file1L.txt: Unchanged skipping 2025/08/22 04:44:05 NOTICE: (52) : copy-as /tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/ file2.txt 2025/08/22 04:44:05 DEBUG : copyFile "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" to "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" as "file2.txt" 2025/08/22 04:44:05 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_resync_modes-semepaz5/file1L.txt" 2025/08/22 04:44:05 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:44:06 DEBUG : operations.CopyFile "file1L.txt" to "B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2" as "file2.txt" 2025/08/22 04:44:07 DEBUG : file1L.txt: Sizes differ (src 33 vs dst 42) 2025/08/22 04:44:08 DEBUG : file1L.txt: sha1 = 6ff9acdd8109de3e4aab0bc72d8fa377c85d59dd OK 2025/08/22 04:44:08 INFO : file1L.txt: Copied (replaced existing) to: file2.txt 2025/08/22 04:44:08 NOTICE: (53) : test bisync run with --resync-mode=newer 2025/08/22 04:44:08 NOTICE: (54) : bisync resync resync-mode=newer 2025/08/22 04:44:16 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:44:16 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata 2025/08/22 04:44:16 INFO : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set. 2025/08/22 04:44:16 INFO : Bisyncing with Comparison Settings: { "Modtime": true, "Size": true, "Checksum": false, "HashType1": 0, "HashType2": 0, "NoSlowHash": false, "SlowHashSyncOnly": false, "SlowHashDetected": false, "DownloadHash": false } 2025/08/22 04:44:16 INFO : Synching Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" with Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:44:16 INFO : Copying Path2 files to Path1 2025/08/22 04:44:16 INFO : - Path2 Resync is copying files to - Path1 2025/08/22 04:44:16 INFO : file1.txt: Copied (server-side copy) 2025/08/22 04:44:17 INFO : file2.txt: Copied (server-side copy) 2025/08/22 04:44:17 INFO : - Path1 Resync is copying files to - Path2 2025/08/22 04:44:17 INFO : Resync updating listings 2025/08/22 04:44:17 INFO : Validating listings for Path1 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path1/" vs Path2 "TestB2:rclone-test-nawuzim6miho/044046ye/resync_modes/path2/" 2025/08/22 04:44:17 INFO : Bisync successful 2025/08/22 04:44:17 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:17 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1077cec240955cad_d20250822_m044219_c001_v0001101_t0006_u01755837739679") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f113d98633672a3bd_d20250822_m044416_c001_v0001180_t0013_u01755837856697") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119c81fb75057208_d20250822_m044405_c001_v0001032_t0008_u01755837845315") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1055fc2d1d17e73f_d20250822_m044344_c001_v0001093_t0039_u01755837824357") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10209eb3a242602f_d20250822_m044326_c001_v0001115_t0007_u01755837806282") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109b271f4f7117be_d20250822_m044320_c001_v0001176_t0034_u01755837800806") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11837f5c8a7df53f_d20250822_m044312_c001_v0001181_t0046_u01755837792336") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f116e1cd98544ee5d_d20250822_m044305_c001_v0001091_t0027_u01755837785879") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f100f24d2217119cc_d20250822_m044257_c001_v0001134_t0019_u01755837777176") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11326b8387d2b32e_d20250822_m044251_c001_v0001182_t0026_u01755837771623") 2025/08/22 04:44:17 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f108631b4c157e176_d20250822_m044242_c001_v0001183_t0000_u01755837762768") 2025/08/22 04:44:18 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1178e7a1238bb30a_d20250822_m044227_c001_v0001171_t0044_u01755837747726") 2025/08/22 04:44:18 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10230b3ae64fd708_d20250822_m044219_c001_v0001150_t0040_u01755837739489") 2025/08/22 04:44:18 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1017899abb7acae8_d20250822_m044416_c001_v0001181_t0056_u01755837856924") 2025/08/22 04:44:18 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11326b8387d2b552_d20250822_m044402_c001_v0001182_t0049_u01755837842861") 2025/08/22 04:44:18 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10668f6c1fd96c5b_d20250822_m044341_c001_v0001092_t0019_u01755837821524") 2025/08/22 04:44:18 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1066cab78e00fdd7_d20250822_m044219_c001_v0001157_t0047_u01755837739293") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f401150c739392092_d20250822_m044412_c001_v7007000_t0000_u01755837852639") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f100c8dfc80bb4b79_d20250822_m044411_c001_v0001130_t0036_u01755837851343") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1066cab78e00ffd3_d20250822_m044409_c001_v0001157_t0033_u01755837849057") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4209e2bde214cfd9_d20250822_m044351_c001_v7007000_t0000_u01755837831847") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f115cf0d6b0debe8b_d20250822_m044350_c001_v0001146_t0038_u01755837830300") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1077cec240955e33_d20250822_m044347_c001_v0001101_t0056_u01755837827835") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4018560ff834b126_d20250822_m044330_c001_v7007000_t0000_u01755837810940") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f117290cfa170646d_d20250822_m044329_c001_v0001145_t0030_u01755837809547") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10230b3ae64fd828_d20250822_m044327_c001_v0001150_t0004_u01755837807216") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f41604f794277c3ef_d20250822_m044316_c001_v7007000_t0000_u01755837796526") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11068f529733e1e3_d20250822_m044315_c001_v0001157_t0032_u01755837795224") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1066cab78e00fede_d20250822_m044312_c001_v0001157_t0022_u01755837792910") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f411122d9355548d1_d20250822_m044301_c001_v7007000_t0000_u01755837781399") 2025/08/22 04:44:18 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1124b16cb4047084_d20250822_m044300_c001_v0001100_t0013_u01755837780093") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1077cec240955d5f_d20250822_m044257_c001_v0001101_t0000_u01755837777821") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f412d3a4cc62d0959_d20250822_m044247_c001_v7007000_t0000_u01755837767022") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111b9e37f10eb6cc_d20250822_m044245_c001_v0001146_t0041_u01755837765722") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10230b3ae64fd764_d20250822_m044243_c001_v0001150_t0050_u01755837763368") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f41604f794277c3a0_d20250822_m044232_c001_v7007000_t0000_u01755837752298") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f104d3b822ced1e25_d20250822_m044230_c001_v0001102_t0024_u01755837750950") 2025/08/22 04:44:19 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1066cab78e00fe19_d20250822_m044228_c001_v0001157_t0048_u01755837748540") 2025/08/22 04:44:19 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/resync_modes/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:19 DEBUG : RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f110cf67adc569702_d20250822_m044221_c001_v0001113_t0012_u01755837741342") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1097f10dc4452973_d20250822_m044400_c001_v0001040_t0041_u01755837840116") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1113a7e54203b812_d20250822_m044356_c001_v0001102_t0038_u01755837836824") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1007786947b0f93e_d20250822_m044338_c001_v0001184_t0012_u01755837818763") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1091771f8edfadf6_d20250822_m044335_c001_v0001102_t0018_u01755837815858") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1098a78a863fc898_d20250822_m044323_c001_v0001179_t0030_u01755837803445") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109ff2621e53c8f5_d20250822_m044309_c001_v0001090_t0004_u01755837789277") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10491cd94e5e02b3_d20250822_m044254_c001_v0001177_t0013_u01755837774329") 2025/08/22 04:44:19 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f118bbadc90486089_d20250822_m044240_c001_v0001171_t0059_u01755837760249") 2025/08/22 04:44:20 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f100fa9503ba63ddb_d20250822_m044236_c001_v0001144_t0024_u01755837756972") 2025/08/22 04:44:20 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f106995384138ee74_d20250822_m044224_c001_v0001144_t0016_u01755837744560") 2025/08/22 04:44:20 DEBUG : file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109da28a785ed16d_d20250822_m044220_c001_v0001183_t0027_u01755837740962") 2025/08/22 04:44:20 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f103811ec91e37e18_d20250822_m044408_c001_v0001157_t0030_u01755837848407") 2025/08/22 04:44:20 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f104bb6672b96a1d0_d20250822_m044357_c001_v0001136_t0030_u01755837837171") 2025/08/22 04:44:20 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10291a8a48bf691b_d20250822_m044347_c001_v0001165_t0057_u01755837827255") 2025/08/22 04:44:20 DEBUG : file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1017287ab574d7b2_d20250822_m044221_c001_v0001043_t0029_u01755837741155") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f40585836e67a6f50_d20250822_m044416_c001_v7007000_t0000_u01755837856303") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10142f5905cf1423_d20250822_m044414_c001_v0001153_t0020_u01755837854957") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109da28a785ed626_d20250822_m044413_c001_v0001183_t0026_u01755837853187") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f40978c0e2f9cc1d1_d20250822_m044356_c001_v7007000_t0000_u01755837836229") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10408d8c43672ec3_d20250822_m044354_c001_v0001099_t0054_u01755837834815") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f110cf67adc569829_d20250822_m044352_c001_v0001113_t0059_u01755837832397") 2025/08/22 04:44:20 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f410b0eeab71acda9_d20250822_m044335_c001_v7007000_t0000_u01755837815282") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f107c087ad1431548_d20250822_m044333_c001_v0001172_t0009_u01755837813962") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1017287ab574d87a_d20250822_m044331_c001_v0001043_t0033_u01755837811488") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f4167ba517f1dbf52_d20250822_m044320_c001_v7007000_t0000_u01755837800422") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1093c9fceea10b69_d20250822_m044319_c001_v0001165_t0016_u01755837799223") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109da28a785ed3dc_d20250822_m044317_c001_v0001183_t0007_u01755837797073") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f414ceec2a179b046_d20250822_m044305_c001_v7007000_t0000_u01755837785482") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f100a19f447556773_d20250822_m044304_c001_v0001178_t0031_u01755837784273") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f110cf67adc56979a_d20250822_m044301_c001_v0001113_t0015_u01755837781947") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f400ccce2f0abcdc1_d20250822_m044251_c001_v7007000_t0000_u01755837771214") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1106434b66efc63e_d20250822_m044249_c001_v0001102_t0045_u01755837769884") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1017287ab574d7f4_d20250822_m044247_c001_v0001043_t0045_u01755837767580") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f407a47d19c5c004e_d20250822_m044236_c001_v7007000_t0000_u01755837756388") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11573640661a226b_d20250822_m044234_c001_v0001100_t0026_u01755837754982") 2025/08/22 04:44:21 DEBUG : modtime_write_test: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109da28a785ed1f5_d20250822_m044232_c001_v0001183_t0040_u01755837752838") bisync_test.go:596: TEST resync_modes PASSED === RUN TestBisyncRemoteRemote/rmdirs 2025/08/22 04:44:22 INFO : path1: Making directory 2025/08/22 04:44:22 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/rmdirs/path1" 2025/08/22 04:44:23 INFO : path2: Making directory 2025/08/22 04:44:23 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/rmdirs/path2" 2025/08/22 04:44:24 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial" 2025/08/22 04:44:24 DEBUG : Creating backend with remote "/tmp/044046ye/initdir/test_rmdirs-binafer3" 2025/08/22 04:44:24 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : subdir: Making directory with metadata 2025/08/22 04:44:24 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/08/22 04:44:24 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/08/22 04:44:24 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : Local file system at /tmp/044046ye/initdir/test_rmdirs-binafer3: Waiting for checks to finish 2025/08/22 04:44:24 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt 2025/08/22 04:44:24 DEBUG : Local file system at /tmp/044046ye/initdir/test_rmdirs-binafer3: Waiting for transfers to finish 2025/08/22 04:44:24 INFO : file1.copy1.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt 2025/08/22 04:44:24 INFO : file1.copy2.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt 2025/08/22 04:44:24 INFO : file1.copy4.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt 2025/08/22 04:44:24 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt 2025/08/22 04:44:24 INFO : file1.copy3.txt: Copied (new) 2025/08/22 04:44:24 INFO : file1.copy5.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:24 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/22 04:44:24 INFO : file1.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2025/08/22 04:44:24 INFO : subdir/file20.txt: Copied (new) 2025/08/22 04:44:24 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/22 04:44:24 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/22 04:44:24 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:24 INFO : subdir: Set directory modification time (using SetModTime) 2025/08/22 04:44:24 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles" 2025/08/22 04:44:24 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_rmdirs-biludin2" 2025/08/22 04:44:24 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:24 DEBUG : Local file system at /tmp/044046ye/datadir/test_rmdirs-biludin2: Waiting for checks to finish 2025/08/22 04:44:24 DEBUG : Local file system at /tmp/044046ye/datadir/test_rmdirs-biludin2: Waiting for transfers to finish 2025/08/22 04:44:24 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:24 DEBUG : file1.txt.13f42ab5.partial: renamed to: file1.txt 2025/08/22 04:44:24 INFO : file1.txt: Copied (new) 2025/08/22 04:44:24 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:25 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:26 NOTICE: checking initFs Local file system at /tmp/044046ye/initdir/test_rmdirs-binafer3 2025/08/22 04:44:26 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 INFO : subdir: Making directory 2025/08/22 04:44:26 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:26 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path1: Waiting for checks to finish 2025/08/22 04:44:26 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path1: Waiting for transfers to finish 2025/08/22 04:44:27 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:27 INFO : file1.copy1.txt: Copied (new) 2025/08/22 04:44:27 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:27 INFO : file1.copy4.txt: Copied (new) 2025/08/22 04:44:27 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:27 INFO : file1.copy3.txt: Copied (new) 2025/08/22 04:44:27 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:44:27 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:27 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:27 INFO : file1.copy2.txt: Copied (new) 2025/08/22 04:44:27 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:27 INFO : file1.copy5.txt: Copied (new) 2025/08/22 04:44:28 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:28 INFO : subdir/file20.txt: Copied (new) 2025/08/22 04:44:28 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:28 INFO : file1.txt: Copied (new) 2025/08/22 04:44:28 NOTICE: checking Path1 B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path1 2025/08/22 04:44:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 INFO : subdir: Making directory 2025/08/22 04:44:28 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:28 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path2: Waiting for checks to finish 2025/08/22 04:44:28 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path2: Waiting for transfers to finish 2025/08/22 04:44:29 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:29 INFO : file1.copy1.txt: Copied (new) 2025/08/22 04:44:29 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:29 INFO : file1.copy2.txt: Copied (new) 2025/08/22 04:44:29 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:29 INFO : file1.copy3.txt: Copied (new) 2025/08/22 04:44:30 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:30 INFO : file1.copy4.txt: Copied (new) 2025/08/22 04:44:30 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:44:30 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:30 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:30 INFO : file1.copy5.txt: Copied (new) 2025/08/22 04:44:30 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:30 INFO : file1.txt: Copied (new) 2025/08/22 04:44:30 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:30 INFO : subdir/file20.txt: Copied (new) 2025/08/22 04:44:30 NOTICE: checking path2 B2 bucket rclone-test-nawuzim6miho path 044046ye/rmdirs/path2 2025/08/22 04:44:30 NOTICE: (01) : test rmdirs 2025/08/22 04:44:30 NOTICE: (02) : test initial bisync 2025/08/22 04:44:30 NOTICE: (03) : bisync resync bisync_test.go:996: skipping test as remote does not support empty dirs === RUN TestBisyncRemoteRemote/volatile 2025/08/22 04:44:30 INFO : path1: Making directory 2025/08/22 04:44:30 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/volatile/path1" 2025/08/22 04:44:31 INFO : path2: Making directory 2025/08/22 04:44:31 DEBUG : Creating backend with remote "TestB2:rclone-test-nawuzim6miho/044046ye/volatile/path2" 2025/08/22 04:44:33 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial" 2025/08/22 04:44:33 DEBUG : Creating backend with remote "/tmp/044046ye/initdir/test_volatile-wutibuq6" 2025/08/22 04:44:33 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : Local file system at /tmp/044046ye/initdir/test_volatile-wutibuq6: Waiting for checks to finish 2025/08/22 04:44:33 DEBUG : Local file system at /tmp/044046ye/initdir/test_volatile-wutibuq6: Waiting for transfers to finish 2025/08/22 04:44:33 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/22 04:44:33 INFO : file1.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/22 04:44:33 INFO : file2.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/22 04:44:33 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/08/22 04:44:33 INFO : file3.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/22 04:44:33 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:33 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/08/22 04:44:33 INFO : file4.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/08/22 04:44:33 INFO : file6.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/08/22 04:44:33 INFO : file5.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/08/22 04:44:33 INFO : file7.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt 2025/08/22 04:44:33 INFO : file8.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles" 2025/08/22 04:44:33 DEBUG : Creating backend with remote "/tmp/044046ye/datadir/test_volatile-fisilot2" 2025/08/22 04:44:33 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file10.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file11.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:33 DEBUG : Local file system at /tmp/044046ye/datadir/test_volatile-fisilot2: Waiting for checks to finish 2025/08/22 04:44:33 DEBUG : Local file system at /tmp/044046ye/datadir/test_volatile-fisilot2: Waiting for transfers to finish 2025/08/22 04:44:33 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/22 04:44:33 DEBUG : dummy.txt.75bafa33.partial: renamed to: dummy.txt 2025/08/22 04:44:33 INFO : dummy.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:33 DEBUG : file1.txt.ae546193.partial: renamed to: file1.txt 2025/08/22 04:44:33 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:33 INFO : file1.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file10.txt.ae546193.partial: renamed to: file10.txt 2025/08/22 04:44:33 INFO : file10.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:33 DEBUG : file11.txt.ae546193.partial: renamed to: file11.txt 2025/08/22 04:44:33 INFO : file11.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2025/08/22 04:44:33 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2025/08/22 04:44:33 DEBUG : file5L.txt.c32cc336.partial: renamed to: file5L.txt 2025/08/22 04:44:33 INFO : file5L.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2025/08/22 04:44:33 DEBUG : file5R.txt.aa998d0a.partial: renamed to: file5R.txt 2025/08/22 04:44:33 INFO : file5R.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:33 DEBUG : file2.txt.8872da9c.partial: renamed to: file2.txt 2025/08/22 04:44:33 INFO : file2.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file6.txt.ae546193.partial: renamed to: file6.txt 2025/08/22 04:44:33 INFO : file6.txt: Copied (new) 2025/08/22 04:44:33 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/22 04:44:33 DEBUG : file7.txt.6bedbe24.partial: renamed to: file7.txt 2025/08/22 04:44:33 INFO : file7.txt: Copied (new) 2025/08/22 04:44:33 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path1: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:33 INFO : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path2: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:34 NOTICE: checking initFs Local file system at /tmp/044046ye/initdir/test_volatile-wutibuq6 2025/08/22 04:44:35 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:35 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path1: Waiting for checks to finish 2025/08/22 04:44:35 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path1: Waiting for transfers to finish 2025/08/22 04:44:36 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file1.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file2.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:44:36 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:36 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file3.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file6.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file4.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file8.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file7.txt: Copied (new) 2025/08/22 04:44:36 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:36 INFO : file5.txt: Copied (new) 2025/08/22 04:44:36 NOTICE: checking Path1 B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path1 2025/08/22 04:44:37 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/08/22 04:44:37 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path2: Waiting for checks to finish 2025/08/22 04:44:37 DEBUG : B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path2: Waiting for transfers to finish 2025/08/22 04:44:38 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file1.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file2.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file4.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK 2025/08/22 04:44:38 INFO : RCLONE_TEST: Copied (new) 2025/08/22 04:44:38 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file5.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file3.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file6.txt: Copied (new) 2025/08/22 04:44:38 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:38 INFO : file7.txt: Copied (new) 2025/08/22 04:44:39 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/08/22 04:44:39 INFO : file8.txt: Copied (new) 2025/08/22 04:44:39 NOTICE: checking path2 B2 bucket rclone-test-nawuzim6miho path 044046ye/volatile/path2 2025/08/22 04:44:39 NOTICE: (01) : test volatile 2025/08/22 04:44:39 NOTICE: (02) : test initial bisync 2025/08/22 04:44:39 NOTICE: (03) : bisync resync bisync_test.go:967: skipping 'volatile' test on non-local as it requires uploading 100 files 2025/08/22 04:44:39 DEBUG : B2 bucket rclone-test-nawuzim6miho: Purge remote 2025/08/22 04:44:39 INFO : B2 bucket rclone-test-nawuzim6miho: cleaning bucket "rclone-test-nawuzim6miho" of all files 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111809eb8f82c9b3_d20250822_m044427_c001_v0001171_t0048_u01755837867590") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.copy1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119f5b8a6be8666c_d20250822_m044427_c001_v0001101_t0007_u01755837867009") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.copy2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1033a83d000ed994_d20250822_m044427_c001_v0001109_t0006_u01755837867207") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.copy3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1120aa36ebea500b_d20250822_m044427_c001_v0001171_t0040_u01755837867398") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.copy4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119f5b8a6be8666e_d20250822_m044427_c001_v0001101_t0014_u01755837867406") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.copy5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119f5b8a6be86670_d20250822_m044427_c001_v0001101_t0017_u01755837867711") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1120aa36ebea500f_d20250822_m044427_c001_v0001171_t0031_u01755837867871") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path1/subdir/file20.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f111809eb8f82c9b7_d20250822_m044427_c001_v0001171_t0026_u01755837867891") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119afc9302faf622_d20250822_m044429_c001_v0001098_t0020_u01755837869834") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.copy1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1027411090173f54_d20250822_m044429_c001_v0001099_t0015_u01755837869270") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.copy2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10700c9f4fc22c60_d20250822_m044429_c001_v0001136_t0012_u01755837869460") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.copy3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119fee83e27e91c3_d20250822_m044429_c001_v0001093_t0035_u01755837869646") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.copy4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1027411090173f56_d20250822_m044429_c001_v0001099_t0056_u01755837869571") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.copy5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10700c9f4fc22c62_d20250822_m044429_c001_v0001136_t0054_u01755837869773") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f119fee83e27e91c7_d20250822_m044430_c001_v0001093_t0028_u01755837870069") 2025/08/22 04:44:40 DEBUG : 044046ye/rmdirs/path2/subdir/file20.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1027411090173f58_d20250822_m044430_c001_v0001099_t0056_u01755837870227") 2025/08/22 04:44:40 DEBUG : 044046ye/volatile/path1/RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11689e4e1a410fd7_d20250822_m044436_c001_v0001180_t0006_u01755837876060") 2025/08/22 04:44:40 DEBUG : 044046ye/volatile/path1/file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10341fbd1cb37b11_d20250822_m044435_c001_v0001105_t0044_u01755837875877") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f106cd40380bece80_d20250822_m044435_c001_v0001117_t0031_u01755837875685") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1003a30280d5830b_d20250822_m044436_c001_v0001157_t0022_u01755837876249") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f10341fbd1cb37b13_d20250822_m044436_c001_v0001105_t0036_u01755837876225") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f106cd40380bece84_d20250822_m044436_c001_v0001117_t0004_u01755837876280") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11689e4e1a410fdb_d20250822_m044436_c001_v0001180_t0039_u01755837876299") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1003a30280d5830d_d20250822_m044436_c001_v0001157_t0035_u01755837876529") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path1/file8.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f11689e4e1a410fe1_d20250822_m044436_c001_v0001180_t0046_u01755837876538") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/RCLONE_TEST: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1025dddb0777d73f_d20250822_m044438_c001_v0001137_t0037_u01755837878141") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file1.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109efbc4052bd5ec_d20250822_m044437_c001_v0001120_t0025_u01755837877755") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file2.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1126db8ff9ed6053_d20250822_m044437_c001_v0001044_t0044_u01755837877957") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file3.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1158a3ebaa6f2421_d20250822_m044438_c001_v0001109_t0018_u01755837878325") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file4.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109efbc4052bd5ee_d20250822_m044438_c001_v0001120_t0053_u01755837878153") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file5.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1126db8ff9ed6055_d20250822_m044438_c001_v0001044_t0010_u01755837878301") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file6.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f109efbc4052bd5f2_d20250822_m044438_c001_v0001120_t0037_u01755837878572") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file7.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1025dddb0777d743_d20250822_m044438_c001_v0001137_t0005_u01755837878694") 2025/08/22 04:44:41 DEBUG : 044046ye/volatile/path2/file8.txt: Deleting (id "4_zcfc24db3104ddb0b9f880e1b_f1126db8ff9ed6059_d20250822_m044438_c001_v0001044_t0010_u01755837878782") --- PASS: TestBisyncRemoteRemote (240.10s) --- PASS: TestBisyncRemoteRemote/resync (88.21s) --- PASS: TestBisyncRemoteRemote/resync_modes (127.70s) --- SKIP: TestBisyncRemoteRemote/rmdirs (8.66s) --- SKIP: TestBisyncRemoteRemote/volatile (8.59s) PASS 2025/08/22 04:44:45 DEBUG : B2 bucket rclone-test-rirepib6poge: Purge remote 2025/08/22 04:44:45 INFO : B2 bucket rclone-test-rirepib6poge: cleaning bucket "rclone-test-rirepib6poge" of all files 2025/08/22 04:44:46 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -test.run '^TestBisyncRemoteRemote$/^(resync|resync_modes|rmdirs|volatile)$'" - Finished OK in 4m1.54379268s (try 2/5)