"./bisync.test -test.v -test.timeout 1h0m0s -remote TestChunkerMailru: -verbose -test.run '^TestBisyncLocalRemote$/^(resync|resync_modes|rmdirs|volatile)$|^TestBisyncRemoteRemote$/^(all_changed|backupdir|basic|changes|check_access|check_access_filters|check_filename|check_sync|compare_all|createemptysrcdirs|dry_run|equal|ext_paths|extended_filenames|filters|filtersfile_checks|ignorelistingchecksum|max_delete_path1|max_delete_path2_force|nomodtime|normalization|rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Starting (try 3/5) 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jolipol0hurawej2murebiw3" 2024/04/18 03:37:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestMailru:rclone-test-jolipol0hurawej2murebiw3" 2024/04/18 03:37:12 DEBUG : Reset feature "ListR" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "/tmp/rclone4303374" === RUN TestBisyncLocalRemote 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4" 2024/04/18 03:37:12 DEBUG : Reset feature "ListR" 2024/04/18 03:37:12 remote: TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4 === RUN TestBisyncLocalRemote/resync 2024/04/18 03:37:12 DEBUG : Creating backend with remote "/tmp/033712de" 2024/04/18 03:37:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "/tmp/033712de/resync/path1" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de" 2024/04/18 03:37:12 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de" 2024/04/18 03:37:12 DEBUG : Reset feature "ListR" 2024/04/18 03:37:12 DEBUG : path2: Making directory 2024/04/18 03:37:12 DEBUG : [rclone-test-jiraqev4goyikol4ramiyat4/033712de]: new meta server: https://cld-extapi.datacloudmail.ru/meta/ 2024/04/18 03:37:12 DEBUG : [rclone-test-jiraqev4goyikol4ramiyat4/033712de]: mkDirs by part "/rclone-test-jiraqev4goyikol4ramiyat4/033712de/path2" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/resync/path2" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/resync/path2" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/initdir/test_resync-yiwexel7" 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_resync-yiwexel7: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_resync-yiwexel7: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.txt.melakef8.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file2.txt.dadibaw0.partial: renamed to: file2.txt 2024/04/18 03:37:13 INFO : file2.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file3.txt.rugimur6.partial: renamed to: file3.txt 2024/04/18 03:37:13 INFO : file3.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file5.txt.tokeqaq1.partial: renamed to: file5.txt 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:13 INFO : file5.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : RCLONE_TEST.roqajoq4.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:13 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:13 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file4.txt.hihatef3.partial: renamed to: file4.txt 2024/04/18 03:37:13 INFO : file4.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file6.txt.yocifuy6.partial: renamed to: file6.txt 2024/04/18 03:37:13 INFO : file6.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file7.txt.temozuh5.partial: renamed to: file7.txt 2024/04/18 03:37:13 INFO : file7.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/datadir/test_resync-leqofax0" 2024/04/18 03:37:13 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_resync-leqofax0: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_resync-leqofax0: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : fileB.txt.sesesek0.partial: renamed to: fileB.txt 2024/04/18 03:37:13 INFO : fileB.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : fileA.txt.xapurid0.partial: renamed to: fileA.txt 2024/04/18 03:37:13 INFO : fileA.txt: Copied (new) 2024/04/18 03:37:13 ERROR : : error listing: directory not found 2024/04/18 03:37:13 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncLocalRemote/resync_modes 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/resync_modes/path1" 2024/04/18 03:37:13 DEBUG : path2: Making directory 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/resync_modes/path2" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/resync_modes/path2" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/initdir/test_resync_modes-qivesif8" 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_resync_modes-qivesif8: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_resync_modes-qivesif8: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.txt.zaxikaf4.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file2.txt.boniseh5.partial: renamed to: file2.txt 2024/04/18 03:37:13 INFO : file2.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:13 DEBUG : RCLONE_TEST.jeyiwix0.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:13 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/datadir/test_resync_modes-yoxobis2" 2024/04/18 03:37:13 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_resync_modes-yoxobis2: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_resync_modes-yoxobis2: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2024/04/18 03:37:13 DEBUG : file1L.txt.nezuwey8.partial: renamed to: file1L.txt 2024/04/18 03:37:13 INFO : file1L.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK 2024/04/18 03:37:13 DEBUG : file1R.txt.lakexuv9.partial: renamed to: file1R.txt 2024/04/18 03:37:13 INFO : file1R.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2024/04/18 03:37:13 DEBUG : file2.txt.neweyol3.partial: renamed to: file2.txt 2024/04/18 03:37:13 INFO : file2.txt: Copied (new) 2024/04/18 03:37:13 ERROR : : error listing: directory not found 2024/04/18 03:37:13 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncLocalRemote/rmdirs 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/rmdirs/path1" 2024/04/18 03:37:13 DEBUG : path2: Making directory 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/rmdirs/path2" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/rmdirs/path2" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/initdir/test_rmdirs-vujewan6" 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:13 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:13 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:13 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.copy1.txt.gavozit2.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:13 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.copy3.txt.fozubev6.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:13 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.copy2.txt.sahanat7.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:13 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_rmdirs-vujewan6: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : file1.copy5.txt.hukirez6.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:13 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_rmdirs-vujewan6: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:13 DEBUG : RCLONE_TEST.sejolam4.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:13 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.txt.xiqamir6.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : subdir/file20.txt.favopos6.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:13 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.copy4.txt.cobemif6.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:13 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:13 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/datadir/test_rmdirs-zehunoq6" 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_rmdirs-zehunoq6: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_rmdirs-zehunoq6: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file1.txt.vilogot1.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 ERROR : : error listing: directory not found 2024/04/18 03:37:13 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncLocalRemote/volatile 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/volatile/path1" 2024/04/18 03:37:13 DEBUG : path2: Making directory 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/volatile/path2" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-jiraqev4goyikol4ramiyat4/033712de/volatile/path2" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/initdir/test_volatile-hilawew6" 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file1.txt.mofuwus2.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file2.txt.veligob4.partial: renamed to: file2.txt 2024/04/18 03:37:13 INFO : file2.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file3.txt.qeciguv1.partial: renamed to: file3.txt 2024/04/18 03:37:13 INFO : file3.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_volatile-hilawew6: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/initdir/test_volatile-hilawew6: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file4.txt.sarokod9.partial: renamed to: file4.txt 2024/04/18 03:37:13 INFO : file4.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file5.txt.toqoqod1.partial: renamed to: file5.txt 2024/04/18 03:37:13 INFO : file5.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:13 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : RCLONE_TEST.tinoyuz8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:13 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:13 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file8.txt.qadukig5.partial: renamed to: file8.txt 2024/04/18 03:37:13 INFO : file8.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : file7.txt.pevoraq2.partial: renamed to: file7.txt 2024/04/18 03:37:13 INFO : file7.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file6.txt.lojowug7.partial: renamed to: file6.txt 2024/04/18 03:37:13 INFO : file6.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "/tmp/033712de/datadir/test_volatile-sabadec2" 2024/04/18 03:37:13 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:13 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:13 DEBUG : dummy.txt.gehekiy3.partial: renamed to: dummy.txt 2024/04/18 03:37:13 INFO : dummy.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file1.txt.tabaleh3.partial: renamed to: file1.txt 2024/04/18 03:37:13 INFO : file1.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_volatile-sabadec2: Waiting for checks to finish 2024/04/18 03:37:13 DEBUG : Local file system at /tmp/033712de/datadir/test_volatile-sabadec2: Waiting for transfers to finish 2024/04/18 03:37:13 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:13 DEBUG : file11.txt.soloqeq6.partial: renamed to: file11.txt 2024/04/18 03:37:13 INFO : file11.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:13 DEBUG : file5L.txt.riqemir0.partial: renamed to: file5L.txt 2024/04/18 03:37:13 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file2.txt.lahorab0.partial: renamed to: file2.txt 2024/04/18 03:37:13 INFO : file2.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file10.txt.hurolif2.partial: renamed to: file10.txt 2024/04/18 03:37:13 INFO : file10.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file6.txt.ponudim6.partial: renamed to: file6.txt 2024/04/18 03:37:13 INFO : file6.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:13 DEBUG : file7.txt.rekuwar8.partial: renamed to: file7.txt 2024/04/18 03:37:13 INFO : file7.txt: Copied (new) 2024/04/18 03:37:13 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:13 DEBUG : file5R.txt.rilorem2.partial: renamed to: file5R.txt 2024/04/18 03:37:13 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:13 ERROR : : error listing: directory not found 2024/04/18 03:37:13 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value 2024/04/18 03:37:13 DEBUG : Chunked 'TestChunkerMailru:rclone-test-jiraqev4goyikol4ramiyat4': Purge remote 2024/04/18 03:37:13 purge failed: purge failed: invalid character '<' looking for beginning of value --- FAIL: TestBisyncLocalRemote (1.16s) --- FAIL: TestBisyncLocalRemote/resync (0.45s) --- FAIL: TestBisyncLocalRemote/resync_modes (0.19s) --- FAIL: TestBisyncLocalRemote/rmdirs (0.20s) --- FAIL: TestBisyncLocalRemote/volatile (0.21s) === RUN TestBisyncRemoteRemote 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 remote: TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5 === RUN TestBisyncRemoteRemote/all_changed 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi" 2024/04/18 03:37:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/18 03:37:13 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi" 2024/04/18 03:37:13 DEBUG : Reset feature "ListR" 2024/04/18 03:37:13 DEBUG : path1: Making directory 2024/04/18 03:37:13 DEBUG : [rclone-test-hizibun6xugetuq6raqimuf5/033713vi]: new meta server: https://cld-extapi.datacloudmail.ru/meta/ 2024/04/18 03:37:13 DEBUG : [rclone-test-hizibun6xugetuq6raqimuf5/033713vi]: mkDirs by part "/rclone-test-hizibun6xugetuq6raqimuf5/033713vi/path1" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/all_changed/path1" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/all_changed/path1" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : path2: Making directory 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/all_changed/path2" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/all_changed/path2" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_all_changed-yexabag4" 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:14 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:14 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:14 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy1.txt.qewoyid8.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:14 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_all_changed-yexabag4: Waiting for checks to finish 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_all_changed-yexabag4: Waiting for transfers to finish 2024/04/18 03:37:14 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy3.txt.wisonov4.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:14 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy5.txt.zinavub0.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:14 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy2.txt.kodaxov8.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:14 DEBUG : file1.txt.puxuhax0.partial: renamed to: file1.txt 2024/04/18 03:37:14 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:14 INFO : file1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file1.copy4.txt.lejuday1.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:14 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : subdir/file20.txt.dasobuj8.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:14 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:14 DEBUG : RCLONE_TEST.felezuw7.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:14 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:14 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:14 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/backupdir 2024/04/18 03:37:14 DEBUG : path1: Making directory 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/backupdir/path1" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/backupdir/path1" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : path2: Making directory 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/backupdir/path2" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/backupdir/path2" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_backupdir/initial" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_backupdir-rukasax2" 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_backupdir-rukasax2: Waiting for checks to finish 2024/04/18 03:37:14 DEBUG : file1.txt.riqujot7.partial: renamed to: file1.txt 2024/04/18 03:37:14 INFO : file1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_backupdir-rukasax2: Waiting for transfers to finish 2024/04/18 03:37:14 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file4.txt.delugay6.partial: renamed to: file4.txt 2024/04/18 03:37:14 INFO : file4.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file2.txt.befeges1.partial: renamed to: file2.txt 2024/04/18 03:37:14 INFO : file2.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file5.txt.rodiwiy4.partial: renamed to: file5.txt 2024/04/18 03:37:14 INFO : file5.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file3.txt.fiwonur4.partial: renamed to: file3.txt 2024/04/18 03:37:14 INFO : file3.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:14 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : RCLONE_TEST.geseceb7.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:14 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:14 DEBUG : file7.txt.kofopoq4.partial: renamed to: file7.txt 2024/04/18 03:37:14 INFO : file7.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file6.txt.hoyudoy7.partial: renamed to: file6.txt 2024/04/18 03:37:14 INFO : file6.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file8.txt.gudayir4.partial: renamed to: file8.txt 2024/04/18 03:37:14 INFO : file8.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_backupdir/modfiles" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_backupdir-jacoboh7" 2024/04/18 03:37:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : file1.txt.bisuwar0.partial: renamed to: file1.txt 2024/04/18 03:37:14 INFO : file1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/datadir/test_backupdir-jacoboh7: Waiting for checks to finish 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/datadir/test_backupdir-jacoboh7: Waiting for transfers to finish 2024/04/18 03:37:14 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:14 DEBUG : file10.txt.ximuvel4.partial: renamed to: file10.txt 2024/04/18 03:37:14 DEBUG : file11.txt.cekuvih4.partial: renamed to: file11.txt 2024/04/18 03:37:14 INFO : file10.txt: Copied (new) 2024/04/18 03:37:14 INFO : file11.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file2.txt.herovec2.partial: renamed to: file2.txt 2024/04/18 03:37:14 INFO : file2.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:14 DEBUG : file5L.txt.wojayiw4.partial: renamed to: file5L.txt 2024/04/18 03:37:14 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : file6.txt.tayiwor9.partial: renamed to: file6.txt 2024/04/18 03:37:14 DEBUG : file7.txt.qemesul1.partial: renamed to: file7.txt 2024/04/18 03:37:14 INFO : file6.txt: Copied (new) 2024/04/18 03:37:14 INFO : file7.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:14 DEBUG : file5R.txt.mifoguc8.partial: renamed to: file5R.txt 2024/04/18 03:37:14 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:14 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/basic 2024/04/18 03:37:14 DEBUG : path1: Making directory 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/basic/path1" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/basic/path1" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : path2: Making directory 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/basic/path2" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/basic/path2" 2024/04/18 03:37:14 DEBUG : Reset feature "ListR" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/initial" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_basic-luyuher2" 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy1.txt.voqozok9.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:14 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:14 DEBUG : file1.copy2.txt.jezatuq0.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:14 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:14 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:14 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:14 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy4.txt.comaruf1.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:14 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_basic-luyuher2: Waiting for checks to finish 2024/04/18 03:37:14 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/initdir/test_basic-luyuher2: Waiting for transfers to finish 2024/04/18 03:37:14 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.copy5.txt.muduman1.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:14 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:14 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:14 DEBUG : file1.txt.xiniyit3.partial: renamed to: file1.txt 2024/04/18 03:37:14 INFO : file1.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : subdir/file20.txt.daqexag2.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:14 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:14 DEBUG : RCLONE_TEST.kogosim9.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:14 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:14 DEBUG : file1.copy3.txt.maxolan0.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:14 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:14 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_basic/modfiles" 2024/04/18 03:37:14 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_basic-somobas7" 2024/04/18 03:37:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/datadir/test_basic-somobas7: Waiting for checks to finish 2024/04/18 03:37:14 DEBUG : Local file system at /tmp/033713vi/datadir/test_basic-somobas7: Waiting for transfers to finish 2024/04/18 03:37:14 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:14 DEBUG : file1.txt.gebecew5.partial: renamed to: file1.txt 2024/04/18 03:37:14 INFO : file1.txt: Copied (new) 2024/04/18 03:37:15 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/changes 2024/04/18 03:37:15 DEBUG : path1: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/changes/path1" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/changes/path1" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : path2: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/changes/path2" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/changes/path2" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/initial" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_changes-kasegoq2" 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_changes-kasegoq2: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_changes-kasegoq2: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file1.txt.livurey1.partial: renamed to: file1.txt 2024/04/18 03:37:15 INFO : file1.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file2.txt.damopuy4.partial: renamed to: file2.txt 2024/04/18 03:37:15 INFO : file2.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file3.txt.sodopiz0.partial: renamed to: file3.txt 2024/04/18 03:37:15 INFO : file3.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file4.txt.viqujud4.partial: renamed to: file4.txt 2024/04/18 03:37:15 INFO : file4.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : file5.txt.fobulag4.partial: renamed to: file5.txt 2024/04/18 03:37:15 INFO : file5.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : RCLONE_TEST.geyukiq8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:15 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : file6.txt.mefuhig8.partial: renamed to: file6.txt 2024/04/18 03:37:15 INFO : file6.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file7.txt.buzeyah1.partial: renamed to: file7.txt 2024/04/18 03:37:15 DEBUG : file8.txt.xixuhib4.partial: renamed to: file8.txt 2024/04/18 03:37:15 INFO : file8.txt: Copied (new) 2024/04/18 03:37:15 INFO : file7.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/modfiles" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_changes-jihumep5" 2024/04/18 03:37:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_changes-jihumep5: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_changes-jihumep5: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:15 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:15 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:15 DEBUG : file10.txt.nozawen3.partial: renamed to: file10.txt 2024/04/18 03:37:15 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:15 DEBUG : file11.txt.bebavit9.partial: renamed to: file11.txt 2024/04/18 03:37:15 INFO : file11.txt: Copied (new) 2024/04/18 03:37:15 INFO : file10.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file2.txt.xehixem2.partial: renamed to: file2.txt 2024/04/18 03:37:15 INFO : file2.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file1.txt.qekihuz1.partial: renamed to: file1.txt 2024/04/18 03:37:15 INFO : file1.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:15 DEBUG : file5L.txt.puxuyag4.partial: renamed to: file5L.txt 2024/04/18 03:37:15 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:15 DEBUG : file5R.txt.sifurux0.partial: renamed to: file5R.txt 2024/04/18 03:37:15 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:15 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:15 DEBUG : file6.txt.suwuxoc6.partial: renamed to: file6.txt 2024/04/18 03:37:15 INFO : file6.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:15 DEBUG : file7.txt.dijejuf0.partial: renamed to: file7.txt 2024/04/18 03:37:15 INFO : file7.txt: Copied (new) 2024/04/18 03:37:15 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/check_access 2024/04/18 03:37:15 DEBUG : path1: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access/path1" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access/path1" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : path2: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access/path2" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access/path2" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access/initial" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_check_access-femumen1" 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:15 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file1.txt.zofuxem5.partial: renamed to: file1.txt 2024/04/18 03:37:15 INFO : file1.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_access-femumen1: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_access-femumen1: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file2.txt.forugop7.partial: renamed to: file2.txt 2024/04/18 03:37:15 INFO : file2.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : file4.txt.payogas7.partial: renamed to: file4.txt 2024/04/18 03:37:15 INFO : file4.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir/file20.txt.zipupiw0.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:15 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : RCLONE_TEST.papexiz8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:15 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file3.txt.fizecog8.partial: renamed to: file3.txt 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 INFO : file3.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST.mixujod0.partial: renamed to: subdir/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access/modfiles" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_check_access-kurijez4" 2024/04/18 03:37:15 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_access-kurijez4: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_access-kurijez4: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/18 03:37:15 DEBUG : hold.txt.gusovoz6.partial: renamed to: hold.txt 2024/04/18 03:37:15 INFO : hold.txt: Copied (new) 2024/04/18 03:37:15 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/check_access_filters 2024/04/18 03:37:15 DEBUG : path1: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access_filters/path1" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access_filters/path1" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : path2: Making directory 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access_filters/path2" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_access_filters/path2" 2024/04/18 03:37:15 DEBUG : Reset feature "ListR" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/initial" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_check_access_filters-fepekun7" 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:15 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:15 DEBUG : subdir-not: Making directory with metadata 2024/04/18 03:37:15 INFO : subdir-not: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir-not", newDst=subdir-not 2024/04/18 03:37:15 DEBUG : subdirX: Making directory with metadata 2024/04/18 03:37:15 INFO : subdirX: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdirX", newDst=subdirX 2024/04/18 03:37:15 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : file1.txt.sazediv8.partial: renamed to: file1.txt 2024/04/18 03:37:15 INFO : file1.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1: Making directory with metadata 2024/04/18 03:37:15 INFO : subdirX/subdirX1: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdirX/subdirX1", newDst=subdirX/subdirX1 2024/04/18 03:37:15 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file2.txt.lozugaj9.partial: renamed to: file2.txt 2024/04/18 03:37:15 INFO : file2.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : RCLONE_TEST.vosigif1.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:15 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2: Making directory with metadata 2024/04/18 03:37:15 DEBUG : file3.txt.zobutit8.partial: renamed to: file3.txt 2024/04/18 03:37:15 INFO : file3.txt: Copied (new) 2024/04/18 03:37:15 INFO : subdir-not/subdir-not2: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir-not/subdir-not2", newDst=subdir-not/subdir-not2 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir/subdirA: Making directory with metadata 2024/04/18 03:37:15 DEBUG : file4.txt.huzaquj7.partial: renamed to: file4.txt 2024/04/18 03:37:15 INFO : file4.txt: Copied (new) 2024/04/18 03:37:15 INFO : subdir/subdirA: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir/subdirA", newDst=subdir/subdirA 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir/subdirB: Making directory with metadata 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/file30.txt.bijecot4.partial: renamed to: subdirX/subdirX1/file30.txt 2024/04/18 03:37:15 INFO : subdirX/subdirX1/file30.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdirX/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 INFO : subdir/subdirB: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:15 DEBUG : Added delayed dir = "subdir/subdirB", newDst=subdir/subdirB 2024/04/18 03:37:15 DEBUG : subdirX/file20.txt.gupegiq2.partial: renamed to: subdirX/file20.txt 2024/04/18 03:37:15 INFO : subdirX/file20.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdirX/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir-not/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir-not/file20.txt.nifofot2.partial: renamed to: subdir-not/file20.txt 2024/04/18 03:37:15 DEBUG : subdirX/subdirX1/RCLONE_TEST.wedusas2.partial: renamed to: subdirX/subdirX1/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir-not/file20.txt: Copied (new) 2024/04/18 03:37:15 INFO : subdirX/subdirX1/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdirX/RCLONE_TEST.warenaz8.partial: renamed to: subdirX/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdirX/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/file30.txt.gisimat6.partial: renamed to: subdir-not/subdir-not2/file30.txt 2024/04/18 03:37:15 INFO : subdir-not/subdir-not2/file30.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_access_filters-fepekun7: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_access_filters-fepekun7: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir/file20.txt.qizedov6.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:15 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir-not/subdir-not2/RCLONE_TEST.yufahok2.partial: renamed to: subdir-not/subdir-not2/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir-not/subdir-not2/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir/RCLONE_TEST.rohibut5.partial: renamed to: subdir/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirB/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 DEBUG : subdir/subdirB/file30.txt.zomitox8.partial: renamed to: subdir/subdirB/file30.txt 2024/04/18 03:37:15 INFO : subdir/subdirB/file30.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir-not/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir/subdirB/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir-not/RCLONE_TEST.yefomag4.partial: renamed to: subdir-not/RCLONE_TEST 2024/04/18 03:37:15 DEBUG : subdir/subdirA/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:15 INFO : subdir-not/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirB/RCLONE_TEST.tehenaw1.partial: renamed to: subdir/subdirB/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir/subdirB/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirA/file30.txt.rehenam5.partial: renamed to: subdir/subdirA/file30.txt 2024/04/18 03:37:15 INFO : subdir/subdirA/file30.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : subdir/subdirA/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:15 DEBUG : subdir/subdirA/RCLONE_TEST.veyaqos4.partial: renamed to: subdir/subdirA/RCLONE_TEST 2024/04/18 03:37:15 INFO : subdir/subdirA/RCLONE_TEST: Copied (new) 2024/04/18 03:37:15 INFO : subdir/subdirB: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdirX/subdirX1: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdir-not/subdir-not2: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdir/subdirA: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdirX: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 INFO : subdir-not: Set directory modification time (using SetModTime) 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/modfiles" 2024/04/18 03:37:15 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_check_access_filters-wototan7" 2024/04/18 03:37:15 DEBUG : exclude-other-filtersfile.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : include-other-filtersfile.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_access_filters-wototan7: Waiting for checks to finish 2024/04/18 03:37:15 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_access_filters-wototan7: Waiting for transfers to finish 2024/04/18 03:37:15 DEBUG : exclude-other-filtersfile.txt: md5 = 5fcc6205d7df1c2e9ed3a15a1356b345 OK 2024/04/18 03:37:15 DEBUG : include-other-filtersfile.txt: md5 = 2ec13b2813141ed088e5978ef5a47b0e OK 2024/04/18 03:37:15 DEBUG : exclude-other-filtersfile.txt.vosator3.partial: renamed to: exclude-other-filtersfile.txt 2024/04/18 03:37:15 INFO : exclude-other-filtersfile.txt: Copied (new) 2024/04/18 03:37:15 DEBUG : include-other-filtersfile.txt.raqekov3.partial: renamed to: include-other-filtersfile.txt 2024/04/18 03:37:15 INFO : include-other-filtersfile.txt: Copied (new) 2024/04/18 03:37:16 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/check_filename 2024/04/18 03:37:16 DEBUG : path1: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_filename/path1" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_filename/path1" 2024/04/18 03:37:16 DEBUG : Reset feature "ListR" 2024/04/18 03:37:16 DEBUG : path2: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_filename/path2" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_filename/path2" 2024/04/18 03:37:16 DEBUG : Reset feature "ListR" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_filename/initial" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_check_filename-xetemub8" 2024/04/18 03:37:16 DEBUG : .chk_file: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:16 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:16 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:16 DEBUG : subdir/.chk_file: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_filename-xetemub8: Waiting for checks to finish 2024/04/18 03:37:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_filename-xetemub8: Waiting for transfers to finish 2024/04/18 03:37:16 DEBUG : file1.txt.futatuf6.partial: renamed to: file1.txt 2024/04/18 03:37:16 INFO : file1.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file2.txt.hicizod2.partial: renamed to: file2.txt 2024/04/18 03:37:16 INFO : file2.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file3.txt.sepukof7.partial: renamed to: file3.txt 2024/04/18 03:37:16 INFO : file3.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file4.txt.nicaguj7.partial: renamed to: file4.txt 2024/04/18 03:37:16 INFO : file4.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : subdir/file20.txt.lozajex9.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:16 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : subdir/.chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:16 DEBUG : .chk_file: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:16 DEBUG : subdir/.chk_file.simayof6.partial: renamed to: subdir/.chk_file 2024/04/18 03:37:16 INFO : subdir/.chk_file: Copied (new) 2024/04/18 03:37:16 DEBUG : .chk_file.gemeqem3.partial: renamed to: .chk_file 2024/04/18 03:37:16 INFO : .chk_file: Copied (new) 2024/04/18 03:37:16 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_filename/modfiles" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_check_filename-litoxed1" 2024/04/18 03:37:16 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_filename-litoxed1: Waiting for checks to finish 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_filename-litoxed1: Waiting for transfers to finish 2024/04/18 03:37:16 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/18 03:37:16 DEBUG : hold.txt.pigirih0.partial: renamed to: hold.txt 2024/04/18 03:37:16 INFO : hold.txt: Copied (new) 2024/04/18 03:37:16 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/check_sync 2024/04/18 03:37:16 DEBUG : path1: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_sync/path1" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_sync/path1" 2024/04/18 03:37:16 DEBUG : Reset feature "ListR" 2024/04/18 03:37:16 DEBUG : path2: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_sync/path2" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/check_sync/path2" 2024/04/18 03:37:16 DEBUG : Reset feature "ListR" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_sync/initial" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_check_sync-lusaquj1" 2024/04/18 03:37:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file1.txt.lahixih2.partial: renamed to: file1.txt 2024/04/18 03:37:16 INFO : file1.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file2.txt.cigamox0.partial: renamed to: file2.txt 2024/04/18 03:37:16 INFO : file2.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:16 DEBUG : file3.txt.mupujop7.partial: renamed to: file3.txt 2024/04/18 03:37:16 INFO : file3.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file4.txt.vodagik2.partial: renamed to: file4.txt 2024/04/18 03:37:16 INFO : file4.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : RCLONE_TEST.tecacod8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:16 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:16 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file8.txt.kivunim8.partial: renamed to: file8.txt 2024/04/18 03:37:16 INFO : file8.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file7.txt.yoqupax9.partial: renamed to: file7.txt 2024/04/18 03:37:16 INFO : file7.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:16 DEBUG : file6.txt.wilubef7.partial: renamed to: file6.txt 2024/04/18 03:37:16 INFO : file6.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : file5.txt.bedufab5.partial: renamed to: file5.txt 2024/04/18 03:37:16 INFO : file5.txt: Copied (new) 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_sync-lusaquj1: Waiting for checks to finish 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/initdir/test_check_sync-lusaquj1: Waiting for transfers to finish 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_sync/modfiles" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_check_sync-likovij0" 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path1.lst: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path2.lst: Need to transfer - File not found at Destination 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_sync-likovij0: Waiting for checks to finish 2024/04/18 03:37:16 DEBUG : Local file system at /tmp/033713vi/datadir/test_check_sync-likovij0: Waiting for transfers to finish 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path2.lst: md5 = d6ce44a26af9c2110b1750fe88dc4b69 OK 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path2.lst.duyegab0.partial: renamed to: _testdir_path1.._testdir_path2.path2.lst 2024/04/18 03:37:16 INFO : _testdir_path1.._testdir_path2.path2.lst: Copied (new) 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path1.lst: md5 = fdb18e0dff6961813e12c57227d2e854 OK 2024/04/18 03:37:16 DEBUG : _testdir_path1.._testdir_path2.path1.lst.konukak2.partial: renamed to: _testdir_path1.._testdir_path2.path1.lst 2024/04/18 03:37:16 INFO : _testdir_path1.._testdir_path2.path1.lst: Copied (new) 2024/04/18 03:37:16 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/compare_all 2024/04/18 03:37:16 DEBUG : path1: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/compare_all/path1" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/compare_all/path1" 2024/04/18 03:37:16 DEBUG : Reset feature "ListR" 2024/04/18 03:37:16 DEBUG : path2: Making directory 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/compare_all/path2" 2024/04/18 03:37:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/compare_all/path2" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/initial" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_compare_all-tafetan6" 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.txt.hagewoz8.partial: renamed to: file1.txt 2024/04/18 03:37:17 INFO : file1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file2.txt.cenoyom7.partial: renamed to: file2.txt 2024/04/18 03:37:17 INFO : file2.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file3.txt.humalar7.partial: renamed to: file3.txt 2024/04/18 03:37:17 INFO : file3.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file4.txt.xiyequg9.partial: renamed to: file4.txt 2024/04/18 03:37:17 INFO : file4.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file5.txt.xorixog4.partial: renamed to: file5.txt 2024/04/18 03:37:17 INFO : file5.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file6.txt.dopizij1.partial: renamed to: file6.txt 2024/04/18 03:37:17 INFO : file6.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file7.txt.lukewur8.partial: renamed to: file7.txt 2024/04/18 03:37:17 INFO : file7.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file8.txt.mayupag3.partial: renamed to: file8.txt 2024/04/18 03:37:17 INFO : file8.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_compare_all-tafetan6: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_compare_all-tafetan6: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:17 DEBUG : RCLONE_TEST.yitidon9.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:17 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/modfiles" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_compare_all-dusapas3" 2024/04/18 03:37:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_compare_all-dusapas3: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_compare_all-dusapas3: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file10.txt.xepitep1.partial: renamed to: file10.txt 2024/04/18 03:37:17 INFO : file10.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:17 DEBUG : file2.txt.qewitix6.partial: renamed to: file2.txt 2024/04/18 03:37:17 INFO : file2.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:17 DEBUG : file5L.txt.tuvifag7.partial: renamed to: file5L.txt 2024/04/18 03:37:17 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:17 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5R.txt.qaxepiy2.partial: renamed to: file5R.txt 2024/04/18 03:37:17 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file11.txt.dutadis9.partial: renamed to: file11.txt 2024/04/18 03:37:17 INFO : file11.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file1.txt.kadozoq9.partial: renamed to: file1.txt 2024/04/18 03:37:17 INFO : file1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file6.txt.xuverod0.partial: renamed to: file6.txt 2024/04/18 03:37:17 INFO : file6.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file7.txt.pumopig7.partial: renamed to: file7.txt 2024/04/18 03:37:17 INFO : file7.txt: Copied (new) 2024/04/18 03:37:17 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/createemptysrcdirs 2024/04/18 03:37:17 DEBUG : path1: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/createemptysrcdirs/path1" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/createemptysrcdirs/path1" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : path2: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/createemptysrcdirs/path2" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/createemptysrcdirs/path2" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_createemptysrcdirs/initial" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_createemptysrcdirs-jotadec0" 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.copy1.txt.yadisiv1.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:17 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.copy2.txt.merixaz4.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:17 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.copy4.txt.zumeteh8.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:17 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_createemptysrcdirs-jotadec0: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.txt.lenogog2.partial: renamed to: file1.txt 2024/04/18 03:37:17 INFO : file1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_createemptysrcdirs-jotadec0: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.copy5.txt.zivudom4.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:17 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.copy3.txt.fadafoy8.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:17 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:17 DEBUG : RCLONE_TEST.cuzatas7.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:17 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_createemptysrcdirs/modfiles" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_createemptysrcdirs-ciyonej3" 2024/04/18 03:37:17 DEBUG : placeholder.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_createemptysrcdirs-ciyonej3: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_createemptysrcdirs-ciyonej3: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : placeholder.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : placeholder.txt.wivajid1.partial: renamed to: placeholder.txt 2024/04/18 03:37:17 INFO : placeholder.txt: Copied (new) 2024/04/18 03:37:17 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/dry_run 2024/04/18 03:37:17 DEBUG : path1: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/dry_run/path1" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/dry_run/path1" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : path2: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/dry_run/path2" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/dry_run/path2" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/initial" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_dry_run-sodufox8" 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_dry_run-sodufox8: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/initdir/test_dry_run-sodufox8: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:17 DEBUG : file2.txt.titiziz4.partial: renamed to: file2.txt 2024/04/18 03:37:17 DEBUG : RCLONE_TEST.zayetoh9.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:17 INFO : file2.txt: Copied (new) 2024/04/18 03:37:17 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:17 DEBUG : file1.txt.zirojef4.partial: renamed to: file1.txt 2024/04/18 03:37:17 INFO : file1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file3.txt.gesotec0.partial: renamed to: file3.txt 2024/04/18 03:37:17 INFO : file3.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file4.txt.sexoviv5.partial: renamed to: file4.txt 2024/04/18 03:37:17 INFO : file4.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file6.txt.luyutur2.partial: renamed to: file6.txt 2024/04/18 03:37:17 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 INFO : file6.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5.txt.rozegaz4.partial: renamed to: file5.txt 2024/04/18 03:37:17 INFO : file5.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:17 DEBUG : file7.txt.fukunur3.partial: renamed to: file7.txt 2024/04/18 03:37:17 INFO : file7.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/modfiles" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_dry_run-tovepod2" 2024/04/18 03:37:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:17 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file1.txt.wonujev4.partial: renamed to: file1.txt 2024/04/18 03:37:17 INFO : file1.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file11.txt.becukex0.partial: renamed to: file11.txt 2024/04/18 03:37:17 INFO : file11.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_dry_run-tovepod2: Waiting for checks to finish 2024/04/18 03:37:17 DEBUG : Local file system at /tmp/033713vi/datadir/test_dry_run-tovepod2: Waiting for transfers to finish 2024/04/18 03:37:17 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:17 DEBUG : file2.txt.noroxox3.partial: renamed to: file2.txt 2024/04/18 03:37:17 INFO : file2.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:17 DEBUG : file5L.txt.mogawix3.partial: renamed to: file5L.txt 2024/04/18 03:37:17 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:17 DEBUG : file5R.txt.ketiqid3.partial: renamed to: file5R.txt 2024/04/18 03:37:17 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file6.txt.biqayoc2.partial: renamed to: file6.txt 2024/04/18 03:37:17 INFO : file6.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file10.txt.femusuk8.partial: renamed to: file10.txt 2024/04/18 03:37:17 INFO : file10.txt: Copied (new) 2024/04/18 03:37:17 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:17 DEBUG : file7.txt.numuvev8.partial: renamed to: file7.txt 2024/04/18 03:37:17 INFO : file7.txt: Copied (new) 2024/04/18 03:37:17 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/equal 2024/04/18 03:37:17 DEBUG : path1: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/equal/path1" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/equal/path1" 2024/04/18 03:37:17 DEBUG : Reset feature "ListR" 2024/04/18 03:37:17 DEBUG : path2: Making directory 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/equal/path2" 2024/04/18 03:37:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/equal/path2" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_equal/initial" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_equal-ripuroh9" 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_equal-ripuroh9: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_equal-ripuroh9: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file1.txt.yojuraf1.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file2.txt.sahopez8.partial: renamed to: file2.txt 2024/04/18 03:37:18 INFO : file2.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:18 DEBUG : RCLONE_TEST.logigig7.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:18 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_equal/modfiles" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_equal-zucevub4" 2024/04/18 03:37:18 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_equal-zucevub4: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_equal-zucevub4: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK 2024/04/18 03:37:18 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2024/04/18 03:37:18 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2024/04/18 03:37:18 DEBUG : file1R.txt.raliwey5.partial: renamed to: file1R.txt 2024/04/18 03:37:18 INFO : file1R.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file2.txt.reqixaj4.partial: renamed to: file2.txt 2024/04/18 03:37:18 INFO : file2.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file1L.txt.vapemey2.partial: renamed to: file1L.txt 2024/04/18 03:37:18 INFO : file1L.txt: Copied (new) 2024/04/18 03:37:18 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/ext_paths 2024/04/18 03:37:18 DEBUG : path1: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ext_paths/path1" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ext_paths/path1" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : path2: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ext_paths/path2" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ext_paths/path2" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/initial" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_ext_paths-vecajut2" 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : 測試_check file: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ: Making directory with metadata 2024/04/18 03:37:18 INFO : 測試Русский ěáñ: Made directory with metadata (mtime=2024-04-17T01:00:03.064427195Z) 2024/04/18 03:37:18 DEBUG : Added delayed dir = "測試Русский ěáñ", newDst=測試Русский ěáñ 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file1.txt.zitegab0.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:18 DEBUG : RCLONE_TEST.hixowey8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:18 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/測試_check file: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_ext_paths-vecajut2: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Русский.txt.vemovol7.partial: renamed to: Русский.txt 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_ext_paths-vecajut2: Waiting for transfers to finish 2024/04/18 03:37:18 INFO : Русский.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt.likerur4.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/18 03:37:18 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : 測試_check file.moboqut8.partial: renamed to: 測試_check file 2024/04/18 03:37:18 INFO : 測試_check file: Copied (new) 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ࢺ_.txt.sumeyep1.partial: renamed to: 測試Русский ěáñ/filename_contains_ࢺ_.txt 2024/04/18 03:37:18 INFO : 測試Русский ěáñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt.rilolon5.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/filename_contains_ě_.txt.ziragax7.partial: renamed to: 測試Русский ěáñ/filename_contains_ě_.txt 2024/04/18 03:37:18 INFO : 測試Русский ěáñ/filename_contains_ě_.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : 測試Русский ěáñ/測試_check file.vewabum6.partial: renamed to: 測試Русский ěáñ/測試_check file 2024/04/18 03:37:18 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/18 03:37:18 INFO : 測試Русский ěáñ/測試_check file: Copied (new) 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt.zoyoxem6.partial: renamed to: filename_contains_ě_.txt 2024/04/18 03:37:18 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/18 03:37:18 INFO : 測試Русский ěáñ: Set directory modification time (using SetModTime) 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/modfiles" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_ext_paths-gizifim2" 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_ext_paths-gizifim2: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_ext_paths-gizifim2: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/18 03:37:18 DEBUG : 測試_filtersfile.txt.yekavad4.partial: renamed to: 測試_filtersfile.txt 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:18 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file1.txt.vekacow4.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/extended_filenames 2024/04/18 03:37:18 DEBUG : path1: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/extended_filenames/path1" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/extended_filenames/path1" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : path2: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/extended_filenames/path2" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/extended_filenames/path2" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_filenames/initial" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_extended_filenames-kofoyob6" 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1 - Copy (2).txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1 - Copy.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_: Making directory with metadata 2024/04/18 03:37:18 INFO : subdir_with_ࢺ_: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:18 DEBUG : Added delayed dir = "subdir_with_ࢺ_", newDst=subdir_with_ࢺ_ 2024/04/18 03:37:18 DEBUG : Русский.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1 - Copy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file1 - Copy (2).txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1 - Copy.txt.temixix8.partial: renamed to: file1 - Copy.txt 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_extended_filenames-kofoyob6: Waiting for checks to finish 2024/04/18 03:37:18 INFO : file1 - Copy.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_extended_filenames-kofoyob6: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file1.txt.sodatoc9.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file1 - Copy (2).txt.ciqabuj0.partial: renamed to: file1 - Copy (2).txt 2024/04/18 03:37:18 INFO : file1 - Copy (2).txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file_enconde_mañana_funcionará.txt.jitufay6.partial: renamed to: file_enconde_mañana_funcionará.txt 2024/04/18 03:37:18 INFO : file_enconde_mañana_funcionará.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : Русский.txt.pegapov1.partial: renamed to: Русский.txt 2024/04/18 03:37:18 INFO : Русский.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:18 DEBUG : RCLONE_TEST.zodeyar3.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:18 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : filename_contains_ࢺ_.txt.gicimok1.partial: renamed to: filename_contains_ࢺ_.txt 2024/04/18 03:37:18 INFO : filename_contains_ࢺ_.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : filename_contains_ě_.txt.sebuqej6.partial: renamed to: filename_contains_ě_.txt 2024/04/18 03:37:18 INFO : filename_contains_ě_.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ě_.txt.wuxayup6.partial: renamed to: subdir_with_ࢺ_/filename_contains_ě_.txt 2024/04/18 03:37:18 INFO : subdir_with_ࢺ_/filename_contains_ě_.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:18 DEBUG : subdir_with_ࢺ_/filename_contains_ࢺ_.txt.nefefih8.partial: renamed to: subdir_with_ࢺ_/filename_contains_ࢺ_.txt 2024/04/18 03:37:18 INFO : subdir_with_ࢺ_/filename_contains_ࢺ_.txt: Copied (new) 2024/04/18 03:37:18 INFO : subdir_with_ࢺ_: Set directory modification time (using SetModTime) 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_extended_filenames/modfiles" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_extended_filenames-haroleg6" 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_extended_filenames-haroleg6: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_extended_filenames-haroleg6: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:18 DEBUG : file1.txt.lecuzix5.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file2.txt: md5 = 40b811fb5009223b6da573f169619d8e OK 2024/04/18 03:37:18 DEBUG : file2.txt.hatibez9.partial: renamed to: file2.txt 2024/04/18 03:37:18 INFO : file2.txt: Copied (new) 2024/04/18 03:37:18 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/filters 2024/04/18 03:37:18 DEBUG : path1: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filters/path1" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filters/path1" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : path2: Making directory 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filters/path2" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filters/path2" 2024/04/18 03:37:18 DEBUG : Reset feature "ListR" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filters/initial" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_filters-fikupux6" 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file1.txt.rebigif8.partial: renamed to: file1.txt 2024/04/18 03:37:18 INFO : file1.txt: Copied (new) 2024/04/18 03:37:18 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:18 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:18 DEBUG : file2.txt.punuzay3.partial: renamed to: file2.txt 2024/04/18 03:37:18 INFO : file2.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file3.txt.vijicoc8.partial: renamed to: file3.txt 2024/04/18 03:37:18 INFO : file3.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_filters-fikupux6: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/initdir/test_filters-fikupux6: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : RCLONE_TEST.xajevus1.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:18 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:18 DEBUG : file4.txt.liliwoh2.partial: renamed to: file4.txt 2024/04/18 03:37:18 INFO : file4.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file5.txt.qibesuz8.partial: renamed to: file5.txt 2024/04/18 03:37:18 INFO : file5.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file6.txt.yoraxug9.partial: renamed to: file6.txt 2024/04/18 03:37:18 INFO : file6.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : file7.txt.kucabaq7.partial: renamed to: file7.txt 2024/04/18 03:37:18 INFO : file7.txt: Copied (new) 2024/04/18 03:37:18 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:18 DEBUG : subdir/file20.txt.nakozay8.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:18 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:18 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filters/modfiles" 2024/04/18 03:37:18 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_filters-tacakep3" 2024/04/18 03:37:18 DEBUG : fileZ.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : filtersfile.flt: Need to transfer - File not found at Destination 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_filters-tacakep3: Waiting for checks to finish 2024/04/18 03:37:18 DEBUG : Local file system at /tmp/033713vi/datadir/test_filters-tacakep3: Waiting for transfers to finish 2024/04/18 03:37:18 DEBUG : fileZ.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:18 DEBUG : filtersfile.flt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/18 03:37:18 DEBUG : fileZ.txt.tuwotuk5.partial: renamed to: fileZ.txt 2024/04/18 03:37:18 DEBUG : filtersfile.flt.xigikab6.partial: renamed to: filtersfile.flt 2024/04/18 03:37:18 INFO : fileZ.txt: Copied (new) 2024/04/18 03:37:18 INFO : filtersfile.flt: Copied (new) 2024/04/18 03:37:19 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/filtersfile_checks 2024/04/18 03:37:19 DEBUG : path1: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filtersfile_checks/path1" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filtersfile_checks/path1" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : path2: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filtersfile_checks/path2" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/filtersfile_checks/path2" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filtersfile_checks/initial" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_filtersfile_checks-zoponug9" 2024/04/18 03:37:19 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:19 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:19 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:19 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_filtersfile_checks-zoponug9: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_filtersfile_checks-zoponug9: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.txt.faripib3.partial: renamed to: file1.txt 2024/04/18 03:37:19 INFO : file1.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : subdir/file20.txt.hicixiw5.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:19 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file2.txt.tifonuv9.partial: renamed to: file2.txt 2024/04/18 03:37:19 INFO : file2.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:19 DEBUG : RCLONE_TEST.sawoyof9.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:19 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:19 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filtersfile_checks/modfiles" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_filtersfile_checks-yovacot3" 2024/04/18 03:37:19 DEBUG : filtersfile.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : filtersfile2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_filtersfile_checks-yovacot3: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_filtersfile_checks-yovacot3: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : filtersfile.txt: md5 = cbf4389cb34d9e160689d1578eb5707f OK 2024/04/18 03:37:19 DEBUG : filtersfile.txt.dorivit5.partial: renamed to: filtersfile.txt 2024/04/18 03:37:19 INFO : filtersfile.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : filtersfile2.txt: md5 = 95acc1e3b5beda465d9b2cb32808588c OK 2024/04/18 03:37:19 DEBUG : filtersfile2.txt.xicasov5.partial: renamed to: filtersfile2.txt 2024/04/18 03:37:19 INFO : filtersfile2.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/18 03:37:19 DEBUG : hold.txt.quyonuf0.partial: renamed to: hold.txt 2024/04/18 03:37:19 INFO : hold.txt: Copied (new) 2024/04/18 03:37:19 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/ignorelistingchecksum 2024/04/18 03:37:19 DEBUG : path1: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ignorelistingchecksum/path1" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ignorelistingchecksum/path1" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : path2: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ignorelistingchecksum/path2" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/ignorelistingchecksum/path2" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/initial" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_ignorelistingchecksum-lonoyuj0" 2024/04/18 03:37:19 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:19 INFO : subdir: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z) 2024/04/18 03:37:19 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:19 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_ignorelistingchecksum-lonoyuj0: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_ignorelistingchecksum-lonoyuj0: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.copy2.txt.lopuqux3.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:19 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.copy1.txt.sobirex3.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:19 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.copy3.txt.zeqowez2.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:19 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.copy4.txt.devikar3.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:19 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.copy5.txt.waxuxaw1.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:19 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : subdir/file20.txt.tefacec6.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:19 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file1.txt.wuvebar9.partial: renamed to: file1.txt 2024/04/18 03:37:19 INFO : file1.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:19 DEBUG : RCLONE_TEST.tamakiq0.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:19 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:19 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ignorelistingchecksum/modfiles" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_ignorelistingchecksum-yatupuv6" 2024/04/18 03:37:19 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_ignorelistingchecksum-yatupuv6: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_ignorelistingchecksum-yatupuv6: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:19 DEBUG : file1.txt.juceded7.partial: renamed to: file1.txt 2024/04/18 03:37:19 INFO : file1.txt: Copied (new) 2024/04/18 03:37:19 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/max_delete_path1 2024/04/18 03:37:19 DEBUG : path1: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path1/path1" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path1/path1" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : path2: Making directory 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path1/path2" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path1/path2" 2024/04/18 03:37:19 DEBUG : Reset feature "ListR" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path1/initial" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_max_delete_path1-zafaxuv3" 2024/04/18 03:37:19 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file4.txt.zomuwul9.partial: renamed to: file4.txt 2024/04/18 03:37:19 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 INFO : file4.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file9.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_max_delete_path1-zafaxuv3: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/initdir/test_max_delete_path1-zafaxuv3: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : file2.txt.kizidux1.partial: renamed to: file2.txt 2024/04/18 03:37:19 INFO : file2.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file3.txt.natabil4.partial: renamed to: file3.txt 2024/04/18 03:37:19 INFO : file3.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file5.txt.vuduzag9.partial: renamed to: file5.txt 2024/04/18 03:37:19 INFO : file5.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file1.txt.jamuxoc6.partial: renamed to: file1.txt 2024/04/18 03:37:19 INFO : file1.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:19 DEBUG : file6.txt.zaxoquq5.partial: renamed to: file6.txt 2024/04/18 03:37:19 INFO : file6.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file8.txt.kayukod8.partial: renamed to: file8.txt 2024/04/18 03:37:19 INFO : file8.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file7.txt.joqaxan9.partial: renamed to: file7.txt 2024/04/18 03:37:19 INFO : file7.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:19 DEBUG : file9.txt.folusax1.partial: renamed to: file9.txt 2024/04/18 03:37:19 INFO : file9.txt: Copied (new) 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path1/modfiles" 2024/04/18 03:37:19 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_max_delete_path1-saqiduq5" 2024/04/18 03:37:19 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_max_delete_path1-saqiduq5: Waiting for checks to finish 2024/04/18 03:37:19 DEBUG : Local file system at /tmp/033713vi/datadir/test_max_delete_path1-saqiduq5: Waiting for transfers to finish 2024/04/18 03:37:19 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/18 03:37:19 DEBUG : hold.txt.coraquk5.partial: renamed to: hold.txt 2024/04/18 03:37:19 INFO : hold.txt: Copied (new) 2024/04/18 03:37:20 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/max_delete_path2_force 2024/04/18 03:37:20 DEBUG : path1: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path2_force/path1" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path2_force/path1" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : path2: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path2_force/path2" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/max_delete_path2_force/path2" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/initial" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_max_delete_path2_force-jabutir6" 2024/04/18 03:37:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file9.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_max_delete_path2_force-jabutir6: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_max_delete_path2_force-jabutir6: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file2.txt.bepifob7.partial: renamed to: file2.txt 2024/04/18 03:37:20 INFO : file2.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file3.txt.gakaxeg5.partial: renamed to: file3.txt 2024/04/18 03:37:20 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 INFO : file3.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file1.txt.qaqoqup1.partial: renamed to: file1.txt 2024/04/18 03:37:20 INFO : file1.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file5.txt.berevud8.partial: renamed to: file5.txt 2024/04/18 03:37:20 INFO : file5.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file4.txt.mecibuh5.partial: renamed to: file4.txt 2024/04/18 03:37:20 INFO : file4.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file8.txt.movayuh3.partial: renamed to: file8.txt 2024/04/18 03:37:20 INFO : file8.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file7.txt.qerifam9.partial: renamed to: file7.txt 2024/04/18 03:37:20 INFO : file7.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file6.txt.wexusow5.partial: renamed to: file6.txt 2024/04/18 03:37:20 INFO : file6.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:20 DEBUG : file9.txt.gabaqeg4.partial: renamed to: file9.txt 2024/04/18 03:37:20 INFO : file9.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/modfiles" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_max_delete_path2_force-jubokuw5" 2024/04/18 03:37:20 DEBUG : hold.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_max_delete_path2_force-jubokuw5: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_max_delete_path2_force-jubokuw5: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2024/04/18 03:37:20 DEBUG : hold.txt.fupefed1.partial: renamed to: hold.txt 2024/04/18 03:37:20 INFO : hold.txt: Copied (new) 2024/04/18 03:37:20 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/nomodtime 2024/04/18 03:37:20 DEBUG : path1: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/nomodtime/path1" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/nomodtime/path1" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : path2: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/nomodtime/path2" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/nomodtime/path2" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_nomodtime/initial" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_nomodtime-ziwopuj3" 2024/04/18 03:37:20 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_nomodtime-ziwopuj3: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_nomodtime-ziwopuj3: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file3.txt.lakewit1.partial: renamed to: file3.txt 2024/04/18 03:37:20 INFO : file3.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file2.txt.hevekor9.partial: renamed to: file2.txt 2024/04/18 03:37:20 INFO : file2.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file1.txt.rujiqac7.partial: renamed to: file1.txt 2024/04/18 03:37:20 INFO : file1.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:20 DEBUG : file4.txt.hutewoc5.partial: renamed to: file4.txt 2024/04/18 03:37:20 INFO : file4.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : RCLONE_TEST.bejasut3.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:20 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:20 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file7.txt.qugeyam6.partial: renamed to: file7.txt 2024/04/18 03:37:20 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 INFO : file7.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file5.txt.faxulun0.partial: renamed to: file5.txt 2024/04/18 03:37:20 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 INFO : file5.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file6.txt.bamilox0.partial: renamed to: file6.txt 2024/04/18 03:37:20 INFO : file6.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : file8.txt.zaqozip4.partial: renamed to: file8.txt 2024/04/18 03:37:20 INFO : file8.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_nomodtime/modfiles" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_nomodtime-fawibam2" 2024/04/18 03:37:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_nomodtime-fawibam2: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_nomodtime-fawibam2: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file10.txt.ximevux2.partial: renamed to: file10.txt 2024/04/18 03:37:20 INFO : file10.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:20 DEBUG : file11.txt.kavikec3.partial: renamed to: file11.txt 2024/04/18 03:37:20 INFO : file11.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file2.txt.sajutax2.partial: renamed to: file2.txt 2024/04/18 03:37:20 INFO : file2.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file1.txt.cudobuw0.partial: renamed to: file1.txt 2024/04/18 03:37:20 INFO : file1.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:20 DEBUG : file5L.txt.gasitur0.partial: renamed to: file5L.txt 2024/04/18 03:37:20 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:20 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file5R.txt.wiqakey4.partial: renamed to: file5R.txt 2024/04/18 03:37:20 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file6.txt.seqomox5.partial: renamed to: file6.txt 2024/04/18 03:37:20 INFO : file6.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file7.txt.duvanip7.partial: renamed to: file7.txt 2024/04/18 03:37:20 INFO : file7.txt: Copied (new) 2024/04/18 03:37:20 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/normalization 2024/04/18 03:37:20 DEBUG : path1: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/normalization/path1" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/normalization/path1" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : path2: Making directory 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/normalization/path2" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/normalization/path2" 2024/04/18 03:37:20 DEBUG : Reset feature "ListR" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/initial" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_normalization-zijasap7" 2024/04/18 03:37:20 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2024/04/18 03:37:20 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z) 2024/04/18 03:37:20 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2024/04/18 03:37:20 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : file1.txt.bedenil9.partial: renamed to: file1.txt 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 INFO : file1.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_normalization-zijasap7: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/initdir/test_normalization-zijasap7: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.qaxugiw3.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2024/04/18 03:37:20 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:20 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.giwicun5.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2024/04/18 03:37:20 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2024/04/18 03:37:20 DEBUG : RCLONE_TEST.pegusoh1.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:20 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:20 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.gelafed4.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2024/04/18 03:37:20 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2024/04/18 03:37:20 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/modfiles" 2024/04/18 03:37:20 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_normalization-podoquw8" 2024/04/18 03:37:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_normalization-podoquw8: Waiting for checks to finish 2024/04/18 03:37:20 DEBUG : Local file system at /tmp/033713vi/datadir/test_normalization-podoquw8: Waiting for transfers to finish 2024/04/18 03:37:20 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:20 DEBUG : file1.txt.taretam9.partial: renamed to: file1.txt 2024/04/18 03:37:20 INFO : file1.txt: Copied (new) 2024/04/18 03:37:20 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2024/04/18 03:37:20 DEBUG : 測試_filtersfile.txt.pitudox5.partial: renamed to: 測試_filtersfile.txt 2024/04/18 03:37:20 INFO : 測試_filtersfile.txt: Copied (new) 2024/04/18 03:37:21 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/rclone_args 2024/04/18 03:37:21 DEBUG : path1: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rclone_args/path1" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rclone_args/path1" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : path2: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rclone_args/path2" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rclone_args/path2" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_rclone_args-tavuwez1" 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:21 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:21 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:21 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file2.txt.tefisih7.partial: renamed to: file2.txt 2024/04/18 03:37:21 INFO : file2.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_rclone_args-tavuwez1: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_rclone_args-tavuwez1: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : subdir/file20.txt.jasumaq7.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:21 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : subdir/file21.txt.bavacil0.partial: renamed to: subdir/file21.txt 2024/04/18 03:37:21 INFO : subdir/file21.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2024/04/18 03:37:21 DEBUG : file1.txt.gusuror8.partial: renamed to: file1.txt 2024/04/18 03:37:21 INFO : file1.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:21 DEBUG : RCLONE_TEST.fiharaw2.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:21 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:21 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_rclone_args-zuzayik3" 2024/04/18 03:37:21 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file21.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_rclone_args-zuzayik3: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_rclone_args-zuzayik3: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file21.txt.kozobin5.partial: renamed to: file21.txt 2024/04/18 03:37:21 INFO : file21.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file20.txt.vuletih2.partial: renamed to: file20.txt 2024/04/18 03:37:21 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:21 INFO : file20.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:21 DEBUG : file2.txt.mizodab1.partial: renamed to: file2.txt 2024/04/18 03:37:21 INFO : file2.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file1.txt.voviyiw0.partial: renamed to: file1.txt 2024/04/18 03:37:21 INFO : file1.txt: Copied (new) 2024/04/18 03:37:21 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/resolve 2024/04/18 03:37:21 DEBUG : path1: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resolve/path1" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resolve/path1" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : path2: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resolve/path2" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resolve/path2" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/initial" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_resolve-jenaboz5" 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_resolve-jenaboz5: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_resolve-jenaboz5: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file2.txt.kucosix6.partial: renamed to: file2.txt 2024/04/18 03:37:21 INFO : file2.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file1.txt.badusoc0.partial: renamed to: file1.txt 2024/04/18 03:37:21 INFO : file1.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:21 DEBUG : RCLONE_TEST.cegokob4.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:21 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/modfiles" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_resolve-vudidub7" 2024/04/18 03:37:21 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_resolve-vudidub7: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_resolve-vudidub7: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2024/04/18 03:37:21 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK 2024/04/18 03:37:21 DEBUG : file1L.txt.reviquf7.partial: renamed to: file1L.txt 2024/04/18 03:37:21 INFO : file1L.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2024/04/18 03:37:21 DEBUG : file1R.txt.kiceruy9.partial: renamed to: file1R.txt 2024/04/18 03:37:21 INFO : file1R.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file2.txt.gibivul1.partial: renamed to: file2.txt 2024/04/18 03:37:21 INFO : file2.txt: Copied (new) 2024/04/18 03:37:21 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/resync 2024/04/18 03:37:21 DEBUG : path1: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync/path1" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync/path1" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : path2: Making directory 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync/path2" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync/path2" 2024/04/18 03:37:21 DEBUG : Reset feature "ListR" 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_resync-pabedas9" 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_resync-pabedas9: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/initdir/test_resync-pabedas9: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file1.txt.nuxoyig5.partial: renamed to: file1.txt 2024/04/18 03:37:21 INFO : file1.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file2.txt.gisozuq5.partial: renamed to: file2.txt 2024/04/18 03:37:21 INFO : file2.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file4.txt.cokilex7.partial: renamed to: file4.txt 2024/04/18 03:37:21 INFO : file4.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file5.txt.cutidip7.partial: renamed to: file5.txt 2024/04/18 03:37:21 INFO : file5.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file6.txt.qusiyeg4.partial: renamed to: file6.txt 2024/04/18 03:37:21 INFO : file6.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : file3.txt.fifuboc9.partial: renamed to: file3.txt 2024/04/18 03:37:21 INFO : file3.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:21 DEBUG : RCLONE_TEST.rofijiz8.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:21 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:21 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:21 DEBUG : file7.txt.tujegep1.partial: renamed to: file7.txt 2024/04/18 03:37:21 INFO : file7.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_resync-gawuvil7" 2024/04/18 03:37:21 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_resync-gawuvil7: Waiting for checks to finish 2024/04/18 03:37:21 DEBUG : Local file system at /tmp/033713vi/datadir/test_resync-gawuvil7: Waiting for transfers to finish 2024/04/18 03:37:21 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:21 DEBUG : fileA.txt.sewoxid6.partial: renamed to: fileA.txt 2024/04/18 03:37:21 INFO : fileA.txt: Copied (new) 2024/04/18 03:37:21 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:21 DEBUG : fileB.txt.jumexig5.partial: renamed to: fileB.txt 2024/04/18 03:37:21 INFO : fileB.txt: Copied (new) 2024/04/18 03:37:22 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/resync_modes 2024/04/18 03:37:22 DEBUG : path1: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync_modes/path1" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync_modes/path1" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : path2: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync_modes/path2" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/resync_modes/path2" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_resync_modes-fimurix1" 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_resync_modes-fimurix1: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_resync_modes-fimurix1: Waiting for transfers to finish 2024/04/18 03:37:22 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.txt.rogogeq2.partial: renamed to: file1.txt 2024/04/18 03:37:22 INFO : file1.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:22 DEBUG : RCLONE_TEST.dekumiq5.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:22 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:22 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file2.txt.fakiluy8.partial: renamed to: file2.txt 2024/04/18 03:37:22 INFO : file2.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_resync_modes-hofubum8" 2024/04/18 03:37:22 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_resync_modes-hofubum8: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2024/04/18 03:37:22 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2024/04/18 03:37:22 DEBUG : file1L.txt.sevobus5.partial: renamed to: file1L.txt 2024/04/18 03:37:22 INFO : file1L.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file2.txt.temijoj0.partial: renamed to: file2.txt 2024/04/18 03:37:22 INFO : file2.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK 2024/04/18 03:37:22 DEBUG : file1R.txt.faquxuq9.partial: renamed to: file1R.txt 2024/04/18 03:37:22 INFO : file1R.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_resync_modes-hofubum8: Waiting for transfers to finish 2024/04/18 03:37:22 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/rmdirs 2024/04/18 03:37:22 DEBUG : path1: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rmdirs/path1" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rmdirs/path1" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : path2: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rmdirs/path2" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/rmdirs/path2" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_rmdirs-juloziq9" 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : subdir: Making directory with metadata 2024/04/18 03:37:22 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2024/04/18 03:37:22 DEBUG : Added delayed dir = "subdir", newDst=subdir 2024/04/18 03:37:22 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_rmdirs-juloziq9: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_rmdirs-juloziq9: Waiting for transfers to finish 2024/04/18 03:37:22 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.copy1.txt.vudijet7.partial: renamed to: file1.copy1.txt 2024/04/18 03:37:22 INFO : file1.copy1.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:22 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.copy3.txt.nazicuf3.partial: renamed to: file1.copy3.txt 2024/04/18 03:37:22 DEBUG : file1.copy4.txt.cabegos1.partial: renamed to: file1.copy4.txt 2024/04/18 03:37:22 INFO : file1.copy3.txt: Copied (new) 2024/04/18 03:37:22 INFO : file1.copy4.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : RCLONE_TEST.wataxom4.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:22 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.txt.wivipok5.partial: renamed to: file1.txt 2024/04/18 03:37:22 INFO : file1.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.copy2.txt.yodecuy8.partial: renamed to: file1.copy2.txt 2024/04/18 03:37:22 INFO : file1.copy2.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.copy5.txt.yazamug3.partial: renamed to: file1.copy5.txt 2024/04/18 03:37:22 INFO : file1.copy5.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : subdir/file20.txt.hebadik2.partial: renamed to: subdir/file20.txt 2024/04/18 03:37:22 INFO : subdir/file20.txt: Copied (new) 2024/04/18 03:37:22 INFO : subdir: Set directory modification time (using SetModTime) 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_rmdirs-tuzijiq2" 2024/04/18 03:37:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_rmdirs-tuzijiq2: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_rmdirs-tuzijiq2: Waiting for transfers to finish 2024/04/18 03:37:22 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file1.txt.vocazut1.partial: renamed to: file1.txt 2024/04/18 03:37:22 INFO : file1.txt: Copied (new) 2024/04/18 03:37:22 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value === RUN TestBisyncRemoteRemote/volatile 2024/04/18 03:37:22 DEBUG : path1: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/volatile/path1" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/volatile/path1" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : path2: Making directory 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/volatile/path2" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "TestMailru:rclone-test-hizibun6xugetuq6raqimuf5/033713vi/volatile/path2" 2024/04/18 03:37:22 DEBUG : Reset feature "ListR" 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/initdir/test_volatile-fifujoz4" 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file3.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file4.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file5.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file8.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file2.txt.paqukoz3.partial: renamed to: file2.txt 2024/04/18 03:37:22 INFO : file2.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file3.txt.kazoxev2.partial: renamed to: file3.txt 2024/04/18 03:37:22 INFO : file3.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file4.txt.hewojit0.partial: renamed to: file4.txt 2024/04/18 03:37:22 INFO : file4.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file5.txt.quhehih7.partial: renamed to: file5.txt 2024/04/18 03:37:22 INFO : file5.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file6.txt.fiwizaj6.partial: renamed to: file6.txt 2024/04/18 03:37:22 INFO : file6.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file7.txt.dukores0.partial: renamed to: file7.txt 2024/04/18 03:37:22 INFO : file7.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file8.txt.nobujus9.partial: renamed to: file8.txt 2024/04/18 03:37:22 INFO : file8.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_volatile-fifujoz4: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/initdir/test_volatile-fifujoz4: Waiting for transfers to finish 2024/04/18 03:37:22 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2024/04/18 03:37:22 DEBUG : RCLONE_TEST.bahigov0.partial: renamed to: RCLONE_TEST 2024/04/18 03:37:22 INFO : RCLONE_TEST: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : file1.txt.yokoker5.partial: renamed to: file1.txt 2024/04/18 03:37:22 INFO : file1.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : Creating backend with remote "/tmp/033713vi/datadir/test_volatile-lejevin9" 2024/04/18 03:37:22 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file10.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file11.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2024/04/18 03:37:22 DEBUG : dummy.txt.seniwin9.partial: renamed to: dummy.txt 2024/04/18 03:37:22 INFO : dummy.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file2.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file1.txt.ritenog0.partial: renamed to: file1.txt 2024/04/18 03:37:22 INFO : file1.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file6.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : file7.txt: Need to transfer - File not found at Destination 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_volatile-lejevin9: Waiting for checks to finish 2024/04/18 03:37:22 DEBUG : Local file system at /tmp/033713vi/datadir/test_volatile-lejevin9: Waiting for transfers to finish 2024/04/18 03:37:22 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file11.txt.viluwoy9.partial: renamed to: file11.txt 2024/04/18 03:37:22 INFO : file11.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2024/04/18 03:37:22 DEBUG : file5L.txt.sidawam6.partial: renamed to: file5L.txt 2024/04/18 03:37:22 INFO : file5L.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2024/04/18 03:37:22 DEBUG : file5R.txt.dutovaz1.partial: renamed to: file5R.txt 2024/04/18 03:37:22 INFO : file5R.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file10.txt.leyazer3.partial: renamed to: file10.txt 2024/04/18 03:37:22 INFO : file10.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file7.txt.naciloj0.partial: renamed to: file7.txt 2024/04/18 03:37:22 INFO : file7.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2024/04/18 03:37:22 DEBUG : file6.txt.pebabiv6.partial: renamed to: file6.txt 2024/04/18 03:37:22 INFO : file6.txt: Copied (new) 2024/04/18 03:37:22 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2024/04/18 03:37:22 DEBUG : file2.txt.yewoluz6.partial: renamed to: file2.txt 2024/04/18 03:37:22 INFO : file2.txt: Copied (new) 2024/04/18 03:37:23 ERROR : : error listing: invalid character '<' looking for beginning of value fstest.go:276: Error listing: invalid character '<' looking for beginning of value 2024/04/18 03:37:23 DEBUG : Chunked 'TestChunkerMailru:rclone-test-hizibun6xugetuq6raqimuf5': Purge remote 2024/04/18 03:37:23 purge failed: purge failed: invalid character '<' looking for beginning of value --- FAIL: TestBisyncRemoteRemote (9.25s) --- FAIL: TestBisyncRemoteRemote/all_changed (0.49s) --- FAIL: TestBisyncRemoteRemote/backupdir (0.34s) --- FAIL: TestBisyncRemoteRemote/basic (0.34s) --- FAIL: TestBisyncRemoteRemote/changes (0.32s) --- FAIL: TestBisyncRemoteRemote/check_access (0.34s) --- FAIL: TestBisyncRemoteRemote/check_access_filters (0.32s) --- FAIL: TestBisyncRemoteRemote/check_filename (0.52s) --- FAIL: TestBisyncRemoteRemote/check_sync (0.33s) --- FAIL: TestBisyncRemoteRemote/compare_all (0.31s) --- FAIL: TestBisyncRemoteRemote/createemptysrcdirs (0.33s) --- FAIL: TestBisyncRemoteRemote/dry_run (0.34s) --- FAIL: TestBisyncRemoteRemote/equal (0.33s) --- FAIL: TestBisyncRemoteRemote/ext_paths (0.32s) --- FAIL: TestBisyncRemoteRemote/extended_filenames (0.33s) --- FAIL: TestBisyncRemoteRemote/filters (0.31s) --- FAIL: TestBisyncRemoteRemote/filtersfile_checks (0.32s) --- FAIL: TestBisyncRemoteRemote/ignorelistingchecksum (0.32s) --- FAIL: TestBisyncRemoteRemote/max_delete_path1 (0.34s) --- FAIL: TestBisyncRemoteRemote/max_delete_path2_force (0.32s) --- FAIL: TestBisyncRemoteRemote/nomodtime (0.32s) --- FAIL: TestBisyncRemoteRemote/normalization (0.32s) --- FAIL: TestBisyncRemoteRemote/rclone_args (0.31s) --- FAIL: TestBisyncRemoteRemote/resolve (0.32s) --- FAIL: TestBisyncRemoteRemote/resync (0.32s) --- FAIL: TestBisyncRemoteRemote/resync_modes (0.33s) --- FAIL: TestBisyncRemoteRemote/rmdirs (0.32s) --- FAIL: TestBisyncRemoteRemote/volatile (0.33s) FAIL 2024/04/18 03:37:23 DEBUG : Chunked 'TestChunkerMailru:rclone-test-jolipol0hurawej2murebiw3': Purge remote 2024/04/18 03:37:23 purge failed: purge failed: invalid character '<' looking for beginning of value "./bisync.test -test.v -test.timeout 1h0m0s -remote TestChunkerMailru: -verbose -test.run '^TestBisyncLocalRemote$/^(resync|resync_modes|rmdirs|volatile)$|^TestBisyncRemoteRemote$/^(all_changed|backupdir|basic|changes|check_access|check_access_filters|check_filename|check_sync|compare_all|createemptysrcdirs|dry_run|equal|ext_paths|extended_filenames|filters|filtersfile_checks|ignorelistingchecksum|max_delete_path1|max_delete_path2_force|nomodtime|normalization|rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Finished ERROR in 10.639552763s (try 3/5): exit status 1: Failed [TestBisyncLocalRemote/resync TestBisyncLocalRemote/resync_modes TestBisyncLocalRemote/rmdirs TestBisyncLocalRemote/volatile TestBisyncRemoteRemote/all_changed TestBisyncRemoteRemote/backupdir TestBisyncRemoteRemote/basic TestBisyncRemoteRemote/changes TestBisyncRemoteRemote/check_access TestBisyncRemoteRemote/check_access_filters TestBisyncRemoteRemote/check_filename TestBisyncRemoteRemote/check_sync TestBisyncRemoteRemote/compare_all TestBisyncRemoteRemote/createemptysrcdirs TestBisyncRemoteRemote/dry_run TestBisyncRemoteRemote/equal TestBisyncRemoteRemote/ext_paths TestBisyncRemoteRemote/extended_filenames TestBisyncRemoteRemote/filters TestBisyncRemoteRemote/filtersfile_checks TestBisyncRemoteRemote/ignorelistingchecksum TestBisyncRemoteRemote/max_delete_path1 TestBisyncRemoteRemote/max_delete_path2_force TestBisyncRemoteRemote/nomodtime TestBisyncRemoteRemote/normalization TestBisyncRemoteRemote/rclone_args TestBisyncRemoteRemote/resolve TestBisyncRemoteRemote/resync TestBisyncRemoteRemote/resync_modes TestBisyncRemoteRemote/rmdirs TestBisyncRemoteRemote/volatile]