"./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncLocalRemote$/^dry_run$'" - Starting (try 2/5) 2025/08/14 03:13:07 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wuxilik2lahu" 2025/08/14 03:13:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/14 03:13:07 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : TestFTPRclone: detected overridden config - adding "{0kAZx}" suffix to name 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: > dial: conn=127.0.0.1:37840->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: dial("tcp","127.0.0.1:30286") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: > dial: conn=127.0.0.1:46348->127.0.0.1:30286, err= 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/tmp/rclone3724246820" === RUN TestBisyncLocalRemote 2025/08/14 03:13:07 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-ciqevaf4boga" 2025/08/14 03:13:07 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : TestFTPRclone: detected overridden config - adding "{0kAZx}" suffix to name 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:37842->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31994") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:43366->127.0.0.1:31994, err= 2025/08/14 03:13:07 NOTICE: remote: TestFTPRclone:rclone-test-ciqevaf4boga === RUN TestBisyncLocalRemote/dry_run 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/tmp/031307fi" 2025/08/14 03:13:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/tmp/031307fi/dry_run/path1" 2025/08/14 03:13:07 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-ciqevaf4boga/031307fi" 2025/08/14 03:13:07 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : TestFTPRclone: detected overridden config - adding "{0kAZx}" suffix to name 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: > dial: conn=127.0.0.1:37844->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: dial("tcp","127.0.0.1:30164") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: > dial: conn=127.0.0.1:35140->127.0.0.1:30164, err= 2025/08/14 03:13:07 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-ciqevaf4boga/031307fi" to be canonical "TestFTPRclone{0kAZx}:rclone-test-ciqevaf4boga/031307fi" 2025/08/14 03:13:07 INFO : path2: Making directory 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: dial("tcp","127.0.0.1:30619") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: > dial: conn=127.0.0.1:60054->127.0.0.1:30619, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: dial("tcp","127.0.0.1:31211") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: > dial: conn=127.0.0.1:46802->127.0.0.1:31211, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: dial("tcp","127.0.0.1:31942") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: > dial: conn=127.0.0.1:38774->127.0.0.1:31942, err= 2025/08/14 03:13:07 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-ciqevaf4boga/031307fi/dry_run/path2" 2025/08/14 03:13:07 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : TestFTPRclone: detected overridden config - adding "{0kAZx}" suffix to name 2025/08/14 03:13:07 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/08/14 03:13:07 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/08/14 03:13:07 DEBUG : Setting pass="SUVYAHWB2Votk7PYN2OoJfbsrLwkhYJ-Tg6biIj-4KP1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/08/14 03:13:07 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37850->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30724") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:43940->127.0.0.1:30724, err= 2025/08/14 03:13:07 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-ciqevaf4boga/031307fi/dry_run/path2" to be canonical "TestFTPRclone{0kAZx}:rclone-test-ciqevaf4boga/031307fi/dry_run/path2" 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/initial" 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/tmp/031307fi/initdir/test_dry_run-nubeyum5" 2025/08/14 03:13:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/initdir/test_dry_run-nubeyum5: Waiting for checks to finish 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/initdir/test_dry_run-nubeyum5: Waiting for transfers to finish 2025/08/14 03:13:07 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/14 03:13:07 INFO : file2.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/08/14 03:13:07 INFO : file3.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/14 03:13:07 INFO : file1.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/08/14 03:13:07 INFO : file5.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/08/14 03:13:07 INFO : file4.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/08/14 03:13:07 INFO : file6.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/08/14 03:13:07 INFO : file7.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/14 03:13:07 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/14 03:13:07 INFO : RCLONE_TEST: Copied (new) 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_dry_run/modfiles" 2025/08/14 03:13:07 DEBUG : Creating backend with remote "/tmp/031307fi/datadir/test_dry_run-joxasum3" 2025/08/14 03:13:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file10.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file11.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/datadir/test_dry_run-joxasum3: Waiting for checks to finish 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/datadir/test_dry_run-joxasum3: Waiting for transfers to finish 2025/08/14 03:13:07 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/14 03:13:07 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt 2025/08/14 03:13:07 INFO : file1.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/14 03:13:07 DEBUG : file10.txt.925c801f.partial: renamed to: file10.txt 2025/08/14 03:13:07 INFO : file10.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/14 03:13:07 DEBUG : file11.txt.925c801f.partial: renamed to: file11.txt 2025/08/14 03:13:07 INFO : file11.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2025/08/14 03:13:07 DEBUG : file2.txt.f8ac1735.partial: renamed to: file2.txt 2025/08/14 03:13:07 INFO : file2.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2025/08/14 03:13:07 DEBUG : file5L.txt.c32cc336.partial: renamed to: file5L.txt 2025/08/14 03:13:07 INFO : file5L.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2025/08/14 03:13:07 DEBUG : file5R.txt.aa998d0a.partial: renamed to: file5R.txt 2025/08/14 03:13:07 INFO : file5R.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/14 03:13:07 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2025/08/14 03:13:07 DEBUG : file7.txt.925c801f.partial: renamed to: file7.txt 2025/08/14 03:13:07 INFO : file7.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file6.txt.925c801f.partial: renamed to: file6.txt 2025/08/14 03:13:07 INFO : file6.txt: Copied (new) 2025/08/14 03:13:07 ERROR : error listing: directory not found 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31939") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:41254->127.0.0.1:31939, err= 2025/08/14 03:13:07 ERROR : error listing: directory not found 2025/08/14 03:13:07 NOTICE: checking initFs Local file system at /tmp/031307fi/initdir/test_dry_run-nubeyum5 2025/08/14 03:13:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/dry_run/path1: Waiting for checks to finish 2025/08/14 03:13:07 DEBUG : Local file system at /tmp/031307fi/dry_run/path1: Waiting for transfers to finish 2025/08/14 03:13:07 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/14 03:13:07 INFO : file2.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/14 03:13:07 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 INFO : file1.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/08/14 03:13:07 INFO : file4.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/08/14 03:13:07 INFO : file3.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/08/14 03:13:07 INFO : file6.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/08/14 03:13:07 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/08/14 03:13:07 INFO : file7.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/08/14 03:13:07 INFO : file5.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/08/14 03:13:07 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/14 03:13:07 INFO : RCLONE_TEST: Copied (new) 2025/08/14 03:13:07 NOTICE: checking Path1 Local file system at /tmp/031307fi/dry_run/path1 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31945") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:41196->127.0.0.1:31945, err= 2025/08/14 03:13:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Waiting for checks to finish 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Waiting for transfers to finish 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30076") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37854->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37212->127.0.0.1:30076, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30596") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:45186->127.0.0.1:30596, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30711") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:43590->127.0.0.1:30711, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30314") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:60086->127.0.0.1:30314, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30129") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:40396->127.0.0.1:30129, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31200") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30932") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:56678->127.0.0.1:31200, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:44472->127.0.0.1:30932, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31713") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30686") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:47802->127.0.0.1:30686, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:60382->127.0.0.1:31713, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31859") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:58256->127.0.0.1:31859, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30704") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:58434->127.0.0.1:30704, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37858->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30682") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30476") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:50202->127.0.0.1:30682, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:34112->127.0.0.1:30476, err= 2025/08/14 03:13:07 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/08/14 03:13:07 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/08/14 03:13:07 INFO : file1.txt: Copied (new) 2025/08/14 03:13:07 INFO : RCLONE_TEST: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31555") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31723") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31653") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:52224->127.0.0.1:31723, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:33634->127.0.0.1:31555, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:50180->127.0.0.1:31653, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30793") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30370") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:33462->127.0.0.1:30370, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30112") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:45380->127.0.0.1:30793, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:49748->127.0.0.1:30112, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31880") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:46552->127.0.0.1:31880, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31012") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:42366->127.0.0.1:31012, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30893") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:56434->127.0.0.1:30893, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30654") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:59994->127.0.0.1:30654, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30088") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37752->127.0.0.1:30088, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31633") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:39464->127.0.0.1:31633, err= 2025/08/14 03:13:07 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/08/14 03:13:07 INFO : file5.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31573") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:58424->127.0.0.1:31573, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:37860->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31830") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:33352->127.0.0.1:31830, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30531") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:38572->127.0.0.1:30531, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31381") 2025/08/14 03:13:07 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/08/14 03:13:07 INFO : file2.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:34474->127.0.0.1:31381, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31323") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:49630->127.0.0.1:31323, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30197") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30289") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:51020->127.0.0.1:30289, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30318") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:38780->127.0.0.1:30318, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:48032->127.0.0.1:30197, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31430") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:44372->127.0.0.1:31430, err= 2025/08/14 03:13:07 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31576") 2025/08/14 03:13:07 INFO : file4.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:48964->127.0.0.1:31576, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30465") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:42322->127.0.0.1:30465, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30047") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30852") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:44332->127.0.0.1:30852, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:51428->127.0.0.1:30047, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31287") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: SetModTime is not supported 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:48084->127.0.0.1:31287, err= 2025/08/14 03:13:07 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/08/14 03:13:07 INFO : file6.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:30572") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:54418->127.0.0.1:30572, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31310") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:52774->127.0.0.1:31310, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31783") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:54118->127.0.0.1:31783, err= 2025/08/14 03:13:07 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/08/14 03:13:07 INFO : file3.txt: Copied (new) 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31371") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:48202->127.0.0.1:31371, err= 2025/08/14 03:13:07 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/08/14 03:13:07 INFO : file7.txt: Copied (new) 2025/08/14 03:13:07 NOTICE: checking path2 ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: dial("tcp","127.0.0.1:31798") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: > dial: conn=127.0.0.1:59258->127.0.0.1:31798, err= 2025/08/14 03:13:07 NOTICE: (01) : test dry-run 2025/08/14 03:13:07 NOTICE: (02) : test initial bisync 2025/08/14 03:13:07 NOTICE: (03) : bisync resync bisync_test.go:974: skipping test as at least one remote does not support setting modtime 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30781") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:57862->127.0.0.1:30781, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31578") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:48284->127.0.0.1:31578, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Connecting to FTP server 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:28622") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30491") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:37868->127.0.0.1:28622, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:55056->127.0.0.1:30491, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31179") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:41562->127.0.0.1:31179, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31617") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:50388->127.0.0.1:31617, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30783") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:60504->127.0.0.1:30783, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/RCLONE_TEST" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31387") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:57762->127.0.0.1:31387, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file1.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31157") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:42174->127.0.0.1:31157, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file2.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30658") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:54044->127.0.0.1:30658, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file3.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30021") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:41674->127.0.0.1:30021, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file4.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31188") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:51642->127.0.0.1:31188, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file5.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30263") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:50112->127.0.0.1:30263, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file6.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:30046") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:37712->127.0.0.1:30046, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge object "031307fi/dry_run/path2/file7.txt" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: dial("tcp","127.0.0.1:31356") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: > dial: conn=127.0.0.1:56532->127.0.0.1:31356, err= 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge dir "031307fi/path2" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge dir "031307fi/dry_run/path2" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge dir "031307fi/dry_run" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge dir "031307fi" 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga: Purge dir "" --- PASS: TestBisyncLocalRemote (0.15s) --- SKIP: TestBisyncLocalRemote/dry_run (0.12s) PASS 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: dial("tcp","127.0.0.1:31240") 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: > dial: conn=127.0.0.1:40886->127.0.0.1:31240, err= 2025/08/14 03:13:07 ERROR : error listing: directory not found 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-wuxilik2lahu: Purge dir "" 2025/08/14 03:13:07 NOTICE: purge failed to rmdir "": directory not found 2025/08/14 03:13:07 NOTICE: purge failed: directory not found 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi: closing 1 unused connections 2025/08/14 03:13:07 DEBUG : ftp://127.0.0.1:28622/rclone-test-ciqevaf4boga/031307fi/dry_run/path2: closing 4 unused connections "./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncLocalRemote$/^dry_run$'" - Finished OK in 232.780128ms (try 2/5)