"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose -test.run '^TestBisyncLocalRemote$/^(backupdir|extended_filenames)$|^TestBisyncRemoteRemote$/^(basic|check_access_filters|createemptysrcdirs|ignorelistingchecksum|max_delete_path2_force)$'" - Starting (try 2/5)
2025/01/17 01:41:54 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-felarut6notu"
2025/01/17 01:41:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/17 01:41:54 DEBUG : Creating backend with remote "/tmp/rclone898833100"
=== RUN   TestBisyncLocalRemote
2025/01/17 01:41:54 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-ravefoh7gayi"
2025/01/17 01:41:54 NOTICE: remote: TestPremiumizeMe:rclone-test-ravefoh7gayi
=== RUN   TestBisyncLocalRemote/backupdir
2025/01/17 01:41:54 DEBUG : Creating backend with remote "/tmp/014154hu"
2025/01/17 01:41:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/17 01:41:54 DEBUG : Creating backend with remote "/tmp/014154hu/backupdir/path1"
2025/01/17 01:41:54 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu"
2025/01/17 01:41:54 INFO  : path2: Making directory
2025/01/17 01:41:54 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/backupdir/path2"
2025/01/17 01:41:55 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_backupdir/initial"
2025/01/17 01:41:55 DEBUG : Creating backend with remote "/tmp/014154hu/initdir/test_backupdir-fipitag1"
2025/01/17 01:41:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/01/17 01:41:55 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 INFO  : file2.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/01/17 01:41:55 INFO  : file3.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/01/17 01:41:55 INFO  : file4.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/01/17 01:41:55 INFO  : file5.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/initdir/test_backupdir-fipitag1: Waiting for checks to finish
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/initdir/test_backupdir-fipitag1: Waiting for transfers to finish
2025/01/17 01:41:55 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/01/17 01:41:55 INFO  : file7.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/01/17 01:41:55 INFO  : file6.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/01/17 01:41:55 INFO  : file8.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:41:55 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:41:55 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:41:55 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:41:55 INFO  : file1.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_backupdir/modfiles"
2025/01/17 01:41:55 DEBUG : Creating backend with remote "/tmp/014154hu/datadir/test_backupdir-sojufek4"
2025/01/17 01:41:55 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:41:55 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt
2025/01/17 01:41:55 INFO  : file1.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:41:55 DEBUG : file10.txt.925c801f.partial: renamed to: file10.txt
2025/01/17 01:41:55 INFO  : file10.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:41:55 DEBUG : file11.txt.925c801f.partial: renamed to: file11.txt
2025/01/17 01:41:55 INFO  : file11.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/01/17 01:41:55 DEBUG : file2.txt.f8ac1735.partial: renamed to: file2.txt
2025/01/17 01:41:55 INFO  : file2.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/01/17 01:41:55 DEBUG : file5L.txt.c32cc336.partial: renamed to: file5L.txt
2025/01/17 01:41:55 INFO  : file5L.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:41:55 DEBUG : file6.txt.925c801f.partial: renamed to: file6.txt
2025/01/17 01:41:55 INFO  : file6.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/01/17 01:41:55 DEBUG : file5R.txt.aa998d0a.partial: renamed to: file5R.txt
2025/01/17 01:41:55 INFO  : file5R.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:41:55 DEBUG : file7.txt.925c801f.partial: renamed to: file7.txt
2025/01/17 01:41:55 INFO  : file7.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/datadir/test_backupdir-sojufek4: Waiting for checks to finish
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/datadir/test_backupdir-sojufek4: Waiting for transfers to finish
2025/01/17 01:41:55 ERROR : : error listing: directory not found
2025/01/17 01:41:55 ERROR : : error listing: directory not found
2025/01/17 01:41:55 NOTICE: checking initFs Local file system at /tmp/014154hu/initdir/test_backupdir-fipitag1
2025/01/17 01:41:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:41:55 INFO  : file1.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/01/17 01:41:55 INFO  : file3.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:41:55 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:41:55 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:41:55 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/01/17 01:41:55 INFO  : file4.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/01/17 01:41:55 INFO  : file2.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/backupdir/path1: Waiting for checks to finish
2025/01/17 01:41:55 DEBUG : Local file system at /tmp/014154hu/backupdir/path1: Waiting for transfers to finish
2025/01/17 01:41:55 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/01/17 01:41:55 INFO  : file6.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/01/17 01:41:55 INFO  : file5.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/01/17 01:41:55 INFO  : file7.txt: Copied (new)
2025/01/17 01:41:55 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:41:55 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/01/17 01:41:55 INFO  : file8.txt: Copied (new)
2025/01/17 01:41:55 NOTICE: checking Path1 Local file system at /tmp/014154hu/backupdir/path1
2025/01/17 01:41:55 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:41:55 DEBUG : premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/backupdir/path2': Waiting for checks to finish
2025/01/17 01:41:55 DEBUG : premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/backupdir/path2': Waiting for transfers to finish
2025/01/17 01:41:57 INFO  : file1.txt: Copied (new)
2025/01/17 01:41:58 INFO  : file2.txt: Copied (new)
2025/01/17 01:42:00 INFO  : file4.txt: Copied (new)
2025/01/17 01:42:01 INFO  : file5.txt: Copied (new)
2025/01/17 01:42:01 INFO  : file3.txt: Copied (new)
2025/01/17 01:42:02 INFO  : file6.txt: Copied (new)
2025/01/17 01:42:03 INFO  : file8.txt: Copied (new)
2025/01/17 01:42:04 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:42:06 INFO  : file7.txt: Copied (new)
2025/01/17 01:42:06 NOTICE: checking path2 premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/backupdir/path2'
2025/01/17 01:42:06 NOTICE: (01)  : test backupdir
2025/01/17 01:42:06 NOTICE: (02)  : test initial bisync
2025/01/17 01:42:06 NOTICE: (03)  : bisync resync backupdir1=/tmp/014154hu/workdir/backupdirs/backupdir1 backupdir2=/tmp/014154hu/workdir/backupdirs/backupdir2
    bisync_test.go:923: backupdir test currently only works on local (it uses the workdir)
