"./bisync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestBisyncRemoteRemote$/^(compare_all|dry_run)$'" - Starting (try 4/5)
2025/10/10 06:41:46 DEBUG : Creating backend with remote "TestDropbox:rclone-test-navupoq8jiyo"
2025/10/10 06:41:46 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/10/10 06:41:46 DEBUG : Creating backend with remote "/tmp/rclone947799781"
=== RUN   TestBisyncRemoteRemote
2025/10/10 06:41:46 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi"
2025/10/10 06:41:47 NOTICE: remote: TestDropbox:rclone-test-homagad7cesi
=== RUN   TestBisyncRemoteRemote/compare_all
2025/10/10 06:41:47 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe"
2025/10/10 06:41:47 INFO  : path1: Making directory
2025/10/10 06:41:48 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1"
2025/10/10 06:41:48 INFO  : path2: Making directory
2025/10/10 06:41:49 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2"
2025/10/10 06:41:49 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/initial"
2025/10/10 06:41:49 DEBUG : Creating backend with remote "/tmp/064147qe/initdir/test_compare_all-yewajax5"
2025/10/10 06:41:49 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : Local file system at /tmp/064147qe/initdir/test_compare_all-yewajax5: Waiting for checks to finish
2025/10/10 06:41:49 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : Local file system at /tmp/064147qe/initdir/test_compare_all-yewajax5: Waiting for transfers to finish
2025/10/10 06:41:49 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/10/10 06:41:49 INFO  : file1.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/10/10 06:41:49 INFO  : file3.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/10/10 06:41:49 INFO  : file2.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/10/10 06:41:49 INFO  : file4.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/10/10 06:41:49 INFO  : file6.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/10/10 06:41:49 INFO  : file5.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/10/10 06:41:49 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:41:49 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/10/10 06:41:49 INFO  : file7.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/10/10 06:41:49 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:41:49 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/10/10 06:41:49 INFO  : file8.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/modfiles"
2025/10/10 06:41:49 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:41:49 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:49 DEBUG : Local file system at /tmp/064147qe/datadir/test_compare_all-yuwuwas4: Waiting for checks to finish
2025/10/10 06:41:49 DEBUG : Local file system at /tmp/064147qe/datadir/test_compare_all-yuwuwas4: Waiting for transfers to finish
2025/10/10 06:41:49 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:41:49 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:41:49 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:41:49 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/10/10 06:41:49 INFO  : file1.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt
2025/10/10 06:41:49 INFO  : file11.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/10/10 06:41:49 INFO  : file10.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/10/10 06:41:49 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt
2025/10/10 06:41:49 INFO  : file2.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:41:49 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/10/10 06:41:49 INFO  : file6.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/10/10 06:41:49 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/10/10 06:41:49 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2025/10/10 06:41:49 INFO  : file5R.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2025/10/10 06:41:49 INFO  : file5L.txt: Copied (new)
2025/10/10 06:41:49 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:41:49 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt
2025/10/10 06:41:49 INFO  : file7.txt: Copied (new)
2025/10/10 06:41:50 ERROR : error listing: directory not found
2025/10/10 06:41:50 ERROR : error listing: directory not found
2025/10/10 06:41:50 NOTICE: checking initFs Local file system at /tmp/064147qe/initdir/test_compare_all-yewajax5
2025/10/10 06:41:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:41:50 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Waiting for checks to finish
2025/10/10 06:41:50 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Waiting for transfers to finish
2025/10/10 06:41:50 DEBUG : file3.txt: Uploading chunk 1/0
2025/10/10 06:41:50 DEBUG : file1.txt: Uploading chunk 1/0
2025/10/10 06:41:50 DEBUG : file2.txt: Uploading chunk 1/0
2025/10/10 06:41:51 DEBUG : file3.txt: Uploading chunk 2/0
2025/10/10 06:41:51 DEBUG : file2.txt: Uploading chunk 2/0
2025/10/10 06:41:51 DEBUG : file4.txt: Uploading chunk 1/0
2025/10/10 06:41:51 DEBUG : file1.txt: Uploading chunk 2/0
2025/10/10 06:41:51 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file3.txt" to batch
2025/10/10 06:41:51 DEBUG : file4.txt: Uploading chunk 2/0
2025/10/10 06:41:51 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file2.txt" to batch
2025/10/10 06:41:51 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file1.txt" to batch
2025/10/10 06:41:51 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file4.txt" to batch
2025/10/10 06:41:51 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 4 starting with: file3.txt
2025/10/10 06:41:52 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 4 starting with: file3.txt
2025/10/10 06:41:52 DEBUG : file4.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:52 INFO  : file4.txt: Copied (new)
2025/10/10 06:41:52 DEBUG : file2.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:52 DEBUG : file3.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:52 INFO  : file2.txt: Copied (new)
2025/10/10 06:41:52 INFO  : file3.txt: Copied (new)
2025/10/10 06:41:52 DEBUG : file1.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:52 INFO  : file1.txt: Copied (new)
2025/10/10 06:41:52 DEBUG : file6.txt: Uploading chunk 1/0
2025/10/10 06:41:52 DEBUG : file8.txt: Uploading chunk 1/0
2025/10/10 06:41:52 DEBUG : file5.txt: Uploading chunk 1/0
2025/10/10 06:41:52 DEBUG : file7.txt: Uploading chunk 1/0
2025/10/10 06:41:52 DEBUG : file8.txt: Uploading chunk 2/0
2025/10/10 06:41:52 DEBUG : file6.txt: Uploading chunk 2/0
2025/10/10 06:41:53 DEBUG : file7.txt: Uploading chunk 2/0
2025/10/10 06:41:53 DEBUG : file5.txt: Uploading chunk 2/0
2025/10/10 06:41:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file8.txt" to batch
2025/10/10 06:41:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file6.txt" to batch
2025/10/10 06:41:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file5.txt" to batch
2025/10/10 06:41:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file7.txt" to batch
2025/10/10 06:41:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 4 starting with: file8.txt
2025/10/10 06:41:54 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 4 starting with: file8.txt
2025/10/10 06:41:54 DEBUG : file7.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:54 INFO  : file7.txt: Copied (new)
2025/10/10 06:41:54 DEBUG : file8.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:54 INFO  : file8.txt: Copied (new)
2025/10/10 06:41:54 DEBUG : file5.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:54 INFO  : file5.txt: Copied (new)
2025/10/10 06:41:54 DEBUG : file6.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:54 INFO  : file6.txt: Copied (new)
2025/10/10 06:41:54 DEBUG : RCLONE_TEST: Uploading chunk 1/1
2025/10/10 06:41:55 DEBUG : RCLONE_TEST: Uploading chunk 2/1
2025/10/10 06:41:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "RCLONE_TEST" to batch
2025/10/10 06:41:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:41:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: RCLONE_TEST
2025/10/10 06:41:57 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: RCLONE_TEST
2025/10/10 06:41:57 DEBUG : RCLONE_TEST: dropbox = c7ddcb950cf985d316be90e07c421557fe39529668db776ef2c16e0c1a1cddee OK
2025/10/10 06:41:57 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:41:57 NOTICE: checking Path1 Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1'
2025/10/10 06:41:57 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:41:57 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Waiting for checks to finish
2025/10/10 06:41:57 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Waiting for transfers to finish
2025/10/10 06:41:57 DEBUG : file3.txt: Uploading chunk 1/0
2025/10/10 06:41:57 DEBUG : file1.txt: Uploading chunk 1/0
2025/10/10 06:41:58 DEBUG : file4.txt: Uploading chunk 1/0
2025/10/10 06:41:58 DEBUG : file2.txt: Uploading chunk 1/0
2025/10/10 06:41:58 DEBUG : file1.txt: Uploading chunk 2/0
2025/10/10 06:41:58 DEBUG : file3.txt: Uploading chunk 2/0
2025/10/10 06:41:58 DEBUG : file4.txt: Uploading chunk 2/0
2025/10/10 06:41:58 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file1.txt" to batch
2025/10/10 06:41:58 DEBUG : file2.txt: Uploading chunk 2/0
2025/10/10 06:41:58 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file3.txt" to batch
2025/10/10 06:41:58 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file2.txt" to batch
2025/10/10 06:41:58 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file4.txt" to batch
2025/10/10 06:41:58 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 4 starting with: file1.txt
2025/10/10 06:41:59 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 4 starting with: file1.txt
2025/10/10 06:41:59 DEBUG : file3.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:59 DEBUG : file2.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:59 INFO  : file2.txt: Copied (new)
2025/10/10 06:41:59 INFO  : file3.txt: Copied (new)
2025/10/10 06:41:59 DEBUG : file4.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:59 INFO  : file4.txt: Copied (new)
2025/10/10 06:41:59 DEBUG : file1.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:41:59 INFO  : file1.txt: Copied (new)
2025/10/10 06:41:59 DEBUG : file7.txt: Uploading chunk 1/0
2025/10/10 06:41:59 DEBUG : file6.txt: Uploading chunk 1/0
2025/10/10 06:41:59 DEBUG : file8.txt: Uploading chunk 1/0
2025/10/10 06:41:59 DEBUG : file5.txt: Uploading chunk 1/0
2025/10/10 06:42:00 DEBUG : file6.txt: Uploading chunk 2/0
2025/10/10 06:42:00 DEBUG : file5.txt: Uploading chunk 2/0
2025/10/10 06:42:00 DEBUG : file7.txt: Uploading chunk 2/0
2025/10/10 06:42:00 DEBUG : file8.txt: Uploading chunk 2/0
2025/10/10 06:42:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file5.txt" to batch
2025/10/10 06:42:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file6.txt" to batch
2025/10/10 06:42:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file8.txt" to batch
2025/10/10 06:42:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file7.txt" to batch
2025/10/10 06:42:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 4 starting with: file5.txt
2025/10/10 06:42:01 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 4 starting with: file5.txt
2025/10/10 06:42:01 DEBUG : file7.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:42:01 INFO  : file7.txt: Copied (new)
2025/10/10 06:42:01 DEBUG : file8.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:42:01 DEBUG : file6.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:42:01 INFO  : file8.txt: Copied (new)
2025/10/10 06:42:01 INFO  : file6.txt: Copied (new)
2025/10/10 06:42:01 DEBUG : file5.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:42:01 INFO  : file5.txt: Copied (new)
2025/10/10 06:42:01 DEBUG : RCLONE_TEST: Uploading chunk 1/1
2025/10/10 06:42:01 DEBUG : RCLONE_TEST: Uploading chunk 2/1
2025/10/10 06:42:02 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "RCLONE_TEST" to batch
2025/10/10 06:42:02 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:02 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: RCLONE_TEST
2025/10/10 06:42:03 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: RCLONE_TEST
2025/10/10 06:42:03 DEBUG : RCLONE_TEST: dropbox = c7ddcb950cf985d316be90e07c421557fe39529668db776ef2c16e0c1a1cddee OK
2025/10/10 06:42:03 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:42:03 NOTICE: checking path2 Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2'
2025/10/10 06:42:03 NOTICE: (01)  : test changes compare-all
2025/10/10 06:42:03 NOTICE: (02)  : test initial bisync
2025/10/10 06:42:03 NOTICE: (03)  : bisync resync compare-all
2025/10/10 06:42:03 DEBUG : Reset feature "Copy"
2025/10/10 06:42:03 DEBUG : Reset feature "Copy"
2025/10/10 06:42:03 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:42:04 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:42:04 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "modtime_write_test" to batch
2025/10/10 06:42:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:08 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:42:09 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:42:09 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "modtime_write_test" to batch
2025/10/10 06:42:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:42:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:42:13 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 512,
	"HashType2": 512,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": true
}
2025/10/10 06:42:13 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:13 INFO  : Copying Path2 files to Path1
2025/10/10 06:42:13 INFO  : - Path2    Resync is copying files to         - Path1
2025/10/10 06:42:13 INFO  : There was nothing to transfer
2025/10/10 06:42:13 INFO  : - Path1    Resync is copying files to         - Path2
2025/10/10 06:42:13 INFO  : There was nothing to transfer
2025/10/10 06:42:13 INFO  : Resync updating listings
2025/10/10 06:42:13 INFO  : Validating listings for Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" vs Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:13 INFO  : Bisync successful
2025/10/10 06:42:13 NOTICE: (04)  : test make modifications on both paths
2025/10/10 06:42:13 NOTICE: (05)  : test new on path2 - file10
2025/10/10 06:42:13 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file10.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/
2025/10/10 06:42:13 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/"
2025/10/10 06:42:13 DEBUG : fs cache: renaming cache item "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" to be canonical "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:13 DEBUG : file10.txt: Set modification time 2001-01-02
2025/10/10 06:42:13 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file10.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" as ""
2025/10/10 06:42:13 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file10.txt"
2025/10/10 06:42:13 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:14 DEBUG : operations.CopyFile "file10.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2'" as "file10.txt"
2025/10/10 06:42:14 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/10/10 06:42:14 DEBUG : file10.txt: Uploading chunk 1/1
2025/10/10 06:42:15 DEBUG : file10.txt: Uploading chunk 2/1
2025/10/10 06:42:15 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file10.txt" to batch
2025/10/10 06:42:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: file10.txt
2025/10/10 06:42:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: file10.txt
2025/10/10 06:42:17 DEBUG : file10.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:42:17 INFO  : file10.txt: Copied (new)
2025/10/10 06:42:17 NOTICE: (07)  : test newer on path2 - file1
2025/10/10 06:42:17 NOTICE: (08)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file1.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/
2025/10/10 06:42:17 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:17 DEBUG : file1.txt: Set modification time 2001-01-02
2025/10/10 06:42:17 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file1.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" as ""
2025/10/10 06:42:17 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file1.txt"
2025/10/10 06:42:17 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:17 DEBUG : operations.CopyFile "file1.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2'" as "file1.txt"
2025/10/10 06:42:17 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:42:17 DEBUG : file1.txt: Uploading chunk 1/1
2025/10/10 06:42:18 DEBUG : file1.txt: Uploading chunk 2/1
2025/10/10 06:42:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file1.txt" to batch
2025/10/10 06:42:19 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:19 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: file1.txt
2025/10/10 06:42:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: file1.txt
2025/10/10 06:42:20 DEBUG : file1.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:42:20 INFO  : file1.txt: Copied (replaced existing)
2025/10/10 06:42:20 NOTICE: (09)  : test new on path1 - file11
2025/10/10 06:42:20 NOTICE: (10)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file11.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/
2025/10/10 06:42:20 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:20 DEBUG : file11.txt: Set modification time 2001-01-02
2025/10/10 06:42:20 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file11.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" as ""
2025/10/10 06:42:20 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file11.txt"
2025/10/10 06:42:20 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/"
2025/10/10 06:42:20 DEBUG : operations.CopyFile "file11.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1'" as "file11.txt"
2025/10/10 06:42:20 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/10/10 06:42:21 DEBUG : file11.txt: Uploading chunk 1/1
2025/10/10 06:42:21 DEBUG : file11.txt: Uploading chunk 2/1
2025/10/10 06:42:21 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file11.txt" to batch
2025/10/10 06:42:22 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:22 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: file11.txt
2025/10/10 06:42:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: file11.txt
2025/10/10 06:42:23 DEBUG : file11.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:42:23 INFO  : file11.txt: Copied (new)
2025/10/10 06:42:23 NOTICE: (11)  : test newer on path1 - file2
2025/10/10 06:42:23 NOTICE: (12)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file2.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/
2025/10/10 06:42:23 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:23 DEBUG : file2.txt: Set modification time 2001-01-02
2025/10/10 06:42:23 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file2.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" as ""
2025/10/10 06:42:23 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file2.txt"
2025/10/10 06:42:23 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/"
2025/10/10 06:42:23 DEBUG : operations.CopyFile "file2.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1'" as "file2.txt"
2025/10/10 06:42:23 DEBUG : file2.txt: Sizes differ (src 13 vs dst 0)
2025/10/10 06:42:24 DEBUG : file2.txt: Uploading chunk 1/1
2025/10/10 06:42:24 DEBUG : file2.txt: Uploading chunk 2/1
2025/10/10 06:42:24 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file2.txt" to batch
2025/10/10 06:42:25 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:25 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: file2.txt
2025/10/10 06:42:26 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: file2.txt
2025/10/10 06:42:26 DEBUG : file2.txt: dropbox = aa7bd1fae1b19dee35c7bd50d644798719ca37fc2e29c776208a5bffe57173ca OK
2025/10/10 06:42:26 INFO  : file2.txt: Copied (replaced existing)
2025/10/10 06:42:26 NOTICE: (13)  : test deleted on path2 - file3
2025/10/10 06:42:26 NOTICE: (14)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file3.txt
2025/10/10 06:42:26 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:26 DEBUG : fs cache: renaming cache item "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" to be canonical "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2"
2025/10/10 06:42:26 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing uploads - please wait...
2025/10/10 06:42:27 INFO  : file3.txt: Deleted
2025/10/10 06:42:27 NOTICE: (15)  : test deleted on path1 - file4
2025/10/10 06:42:27 NOTICE: (16)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file4.txt
2025/10/10 06:42:27 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/"
2025/10/10 06:42:27 DEBUG : fs cache: renaming cache item "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" to be canonical "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1"
2025/10/10 06:42:27 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing uploads - please wait...
2025/10/10 06:42:28 INFO  : file4.txt: Deleted
2025/10/10 06:42:28 NOTICE: (17)  : test deleted on both paths - file8
2025/10/10 06:42:28 NOTICE: (18)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file8.txt
2025/10/10 06:42:28 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1"
2025/10/10 06:42:29 INFO  : file8.txt: Deleted
2025/10/10 06:42:29 NOTICE: (19)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file8.txt
2025/10/10 06:42:29 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2"
2025/10/10 06:42:30 INFO  : file8.txt: Deleted
2025/10/10 06:42:30 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/10/10 06:42:30 NOTICE: (21)  : touch-glob 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/ file5R.txt
2025/10/10 06:42:30 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:30 DEBUG : file5R.txt: Set modification time 2001-01-02
2025/10/10 06:42:30 NOTICE: (22)  : copy-as /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5R.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/ file5.txt
2025/10/10 06:42:30 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5R.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" as "file5.txt"
2025/10/10 06:42:30 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5R.txt"
2025/10/10 06:42:30 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:30 DEBUG : operations.CopyFile "file5R.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2'" as "file5.txt"
2025/10/10 06:42:30 DEBUG : file5R.txt: Sizes differ (src 39 vs dst 0)
2025/10/10 06:42:31 DEBUG : file5.txt: Uploading chunk 1/1
2025/10/10 06:42:31 DEBUG : file5.txt: Uploading chunk 2/1
2025/10/10 06:42:32 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file5.txt" to batch
2025/10/10 06:42:32 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:32 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: file5.txt
2025/10/10 06:42:33 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: file5.txt
2025/10/10 06:42:33 DEBUG : file5R.txt: dropbox = ab00bdb95bb0ada6d648f38df403c8de2a8b0b08d925e2d60bba4a7e33a89b6c OK
2025/10/10 06:42:33 INFO  : file5R.txt: Copied (replaced existing) to: file5.txt
2025/10/10 06:42:33 NOTICE: (23)  : touch-glob 2001-03-04 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/ file5L.txt
2025/10/10 06:42:33 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:33 DEBUG : file5L.txt: Set modification time 2001-03-04
2025/10/10 06:42:33 NOTICE: (24)  : copy-as /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5L.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/ file5.txt
2025/10/10 06:42:33 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5L.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" as "file5.txt"
2025/10/10 06:42:33 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file5L.txt"
2025/10/10 06:42:33 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/"
2025/10/10 06:42:33 DEBUG : operations.CopyFile "file5L.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1'" as "file5.txt"
2025/10/10 06:42:34 DEBUG : file5L.txt: Sizes differ (src 39 vs dst 0)
2025/10/10 06:42:34 DEBUG : file5.txt: Uploading chunk 1/1
2025/10/10 06:42:34 DEBUG : file5.txt: Uploading chunk 2/1
2025/10/10 06:42:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file5.txt" to batch
2025/10/10 06:42:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: file5.txt
2025/10/10 06:42:37 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: file5.txt
2025/10/10 06:42:37 DEBUG : file5L.txt: dropbox = f1f0875619752e49a5a2df9cb6875cc0c07f53aec8610752eba588224441fb63 OK
2025/10/10 06:42:37 INFO  : file5L.txt: Copied (replaced existing) to: file5.txt
2025/10/10 06:42:37 NOTICE: (25)  : test newer on path2 and deleted on path1 - file6
2025/10/10 06:42:37 NOTICE: (26)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file6.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/
2025/10/10 06:42:37 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:37 DEBUG : file6.txt: Set modification time 2001-01-02
2025/10/10 06:42:37 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file6.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" as ""
2025/10/10 06:42:37 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file6.txt"
2025/10/10 06:42:37 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:37 DEBUG : operations.CopyFile "file6.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2'" as "file6.txt"
2025/10/10 06:42:37 DEBUG : file6.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:42:38 DEBUG : file6.txt: Uploading chunk 1/1
2025/10/10 06:42:38 DEBUG : file6.txt: Uploading chunk 2/1
2025/10/10 06:42:39 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "file6.txt" to batch
2025/10/10 06:42:39 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:39 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: file6.txt
2025/10/10 06:42:40 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: file6.txt
2025/10/10 06:42:40 DEBUG : file6.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:42:40 INFO  : file6.txt: Copied (replaced existing)
2025/10/10 06:42:40 NOTICE: (27)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file6.txt
2025/10/10 06:42:40 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1"
2025/10/10 06:42:42 INFO  : file6.txt: Deleted
2025/10/10 06:42:42 NOTICE: (28)  : test newer on path1 and deleted on path2 - file7
2025/10/10 06:42:42 NOTICE: (29)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_compare_all-yuwuwas4/file7.txt TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/
2025/10/10 06:42:42 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/" for canonical name "/tmp/064147qe/datadir/test_compare_all-yuwuwas4"
2025/10/10 06:42:42 DEBUG : file7.txt: Set modification time 2001-01-02
2025/10/10 06:42:42 DEBUG : copyFile "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file7.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" as ""
2025/10/10 06:42:42 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_compare_all-yuwuwas4/file7.txt"
2025/10/10 06:42:42 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/"
2025/10/10 06:42:42 DEBUG : operations.CopyFile "file7.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1'" as "file7.txt"
2025/10/10 06:42:42 DEBUG : file7.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:42:43 DEBUG : file7.txt: Uploading chunk 1/1
2025/10/10 06:42:43 DEBUG : file7.txt: Uploading chunk 2/1
2025/10/10 06:42:44 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "file7.txt" to batch
2025/10/10 06:42:44 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:44 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: file7.txt
2025/10/10 06:42:45 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: file7.txt
2025/10/10 06:42:45 DEBUG : file7.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:42:45 INFO  : file7.txt: Copied (replaced existing)
2025/10/10 06:42:45 NOTICE: (30)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file7.txt
2025/10/10 06:42:45 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2"
2025/10/10 06:42:46 INFO  : file7.txt: Deleted
2025/10/10 06:42:46 NOTICE: (31)  : test bisync run
2025/10/10 06:42:46 NOTICE: (32)  : bisync compare-all
2025/10/10 06:42:46 DEBUG : Reset feature "Copy"
2025/10/10 06:42:46 DEBUG : Reset feature "Copy"
2025/10/10 06:42:46 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:42:46 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:42:47 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Adding "modtime_write_test" to batch
2025/10/10 06:42:47 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Batch idle for 500ms so committing
2025/10/10 06:42:47 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:48 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:51 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:42:52 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:42:52 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Adding "modtime_write_test" to batch
2025/10/10 06:42:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Batch idle for 500ms so committing
2025/10/10 06:42:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:42:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:42:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:42:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 512,
	"HashType2": 512,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": true
}
2025/10/10 06:42:56 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:42:56 INFO  : Building Path1 and Path2 listings
2025/10/10 06:42:56 INFO  : Path1 checking for diffs
2025/10/10 06:42:56 INFO  : - Path1    File changed: size (larger), time (newer), hash - file2.txt
2025/10/10 06:42:56 INFO  : - Path1    File was deleted          - file4.txt
2025/10/10 06:42:56 INFO  : - Path1    File changed: size (larger), time (newer), hash - file5.txt
2025/10/10 06:42:56 INFO  : - Path1    File was deleted          - file6.txt
2025/10/10 06:42:56 INFO  : - Path1    File changed: size (larger), time (newer), hash - file7.txt
2025/10/10 06:42:56 INFO  : - Path1    File was deleted          - file8.txt
2025/10/10 06:42:56 INFO  : - Path1    File is new               - file11.txt
2025/10/10 06:42:56 INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/10/10 06:42:56 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/10/10 06:42:56 INFO  : Path2 checking for diffs
2025/10/10 06:42:56 INFO  : - Path2    File changed: size (larger), time (newer), hash - file1.txt
2025/10/10 06:42:56 INFO  : - Path2    File was deleted          - file3.txt
2025/10/10 06:42:56 INFO  : - Path2    File changed: size (larger), time (newer), hash - file5.txt
2025/10/10 06:42:56 INFO  : - Path2    File changed: size (larger), time (newer), hash - file6.txt
2025/10/10 06:42:56 INFO  : - Path2    File was deleted          - file7.txt
2025/10/10 06:42:56 INFO  : - Path2    File was deleted          - file8.txt
2025/10/10 06:42:56 INFO  : - Path2    File is new               - file10.txt
2025/10/10 06:42:56 INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/10/10 06:42:56 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/10/10 06:42:56 INFO  : Applying changes
2025/10/10 06:42:56 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file11.txt
2025/10/10 06:42:56 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file2.txt
2025/10/10 06:42:56 INFO  : - Path2    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file4.txt
2025/10/10 06:42:56 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/10/10 06:42:56 NOTICE: - Path1    Renaming Path1 copy                - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file5.txt.conflict1
2025/10/10 06:42:58 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/10/10 06:42:58 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file5.txt.conflict1
2025/10/10 06:42:58 NOTICE: - Path2    Renaming Path2 copy                - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file5.txt.conflict2
2025/10/10 06:43:00 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/10/10 06:43:00 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file5.txt.conflict2
2025/10/10 06:43:00 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file6.txt
2025/10/10 06:43:00 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/file7.txt
2025/10/10 06:43:00 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file1.txt
2025/10/10 06:43:00 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file10.txt
2025/10/10 06:43:00 INFO  : - Path1    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/file3.txt
2025/10/10 06:43:00 INFO  : - Path2    Do queued copies to                - Path1
2025/10/10 06:43:03 INFO  : file1.txt: Copied (replaced existing)
2025/10/10 06:43:03 INFO  : file10.txt: Copied (new)
2025/10/10 06:43:03 INFO  : file5.txt.conflict2: Copied (new)
2025/10/10 06:43:03 INFO  : file6.txt: Copied (new)
2025/10/10 06:43:04 INFO  : file3.txt: Deleted
2025/10/10 06:43:04 INFO  : - Path1    Do queued copies to                - Path2
2025/10/10 06:43:08 INFO  : file7.txt: Copied (new)
2025/10/10 06:43:08 INFO  : file5.txt.conflict1: Copied (new)
2025/10/10 06:43:08 INFO  : file11.txt: Copied (new)
2025/10/10 06:43:08 INFO  : file2.txt: Copied (replaced existing)
2025/10/10 06:43:08 INFO  : file4.txt: Deleted
2025/10/10 06:43:08 INFO  : Updating listings
2025/10/10 06:43:08 INFO  : Validating listings for Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path1/" vs Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/compare_all/path2/"
2025/10/10 06:43:08 INFO  : Bisync successful
    bisync_test.go:608: TEST compare_all PASSED
