"./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncRemoteLocal$/^max_delete_path2_force$'" - Starting (try 2/5) 2025/07/15 02:52:18 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-gebigim0buwa" 2025/07/15 02:52:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/15 02:52:18 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : TestFTPRclone: detected overridden config - adding "{aKHiS}" suffix to name 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: > dial: conn=127.0.0.1:49104->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: dial("tcp","127.0.0.1:31992") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: > dial: conn=127.0.0.1:51200->127.0.0.1:31992, err= 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/tmp/rclone3309443795" === RUN TestBisyncRemoteLocal 2025/07/15 02:52:18 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-kucijep3xene" 2025/07/15 02:52:18 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : TestFTPRclone: detected overridden config - adding "{aKHiS}" suffix to name 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:49108->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31494") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:59070->127.0.0.1:31494, err= 2025/07/15 02:52:18 NOTICE: remote: TestFTPRclone:rclone-test-kucijep3xene === RUN TestBisyncRemoteLocal/max_delete_path2_force 2025/07/15 02:52:18 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-kucijep3xene/025218fo" 2025/07/15 02:52:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/15 02:52:18 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : TestFTPRclone: detected overridden config - adding "{aKHiS}" suffix to name 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: > dial: conn=127.0.0.1:49118->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: dial("tcp","127.0.0.1:30044") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: > dial: conn=127.0.0.1:57292->127.0.0.1:30044, err= 2025/07/15 02:52:18 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-kucijep3xene/025218fo" to be canonical "TestFTPRclone{aKHiS}:rclone-test-kucijep3xene/025218fo" 2025/07/15 02:52:18 INFO : path1: Making directory 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: dial("tcp","127.0.0.1:31360") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: > dial: conn=127.0.0.1:54618->127.0.0.1:31360, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: dial("tcp","127.0.0.1:31272") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: > dial: conn=127.0.0.1:48352->127.0.0.1:31272, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: dial("tcp","127.0.0.1:30926") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: > dial: conn=127.0.0.1:45522->127.0.0.1:30926, err= 2025/07/15 02:52:18 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1" 2025/07/15 02:52:18 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : TestFTPRclone: detected overridden config - adding "{aKHiS}" suffix to name 2025/07/15 02:52:18 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/07/15 02:52:18 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/07/15 02:52:18 DEBUG : Setting pass="qpvX0pinJXrmfdMAvWjbPHGq78AKwScTr9BU84sgdUqA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/07/15 02:52:18 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:49126->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30626") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:44058->127.0.0.1:30626, err= 2025/07/15 02:52:18 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1" to be canonical "TestFTPRclone{aKHiS}:rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1" 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/tmp/025218fo" 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/tmp/025218fo/max_delete_path2_force/path2" 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/initial" 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/tmp/025218fo/initdir/test_max_delete_path2_force-mititur8" 2025/07/15 02:52:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file9.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/07/15 02:52:18 INFO : file1.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/07/15 02:52:18 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 INFO : file5.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/07/15 02:52:18 INFO : file2.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/initdir/test_max_delete_path2_force-mititur8: Waiting for checks to finish 2025/07/15 02:52:18 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/initdir/test_max_delete_path2_force-mititur8: Waiting for transfers to finish 2025/07/15 02:52:18 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/07/15 02:52:18 INFO : file3.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/07/15 02:52:18 INFO : file6.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/07/15 02:52:18 INFO : file4.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/07/15 02:52:18 INFO : file7.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt 2025/07/15 02:52:18 INFO : file8.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/07/15 02:52:18 DEBUG : file9.txt.cf9a93ac.partial: renamed to: file9.txt 2025/07/15 02:52:18 INFO : file9.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/modfiles" 2025/07/15 02:52:18 DEBUG : Creating backend with remote "/tmp/025218fo/datadir/test_max_delete_path2_force-wodozir8" 2025/07/15 02:52:18 DEBUG : hold.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/datadir/test_max_delete_path2_force-wodozir8: Waiting for checks to finish 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/datadir/test_max_delete_path2_force-wodozir8: Waiting for transfers to finish 2025/07/15 02:52:18 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2025/07/15 02:52:18 DEBUG : hold.txt.627e309f.partial: renamed to: hold.txt 2025/07/15 02:52:18 INFO : hold.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30768") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:49844->127.0.0.1:30768, err= 2025/07/15 02:52:18 ERROR : error listing: directory not found 2025/07/15 02:52:18 ERROR : error listing: directory not found 2025/07/15 02:52:18 NOTICE: checking initFs Local file system at /tmp/025218fo/initdir/test_max_delete_path2_force-mititur8 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31921") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:38026->127.0.0.1:31921, err= 2025/07/15 02:52:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file9.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31116") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:49134->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Waiting for checks to finish 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Waiting for transfers to finish 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:53244->127.0.0.1:31116, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31225") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:43684->127.0.0.1:31225, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30758") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:34262->127.0.0.1:30758, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30914") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:32908->127.0.0.1:30914, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31744") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:33818->127.0.0.1:31744, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30692") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:56018->127.0.0.1:30692, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30514") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:54466->127.0.0.1:30514, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30801") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:36964->127.0.0.1:30801, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31168") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:34008->127.0.0.1:31168, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:49150->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30632") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:47666->127.0.0.1:30632, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30716") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31013") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:57806->127.0.0.1:30716, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:60640->127.0.0.1:31013, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30301") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:46664->127.0.0.1:30301, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31032") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:52582->127.0.0.1:31032, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30144") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31663") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:39940->127.0.0.1:30144, err= 2025/07/15 02:52:18 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/07/15 02:52:18 INFO : file3.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:35896->127.0.0.1:31663, err= 2025/07/15 02:52:18 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/07/15 02:52:18 INFO : file1.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30195") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:41886->127.0.0.1:30195, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30681") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:43514->127.0.0.1:30681, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31056") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30145") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:37290->127.0.0.1:31056, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30889") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:35906->127.0.0.1:30889, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:44248->127.0.0.1:30145, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31789") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:38228->127.0.0.1:31789, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30149") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:58926->127.0.0.1:30149, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30999") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:57714->127.0.0.1:30999, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30356") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:56726->127.0.0.1:30356, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30369") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:52814->127.0.0.1:30369, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31813") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:49160->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:56482->127.0.0.1:31813, err= 2025/07/15 02:52:18 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/07/15 02:52:18 INFO : file4.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30307") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31826") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:53126->127.0.0.1:31826, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:43952->127.0.0.1:30307, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30664") 2025/07/15 02:52:18 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/07/15 02:52:18 INFO : file6.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:45348->127.0.0.1:30664, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30381") 2025/07/15 02:52:18 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/07/15 02:52:18 INFO : file5.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31234") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:42830->127.0.0.1:31234, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30700") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30316") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:57104->127.0.0.1:30381, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:52692->127.0.0.1:30316, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:48940->127.0.0.1:30700, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30304") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30324") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31156") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:38616->127.0.0.1:31156, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:54530->127.0.0.1:30324, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:42092->127.0.0.1:30304, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31703") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:45326->127.0.0.1:31703, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31104") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: SetModTime is not supported 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:44752->127.0.0.1:31104, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30058") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:56654->127.0.0.1:30058, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30671") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:52050->127.0.0.1:30671, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30025") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:51650->127.0.0.1:30025, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30557") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:34266->127.0.0.1:30557, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31128") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31156") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:34430->127.0.0.1:31128, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:38618->127.0.0.1:31156, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31903") 2025/07/15 02:52:18 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/07/15 02:52:18 INFO : file7.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:42458->127.0.0.1:31903, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31493") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30653") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:31047") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:43632->127.0.0.1:31047, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:41832->127.0.0.1:31493, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:50022->127.0.0.1:30653, err= 2025/07/15 02:52:18 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/07/15 02:52:18 INFO : file2.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file9.txt.cf9a93ac.partial: renamed to: file9.txt 2025/07/15 02:52:18 INFO : file9.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt 2025/07/15 02:52:18 INFO : file8.txt: Copied (new) 2025/07/15 02:52:18 NOTICE: checking Path1 ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: dial("tcp","127.0.0.1:30171") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: > dial: conn=127.0.0.1:41138->127.0.0.1:30171, err= 2025/07/15 02:52:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file2.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file3.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file4.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file5.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file6.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file7.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file8.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : file9.txt: Need to transfer - File not found at Destination 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/max_delete_path2_force/path2: Waiting for checks to finish 2025/07/15 02:52:18 DEBUG : Local file system at /tmp/025218fo/max_delete_path2_force/path2: Waiting for transfers to finish 2025/07/15 02:52:18 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt 2025/07/15 02:52:18 INFO : file2.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt 2025/07/15 02:52:18 INFO : file3.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt 2025/07/15 02:52:18 INFO : file5.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt 2025/07/15 02:52:18 INFO : file6.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt 2025/07/15 02:52:18 INFO : file7.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt 2025/07/15 02:52:18 INFO : file8.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt 2025/07/15 02:52:18 INFO : file4.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/07/15 02:52:18 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/07/15 02:52:18 INFO : file1.txt: Copied (new) 2025/07/15 02:52:18 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/07/15 02:52:18 DEBUG : file9.txt.cf9a93ac.partial: renamed to: file9.txt 2025/07/15 02:52:18 INFO : file9.txt: Copied (new) 2025/07/15 02:52:18 NOTICE: checking path2 Local file system at /tmp/025218fo/max_delete_path2_force/path2 2025/07/15 02:52:18 NOTICE: (01) : test max-delete-path2-force 2025/07/15 02:52:18 NOTICE: (02) : test initial bisync 2025/07/15 02:52:18 NOTICE: (03) : bisync resync bisync_test.go:968: skipping test as at least one remote does not support setting modtime 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30148") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:41910->127.0.0.1:30148, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31974") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:33160->127.0.0.1:31974, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Connecting to FTP server 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:28622") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:49164->127.0.0.1:28622, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31060") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:54066->127.0.0.1:31060, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31277") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:60608->127.0.0.1:31277, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31899") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:54942->127.0.0.1:31899, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30548") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:47490->127.0.0.1:30548, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file1.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30931") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:43518->127.0.0.1:30931, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file2.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30806") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:42286->127.0.0.1:30806, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file3.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30713") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:43688->127.0.0.1:30713, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file4.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30920") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:53232->127.0.0.1:30920, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file5.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30262") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:40402->127.0.0.1:30262, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file6.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:30894") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:49022->127.0.0.1:30894, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file7.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31871") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:45682->127.0.0.1:31871, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file8.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31857") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:42696->127.0.0.1:31857, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge object "025218fo/max_delete_path2_force/path1/file9.txt" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: dial("tcp","127.0.0.1:31504") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: > dial: conn=127.0.0.1:40700->127.0.0.1:31504, err= 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge dir "025218fo/path1" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge dir "025218fo/max_delete_path2_force/path1" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge dir "025218fo/max_delete_path2_force" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge dir "025218fo" 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene: Purge dir "" --- PASS: TestBisyncRemoteLocal (0.15s) --- SKIP: TestBisyncRemoteLocal/max_delete_path2_force (0.11s) PASS 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: dial("tcp","127.0.0.1:30626") 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: > dial: conn=127.0.0.1:44064->127.0.0.1:30626, err= 2025/07/15 02:52:18 ERROR : error listing: directory not found 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-gebigim0buwa: Purge dir "" 2025/07/15 02:52:18 NOTICE: purge failed to rmdir "": directory not found 2025/07/15 02:52:18 NOTICE: purge failed: directory not found 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo: closing 1 unused connections 2025/07/15 02:52:18 DEBUG : ftp://127.0.0.1:28622/rclone-test-kucijep3xene/025218fo/max_delete_path2_force/path1: closing 4 unused connections "./bisync.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestBisyncRemoteLocal$/^max_delete_path2_force$'" - Finished OK in 223.531949ms (try 2/5)