=== RUN   TestBisyncLocalRemote/extended_filenames
2025/01/17 01:42:06 DEBUG : Creating backend with remote "/tmp/014154hu/extended_filenames/path1"
2025/01/17 01:42:06 INFO  : path2: Making directory
2025/01/17 01:42:06 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2"
2025/01/17 01:42:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_filenames/initial"
2025/01/17 01:42:07 DEBUG : Creating backend with remote "/tmp/014154hu/initdir/test_extended_filenames-zodomef3"
2025/01/17 01:42:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_: Making directory with metadata
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:42:07 DEBUG : Added delayed dir = "subdir_with_ࢺ_", newDst=subdir_with_ࢺ_
2025/01/17 01:42:07 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/initdir/test_extended_filenames-zodomef3: Waiting for checks to finish
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/initdir/test_extended_filenames-zodomef3: Waiting for transfers to finish
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt.5028a97.partial: renamed to: file1 - Copy (2).txt
2025/01/17 01:42:07 INFO  : file1 - Copy (2).txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt.5028a97.partial: renamed to: file1 - Copy.txt
2025/01/17 01:42:07 INFO  : file1 - Copy.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt.5028a97.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/01/17 01:42:07 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:42:07 INFO  : file1.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:42:07 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:42:07 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: filename_contains_ࢺ_.txt
2025/01/17 01:42:07 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt.480f4fd7.partial: renamed to: filename_contains_ě_.txt
2025/01/17 01:42:07 INFO  : filename_contains_ě_.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : Русский.txt.5028a97.partial: renamed to: Русский.txt
2025/01/17 01:42:07 INFO  : Русский.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: subdir_with_ࢺ_/filename_contains_ࢺ_.txt
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt.480f4fd7.partial: renamed to: subdir_with_ࢺ_/filename_contains_ě_.txt
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_/filename_contains_ě_.txt: Copied (new)
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_: Set directory modification time (using SetModTime)
2025/01/17 01:42:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_filenames/modfiles"
2025/01/17 01:42:07 DEBUG : Creating backend with remote "/tmp/014154hu/datadir/test_extended_filenames-fotunup8"
2025/01/17 01:42:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/datadir/test_extended_filenames-fotunup8: Waiting for checks to finish
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/datadir/test_extended_filenames-fotunup8: Waiting for transfers to finish
2025/01/17 01:42:07 DEBUG : file2.txt: md5 = 40b811fb5009223b6da573f169619d8e OK
2025/01/17 01:42:07 DEBUG : file2.txt.761be064.partial: renamed to: file2.txt
2025/01/17 01:42:07 INFO  : file2.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:42:07 DEBUG : file1.txt.f73bbb59.partial: renamed to: file1.txt
2025/01/17 01:42:07 INFO  : file1.txt: Copied (new)
2025/01/17 01:42:07 ERROR : : error listing: directory not found
2025/01/17 01:42:07 ERROR : : error listing: directory not found
2025/01/17 01:42:07 NOTICE: checking initFs Local file system at /tmp/014154hu/initdir/test_extended_filenames-zodomef3
2025/01/17 01:42:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_: Making directory with metadata
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:42:07 DEBUG : Added delayed dir = "subdir_with_ࢺ_", newDst=subdir_with_ࢺ_
2025/01/17 01:42:07 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/extended_filenames/path1: Waiting for checks to finish
2025/01/17 01:42:07 DEBUG : Local file system at /tmp/014154hu/extended_filenames/path1: Waiting for transfers to finish
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt.5028a97.partial: renamed to: file1 - Copy.txt
2025/01/17 01:42:07 INFO  : file1 - Copy.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:42:07 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:42:07 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:42:07 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:42:07 INFO  : file1.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt.5028a97.partial: renamed to: file1 - Copy (2).txt
2025/01/17 01:42:07 INFO  : file1 - Copy (2).txt: Copied (new)
2025/01/17 01:42:07 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : Русский.txt.5028a97.partial: renamed to: Русский.txt
2025/01/17 01:42:07 INFO  : Русский.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt.480f4fd7.partial: renamed to: filename_contains_ě_.txt
2025/01/17 01:42:07 INFO  : filename_contains_ě_.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: filename_contains_ࢺ_.txt
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt.5028a97.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt.480f4fd7.partial: renamed to: subdir_with_ࢺ_/filename_contains_ě_.txt
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_/filename_contains_ě_.txt: Copied (new)
2025/01/17 01:42:07 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: subdir_with_ࢺ_/filename_contains_ࢺ_.txt
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_: Set directory modification time (using SetModTime)
2025/01/17 01:42:07 NOTICE: checking Path1 Local file system at /tmp/014154hu/extended_filenames/path1
2025/01/17 01:42:07 DEBUG : file1 - Copy (2).txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1 - Copy.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:42:07 INFO  : subdir_with_ࢺ_: Making directory
2025/01/17 01:42:07 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/01/17 01:42:07 DEBUG : premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2': Waiting for checks to finish
2025/01/17 01:42:07 DEBUG : premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2': Waiting for transfers to finish
2025/01/17 01:42:10 INFO  : file1.txt: Copied (new)
2025/01/17 01:42:10 INFO  : file1 - Copy.txt: Copied (new)
2025/01/17 01:42:12 INFO  : file1 - Copy (2).txt: Copied (new)
2025/01/17 01:42:13 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/01/17 01:42:15 INFO  : filename_contains_ě_.txt: Copied (new)
2025/01/17 01:42:16 INFO  : Русский.txt: Copied (new)
2025/01/17 01:42:16 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:42:29 INFO  : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:42:36 INFO  : subdir_with_ࢺ_/filename_contains_ě_.txt: Copied (new)
2025/01/17 01:43:34 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/01/17 01:43:34 NOTICE: checking path2 premiumize.me root 'rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2'
2025/01/17 01:43:34 NOTICE: (01)  : test extended-filenames
2025/01/17 01:43:34 NOTICE: (02)  : fix-names /tmp/014154hu/extended_filenames/path1/subdir_with_ࢺ_/
2025/01/17 01:43:34 NOTICE: (03)  : fix-names TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2/subdir_with_ࢺ_/
2025/01/17 01:43:34 NOTICE: (04)  : fix-names /tmp/014154hu/extended_filenames/path1/subdir_with_ࢺ_/filename_contains_ě_.txt
2025/01/17 01:43:34 NOTICE: (05)  : fix-names TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2/subdir_with_ࢺ_/filename_contains_ě_.txt
2025/01/17 01:43:35 NOTICE: (06)  : fix-names /tmp/014154hu/extended_filenames/path1/Русский.txt
2025/01/17 01:43:35 NOTICE: (07)  : fix-names TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2/Русский.txt
2025/01/17 01:43:35 NOTICE: (08)  : fix-names /tmp/014154hu/extended_filenames/path1/file_enconde_mañana_funcionará.txt
2025/01/17 01:43:35 NOTICE: (09)  : fix-names TestPremiumizeMe:rclone-test-ravefoh7gayi/014154hu/extended_filenames/path2/file_enconde_mañana_funcionará.txt
2025/01/17 01:43:35 NOTICE: (10)  : test initial bisync
2025/01/17 01:43:35 NOTICE: (11)  : bisync resync
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
2025/01/17 01:43:35 DEBUG : premiumize.me root 'rclone-test-ravefoh7gayi': Purge remote
--- PASS: TestBisyncLocalRemote (101.63s)
    --- SKIP: TestBisyncLocalRemote/backupdir (12.32s)
    --- SKIP: TestBisyncLocalRemote/extended_filenames (89.00s)
