"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/10/10 04:52:47 NOTICE: TestFTPProftpd: Starting server 2026/10/10 04:52:48 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2026/10/10 04:52:48 DEBUG : TestFTPProftpd: Read 1, error: 2026/10/10 04:52:48 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2026/10/10 04:52:48 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hefubag6daco" 2026/10/10 04:52:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/10 04:52:48 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Connecting to FTP server 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36218->172.17.0.3:21, err= 2026/10/10 04:52:48 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:45288") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54748->172.17.0.3:45288, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRootCannotChangeHost 2026/10/10 04:52:48 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:41785/" 2026/10/10 04:52:48 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785: Connecting to FTP server 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785: > dial: conn=172.17.0.1:36234->172.17.0.3:21, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785: dial("tcp","172.17.0.3:51551") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785: > dial: conn=172.17.0.1:37200->172.17.0.3:51551, err= 2026/10/10 04:52:48 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:41785/rclone-test-hefubag6daco/" 2026/10/10 04:52:48 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785/rclone-test-hefubag6daco: Connecting to FTP server 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36238->172.17.0.3:21, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:38973") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/127.0.0.1:41785/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:60416->172.17.0.3:38973, err= 2026/10/10 04:52:48 DEBUG : Creating backend with remote "TestFTPProftpd://user:pass@127.0.0.1:41785/" 2026/10/10 04:52:48 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:48 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:48 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:48 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/user:pass@127.0.0.1:41785: Connecting to FTP server 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/user:pass@127.0.0.1:41785: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/user:pass@127.0.0.1:41785: > dial: conn=172.17.0.1:36242->172.17.0.3:21, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/user:pass@127.0.0.1:41785: dial("tcp","172.17.0.3:13961") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/user:pass@127.0.0.1:41785: > dial: conn=172.17.0.1:38596->172.17.0.3:13961, err= === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:28451") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46168->172.17.0.3:28451, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/10 04:52:48 INFO : dir/subdir: Making directory 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:18761") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34072->172.17.0.3:18761, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:19474") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51682->172.17.0.3:19474, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55634") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40096->172.17.0.3:55634, err= 2026/10/10 04:52:48 INFO : dir/subdir: Removing directory 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:28309") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59900->172.17.0.3:28309, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:5148") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42166->172.17.0.3:5148, err= 2026/10/10 04:52:48 INFO : dir: Removing directory 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:5192") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35270->172.17.0.3:5192, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:10963") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:44968->172.17.0.3:10963, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53415") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53120->172.17.0.3:53415, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:30450") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:58364->172.17.0.3:30450, err= 2026/10/10 04:52:48 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:45827") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:41090->172.17.0.3:45827, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:779: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:2107") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:58436->172.17.0.3:2107, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:1671") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39756->172.17.0.3:1671, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:27084") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36264->172.17.0.3:27084, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:51130") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55118->172.17.0.3:51130, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:779: testing "．" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:33169") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36370->172.17.0.3:33169, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40118") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46596->172.17.0.3:40118, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:48987") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35642->172.17.0.3:48987, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:59998") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55288->172.17.0.3:59998, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:779: testing "．．" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:27460") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36774->172.17.0.3:27460, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55366") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46558->172.17.0.3:55366, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:41515") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42334->172.17.0.3:41515, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:49155") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52700->172.17.0.3:49155, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:779: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:8037") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46272->172.17.0.3:8037, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40619") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:44600->172.17.0.3:40619, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:33476") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38518->172.17.0.3:33476, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:38927") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34494->172.17.0.3:38927, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:779: testing " leading space" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:18419") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54658->172.17.0.3:18419, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:34264") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43020->172.17.0.3:34264, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:57855") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33786->172.17.0.3:57855, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:62683") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42946->172.17.0.3:62683, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:779: testing "~leading tilde" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:61691") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39644->172.17.0.3:61691, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:11081") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34698->172.17.0.3:11081, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:16623") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52960->172.17.0.3:16623, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:51790") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:49980->172.17.0.3:51790, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:779: testing "␍leading CR" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:38367") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48420->172.17.0.3:38367, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:20748") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35372->172.17.0.3:20748, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55959") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:41534->172.17.0.3:55959, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:48307") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:56860->172.17.0.3:48307, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:779: testing "␊leading LF" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:8629") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33772->172.17.0.3:8629, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:20874") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39982->172.17.0.3:20874, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:28599") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38970->172.17.0.3:28599, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:9712") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48014->172.17.0.3:9712, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:779: testing "␉leading HT" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21521") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55546->172.17.0.3:21521, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:54660") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33374->172.17.0.3:54660, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:59818") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40646->172.17.0.3:59818, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53667") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51194->172.17.0.3:53667, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:779: testing "␋leading VT" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29244") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52410->172.17.0.3:29244, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:43271") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52138->172.17.0.3:43271, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:48130") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59946->172.17.0.3:48130, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55680") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55938->172.17.0.3:55680, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:779: testing ".leading dot" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:33102") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:41824->172.17.0.3:33102, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:24111") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39916->172.17.0.3:24111, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:39301") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51374->172.17.0.3:39301, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40115") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:49498->172.17.0.3:40115, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:779: testing "trailing space " 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:63706") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59490->172.17.0.3:63706, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:7242") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51156->172.17.0.3:7242, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:13508") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54496->172.17.0.3:13508, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:16591") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38332->172.17.0.3:16591, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:779: testing "trailing CR␍" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40483") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51154->172.17.0.3:40483, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:5829") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42768->172.17.0.3:5829, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:13740") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:50292->172.17.0.3:13740, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:36639") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54478->172.17.0.3:36639, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:779: testing "trailing LF␊" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:15886") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33244->172.17.0.3:15886, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29340") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43618->172.17.0.3:29340, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:22895") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38992->172.17.0.3:22895, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53230") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57686->172.17.0.3:53230, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:779: testing "trailing HT␉" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:49064") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:50782->172.17.0.3:49064, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:13319") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51666->172.17.0.3:13319, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:36003") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34496->172.17.0.3:36003, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:56669") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35534->172.17.0.3:56669, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:779: testing "trailing VT␋" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:33170") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40564->172.17.0.3:33170, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:63578") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:56922->172.17.0.3:63578, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:65358") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53540->172.17.0.3:65358, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53667") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51198->172.17.0.3:53667, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:779: testing "trailing dot." 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:52704") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57034->172.17.0.3:52704, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:59642") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:49012->172.17.0.3:59642, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:41800") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55134->172.17.0.3:41800, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:16413") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51574->172.17.0.3:16413, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:779: testing "invalid utf-8\xfe" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:37378") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:49366->172.17.0.3:37378, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:24395") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51648->172.17.0.3:24395, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:6559") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57290->172.17.0.3:6559, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:4946") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39874->172.17.0.3:4946, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:779: testing "test%46.txt" 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:47483") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:44462->172.17.0.3:47483, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:44836") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:45920->172.17.0.3:44836, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:44038") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34274->172.17.0.3:44038, err= 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:45654") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40994->172.17.0.3:45654, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:51054") 2026/10/10 04:52:48 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36512->172.17.0.3:51054, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36254->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:1643") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:45282->172.17.0.3:1643, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:27796") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33892->172.17.0.3:27796, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:858: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:895: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:977: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:57196") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52982->172.17.0.3:57196, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:22190") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:47518->172.17.0.3:22190, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:58537") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:37964->172.17.0.3:58537, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:47334") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46750->172.17.0.3:47334, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:35381") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:60982->172.17.0.3:35381, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:28753") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40170->172.17.0.3:28753, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:15426") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43354->172.17.0.3:15426, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29317") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:37580->172.17.0.3:29317, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:18276") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33210->172.17.0.3:18276, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:20521") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33650->172.17.0.3:20521, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:12524") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42030->172.17.0.3:12524, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:19298") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:37268->172.17.0.3:19298, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:34518") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40168->172.17.0.3:34518, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:1611") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38076->172.17.0.3:1611, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:51926") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:58980->172.17.0.3:51926, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:35884") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51784->172.17.0.3:35884, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:35591") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43606->172.17.0.3:35591, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/10/10 04:52:49 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/10 04:52:49 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36262->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:44318") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45012->172.17.0.3:44318, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:19587") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:47120->172.17.0.3:19587, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:15885") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34410->172.17.0.3:15885, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:48680") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39642->172.17.0.3:48680, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:50688") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40552->172.17.0.3:50688, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:20449") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51284->172.17.0.3:20449, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:50303") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42318->172.17.0.3:50303, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:5863") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:44966->172.17.0.3:5863, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:44398") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38680->172.17.0.3:44398, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29003") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48198->172.17.0.3:29003, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1230: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:5632") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:37072->172.17.0.3:5632, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:41587") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57878->172.17.0.3:41587, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:41709") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:56496->172.17.0.3:41709, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:6252") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35596->172.17.0.3:6252, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:3848") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33452->172.17.0.3:3848, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1262: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1299: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/10/10 04:52:49 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hefubag6daco/hello? sausage/êé" 2026/10/10 04:52:49 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:36274->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-hefubag6daco/hello? sausage/êé" to be canonical "TestFTPProftpd{pg3oH}:rclone-test-hefubag6daco/hello? sausage/êé" 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:41573") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:58834->172.17.0.3:41573, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:43047") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:46302->172.17.0.3:43047, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:36276->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:23579") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:43084->172.17.0.3:23579, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:41820") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:41770->172.17.0.3:41820, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:31858") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:46796->172.17.0.3:31858, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:32788") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:33494->172.17.0.3:32788, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:60762") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:34332->172.17.0.3:60762, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:14135") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:46160->172.17.0.3:14135, err= 2026/10/10 04:52:49 DEBUG : Waiting for deletions to finish 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:58154") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:57068->172.17.0.3:58154, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:40286") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:33788->172.17.0.3:40286, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:55435") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:51984->172.17.0.3:55435, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:43980") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:34160->172.17.0.3:43980, err= 2026/10/10 04:52:49 INFO : a/b/c/d/e.txt: Deleted 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:45977") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:46382->172.17.0.3:45977, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:35737") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:42650->172.17.0.3:35737, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:39305") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:45722->172.17.0.3:39305, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: dial("tcp","172.17.0.3:23429") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé: > dial: conn=172.17.0.1:38962->172.17.0.3:23429, err= 2026/10/10 04:52:49 DEBUG : removing 1 level 4 directories 2026/10/10 04:52:49 INFO : a/b/c/d: Removing directory 2026/10/10 04:52:49 DEBUG : removing 1 level 3 directories 2026/10/10 04:52:49 INFO : a/b/c: Removing directory 2026/10/10 04:52:49 DEBUG : removing 1 level 2 directories 2026/10/10 04:52:49 INFO : a/b: Removing directory 2026/10/10 04:52:49 DEBUG : removing 1 level 1 directories 2026/10/10 04:52:49 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1363: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:33370") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53508->172.17.0.3:33370, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:27418") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34318->172.17.0.3:27418, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:61362") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34746->172.17.0.3:61362, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:15170") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:50384->172.17.0.3:15170, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:61776") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53976->172.17.0.3:61776, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:24580") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59336->172.17.0.3:24580, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36284->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29572") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36314->172.17.0.3:29572, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:46410") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:56022->172.17.0.3:46410, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:25559") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57418->172.17.0.3:25559, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:60436") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38796->172.17.0.3:60436, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:41833") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43808->172.17.0.3:41833, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:37165") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40750->172.17.0.3:37165, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:49069") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33338->172.17.0.3:49069, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:28101") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43404->172.17.0.3:28101, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:37059") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34070->172.17.0.3:37059, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:45771") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53458->172.17.0.3:45771, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:60107") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38728->172.17.0.3:60107, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:38183") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:49624->172.17.0.3:38183, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:18053") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:41528->172.17.0.3:18053, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:56622") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48646->172.17.0.3:56622, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:37646") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43012->172.17.0.3:37646, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:14063") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33724->172.17.0.3:14063, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:46499") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:40408->172.17.0.3:46499, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1515: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/10/10 04:52:49 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lanefim0tiba" 2026/10/10 04:52:49 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:49 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:49 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:49 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:49 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: Connecting to FTP server 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:36300->172.17.0.3:21, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:51548") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:45752->172.17.0.3:51548, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:43875") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:48290->172.17.0.3:43875, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:24592") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:37766->172.17.0.3:24592, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:42889") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:47436->172.17.0.3:42889, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:19439") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:49174->172.17.0.3:19439, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:24830") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:54402->172.17.0.3:24830, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:4796") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:41962->172.17.0.3:4796, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:59982") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:60980->172.17.0.3:59982, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:52914") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:50472->172.17.0.3:52914, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:60826") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54866->172.17.0.3:60826, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:7703") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51406->172.17.0.3:7703, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:31485") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:43678->172.17.0.3:31485, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:65062") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35074->172.17.0.3:65062, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:25442") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:33528->172.17.0.3:25442, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:33809") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:56716->172.17.0.3:33809, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:63380") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:35030->172.17.0.3:63380, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: dial("tcp","172.17.0.3:60008") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: > dial: conn=172.17.0.1:38176->172.17.0.3:60008, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: Purge dir "new_name" 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-lanefim0tiba: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1711: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1742: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1813: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:3264") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34638->172.17.0.3:3264, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55360") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:50392->172.17.0.3:55360, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:50216") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39504->172.17.0.3:50216, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53027") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:47788->172.17.0.3:53027, err= 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:22690") 2026/10/10 04:52:49 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:53274->172.17.0.3:22690, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:50560") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:60634->172.17.0.3:50560, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:49368") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35550->172.17.0.3:49368, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:54595") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59486->172.17.0.3:54595, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:23005") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57760->172.17.0.3:23005, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40129") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:46654->172.17.0.3:40129, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:65391") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:41154->172.17.0.3:65391, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:55056") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:54832->172.17.0.3:55056, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:59714") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:38496->172.17.0.3:59714, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:14901") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42298->172.17.0.3:14901, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:62318") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52806->172.17.0.3:62318, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:4090") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39592->172.17.0.3:4090, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/10 04:52:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/10/10 04:52:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:36314->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:16830") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56454->172.17.0.3:16830, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/10 04:52:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hefubag6daco/not found.txt" 2026/10/10 04:52:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/not found.txt: Connecting to FTP server 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/not found.txt: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/not found.txt: > dial: conn=172.17.0.1:36328->172.17.0.3:21, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/not found.txt: dial("tcp","172.17.0.3:62533") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/not found.txt: > dial: conn=172.17.0.1:37604->172.17.0.3:62533, err= 2026/10/10 04:52:50 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:2072: Opening root remote "TestFTPProftpd:" path "rclone-test-hefubag6daco" from "TestFTPProftpd:rclone-test-hefubag6daco" 2026/10/10 04:52:50 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/10 04:52:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36344->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38427") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35078->172.17.0.3:38427, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:11138") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35580->172.17.0.3:11138, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43396") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33526->172.17.0.3:43396, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30067") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41412->172.17.0.3:30067, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:44931") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:32960->172.17.0.3:44931, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:10595") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38786->172.17.0.3:10595, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2109: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:58113") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56018->172.17.0.3:58113, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:18839") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58366->172.17.0.3:18839, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:62251") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43928->172.17.0.3:62251, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:61377") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48424->172.17.0.3:61377, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:24391") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56286->172.17.0.3:24391, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35659") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:57168->172.17.0.3:35659, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:52334") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34742->172.17.0.3:52334, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:44539") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51068->172.17.0.3:44539, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:51394") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44048->172.17.0.3:51394, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:7042") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33688->172.17.0.3:7042, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:54256") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49340->172.17.0.3:54256, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2168: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2273: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2289: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:1554") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:37330->172.17.0.3:1554, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:23398") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:34210->172.17.0.3:23398, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:3597") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33340->172.17.0.3:3597, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:18512") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:60318->172.17.0.3:18512, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:59665") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48044->172.17.0.3:59665, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2445: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:42117") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52588->172.17.0.3:42117, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:29833") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52338->172.17.0.3:29833, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/10/10 04:52:50 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-hefubag6daco" 2026/10/10 04:52:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{GZrpY}" suffix to name 2026/10/10 04:52:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Connecting to FTP server 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36358->172.17.0.3:21, err= 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:2441") 2026/10/10 04:52:50 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:33466->172.17.0.3:2441, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2530: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:44283") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:57352->172.17.0.3:44283, err= fstests.go:2733: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53819") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42544->172.17.0.3:53819, err= fstests.go:2733: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2775: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:64893") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:60556->172.17.0.3:64893, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2906: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2948: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:12211") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:51962->172.17.0.3:12211, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:53527") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36520->172.17.0.3:53527, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:44942") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59018->172.17.0.3:44942, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/10 04:52:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hefubag6daco/deeper/nonexisting/directory" 2026/10/10 04:52:51 DEBUG : Config file has changed externally - reloading 2026/10/10 04:52:51 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/10 04:52:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{pg3oH}" suffix to name 2026/10/10 04:52:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/10 04:52:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/10 04:52:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/10 04:52:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/deeper/nonexisting/directory: Connecting to FTP server 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco/deeper/nonexisting/directory: > dial: conn=172.17.0.1:36364->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3097: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3140: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3197: FS has no Directory methods and doesn't Wrap 2026/10/10 04:52:51 DEBUG : Waiting for deletions to finish 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:30105") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55904->172.17.0.3:30105, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:12119") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:35992->172.17.0.3:12119, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:1585") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52750->172.17.0.3:1585, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:26777") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:36310->172.17.0.3:26777, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:7543") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52068->172.17.0.3:7543, err= 2026/10/10 04:52:51 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:40769") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:59540->172.17.0.3:40769, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:26904") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:56208->172.17.0.3:26904, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:26265") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:52046->172.17.0.3:26265, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:46972") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42394->172.17.0.3:46972, err= 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:23018") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:42342->172.17.0.3:23018, err= 2026/10/10 04:52:51 DEBUG : removing 1 level 4 directories 2026/10/10 04:52:51 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/10/10 04:52:51 DEBUG : removing 1 level 3 directories 2026/10/10 04:52:51 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/10/10 04:52:51 DEBUG : removing 1 level 2 directories 2026/10/10 04:52:51 INFO : hello? sausage/êé: Removing directory 2026/10/10 04:52:51 DEBUG : removing 1 level 1 directories 2026/10/10 04:52:51 INFO : hello? sausage: Removing directory 2026/10/10 04:52:51 DEBUG : removing 1 level 0 directories 2026/10/10 04:52:51 INFO : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Removing directory 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:64326") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:55682->172.17.0.3:64326, err= 2026/10/10 04:52:51 ERROR : error listing: directory not found 2026/10/10 04:52:51 DEBUG : Waiting for deletions to finish 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:2444") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:39224->172.17.0.3:2444, err= 2026/10/10 04:52:51 ERROR : error listing: directory not found 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: dial("tcp","172.17.0.3:54813") 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: > dial: conn=172.17.0.1:48304->172.17.0.3:54813, err= 2026/10/10 04:52:51 ERROR : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Failed to list "": directory not found 2026/10/10 04:52:51 DEBUG : removing 1 level 0 directories 2026/10/10 04:52:51 INFO : ftp://172.17.0.3:21/rclone-test-hefubag6daco: Removing directory 2026/10/10 04:52:51 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/10/10 04:52:51 DEBUG : ftp://172.17.0.3:21/rclone-test-hefubag6daco: closing 2 unused connections 2026/10/10 04:52:51 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.33s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRootCannotChangeHost (0.04s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.98s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.358s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 6.013019931s (try 1/5)