"./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncLocalRemote$/^rclone_args$'" - Starting (try 2/5) 2026/07/17 03:14:50 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-juzureb7tufa" 2026/07/17 03:14:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/07/17 03:14:50 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : TestFTPRclone: detected overridden config - adding "{3Tt2A}" suffix to name 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: > dial: conn=127.0.0.1:53438->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: dial("tcp","127.0.0.1:31230") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: > dial: conn=127.0.0.1:33578->127.0.0.1:31230, err= 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/rclone1352869799" === RUN TestBisyncLocalRemote 2026/07/17 03:14:50 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-sobavok0jame" 2026/07/17 03:14:50 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : TestFTPRclone: detected overridden config - adding "{3Tt2A}" suffix to name 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:53452->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30272") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:38174->127.0.0.1:30272, err= 2026/07/17 03:14:50 NOTICE: remote: TestFTPRclone:rclone-test-sobavok0jame === RUN TestBisyncLocalRemote/rclone_args 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/031450keteyex7" 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/031450keteyex7/rclone_args/path1" 2026/07/17 03:14:50 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-sobavok0jame/031450keteyex7" 2026/07/17 03:14:50 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : TestFTPRclone: detected overridden config - adding "{3Tt2A}" suffix to name 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: > dial: conn=127.0.0.1:53464->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: dial("tcp","127.0.0.1:31216") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: > dial: conn=127.0.0.1:34416->127.0.0.1:31216, err= 2026/07/17 03:14:50 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-sobavok0jame/031450keteyex7" to be canonical "TestFTPRclone{3Tt2A}:rclone-test-sobavok0jame/031450keteyex7" 2026/07/17 03:14:50 INFO : path2: Making directory 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: dial("tcp","127.0.0.1:30580") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: > dial: conn=127.0.0.1:37670->127.0.0.1:30580, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: dial("tcp","127.0.0.1:30372") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: > dial: conn=127.0.0.1:40392->127.0.0.1:30372, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: dial("tcp","127.0.0.1:30402") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: > dial: conn=127.0.0.1:48668->127.0.0.1:30402, err= 2026/07/17 03:14:50 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2" 2026/07/17 03:14:50 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : TestFTPRclone: detected overridden config - adding "{3Tt2A}" suffix to name 2026/07/17 03:14:50 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/07/17 03:14:50 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/07/17 03:14:50 DEBUG : Setting pass="1zobfRnYUiTacfbf98Y3w-7hjLgUc678vjmHFZqkExKZ" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/07/17 03:14:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:53474->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30931") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:58976->127.0.0.1:30931, err= 2026/07/17 03:14:50 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2" to be canonical "TestFTPRclone{3Tt2A}:rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2" 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/031450keteyex7/initdir/test_rclone_args-jixeciz4" 2026/07/17 03:14:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir: Making directory with metadata 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/07/17 03:14:50 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/07/17 03:14:50 INFO : file1.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/07/17 03:14:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/07/17 03:14:50 INFO : RCLONE_TEST: Copied (new) 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/07/17 03:14:50 INFO : file2.txt: Copied (new) 2026/07/17 03:14:50 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/07/17 03:14:50 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/07/17 03:14:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/initdir/test_rclone_args-jixeciz4: Waiting for checks to finish 2026/07/17 03:14:50 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/07/17 03:14:50 INFO : subdir/file20.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/07/17 03:14:50 INFO : subdir/file21.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/initdir/test_rclone_args-jixeciz4: Waiting for transfers to finish 2026/07/17 03:14:50 INFO : subdir: Set directory modification time (using SetModTime) 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8" 2026/07/17 03:14:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file20.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file21.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file1.txt.8c06417f.partial: size = 19 OK 2026/07/17 03:14:50 DEBUG : file2.txt.d6677e1f.partial: size = 19 OK 2026/07/17 03:14:50 DEBUG : file20.txt.fd848222.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : file21.txt.68f456b7.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8: Waiting for checks to finish 2026/07/17 03:14:50 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/07/17 03:14:50 DEBUG : file1.txt.8c06417f.partial: renamed to: file1.txt 2026/07/17 03:14:50 INFO : file1.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/07/17 03:14:50 DEBUG : file2.txt.d6677e1f.partial: renamed to: file2.txt 2026/07/17 03:14:50 INFO : file2.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : file20.txt.fd848222.partial: renamed to: file20.txt 2026/07/17 03:14:50 INFO : file20.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : file21.txt.68f456b7.partial: renamed to: file21.txt 2026/07/17 03:14:50 INFO : file21.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8: Waiting for transfers to finish 2026/07/17 03:14:50 DEBUG : Waiting for deletions to finish 2026/07/17 03:14:50 ERROR : error listing: directory not found 2026/07/17 03:14:50 ERROR : Local file system at /tmp/031450keteyex7/rclone_args/path1: Failed to list "": directory not found 2026/07/17 03:14:50 DEBUG : removing 1 level 0 directories 2026/07/17 03:14:50 INFO : Local file system at /tmp/031450keteyex7/rclone_args/path1: Removing directory 2026/07/17 03:14:50 ERROR : Failed to rmdir: stat /tmp/031450keteyex7/rclone_args/path1: no such file or directory 2026/07/17 03:14:50 DEBUG : Waiting for deletions to finish 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30044") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:38242->127.0.0.1:30044, err= 2026/07/17 03:14:50 ERROR : error listing: directory not found 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31872") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:42076->127.0.0.1:31872, err= 2026/07/17 03:14:50 ERROR : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Failed to list "": directory not found 2026/07/17 03:14:50 DEBUG : removing 1 level 0 directories 2026/07/17 03:14:50 INFO : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Removing directory 2026/07/17 03:14:50 ERROR : Failed to rmdir: directory not found 2026/07/17 03:14:50 ERROR : error listing: directory not found 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31214") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:38254->127.0.0.1:31214, err= 2026/07/17 03:14:50 ERROR : error listing: directory not found 2026/07/17 03:14:50 NOTICE: checking initFs Local file system at /tmp/031450keteyex7/initdir/test_rclone_args-jixeciz4 2026/07/17 03:14:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir: Making directory with metadata 2026/07/17 03:14:50 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/07/17 03:14:50 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/07/17 03:14:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/07/17 03:14:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/rclone_args/path1: Waiting for checks to finish 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/07/17 03:14:50 INFO : RCLONE_TEST: Copied (new) 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/07/17 03:14:50 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/07/17 03:14:50 INFO : subdir/file21.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/07/17 03:14:50 INFO : file2.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/07/17 03:14:50 INFO : file1.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : Local file system at /tmp/031450keteyex7/rclone_args/path1: Waiting for transfers to finish 2026/07/17 03:14:50 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/07/17 03:14:50 INFO : subdir/file20.txt: Copied (new) 2026/07/17 03:14:50 INFO : subdir: Set directory modification time (using SetModTime) 2026/07/17 03:14:50 NOTICE: checking Path1 Local file system at /tmp/031450keteyex7/rclone_args/path1 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30505") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:42090->127.0.0.1:30505, err= 2026/07/17 03:14:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:53482->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31630") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:39450->127.0.0.1:31630, err= 2026/07/17 03:14:50 INFO : subdir: Making directory 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31837") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31316") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:53922->127.0.0.1:31837, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:44856->127.0.0.1:31316, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30129") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:44688->127.0.0.1:30129, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31213") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:34130->127.0.0.1:31213, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31986") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:53488->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:49298->127.0.0.1:31986, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31989") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:40720->127.0.0.1:31989, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:53500->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: SetModTime is not supported 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: SetModTime is not supported 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31909") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:58412->127.0.0.1:31909, err= 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30767") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:39004->127.0.0.1:30767, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30514") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:47970->127.0.0.1:30514, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30627") 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30538") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:48562->127.0.0.1:30538, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:57188->127.0.0.1:30627, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31565") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:39910->127.0.0.1:31565, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30695") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31140") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:51510->127.0.0.1:30695, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:34454->127.0.0.1:31140, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30540") 2026/07/17 03:14:50 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/07/17 03:14:50 INFO : file1.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: SetModTime is not supported 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30985") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:47650->127.0.0.1:30985, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:33182->127.0.0.1:30540, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31177") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:58108->127.0.0.1:31177, err= 2026/07/17 03:14:50 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/07/17 03:14:50 INFO : RCLONE_TEST: Copied (new) 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Waiting for checks to finish 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: Waiting for transfers to finish 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31258") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:47104->127.0.0.1:31258, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31156") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:57550->127.0.0.1:31156, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30067") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:54878->127.0.0.1:30067, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30261") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30747") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:55784->127.0.0.1:30747, err= 2026/07/17 03:14:50 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/07/17 03:14:50 INFO : file2.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:52804->127.0.0.1:30261, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: SetModTime is not supported 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31346") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31674") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:57882->127.0.0.1:31674, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:50418->127.0.0.1:31346, err= 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30219") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: SetModTime is not supported 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:43610->127.0.0.1:30219, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31807") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:39416->127.0.0.1:31807, err= 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31462") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:34520->127.0.0.1:31462, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31692") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:33358->127.0.0.1:31692, err= 2026/07/17 03:14:50 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/07/17 03:14:50 INFO : subdir/file21.txt: Copied (new) 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31473") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:42054->127.0.0.1:31473, err= 2026/07/17 03:14:50 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/07/17 03:14:50 INFO : subdir/file20.txt: Copied (new) 2026/07/17 03:14:50 NOTICE: checking path2 ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:31324") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:39760->127.0.0.1:31324, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: dial("tcp","127.0.0.1:30863") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: > dial: conn=127.0.0.1:49554->127.0.0.1:30863, err= 2026/07/17 03:14:50 NOTICE: (01) : test rclone-args 2026/07/17 03:14:50 NOTICE: (02) : touch-glob 2001-01-02 /tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8/ * 2026/07/17 03:14:50 DEBUG : Creating backend with remote "/tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8/" 2026/07/17 03:14:50 DEBUG : fs cache: renaming cache item "/tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8/" to be canonical "/tmp/031450keteyex7/datadir/test_rclone_args-wajicuf8" 2026/07/17 03:14:50 DEBUG : file21.txt: Set modification time 2001-01-02 2026/07/17 03:14:50 DEBUG : file1.txt: Set modification time 2001-01-02 2026/07/17 03:14:50 DEBUG : file2.txt: Set modification time 2001-01-02 2026/07/17 03:14:50 DEBUG : file20.txt: Set modification time 2001-01-02 2026/07/17 03:14:50 NOTICE: (03) : test initial bisync 2026/07/17 03:14:50 NOTICE: (04) : bisync resync checksum bisync_test.go:1017: skipping test as at least one remote does not support setting modtime 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30404") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:33884->127.0.0.1:30404, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30008") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:49314->127.0.0.1:30008, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Connecting to FTP server 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:28622") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:53516->127.0.0.1:28622, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31954") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:50094->127.0.0.1:31954, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31482") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:41032->127.0.0.1:31482, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge object "031450keteyex7/rclone_args/path2/RCLONE_TEST" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31726") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:39488->127.0.0.1:31726, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30253") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:33972->127.0.0.1:30253, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31264") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge object "031450keteyex7/rclone_args/path2/file1.txt" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:60700->127.0.0.1:31264, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30801") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:33502->127.0.0.1:30801, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge object "031450keteyex7/rclone_args/path2/file2.txt" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:30681") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:49578->127.0.0.1:30681, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31729") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:44966->127.0.0.1:31729, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge object "031450keteyex7/rclone_args/path2/subdir/file20.txt" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31986") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:49308->127.0.0.1:31986, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge object "031450keteyex7/rclone_args/path2/subdir/file21.txt" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: dial("tcp","127.0.0.1:31797") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: > dial: conn=127.0.0.1:58904->127.0.0.1:31797, err= 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "031450keteyex7/rclone_args/path2/subdir" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "031450keteyex7/rclone_args/path2" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "031450keteyex7/rclone_args" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "031450keteyex7/path2" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "031450keteyex7" 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame: Purge dir "" --- PASS: TestBisyncLocalRemote (0.23s) --- SKIP: TestBisyncLocalRemote/rclone_args (0.18s) PASS 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: dial("tcp","127.0.0.1:31288") 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: > dial: conn=127.0.0.1:56696->127.0.0.1:31288, err= 2026/07/17 03:14:50 ERROR : error listing: directory not found 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-juzureb7tufa: Purge dir "" 2026/07/17 03:14:50 NOTICE: purge failed to rmdir "": directory not found 2026/07/17 03:14:50 NOTICE: purge failed: directory not found 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7: closing 1 unused connections 2026/07/17 03:14:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-sobavok0jame/031450keteyex7/rclone_args/path2: closing 4 unused connections "./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncLocalRemote$/^rclone_args$'" - Finished OK in 470.241958ms (try 2/5)