=== RUN   TestBisyncRemoteRemote
2025/01/17 01:43:35 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi"
2025/01/17 01:43:36 NOTICE: remote: TestPremiumizeMe:rclone-test-sagucay9nopi
=== RUN   TestBisyncRemoteRemote/basic
2025/01/17 01:43:36 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu"
2025/01/17 01:43:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/17 01:43:36 INFO  : path1: Making directory
2025/01/17 01:43:36 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/basic/path1"
2025/01/17 01:43:36 INFO  : path2: Making directory
2025/01/17 01:43:36 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/basic/path2"
2025/01/17 01:43:37 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/initial"
2025/01/17 01:43:37 DEBUG : Creating backend with remote "/tmp/014336pu/initdir/test_basic-wusagen1"
2025/01/17 01:43:37 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : subdir: Making directory with metadata
2025/01/17 01:43:37 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:43:37 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/01/17 01:43:37 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt
2025/01/17 01:43:37 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt
2025/01/17 01:43:37 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt
2025/01/17 01:43:37 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt
2025/01/17 01:43:37 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt
2025/01/17 01:43:37 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:43:37 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:43:37 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:43:37 DEBUG : Local file system at /tmp/014336pu/initdir/test_basic-wusagen1: Waiting for checks to finish
2025/01/17 01:43:37 DEBUG : Local file system at /tmp/014336pu/initdir/test_basic-wusagen1: Waiting for transfers to finish
2025/01/17 01:43:37 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:43:37 INFO  : file1.txt: Copied (new)
2025/01/17 01:43:37 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:43:37 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/01/17 01:43:37 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:43:37 INFO  : subdir: Set directory modification time (using SetModTime)
2025/01/17 01:43:37 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/modfiles"
2025/01/17 01:43:37 DEBUG : Creating backend with remote "/tmp/014336pu/datadir/test_basic-nicotov0"
2025/01/17 01:43:37 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : Local file system at /tmp/014336pu/datadir/test_basic-nicotov0: Waiting for checks to finish
2025/01/17 01:43:37 DEBUG : Local file system at /tmp/014336pu/datadir/test_basic-nicotov0: Waiting for transfers to finish
2025/01/17 01:43:37 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:43:37 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt
2025/01/17 01:43:37 INFO  : file1.txt: Copied (new)
2025/01/17 01:43:37 ERROR : : error listing: directory not found
2025/01/17 01:43:37 ERROR : : error listing: directory not found
2025/01/17 01:43:37 NOTICE: checking initFs Local file system at /tmp/014336pu/initdir/test_basic-wusagen1
2025/01/17 01:43:37 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:43:37 INFO  : subdir: Making directory
2025/01/17 01:43:37 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:43:37 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path1': Waiting for checks to finish
2025/01/17 01:43:37 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path1': Waiting for transfers to finish
2025/01/17 01:43:41 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:43:42 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:43:43 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:43:43 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:43:43 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:43:48 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:43:48 INFO  : file1.txt: Copied (new)
2025/01/17 01:44:14 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:44:14 NOTICE: checking Path1 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path1'
2025/01/17 01:44:14 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:14 INFO  : subdir: Making directory
2025/01/17 01:44:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:14 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path2': Waiting for checks to finish
2025/01/17 01:44:14 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path2': Waiting for transfers to finish
2025/01/17 01:44:15 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:44:16 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:44:16 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:44:17 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:44:17 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:44:17 INFO  : file1.txt: Copied (new)
2025/01/17 01:44:20 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:44:23 NOTICE: checking path2 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/basic/path2'
2025/01/17 01:44:23 NOTICE: (01)  : test basic
2025/01/17 01:44:23 NOTICE: (02)  : test initial bisync
2025/01/17 01:44:23 NOTICE: (03)  : bisync resync
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncRemoteRemote/check_access_filters
2025/01/17 01:44:23 INFO  : path1: Making directory
2025/01/17 01:44:23 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/check_access_filters/path1"
2025/01/17 01:44:23 INFO  : path2: Making directory
2025/01/17 01:44:23 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/check_access_filters/path2"
2025/01/17 01:44:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/initial"
2025/01/17 01:44:23 DEBUG : Creating backend with remote "/tmp/014336pu/initdir/test_check_access_filters-suyenek6"
2025/01/17 01:44:23 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir: Making directory with metadata
2025/01/17 01:44:23 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/01/17 01:44:23 DEBUG : subdir-not: Making directory with metadata
2025/01/17 01:44:23 INFO  : subdir-not: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdir-not", newDst=subdir-not
2025/01/17 01:44:23 DEBUG : subdirX: Making directory with metadata
2025/01/17 01:44:23 INFO  : subdirX: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdirX", newDst=subdirX
2025/01/17 01:44:23 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1: Making directory with metadata
2025/01/17 01:44:23 INFO  : subdirX/subdirX1: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdirX/subdirX1", newDst=subdirX/subdirX1
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir/subdirA: Making directory with metadata
2025/01/17 01:44:23 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/01/17 01:44:23 INFO  : file2.txt: Copied (new)
2025/01/17 01:44:23 INFO  : subdir/subdirA: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdir/subdirA", newDst=subdir/subdirA
2025/01/17 01:44:23 DEBUG : subdir/subdirB: Making directory with metadata
2025/01/17 01:44:23 INFO  : subdir/subdirB: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdir/subdirB", newDst=subdir/subdirB
2025/01/17 01:44:23 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/01/17 01:44:23 INFO  : file3.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2: Making directory with metadata
2025/01/17 01:44:23 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:44:23 INFO  : file1.txt: Copied (new)
2025/01/17 01:44:23 INFO  : subdir-not/subdir-not2: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/01/17 01:44:23 DEBUG : Added delayed dir = "subdir-not/subdir-not2", newDst=subdir-not/subdir-not2
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : subdirX/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : Local file system at /tmp/014336pu/initdir/test_check_access_filters-suyenek6: Waiting for checks to finish
2025/01/17 01:44:23 DEBUG : subdirX/file20.txt.5028a97.partial: renamed to: subdirX/file20.txt
2025/01/17 01:44:23 INFO  : subdirX/file20.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : Local file system at /tmp/014336pu/initdir/test_check_access_filters-suyenek6: Waiting for transfers to finish
2025/01/17 01:44:23 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/01/17 01:44:23 INFO  : file4.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/file30.txt.5028a97.partial: renamed to: subdirX/subdirX1/file30.txt
2025/01/17 01:44:23 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:44:23 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/01/17 01:44:23 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdirX/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir/subdirB/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir/subdirB/file30.txt.5028a97.partial: renamed to: subdir/subdirB/file30.txt
2025/01/17 01:44:23 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdirX/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/subdirA/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir/subdirA/file30.txt.5028a97.partial: renamed to: subdir/subdirA/file30.txt
2025/01/17 01:44:23 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/subdirB/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir/subdirB/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirB/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdirX/subdirX1/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/subdirX1/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir-not/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir-not/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/file30.txt.5028a97.partial: renamed to: subdir-not/subdir-not2/file30.txt
2025/01/17 01:44:23 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir-not/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:44:23 DEBUG : subdir-not/file20.txt.5028a97.partial: renamed to: subdir-not/file20.txt
2025/01/17 01:44:23 INFO  : subdir-not/file20.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir/subdirA/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir/subdirA/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirA/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:44:23 DEBUG : subdir-not/subdir-not2/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/subdir-not2/RCLONE_TEST
2025/01/17 01:44:23 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/01/17 01:44:23 INFO  : subdir-not/subdir-not2: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdir/subdirA: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdir/subdirB: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdirX/subdirX1: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdirX: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdir-not: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 INFO  : subdir: Set directory modification time (using SetModTime)
2025/01/17 01:44:23 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/modfiles"
2025/01/17 01:44:23 DEBUG : Creating backend with remote "/tmp/014336pu/datadir/test_check_access_filters-voqofec9"
2025/01/17 01:44:23 DEBUG : exclude-other-filtersfile.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : include-other-filtersfile.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:23 DEBUG : Local file system at /tmp/014336pu/datadir/test_check_access_filters-voqofec9: Waiting for checks to finish
2025/01/17 01:44:23 DEBUG : Local file system at /tmp/014336pu/datadir/test_check_access_filters-voqofec9: Waiting for transfers to finish
2025/01/17 01:44:23 DEBUG : exclude-other-filtersfile.txt: md5 = 5fcc6205d7df1c2e9ed3a15a1356b345 OK
2025/01/17 01:44:23 DEBUG : include-other-filtersfile.txt: md5 = 2ec13b2813141ed088e5978ef5a47b0e OK
2025/01/17 01:44:23 DEBUG : exclude-other-filtersfile.txt.9180e6d6.partial: renamed to: exclude-other-filtersfile.txt
2025/01/17 01:44:23 INFO  : exclude-other-filtersfile.txt: Copied (new)
2025/01/17 01:44:23 DEBUG : include-other-filtersfile.txt.5fb1cd78.partial: renamed to: include-other-filtersfile.txt
2025/01/17 01:44:23 INFO  : include-other-filtersfile.txt: Copied (new)
2025/01/17 01:44:23 ERROR : : error listing: directory not found
2025/01/17 01:44:23 ERROR : : error listing: directory not found
2025/01/17 01:44:23 NOTICE: checking initFs Local file system at /tmp/014336pu/initdir/test_check_access_filters-suyenek6
2025/01/17 01:44:24 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 INFO  : subdir: Making directory
2025/01/17 01:44:24 INFO  : subdir-not: Making directory
2025/01/17 01:44:24 INFO  : subdirX: Making directory
2025/01/17 01:44:24 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 INFO  : subdir-not/subdir-not2: Making directory
2025/01/17 01:44:24 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 INFO  : subdir/subdirA: Making directory
2025/01/17 01:44:24 INFO  : subdirX/subdirX1: Making directory
2025/01/17 01:44:24 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 INFO  : subdir/subdirB: Making directory
2025/01/17 01:44:24 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:44:24 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path1': Waiting for checks to finish
2025/01/17 01:44:24 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path1': Waiting for transfers to finish
2025/01/17 01:44:26 INFO  : file1.txt: Copied (new)
2025/01/17 01:44:27 INFO  : file4.txt: Copied (new)
2025/01/17 01:44:27 INFO  : file3.txt: Copied (new)
2025/01/17 01:44:29 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:44:30 INFO  : subdirX/file20.txt: Copied (new)
2025/01/17 01:44:30 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/01/17 01:44:32 INFO  : subdir-not/file20.txt: Copied (new)
2025/01/17 01:44:32 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:44:36 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/01/17 01:44:38 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/01/17 01:44:39 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/01/17 01:44:42 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/01/17 01:44:44 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/01/17 01:44:48 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/01/17 01:44:49 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/01/17 01:44:50 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/01/17 01:44:52 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/01/17 01:44:57 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/01/17 01:45:11 INFO  : file2.txt: Copied (new)
2025/01/17 01:45:11 NOTICE: checking Path1 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path1'
2025/01/17 01:45:11 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:11 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:11 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:11 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:11 INFO  : subdir: Making directory
2025/01/17 01:45:12 INFO  : subdir-not: Making directory
2025/01/17 01:45:12 INFO  : subdirX: Making directory
2025/01/17 01:45:12 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 INFO  : subdir-not/subdir-not2: Making directory
2025/01/17 01:45:12 INFO  : subdir/subdirA: Making directory
2025/01/17 01:45:12 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 INFO  : subdirX/subdirX1: Making directory
2025/01/17 01:45:12 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 INFO  : subdir/subdirB: Making directory
2025/01/17 01:45:12 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:12 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path2': Waiting for checks to finish
2025/01/17 01:45:12 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path2': Waiting for transfers to finish
2025/01/17 01:45:13 INFO  : file2.txt: Copied (new)
2025/01/17 01:45:14 INFO  : file3.txt: Copied (new)
2025/01/17 01:45:15 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:15 INFO  : subdir-not/file20.txt: Copied (new)
2025/01/17 01:45:16 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:45:17 INFO  : file4.txt: Copied (new)
2025/01/17 01:45:19 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:45:21 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/01/17 01:45:21 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/01/17 01:45:21 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/01/17 01:45:22 INFO  : subdirX/file20.txt: Copied (new)
2025/01/17 01:45:23 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/01/17 01:45:23 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/01/17 01:45:24 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/01/17 01:45:24 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/01/17 01:45:24 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/01/17 01:45:26 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/01/17 01:45:26 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/01/17 01:45:28 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/01/17 01:45:28 NOTICE: checking path2 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/check_access_filters/path2'
2025/01/17 01:45:28 NOTICE: (01)  : test check-access-filters
2025/01/17 01:45:28 NOTICE: (02)  : test EXCLUDE - OTHER TESTS
2025/01/17 01:45:28 NOTICE: (03)  : copy-file /tmp/014336pu/datadir/test_check_access_filters-voqofec9/exclude-other-filtersfile.txt /tmp/014336pu/workdir/
2025/01/17 01:45:28 INFO  : exclude-other-filtersfile.txt: Copied (new)
2025/01/17 01:45:28 NOTICE: (04)  : test resync to get the filters file md5 built.
2025/01/17 01:45:28 NOTICE: (05)  : bisync resync filters-file=/tmp/014336pu/workdir/exclude-other-filtersfile.txt
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncRemoteRemote/createemptysrcdirs
2025/01/17 01:45:28 INFO  : path1: Making directory
2025/01/17 01:45:28 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1"
2025/01/17 01:45:29 INFO  : path2: Making directory
2025/01/17 01:45:29 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path2"
2025/01/17 01:45:29 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_createemptysrcdirs/initial"
2025/01/17 01:45:29 DEBUG : Creating backend with remote "/tmp/014336pu/initdir/test_createemptysrcdirs-mudemeb8"
2025/01/17 01:45:29 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : Local file system at /tmp/014336pu/initdir/test_createemptysrcdirs-mudemeb8: Waiting for checks to finish
2025/01/17 01:45:29 DEBUG : Local file system at /tmp/014336pu/initdir/test_createemptysrcdirs-mudemeb8: Waiting for transfers to finish
2025/01/17 01:45:29 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt
2025/01/17 01:45:29 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt
2025/01/17 01:45:29 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:45:29 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt
2025/01/17 01:45:29 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:45:29 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:45:29 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt
2025/01/17 01:45:29 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:45:29 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt
2025/01/17 01:45:29 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:45:29 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_createemptysrcdirs/modfiles"
2025/01/17 01:45:29 DEBUG : Creating backend with remote "/tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9"
2025/01/17 01:45:29 DEBUG : placeholder.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : Local file system at /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9: Waiting for checks to finish
2025/01/17 01:45:29 DEBUG : Local file system at /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9: Waiting for transfers to finish
2025/01/17 01:45:29 DEBUG : placeholder.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:29 DEBUG : placeholder.txt.4db661ca.partial: renamed to: placeholder.txt
2025/01/17 01:45:29 INFO  : placeholder.txt: Copied (new)
2025/01/17 01:45:29 ERROR : : error listing: directory not found
2025/01/17 01:45:29 ERROR : : error listing: directory not found
2025/01/17 01:45:29 NOTICE: checking initFs Local file system at /tmp/014336pu/initdir/test_createemptysrcdirs-mudemeb8
2025/01/17 01:45:29 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:29 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1': Waiting for checks to finish
2025/01/17 01:45:29 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1': Waiting for transfers to finish
2025/01/17 01:45:32 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:45:32 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:45:33 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:45:33 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:45:34 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:45:35 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:35 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:45:35 NOTICE: checking Path1 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1'
2025/01/17 01:45:35 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:35 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path2': Waiting for checks to finish
2025/01/17 01:45:35 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path2': Waiting for transfers to finish
2025/01/17 01:45:38 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:45:39 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:45:39 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:45:39 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:45:40 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:41 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:45:44 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:45:44 NOTICE: checking path2 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path2'
2025/01/17 01:45:44 NOTICE: (01)  : test createemptysrcdirs
2025/01/17 01:45:44 NOTICE: (02)  : test initial bisync
2025/01/17 01:45:44 NOTICE: (03)  : touch-glob 2001-01-02 /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/ placeholder.txt
2025/01/17 01:45:44 NOTICE: (04)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.txt
2025/01/17 01:45:44 NOTICE: (05)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.copy1.txt
2025/01/17 01:45:44 NOTICE: (06)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.copy2.txt
2025/01/17 01:45:45 NOTICE: (07)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.copy3.txt
2025/01/17 01:45:45 NOTICE: (08)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.copy4.txt
2025/01/17 01:45:45 NOTICE: (09)  : copy-as /tmp/014336pu/datadir/test_createemptysrcdirs-nalipip9/placeholder.txt TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/createemptysrcdirs/path1/ file1.copy5.txt
2025/01/17 01:45:46 NOTICE: (10)  : bisync resync
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncRemoteRemote/ignorelistingchecksum
2025/01/17 01:45:46 INFO  : path1: Making directory
2025/01/17 01:45:46 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path1"
2025/01/17 01:45:46 INFO  : path2: Making directory
2025/01/17 01:45:46 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path2"
2025/01/17 01:45:46 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/initial"
2025/01/17 01:45:46 DEBUG : Creating backend with remote "/tmp/014336pu/initdir/test_ignorelistingchecksum-gigotoj0"
2025/01/17 01:45:46 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : subdir: Making directory with metadata
2025/01/17 01:45:46 INFO  : subdir: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z)
2025/01/17 01:45:46 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/01/17 01:45:46 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : Local file system at /tmp/014336pu/initdir/test_ignorelistingchecksum-gigotoj0: Waiting for checks to finish
2025/01/17 01:45:46 DEBUG : Local file system at /tmp/014336pu/initdir/test_ignorelistingchecksum-gigotoj0: Waiting for transfers to finish
2025/01/17 01:45:46 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt
2025/01/17 01:45:46 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:45:46 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:45:46 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt
2025/01/17 01:45:46 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:45:46 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt
2025/01/17 01:45:46 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:45:46 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/01/17 01:45:46 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:45:46 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:45:46 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:46 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt
2025/01/17 01:45:46 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/01/17 01:45:46 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:45:46 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:45:46 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:45:46 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt
2025/01/17 01:45:46 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:45:46 INFO  : subdir: Set directory modification time (using SetModTime)
2025/01/17 01:45:46 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/modfiles"
2025/01/17 01:45:46 DEBUG : Creating backend with remote "/tmp/014336pu/datadir/test_ignorelistingchecksum-pawitaz3"
2025/01/17 01:45:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : Local file system at /tmp/014336pu/datadir/test_ignorelistingchecksum-pawitaz3: Waiting for checks to finish
2025/01/17 01:45:46 DEBUG : Local file system at /tmp/014336pu/datadir/test_ignorelistingchecksum-pawitaz3: Waiting for transfers to finish
2025/01/17 01:45:46 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/01/17 01:45:46 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt
2025/01/17 01:45:46 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:46 ERROR : : error listing: directory not found
2025/01/17 01:45:46 ERROR : : error listing: directory not found
2025/01/17 01:45:46 NOTICE: checking initFs Local file system at /tmp/014336pu/initdir/test_ignorelistingchecksum-gigotoj0
2025/01/17 01:45:46 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:46 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:45:46 INFO  : subdir: Making directory
2025/01/17 01:45:47 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:45:47 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path1': Waiting for checks to finish
2025/01/17 01:45:47 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path1': Waiting for transfers to finish
2025/01/17 01:45:49 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:45:49 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:45:50 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:45:52 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:45:52 INFO  : file1.txt: Copied (new)
2025/01/17 01:45:54 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:45:55 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:46:07 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:46:07 NOTICE: checking Path1 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path1'
2025/01/17 01:46:07 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/01/17 01:46:07 INFO  : subdir: Making directory
2025/01/17 01:46:07 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:07 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path2': Waiting for checks to finish
2025/01/17 01:46:07 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path2': Waiting for transfers to finish
2025/01/17 01:46:10 INFO  : file1.copy1.txt: Copied (new)
2025/01/17 01:46:10 INFO  : file1.copy3.txt: Copied (new)
2025/01/17 01:46:10 INFO  : file1.copy2.txt: Copied (new)
2025/01/17 01:46:11 INFO  : file1.copy4.txt: Copied (new)
2025/01/17 01:46:12 INFO  : file1.txt: Copied (new)
2025/01/17 01:46:13 INFO  : RCLONE_TEST: Copied (new)
2025/01/17 01:46:14 INFO  : subdir/file20.txt: Copied (new)
2025/01/17 01:46:15 INFO  : file1.copy5.txt: Copied (new)
2025/01/17 01:46:15 NOTICE: checking path2 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/ignorelistingchecksum/path2'
2025/01/17 01:46:15 NOTICE: (01)  : test basic
2025/01/17 01:46:15 NOTICE: (02)  : test initial bisync
2025/01/17 01:46:15 NOTICE: (03)  : bisync resync
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncRemoteRemote/max_delete_path2_force
2025/01/17 01:46:15 INFO  : path1: Making directory
2025/01/17 01:46:15 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path1"
2025/01/17 01:46:15 INFO  : path2: Making directory
2025/01/17 01:46:15 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path2"
2025/01/17 01:46:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/initial"
2025/01/17 01:46:16 DEBUG : Creating backend with remote "/tmp/014336pu/initdir/test_max_delete_path2_force-tuxecuz2"
2025/01/17 01:46:16 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file9.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/01/17 01:46:16 INFO  : file2.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : Local file system at /tmp/014336pu/initdir/test_max_delete_path2_force-tuxecuz2: Waiting for checks to finish
2025/01/17 01:46:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/01/17 01:46:16 INFO  : file3.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/01/17 01:46:16 INFO  : file1.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/01/17 01:46:16 INFO  : file6.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : Local file system at /tmp/014336pu/initdir/test_max_delete_path2_force-tuxecuz2: Waiting for transfers to finish
2025/01/17 01:46:16 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/01/17 01:46:16 INFO  : file8.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/01/17 01:46:16 INFO  : file4.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/01/17 01:46:16 INFO  : file5.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/01/17 01:46:16 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/01/17 01:46:16 INFO  : file7.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/01/17 01:46:16 DEBUG : file9.txt.cf9a93ac.partial: renamed to: file9.txt
2025/01/17 01:46:16 INFO  : file9.txt: Copied (new)
2025/01/17 01:46:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/modfiles"
2025/01/17 01:46:16 DEBUG : Creating backend with remote "/tmp/014336pu/datadir/test_max_delete_path2_force-kasazat6"
2025/01/17 01:46:16 DEBUG : hold.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : Local file system at /tmp/014336pu/datadir/test_max_delete_path2_force-kasazat6: Waiting for checks to finish
2025/01/17 01:46:16 DEBUG : Local file system at /tmp/014336pu/datadir/test_max_delete_path2_force-kasazat6: Waiting for transfers to finish
2025/01/17 01:46:16 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK
2025/01/17 01:46:16 DEBUG : hold.txt.627e309f.partial: renamed to: hold.txt
2025/01/17 01:46:16 INFO  : hold.txt: Copied (new)
2025/01/17 01:46:16 ERROR : : error listing: directory not found
2025/01/17 01:46:16 ERROR : : error listing: directory not found
2025/01/17 01:46:16 NOTICE: checking initFs Local file system at /tmp/014336pu/initdir/test_max_delete_path2_force-tuxecuz2
2025/01/17 01:46:16 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : file9.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:16 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path1': Waiting for checks to finish
2025/01/17 01:46:16 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path1': Waiting for transfers to finish
2025/01/17 01:46:19 INFO  : file4.txt: Copied (new)
2025/01/17 01:46:19 INFO  : file3.txt: Copied (new)
2025/01/17 01:46:19 INFO  : file1.txt: Copied (new)
2025/01/17 01:46:20 INFO  : file2.txt: Copied (new)
2025/01/17 01:46:20 INFO  : file6.txt: Copied (new)
2025/01/17 01:46:21 INFO  : file5.txt: Copied (new)
2025/01/17 01:46:22 INFO  : file8.txt: Copied (new)
2025/01/17 01:46:23 INFO  : file9.txt: Copied (new)
2025/01/17 01:46:23 INFO  : file7.txt: Copied (new)
2025/01/17 01:46:23 NOTICE: checking Path1 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path1'
2025/01/17 01:46:23 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : file9.txt: Need to transfer - File not found at Destination
2025/01/17 01:46:23 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path2': Waiting for checks to finish
2025/01/17 01:46:23 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path2': Waiting for transfers to finish
2025/01/17 01:46:25 INFO  : file2.txt: Copied (new)
2025/01/17 01:46:25 INFO  : file3.txt: Copied (new)
2025/01/17 01:46:26 INFO  : file1.txt: Copied (new)
2025/01/17 01:46:27 INFO  : file6.txt: Copied (new)
2025/01/17 01:46:27 INFO  : file5.txt: Copied (new)
2025/01/17 01:46:27 INFO  : file4.txt: Copied (new)
2025/01/17 01:46:27 INFO  : file7.txt: Copied (new)
2025/01/17 01:46:29 INFO  : file8.txt: Copied (new)
2025/01/17 01:46:32 INFO  : file9.txt: Copied (new)
2025/01/17 01:46:32 NOTICE: checking path2 premiumize.me root 'rclone-test-sagucay9nopi/014336pu/max_delete_path2_force/path2'
2025/01/17 01:46:32 NOTICE: (01)  : test max-delete-path2-force
2025/01/17 01:46:32 NOTICE: (02)  : test initial bisync
2025/01/17 01:46:32 NOTICE: (03)  : bisync resync
    bisync_test.go:957: skipping test as at least one remote does not support setting modtime
2025/01/17 01:46:32 DEBUG : premiumize.me root 'rclone-test-sagucay9nopi': Purge remote
--- PASS: TestBisyncRemoteRemote (176.33s)
    --- SKIP: TestBisyncRemoteRemote/basic (47.08s)
    --- SKIP: TestBisyncRemoteRemote/check_access_filters (65.62s)
    --- SKIP: TestBisyncRemoteRemote/createemptysrcdirs (17.25s)
    --- SKIP: TestBisyncRemoteRemote/ignorelistingchecksum (29.46s)
    --- SKIP: TestBisyncRemoteRemote/max_delete_path2_force (16.62s)
PASS
2025/01/17 01:46:32 DEBUG : premiumize.me root 'rclone-test-felarut6notu': Purge remote
2025/01/17 01:46:32 NOTICE: purge failed: directory not found
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose -test.run '^TestBisyncLocalRemote$/^(backupdir|extended_filenames)$|^TestBisyncRemoteRemote$/^(basic|check_access_filters|createemptysrcdirs|ignorelistingchecksum|max_delete_path2_force)$'" - Finished OK in 4m38.304882112s (try 2/5)