=== RUN   TestBisyncRemoteRemote/dry_run
2025/10/10 06:43:10 INFO  : path1: Making directory
2025/10/10 06:43:10 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1"
2025/10/10 06:43:10 INFO  : path2: Making directory
2025/10/10 06:43:11 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2"
2025/10/10 06:43:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/initial"
2025/10/10 06:43:11 DEBUG : Creating backend with remote "/tmp/064147qe/initdir/test_dry_run-sopohoy8"
2025/10/10 06:43:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : Local file system at /tmp/064147qe/initdir/test_dry_run-sopohoy8: Waiting for checks to finish
2025/10/10 06:43:11 DEBUG : Local file system at /tmp/064147qe/initdir/test_dry_run-sopohoy8: Waiting for transfers to finish
2025/10/10 06:43:11 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/10/10 06:43:11 INFO  : file2.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/10/10 06:43:11 INFO  : file3.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/10/10 06:43:11 INFO  : file1.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/10/10 06:43:11 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/10/10 06:43:11 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:43:11 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/10/10 06:43:11 INFO  : file4.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/10/10 06:43:11 INFO  : file5.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/10/10 06:43:11 INFO  : file6.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/10/10 06:43:11 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/10/10 06:43:11 INFO  : file7.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/modfiles"
2025/10/10 06:43:11 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:11 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:11 DEBUG : Local file system at /tmp/064147qe/datadir/test_dry_run-suzedip3: Waiting for checks to finish
2025/10/10 06:43:11 DEBUG : Local file system at /tmp/064147qe/datadir/test_dry_run-suzedip3: Waiting for transfers to finish
2025/10/10 06:43:11 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:43:11 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:43:11 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/10/10 06:43:11 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt
2025/10/10 06:43:11 INFO  : file11.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt
2025/10/10 06:43:11 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/10/10 06:43:11 INFO  : file2.txt: Copied (new)
2025/10/10 06:43:11 INFO  : file1.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:43:11 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/10/10 06:43:11 INFO  : file10.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:43:11 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/10/10 06:43:11 INFO  : file6.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/10/10 06:43:11 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/10/10 06:43:11 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2025/10/10 06:43:11 INFO  : file5R.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2025/10/10 06:43:11 INFO  : file5L.txt: Copied (new)
2025/10/10 06:43:11 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/10/10 06:43:11 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt
2025/10/10 06:43:11 INFO  : file7.txt: Copied (new)
2025/10/10 06:43:12 ERROR : error listing: directory not found
2025/10/10 06:43:13 ERROR : error listing: directory not found
2025/10/10 06:43:13 NOTICE: checking initFs Local file system at /tmp/064147qe/initdir/test_dry_run-sopohoy8
2025/10/10 06:43:13 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:43:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Waiting for checks to finish
2025/10/10 06:43:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Waiting for transfers to finish
2025/10/10 06:43:13 DEBUG : file3.txt: Uploading chunk 1/0
2025/10/10 06:43:13 DEBUG : file1.txt: Uploading chunk 1/0
2025/10/10 06:43:13 DEBUG : file4.txt: Uploading chunk 1/0
2025/10/10 06:43:13 DEBUG : file2.txt: Uploading chunk 1/0
2025/10/10 06:43:13 DEBUG : file3.txt: Uploading chunk 2/0
2025/10/10 06:43:13 DEBUG : file2.txt: Uploading chunk 2/0
2025/10/10 06:43:13 DEBUG : file1.txt: Uploading chunk 2/0
2025/10/10 06:43:14 DEBUG : file4.txt: Uploading chunk 2/0
2025/10/10 06:43:14 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file3.txt" to batch
2025/10/10 06:43:14 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file2.txt" to batch
2025/10/10 06:43:14 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file1.txt" to batch
2025/10/10 06:43:14 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file4.txt" to batch
2025/10/10 06:43:14 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 4 starting with: file3.txt
2025/10/10 06:43:15 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 4 starting with: file3.txt
2025/10/10 06:43:15 DEBUG : file4.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:15 INFO  : file4.txt: Copied (new)
2025/10/10 06:43:15 DEBUG : file1.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:15 INFO  : file1.txt: Copied (new)
2025/10/10 06:43:15 DEBUG : file3.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:15 INFO  : file3.txt: Copied (new)
2025/10/10 06:43:15 DEBUG : file2.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:15 INFO  : file2.txt: Copied (new)
2025/10/10 06:43:15 DEBUG : file5.txt: Uploading chunk 1/0
2025/10/10 06:43:15 DEBUG : file7.txt: Uploading chunk 1/0
2025/10/10 06:43:15 DEBUG : file6.txt: Uploading chunk 1/0
2025/10/10 06:43:15 DEBUG : file5.txt: Uploading chunk 2/0
2025/10/10 06:43:15 DEBUG : RCLONE_TEST: Uploading chunk 1/1
2025/10/10 06:43:15 DEBUG : file7.txt: Uploading chunk 2/0
2025/10/10 06:43:15 DEBUG : file6.txt: Uploading chunk 2/0
2025/10/10 06:43:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file5.txt" to batch
2025/10/10 06:43:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file7.txt" to batch
2025/10/10 06:43:16 DEBUG : RCLONE_TEST: Uploading chunk 2/1
2025/10/10 06:43:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file6.txt" to batch
2025/10/10 06:43:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "RCLONE_TEST" to batch
2025/10/10 06:43:16 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 4 starting with: file5.txt
2025/10/10 06:43:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 4 starting with: file5.txt
2025/10/10 06:43:17 DEBUG : RCLONE_TEST: dropbox = c7ddcb950cf985d316be90e07c421557fe39529668db776ef2c16e0c1a1cddee OK
2025/10/10 06:43:17 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:43:17 DEBUG : file5.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:17 INFO  : file5.txt: Copied (new)
2025/10/10 06:43:17 DEBUG : file6.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:17 DEBUG : file7.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:17 INFO  : file7.txt: Copied (new)
2025/10/10 06:43:17 INFO  : file6.txt: Copied (new)
2025/10/10 06:43:17 NOTICE: checking Path1 Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1'
2025/10/10 06:43:17 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/10/10 06:43:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Waiting for checks to finish
2025/10/10 06:43:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Waiting for transfers to finish
2025/10/10 06:43:17 DEBUG : file2.txt: Uploading chunk 1/0
2025/10/10 06:43:18 DEBUG : file3.txt: Uploading chunk 1/0
2025/10/10 06:43:18 DEBUG : file4.txt: Uploading chunk 1/0
2025/10/10 06:43:18 DEBUG : file1.txt: Uploading chunk 1/0
2025/10/10 06:43:18 DEBUG : file3.txt: Uploading chunk 2/0
2025/10/10 06:43:18 DEBUG : file1.txt: Uploading chunk 2/0
2025/10/10 06:43:18 DEBUG : file2.txt: Uploading chunk 2/0
2025/10/10 06:43:18 DEBUG : file4.txt: Uploading chunk 2/0
2025/10/10 06:43:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file1.txt" to batch
2025/10/10 06:43:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file3.txt" to batch
2025/10/10 06:43:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file4.txt" to batch
2025/10/10 06:43:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file2.txt" to batch
2025/10/10 06:43:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 4 starting with: file1.txt
2025/10/10 06:43:19 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 4 starting with: file1.txt
2025/10/10 06:43:19 DEBUG : file3.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:19 INFO  : file3.txt: Copied (new)
2025/10/10 06:43:19 DEBUG : file4.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:19 INFO  : file4.txt: Copied (new)
2025/10/10 06:43:19 DEBUG : file2.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:19 INFO  : file2.txt: Copied (new)
2025/10/10 06:43:19 DEBUG : file1.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:19 INFO  : file1.txt: Copied (new)
2025/10/10 06:43:19 DEBUG : RCLONE_TEST: Uploading chunk 1/1
2025/10/10 06:43:19 DEBUG : file7.txt: Uploading chunk 1/0
2025/10/10 06:43:19 DEBUG : file6.txt: Uploading chunk 1/0
2025/10/10 06:43:20 DEBUG : file5.txt: Uploading chunk 1/0
2025/10/10 06:43:20 DEBUG : RCLONE_TEST: Uploading chunk 2/1
2025/10/10 06:43:20 DEBUG : file7.txt: Uploading chunk 2/0
2025/10/10 06:43:20 DEBUG : file6.txt: Uploading chunk 2/0
2025/10/10 06:43:20 DEBUG : file5.txt: Uploading chunk 2/0
2025/10/10 06:43:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "RCLONE_TEST" to batch
2025/10/10 06:43:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file6.txt" to batch
2025/10/10 06:43:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file7.txt" to batch
2025/10/10 06:43:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file5.txt" to batch
2025/10/10 06:43:20 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 4 starting with: RCLONE_TEST
2025/10/10 06:43:21 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 4 starting with: RCLONE_TEST
2025/10/10 06:43:21 DEBUG : file6.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:21 INFO  : file6.txt: Copied (new)
2025/10/10 06:43:21 DEBUG : RCLONE_TEST: dropbox = c7ddcb950cf985d316be90e07c421557fe39529668db776ef2c16e0c1a1cddee OK
2025/10/10 06:43:21 DEBUG : file7.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:21 INFO  : RCLONE_TEST: Copied (new)
2025/10/10 06:43:21 INFO  : file7.txt: Copied (new)
2025/10/10 06:43:21 DEBUG : file5.txt: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2025/10/10 06:43:21 INFO  : file5.txt: Copied (new)
2025/10/10 06:43:21 NOTICE: checking path2 Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2'
2025/10/10 06:43:21 NOTICE: (01)  : test dry-run
2025/10/10 06:43:21 NOTICE: (02)  : test initial bisync
2025/10/10 06:43:21 NOTICE: (03)  : bisync resync
2025/10/10 06:43:21 DEBUG : Reset feature "Copy"
2025/10/10 06:43:21 DEBUG : Reset feature "Copy"
2025/10/10 06:43:21 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:43:22 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:43:22 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "modtime_write_test" to batch
2025/10/10 06:43:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:43:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:43:24 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:43:27 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:43:27 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:43:27 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "modtime_write_test" to batch
2025/10/10 06:43:28 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:43:28 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:43:29 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:43:31 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:43:31 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:43:31 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/10/10 06:43:31 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/10/10 06:43:31 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:31 INFO  : Copying Path2 files to Path1
2025/10/10 06:43:31 INFO  : - Path2    Resync is copying files to         - Path1
2025/10/10 06:43:31 INFO  : There was nothing to transfer
2025/10/10 06:43:31 INFO  : - Path1    Resync is copying files to         - Path2
2025/10/10 06:43:32 INFO  : There was nothing to transfer
2025/10/10 06:43:32 INFO  : Resync updating listings
2025/10/10 06:43:32 INFO  : Validating listings for Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" vs Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:32 INFO  : Bisync successful
2025/10/10 06:43:32 NOTICE: (04)  : test new on path2 - file10
2025/10/10 06:43:32 NOTICE: (05)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file10.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/
2025/10/10 06:43:32 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/"
2025/10/10 06:43:32 DEBUG : fs cache: renaming cache item "/tmp/064147qe/datadir/test_dry_run-suzedip3/" to be canonical "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:32 DEBUG : file10.txt: Set modification time 2001-01-02
2025/10/10 06:43:32 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file10.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" as ""
2025/10/10 06:43:32 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file10.txt"
2025/10/10 06:43:32 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:32 DEBUG : operations.CopyFile "file10.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2'" as "file10.txt"
2025/10/10 06:43:32 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:32 DEBUG : file10.txt: Uploading chunk 1/1
2025/10/10 06:43:33 DEBUG : file10.txt: Uploading chunk 2/1
2025/10/10 06:43:33 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file10.txt" to batch
2025/10/10 06:43:34 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:43:34 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: file10.txt
2025/10/10 06:43:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: file10.txt
2025/10/10 06:43:35 DEBUG : file10.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:43:35 INFO  : file10.txt: Copied (new)
2025/10/10 06:43:35 NOTICE: (06)  : test newer on path2 - file1
2025/10/10 06:43:35 NOTICE: (07)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file1.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/
2025/10/10 06:43:35 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:35 DEBUG : file1.txt: Set modification time 2001-01-02
2025/10/10 06:43:35 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file1.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" as ""
2025/10/10 06:43:35 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file1.txt"
2025/10/10 06:43:35 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:35 DEBUG : operations.CopyFile "file1.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2'" as "file1.txt"
2025/10/10 06:43:35 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:43:35 DEBUG : file1.txt: Uploading chunk 1/1
2025/10/10 06:43:36 DEBUG : file1.txt: Uploading chunk 2/1
2025/10/10 06:43:36 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file1.txt" to batch
2025/10/10 06:43:37 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:43:37 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: file1.txt
2025/10/10 06:43:39 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: file1.txt
2025/10/10 06:43:39 DEBUG : file1.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:43:39 INFO  : file1.txt: Copied (replaced existing)
2025/10/10 06:43:39 NOTICE: (08)  : test new on path1 - file11
2025/10/10 06:43:39 NOTICE: (09)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file11.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/
2025/10/10 06:43:39 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:39 DEBUG : file11.txt: Set modification time 2001-01-02
2025/10/10 06:43:39 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file11.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" as ""
2025/10/10 06:43:39 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file11.txt"
2025/10/10 06:43:39 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/"
2025/10/10 06:43:39 DEBUG : operations.CopyFile "file11.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1'" as "file11.txt"
2025/10/10 06:43:39 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/10/10 06:43:39 DEBUG : file11.txt: Uploading chunk 1/1
2025/10/10 06:43:40 DEBUG : file11.txt: Uploading chunk 2/1
2025/10/10 06:43:40 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file11.txt" to batch
2025/10/10 06:43:41 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:43:41 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: file11.txt
2025/10/10 06:43:42 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: file11.txt
2025/10/10 06:43:42 DEBUG : file11.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:43:42 INFO  : file11.txt: Copied (new)
2025/10/10 06:43:42 NOTICE: (10)  : test newer on path1 - file2
2025/10/10 06:43:42 NOTICE: (11)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file2.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/
2025/10/10 06:43:42 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:42 DEBUG : file2.txt: Set modification time 2001-01-02
2025/10/10 06:43:42 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file2.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" as ""
2025/10/10 06:43:42 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file2.txt"
2025/10/10 06:43:42 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/"
2025/10/10 06:43:42 DEBUG : operations.CopyFile "file2.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1'" as "file2.txt"
2025/10/10 06:43:42 DEBUG : file2.txt: Sizes differ (src 13 vs dst 0)
2025/10/10 06:43:42 DEBUG : file2.txt: Uploading chunk 1/1
2025/10/10 06:43:43 DEBUG : file2.txt: Uploading chunk 2/1
2025/10/10 06:43:43 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file2.txt" to batch
2025/10/10 06:43:44 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:43:44 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: file2.txt
2025/10/10 06:43:45 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: file2.txt
2025/10/10 06:43:45 DEBUG : file2.txt: dropbox = aa7bd1fae1b19dee35c7bd50d644798719ca37fc2e29c776208a5bffe57173ca OK
2025/10/10 06:43:45 INFO  : file2.txt: Copied (replaced existing)
2025/10/10 06:43:45 NOTICE: (12)  : test deleted on path2 - file3
2025/10/10 06:43:45 NOTICE: (13)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file3.txt
2025/10/10 06:43:45 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:45 DEBUG : fs cache: renaming cache item "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" to be canonical "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2"
2025/10/10 06:43:45 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing uploads - please wait...
2025/10/10 06:43:46 INFO  : file3.txt: Deleted
2025/10/10 06:43:46 NOTICE: (14)  : test deleted on path1 - file4
2025/10/10 06:43:46 NOTICE: (15)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file4.txt
2025/10/10 06:43:46 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/"
2025/10/10 06:43:46 DEBUG : fs cache: renaming cache item "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" to be canonical "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1"
2025/10/10 06:43:46 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing uploads - please wait...
2025/10/10 06:43:47 INFO  : file4.txt: Deleted
2025/10/10 06:43:47 NOTICE: (16)  : test changed on path2 and on path1 - file5 (file5R, file5L)
2025/10/10 06:43:47 NOTICE: (17)  : touch-glob 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/ file5R.txt
2025/10/10 06:43:47 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:47 DEBUG : file5R.txt: Set modification time 2001-01-02
2025/10/10 06:43:47 NOTICE: (18)  : copy-as /tmp/064147qe/datadir/test_dry_run-suzedip3/file5R.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/ file5.txt
2025/10/10 06:43:47 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file5R.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" as "file5.txt"
2025/10/10 06:43:47 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file5R.txt"
2025/10/10 06:43:47 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:47 DEBUG : operations.CopyFile "file5R.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2'" as "file5.txt"
2025/10/10 06:43:47 DEBUG : file5R.txt: Sizes differ (src 39 vs dst 0)
2025/10/10 06:43:48 DEBUG : file5.txt: Uploading chunk 1/1
2025/10/10 06:43:48 DEBUG : file5.txt: Uploading chunk 2/1
2025/10/10 06:43:49 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file5.txt" to batch
2025/10/10 06:43:49 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:43:49 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: file5.txt
2025/10/10 06:43:50 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: file5.txt
2025/10/10 06:43:50 DEBUG : file5R.txt: dropbox = ab00bdb95bb0ada6d648f38df403c8de2a8b0b08d925e2d60bba4a7e33a89b6c OK
2025/10/10 06:43:50 INFO  : file5R.txt: Copied (replaced existing) to: file5.txt
2025/10/10 06:43:50 NOTICE: (19)  : touch-glob 2001-03-04 /tmp/064147qe/datadir/test_dry_run-suzedip3/ file5L.txt
2025/10/10 06:43:50 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:50 DEBUG : file5L.txt: Set modification time 2001-03-04
2025/10/10 06:43:50 NOTICE: (20)  : copy-as /tmp/064147qe/datadir/test_dry_run-suzedip3/file5L.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/ file5.txt
2025/10/10 06:43:50 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file5L.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" as "file5.txt"
2025/10/10 06:43:50 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file5L.txt"
2025/10/10 06:43:50 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/"
2025/10/10 06:43:50 DEBUG : operations.CopyFile "file5L.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1'" as "file5.txt"
2025/10/10 06:43:51 DEBUG : file5L.txt: Sizes differ (src 39 vs dst 0)
2025/10/10 06:43:51 DEBUG : file5.txt: Uploading chunk 1/1
2025/10/10 06:43:51 DEBUG : file5.txt: Uploading chunk 2/1
2025/10/10 06:43:52 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file5.txt" to batch
2025/10/10 06:43:52 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:43:52 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: file5.txt
2025/10/10 06:43:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: file5.txt
2025/10/10 06:43:53 DEBUG : file5L.txt: dropbox = f1f0875619752e49a5a2df9cb6875cc0c07f53aec8610752eba588224441fb63 OK
2025/10/10 06:43:53 INFO  : file5L.txt: Copied (replaced existing) to: file5.txt
2025/10/10 06:43:53 NOTICE: (21)  : test newer on path2 and deleted on path1 - file6
2025/10/10 06:43:53 NOTICE: (22)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file6.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/
2025/10/10 06:43:53 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:53 DEBUG : file6.txt: Set modification time 2001-01-02
2025/10/10 06:43:53 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file6.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" as ""
2025/10/10 06:43:53 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file6.txt"
2025/10/10 06:43:53 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:43:54 DEBUG : operations.CopyFile "file6.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2'" as "file6.txt"
2025/10/10 06:43:54 DEBUG : file6.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:43:54 DEBUG : file6.txt: Uploading chunk 1/1
2025/10/10 06:43:55 DEBUG : file6.txt: Uploading chunk 2/1
2025/10/10 06:43:55 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "file6.txt" to batch
2025/10/10 06:43:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:43:56 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: file6.txt
2025/10/10 06:43:57 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: file6.txt
2025/10/10 06:43:57 DEBUG : file6.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:43:57 INFO  : file6.txt: Copied (replaced existing)
2025/10/10 06:43:57 NOTICE: (23)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file6.txt
2025/10/10 06:43:57 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1"
2025/10/10 06:43:58 INFO  : file6.txt: Deleted
2025/10/10 06:43:58 NOTICE: (24)  : test newer on path1 and deleted on path2 - file7
2025/10/10 06:43:58 NOTICE: (25)  : touch-copy 2001-01-02 /tmp/064147qe/datadir/test_dry_run-suzedip3/file7.txt TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/
2025/10/10 06:43:58 DEBUG : fs cache: switching user supplied name "/tmp/064147qe/datadir/test_dry_run-suzedip3/" for canonical name "/tmp/064147qe/datadir/test_dry_run-suzedip3"
2025/10/10 06:43:58 DEBUG : file7.txt: Set modification time 2001-01-02
2025/10/10 06:43:58 DEBUG : copyFile "/tmp/064147qe/datadir/test_dry_run-suzedip3/file7.txt" to "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" as ""
2025/10/10 06:43:58 DEBUG : Creating backend with remote "/tmp/064147qe/datadir/test_dry_run-suzedip3/file7.txt"
2025/10/10 06:43:58 DEBUG : Creating backend with remote "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/"
2025/10/10 06:43:58 DEBUG : operations.CopyFile "file7.txt" to "Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1'" as "file7.txt"
2025/10/10 06:43:58 DEBUG : file7.txt: Sizes differ (src 19 vs dst 0)
2025/10/10 06:43:58 DEBUG : file7.txt: Uploading chunk 1/1
2025/10/10 06:43:59 DEBUG : file7.txt: Uploading chunk 2/1
2025/10/10 06:43:59 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "file7.txt" to batch
2025/10/10 06:44:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:44:00 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: file7.txt
2025/10/10 06:44:02 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: file7.txt
2025/10/10 06:44:02 DEBUG : file7.txt: dropbox = 7400df2260f021cfd643bc1695434ee8bfd86daf687981b5d58eb57a80a4dd50 OK
2025/10/10 06:44:02 INFO  : file7.txt: Copied (replaced existing)
2025/10/10 06:44:02 NOTICE: (26)  : delete-file TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file7.txt
2025/10/10 06:44:02 DEBUG : fs cache: switching user supplied name "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/" for canonical name "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2"
2025/10/10 06:44:03 INFO  : file7.txt: Deleted
2025/10/10 06:44:03 NOTICE: (27)  : test sync with dry-run and resync
2025/10/10 06:44:03 NOTICE: (28)  : bisync dry-run resync
2025/10/10 06:44:03 DEBUG : Reset feature "Copy"
2025/10/10 06:44:03 DEBUG : Reset feature "Copy"
2025/10/10 06:44:03 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:03 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:04 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "modtime_write_test" to batch
2025/10/10 06:44:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:44:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:05 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:08 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:09 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:09 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "modtime_write_test" to batch
2025/10/10 06:44:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:44:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:10 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:13 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:13 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/10/10 06:44:13 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/10/10 06:44:13 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:44:13 INFO  : Copying Path2 files to Path1
2025/10/10 06:44:13 NOTICE: - Path2    Resync is copying files to         - Path1
2025/10/10 06:44:13 NOTICE: file10.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:13 NOTICE: file4.txt: Skipped copy as --dry-run is set (size 0)
2025/10/10 06:44:13 NOTICE: file6.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:13 NOTICE: - Path1    Resync is copying files to         - Path2
2025/10/10 06:44:14 NOTICE: file7.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:14 NOTICE: file11.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:14 NOTICE: file3.txt: Skipped copy as --dry-run is set (size 0)
2025/10/10 06:44:14 NOTICE: file2.txt: Skipped copy as --dry-run is set (size 13)
2025/10/10 06:44:14 NOTICE: file1.txt: Skipped copy as --dry-run is set (size 0)
2025/10/10 06:44:14 NOTICE: file5.txt: Skipped copy as --dry-run is set (size 39)
2025/10/10 06:44:14 INFO  : Resync updating listings
2025/10/10 06:44:16 INFO  : Bisync successful
2025/10/10 06:44:16 NOTICE: (29)  : copy-listings dryrun-resync
2025/10/10 06:44:16 NOTICE: (30)  : test sync with dry-run
2025/10/10 06:44:16 NOTICE: (31)  : bisync dry-run
2025/10/10 06:44:16 DEBUG : Reset feature "Copy"
2025/10/10 06:44:16 DEBUG : Reset feature "Copy"
2025/10/10 06:44:16 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:17 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "modtime_write_test" to batch
2025/10/10 06:44:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:44:17 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:18 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:21 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:22 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:22 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "modtime_write_test" to batch
2025/10/10 06:44:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:44:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:23 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:26 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:26 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:26 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/10/10 06:44:26 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/10/10 06:44:26 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:44:26 INFO  : Building Path1 and Path2 listings
2025/10/10 06:44:26 INFO  : Path1 checking for diffs
2025/10/10 06:44:26 NOTICE: - Path1    File changed: size (larger), time (newer) - file2.txt
2025/10/10 06:44:26 NOTICE: - Path1    File was deleted          - file4.txt
2025/10/10 06:44:26 NOTICE: - Path1    File changed: size (larger), time (newer) - file5.txt
2025/10/10 06:44:26 NOTICE: - Path1    File was deleted          - file6.txt
2025/10/10 06:44:26 NOTICE: - Path1    File changed: size (larger), time (newer) - file7.txt
2025/10/10 06:44:26 NOTICE: - Path1    File is new               - file11.txt
2025/10/10 06:44:26 INFO  : Path1:    6 changes:    1 new,    3 modified,    2 deleted
2025/10/10 06:44:26 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/10/10 06:44:26 INFO  : Path2 checking for diffs
2025/10/10 06:44:26 NOTICE: - Path2    File changed: size (larger), time (newer) - file1.txt
2025/10/10 06:44:26 NOTICE: - Path2    File was deleted          - file3.txt
2025/10/10 06:44:26 NOTICE: - Path2    File changed: size (larger), time (newer) - file5.txt
2025/10/10 06:44:26 NOTICE: - Path2    File changed: size (larger), time (newer) - file6.txt
2025/10/10 06:44:26 NOTICE: - Path2    File was deleted          - file7.txt
2025/10/10 06:44:26 NOTICE: - Path2    File is new               - file10.txt
2025/10/10 06:44:26 INFO  : Path2:    6 changes:    1 new,    3 modified,    2 deleted
2025/10/10 06:44:26 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/10/10 06:44:26 INFO  : Applying changes
2025/10/10 06:44:26 INFO  : Checking potential conflicts...
2025/10/10 06:44:26 ERROR : file5.txt: dropbox differ
2025/10/10 06:44:26 NOTICE: Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': 1 differences found
2025/10/10 06:44:26 NOTICE: Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': 1 errors while checking
2025/10/10 06:44:26 INFO  : Finished checking the potential conflicts. 1 differences found
2025/10/10 06:44:26 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file11.txt
2025/10/10 06:44:26 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file2.txt
2025/10/10 06:44:26 NOTICE: - Path2    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file4.txt
2025/10/10 06:44:26 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/10/10 06:44:26 NOTICE: file5.txt: Skipped rename as --dry-run is set
2025/10/10 06:44:26 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file5.txt.conflict1
2025/10/10 06:44:26 NOTICE: file5.txt: Skipped rename as --dry-run is set
2025/10/10 06:44:26 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file5.txt.conflict2
2025/10/10 06:44:26 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file6.txt
2025/10/10 06:44:26 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file7.txt
2025/10/10 06:44:26 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file1.txt
2025/10/10 06:44:26 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file10.txt
2025/10/10 06:44:26 NOTICE: - Path1    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file3.txt
2025/10/10 06:44:26 NOTICE: - Path2    Do queued copies to                - Path1
2025/10/10 06:44:27 NOTICE: file10.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:27 NOTICE: file6.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:27 NOTICE: file1.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:27 NOTICE: file3.txt: Skipped delete as --dry-run is set (size 0)
2025/10/10 06:44:27 NOTICE: - Path1    Do queued copies to                - Path2
2025/10/10 06:44:27 NOTICE: file11.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:27 NOTICE: file7.txt: Skipped copy as --dry-run is set (size 19)
2025/10/10 06:44:27 NOTICE: file2.txt: Skipped copy as --dry-run is set (size 13)
2025/10/10 06:44:27 NOTICE: file4.txt: Skipped delete as --dry-run is set (size 0)
2025/10/10 06:44:27 INFO  : Updating listings
2025/10/10 06:44:28 INFO  : Bisync successful
2025/10/10 06:44:28 NOTICE: (32)  : copy-listings dryrun
2025/10/10 06:44:28 NOTICE: (33)  : test sync without dry-run
2025/10/10 06:44:28 NOTICE: (34)  : bisync
2025/10/10 06:44:28 DEBUG : Reset feature "Copy"
2025/10/10 06:44:28 DEBUG : Reset feature "Copy"
2025/10/10 06:44:28 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:29 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:29 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Adding "modtime_write_test" to batch
2025/10/10 06:44:30 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Batch idle for 500ms so committing
2025/10/10 06:44:30 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:31 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:33 DEBUG : modtime_write_test: Uploading chunk 1/1
2025/10/10 06:44:34 DEBUG : modtime_write_test: Uploading chunk 2/1
2025/10/10 06:44:34 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Adding "modtime_write_test" to batch
2025/10/10 06:44:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Batch idle for 500ms so committing
2025/10/10 06:44:35 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:36 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committed sync batch length 1 starting with: modtime_write_test
2025/10/10 06:44:38 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:38 DEBUG : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/10/10 06:44:38 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/10/10 06:44:38 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/10/10 06:44:38 INFO  : Synching Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" with Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:44:38 INFO  : Building Path1 and Path2 listings
2025/10/10 06:44:39 INFO  : Path1 checking for diffs
2025/10/10 06:44:39 INFO  : - Path1    File changed: size (larger), time (newer) - file2.txt
2025/10/10 06:44:39 INFO  : - Path1    File was deleted          - file4.txt
2025/10/10 06:44:39 INFO  : - Path1    File changed: size (larger), time (newer) - file5.txt
2025/10/10 06:44:39 INFO  : - Path1    File was deleted          - file6.txt
2025/10/10 06:44:39 INFO  : - Path1    File changed: size (larger), time (newer) - file7.txt
2025/10/10 06:44:39 INFO  : - Path1    File is new               - file11.txt
2025/10/10 06:44:39 INFO  : Path1:    6 changes:    1 new,    3 modified,    2 deleted
2025/10/10 06:44:39 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/10/10 06:44:39 INFO  : Path2 checking for diffs
2025/10/10 06:44:39 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/10/10 06:44:39 INFO  : - Path2    File was deleted          - file3.txt
2025/10/10 06:44:39 INFO  : - Path2    File changed: size (larger), time (newer) - file5.txt
2025/10/10 06:44:39 INFO  : - Path2    File changed: size (larger), time (newer) - file6.txt
2025/10/10 06:44:39 INFO  : - Path2    File was deleted          - file7.txt
2025/10/10 06:44:39 INFO  : - Path2    File is new               - file10.txt
2025/10/10 06:44:39 INFO  : Path2:    6 changes:    1 new,    3 modified,    2 deleted
2025/10/10 06:44:39 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller)
2025/10/10 06:44:39 INFO  : Applying changes
2025/10/10 06:44:39 INFO  : Checking potential conflicts...
2025/10/10 06:44:39 ERROR : file5.txt: dropbox differ
2025/10/10 06:44:39 NOTICE: Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': 1 differences found
2025/10/10 06:44:39 NOTICE: Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': 1 errors while checking
2025/10/10 06:44:39 INFO  : Finished checking the potential conflicts. 1 differences found
2025/10/10 06:44:39 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file11.txt
2025/10/10 06:44:39 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file2.txt
2025/10/10 06:44:39 INFO  : - Path2    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file4.txt
2025/10/10 06:44:39 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/10/10 06:44:39 NOTICE: - Path1    Renaming Path1 copy                - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file5.txt.conflict1
2025/10/10 06:44:41 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/10/10 06:44:41 NOTICE: - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file5.txt.conflict1
2025/10/10 06:44:41 NOTICE: - Path2    Renaming Path2 copy                - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file5.txt.conflict2
2025/10/10 06:44:43 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/10/10 06:44:43 NOTICE: - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file5.txt.conflict2
2025/10/10 06:44:43 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file6.txt
2025/10/10 06:44:43 INFO  : - Path1    Queue copy to Path2       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/file7.txt
2025/10/10 06:44:43 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file1.txt
2025/10/10 06:44:43 INFO  : - Path2    Queue copy to Path1       - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file10.txt
2025/10/10 06:44:43 INFO  : - Path1    Queue delete              - TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/file3.txt
2025/10/10 06:44:43 INFO  : - Path2    Do queued copies to                - Path1
2025/10/10 06:44:46 INFO  : file6.txt: Copied (new)
2025/10/10 06:44:46 INFO  : file1.txt: Copied (replaced existing)
2025/10/10 06:44:46 INFO  : file10.txt: Copied (new)
2025/10/10 06:44:46 INFO  : file5.txt.conflict2: Copied (new)
2025/10/10 06:44:47 INFO  : file3.txt: Deleted
2025/10/10 06:44:47 INFO  : - Path1    Do queued copies to                - Path2
2025/10/10 06:44:51 INFO  : file5.txt.conflict1: Copied (new)
2025/10/10 06:44:51 INFO  : file7.txt: Copied (new)
2025/10/10 06:44:51 INFO  : file2.txt: Copied (replaced existing)
2025/10/10 06:44:51 INFO  : file11.txt: Copied (new)
2025/10/10 06:44:52 INFO  : file4.txt: Deleted
2025/10/10 06:44:52 INFO  : Updating listings
2025/10/10 06:44:52 INFO  : Validating listings for Path1 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path1/" vs Path2 "TestDropbox:rclone-test-homagad7cesi/064147qe/dry_run/path2/"
2025/10/10 06:44:52 INFO  : Bisync successful
    bisync_test.go:608: TEST dry_run PASSED
2025/10/10 06:44:53 DEBUG : Dropbox root 'rclone-test-homagad7cesi': Purge remote
--- PASS: TestBisyncRemoteRemote (187.66s)
    --- PASS: TestBisyncRemoteRemote/compare_all (83.24s)
    --- PASS: TestBisyncRemoteRemote/dry_run (103.43s)
PASS
2025/10/10 06:44:54 DEBUG : Dropbox root 'rclone-test-navupoq8jiyo': Purge remote
2025/10/10 06:44:54 NOTICE: purge failed: path_lookup/not_found/
2025/10/10 06:44:54 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path1': Committing uploads - please wait...
2025/10/10 06:44:54 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/dry_run/path2': Committing uploads - please wait...
2025/10/10 06:44:54 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe': Committing uploads - please wait...
2025/10/10 06:44:54 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path1': Committing uploads - please wait...
2025/10/10 06:44:54 INFO  : Dropbox root 'rclone-test-homagad7cesi/064147qe/compare_all/path2': Committing uploads - please wait...
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestBisyncRemoteRemote$/^(compare_all|dry_run)$'" - Finished OK in 3m8.388316926s (try 4/5)