"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPPureftpd:" 2026/09/29 02:35:48 NOTICE: TestFTPPureftpd: Starting server 2026/09/29 02:35:49 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/09/29 02:35:49 DEBUG : TestFTPPureftpd: Read 1, error: 2026/09/29 02:35:49 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.4:21" 2026/09/29 02:35:49 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xahicuq0suwi" 2026/09/29 02:35:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/29 02:35:49 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:35:49 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:49 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:49 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:49 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:49 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:35:49 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:49 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:49 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:49 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:49 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Connecting to FTP server 2026/09/29 02:35:49 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:21") 2026/09/29 02:35:49 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:56566->172.17.0.4:21, err= 2026/09/29 02:35:52 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_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/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35039") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34536->172.17.0.4:35039, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35273") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41450->172.17.0.4:35273, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/29 02:35:52 INFO : dir/subdir: Making directory 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38469") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57426->172.17.0.4:38469, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35418") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:52324->172.17.0.4:35418, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39465") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:35170->172.17.0.4:39465, err= 2026/09/29 02:35:52 INFO : dir/subdir: Removing directory 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33001") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:44084->172.17.0.4:33001, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32399") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38378->172.17.0.4:32399, err= 2026/09/29 02:35:52 INFO : dir: Removing directory 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35342") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36294->172.17.0.4:35342, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37731") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33184->172.17.0.4:37731, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34309") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53070->172.17.0.4:34309, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31738") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39746->172.17.0.4:31738, err= 2026/09/29 02:35:52 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/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32855") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51638->172.17.0.4:32855, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31319") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49704->172.17.0.4:31319, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39793") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:32796->172.17.0.4:39793, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39389") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36374->172.17.0.4:39389, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36743") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55876->172.17.0.4:36743, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33624") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41414->172.17.0.4:33624, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31668") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:40264->172.17.0.4:31668, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36395") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34610->172.17.0.4:36395, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35780") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41998->172.17.0.4:35780, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34918") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41916->172.17.0.4:34918, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30385") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:56236->172.17.0.4:30385, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35524") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43938->172.17.0.4:35524, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31101") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46238->172.17.0.4:31101, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37002") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:52648->172.17.0.4:37002, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38166") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:47740->172.17.0.4:38166, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38812") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36724->172.17.0.4:38812, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31219") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55676->172.17.0.4:31219, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33074") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33204->172.17.0.4:33074, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34620") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48090->172.17.0.4:34620, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36662") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37634->172.17.0.4:36662, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39321") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55086->172.17.0.4:39321, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32107") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46040->172.17.0.4:32107, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38878") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57984->172.17.0.4:38878, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34997") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:35578->172.17.0.4:34997, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39144") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55540->172.17.0.4:39144, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37457") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54594->172.17.0.4:37457, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36602") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:32952->172.17.0.4:36602, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39119") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54642->172.17.0.4:39119, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33752") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43060->172.17.0.4:33752, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32069") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55058->172.17.0.4:32069, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30085") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38948->172.17.0.4:30085, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30089") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:50724->172.17.0.4:30089, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35072") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59706->172.17.0.4:35072, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39746") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58880->172.17.0.4:39746, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35995") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49624->172.17.0.4:35995, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32194") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39826->172.17.0.4:32194, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32954") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:50932->172.17.0.4:32954, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37480") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59126->172.17.0.4:37480, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33820") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55816->172.17.0.4:33820, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31943") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38032->172.17.0.4:31943, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30828") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38666->172.17.0.4:30828, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32012") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59760->172.17.0.4:32012, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35954") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48910->172.17.0.4:35954, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30737") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33212->172.17.0.4:30737, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38896") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36046->172.17.0.4:38896, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32496") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51188->172.17.0.4:32496, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34658") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37334->172.17.0.4:34658, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32901") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38748->172.17.0.4:32901, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37546") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37942->172.17.0.4:37546, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34716") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59358->172.17.0.4:34716, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34854") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54274->172.17.0.4:34854, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32799") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:40982->172.17.0.4:32799, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36622") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54784->172.17.0.4:36622, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34489") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39108->172.17.0.4:34489, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30114") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:32994->172.17.0.4:30114, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31471") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37574->172.17.0.4:31471, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31949") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33356->172.17.0.4:31949, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31311") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38630->172.17.0.4:31311, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37544") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:52768->172.17.0.4:37544, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34440") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49158->172.17.0.4:34440, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39772") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48564->172.17.0.4:39772, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36575") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53752->172.17.0.4:36575, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37980") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39316->172.17.0.4:37980, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36797") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:40256->172.17.0.4:36797, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37137") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33784->172.17.0.4:37137, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34709") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33140->172.17.0.4:34709, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39200") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:47372->172.17.0.4:39200, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35588") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:44932->172.17.0.4:35588, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38846") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51834->172.17.0.4:38846, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30119") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:60022->172.17.0.4:30119, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31448") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36336->172.17.0.4:31448, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36371") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49132->172.17.0.4:36371, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36825") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37636->172.17.0.4:36825, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38557") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57194->172.17.0.4:38557, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33076") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:42214->172.17.0.4:33076, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37016") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38176->172.17.0.4:37016, err= 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34531") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54314->172.17.0.4:34531, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32696") 2026/09/29 02:35:52 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:56240->172.17.0.4:32696, err= 2026/09/29 02:35:53 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Connecting to FTP server 2026/09/29 02:35:53 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:21") 2026/09/29 02:35:53 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53170->172.17.0.4:21, err= 2026/09/29 02:35:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36349") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36526->172.17.0.4:36349, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32294") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59584->172.17.0.4:32294, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39487") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53318->172.17.0.4:39487, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30176") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:47376->172.17.0.4:30176, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33871") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48506->172.17.0.4:33871, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38497") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36154->172.17.0.4:38497, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37595") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:60286->172.17.0.4:37595, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37035") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57706->172.17.0.4:37035, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32981") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:40246->172.17.0.4:32981, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31409") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46556->172.17.0.4:31409, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36435") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33952->172.17.0.4:36435, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39876") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51654->172.17.0.4:39876, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34531") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54328->172.17.0.4:34531, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31001") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43054->172.17.0.4:31001, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33749") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34194->172.17.0.4:33749, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38012") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:56506->172.17.0.4:38012, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34677") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34964->172.17.0.4:34677, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38810") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:50402->172.17.0.4:38810, err= 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30559") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57846->172.17.0.4:30559, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/29 02:35:57 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/29 02:35:57 DEBUG : Config file has changed externally - reloading 2026/09/29 02:35:57 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:35:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:57 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:35:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/09/29 02:35:57 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53176->172.17.0.4:21, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34459") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58182->172.17.0.4:34459, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38357") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51776->172.17.0.4:38357, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34866") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48352->172.17.0.4:34866, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37739") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49306->172.17.0.4:37739, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35660") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:33080->172.17.0.4:35660, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36057") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39792->172.17.0.4:36057, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33493") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:60726->172.17.0.4:33493, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30655") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43030->172.17.0.4:30655, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37292") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36246->172.17.0.4:37292, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33481") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41000->172.17.0.4:33481, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37245") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:48928->172.17.0.4:37245, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39068") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46254->172.17.0.4:39068, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38404") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53736->172.17.0.4:38404, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31525") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36050->172.17.0.4:31525, err= 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38022") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59178->172.17.0.4:38022, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/09/29 02:35:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xahicuq0suwi/hello? sausage/êé" 2026/09/29 02:35:59 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:35:59 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:59 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:59 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:35:59 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:35:59 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:35:59 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:35:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: Connecting to FTP server 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/09/29 02:35:59 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:53182->172.17.0.4:21, err= 2026/09/29 02:36:02 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-xahicuq0suwi/hello? sausage/êé" to be canonical "TestFTPPureftpd{pMk8B}:rclone-test-xahicuq0suwi/hello? sausage/êé" 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:35530") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:35282->172.17.0.4:35530, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:35270") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:56392->172.17.0.4:35270, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: Connecting to FTP server 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:47238->172.17.0.4:21, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:31029") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:45258->172.17.0.4:31029, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:35940") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:57040->172.17.0.4:35940, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:36497") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:52226->172.17.0.4:36497, err= 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:36815") 2026/09/29 02:36:02 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:54310->172.17.0.4:36815, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:36123") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:45850->172.17.0.4:36123, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:31506") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:39192->172.17.0.4:31506, err= 2026/09/29 02:36:06 DEBUG : Waiting for deletions to finish 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:37478") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:36662->172.17.0.4:37478, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:31851") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:55806->172.17.0.4:31851, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:32715") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:60906->172.17.0.4:32715, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:39703") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:32836->172.17.0.4:39703, err= 2026/09/29 02:36:06 INFO : a/b/c/d/e.txt: Deleted 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:31113") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:44698->172.17.0.4:31113, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:34951") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:35664->172.17.0.4:34951, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:33193") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:33324->172.17.0.4:33193, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: dial("tcp","172.17.0.4:35001") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé: > dial: conn=172.17.0.1:44024->172.17.0.4:35001, err= 2026/09/29 02:36:06 DEBUG : removing 1 level 4 directories 2026/09/29 02:36:06 INFO : a/b/c/d: Removing directory 2026/09/29 02:36:06 DEBUG : removing 1 level 3 directories 2026/09/29 02:36:06 INFO : a/b/c: Removing directory 2026/09/29 02:36:06 DEBUG : removing 1 level 2 directories 2026/09/29 02:36:06 INFO : a/b: Removing directory 2026/09/29 02:36:06 DEBUG : removing 1 level 1 directories 2026/09/29 02:36:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31257") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55542->172.17.0.4:31257, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31571") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:56438->172.17.0.4:31571, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34678") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38834->172.17.0.4:34678, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31731") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55790->172.17.0.4:31731, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37222") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58328->172.17.0.4:37222, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35349") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51788->172.17.0.4:35349, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Connecting to FTP server 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:47246->172.17.0.4:21, err= 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32400") 2026/09/29 02:36:06 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46752->172.17.0.4:32400, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32098") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:32890->172.17.0.4:32098, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30443") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59866->172.17.0.4:30443, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39818") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41048->172.17.0.4:39818, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35258") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54908->172.17.0.4:35258, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37383") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51376->172.17.0.4:37383, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30002") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58636->172.17.0.4:30002, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38158") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51598->172.17.0.4:38158, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31605") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39468->172.17.0.4:31605, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34107") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54126->172.17.0.4:34107, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39187") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36374->172.17.0.4:39187, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31855") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59528->172.17.0.4:31855, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37679") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38884->172.17.0.4:37679, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32107") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57106->172.17.0.4:32107, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35549") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34658->172.17.0.4:35549, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36570") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39802->172.17.0.4:36570, err= 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37592") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:44866->172.17.0.4:37592, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/29 02:36:09 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henazez4qapi" 2026/09/29 02:36:09 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:09 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:09 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:09 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:09 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:09 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:36:09 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:09 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:09 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:09 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: Connecting to FTP server 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:09 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:47254->172.17.0.4:21, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38922") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51878->172.17.0.4:38922, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:37468") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:55172->172.17.0.4:37468, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:34490") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:49042->172.17.0.4:34490, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:30184") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:53022->172.17.0.4:30184, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:36858") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:40754->172.17.0.4:36858, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:38911") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:36694->172.17.0.4:38911, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:38817") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:38388->172.17.0.4:38817, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:34999") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:42096->172.17.0.4:34999, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38659") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:49172->172.17.0.4:38659, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38944") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55120->172.17.0.4:38944, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36716") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58796->172.17.0.4:36716, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36542") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:60950->172.17.0.4:36542, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39690") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58446->172.17.0.4:39690, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:30828") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:46380->172.17.0.4:30828, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:36565") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:45116->172.17.0.4:36565, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:36546") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:46122->172.17.0.4:36546, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: dial("tcp","172.17.0.4:34635") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: > dial: conn=172.17.0.1:43376->172.17.0.4:34635, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: Purge dir "new_name" 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-henazez4qapi: 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:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1664: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31195") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:36596->172.17.0.4:31195, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32136") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34992->172.17.0.4:32136, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38906") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:50058->172.17.0.4:38906, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33359") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53434->172.17.0.4:33359, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39699") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51788->172.17.0.4:39699, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39290") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43262->172.17.0.4:39290, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32873") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:60112->172.17.0.4:32873, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35464") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55226->172.17.0.4:35464, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39712") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:34754->172.17.0.4:39712, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30342") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:37512->172.17.0.4:30342, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30226") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43572->172.17.0.4:30226, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33292") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55150->172.17.0.4:33292, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37956") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:35182->172.17.0.4:37956, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30147") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39028->172.17.0.4:30147, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34005") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:54584->172.17.0.4:34005, err= 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34100") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43268->172.17.0.4:34100, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/29 02:36:12 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/29 02:36:12 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:12 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:36:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:12 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:46814->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/29 02:36:16 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:39511") 2026/09/29 02:36:16 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37760->172.17.0.4:39511, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/29 02:36:16 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xahicuq0suwi/not found.txt" 2026/09/29 02:36:16 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:16 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:16 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:16 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:16 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:16 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:36:16 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:16 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:16 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:16 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:16 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/not found.txt: Connecting to FTP server 2026/09/29 02:36:16 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/not found.txt: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:16 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/not found.txt: > dial: conn=172.17.0.1:46826->172.17.0.4:21, err= 2026/09/29 02:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/not found.txt: dial("tcp","172.17.0.4:39715") 2026/09/29 02:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/not found.txt: > dial: conn=172.17.0.1:35734->172.17.0.4:39715, err= 2026/09/29 02:36:19 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPPureftpd:" path "rclone-test-xahicuq0suwi" from "TestFTPPureftpd:rclone-test-xahicuq0suwi" 2026/09/29 02:36:19 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/29 02:36:19 DEBUG : Config file has changed externally - reloading 2026/09/29 02:36:19 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:19 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:19 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:19 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:36:19 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:19 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:19 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:19 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/09/29 02:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46858->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37815") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56814->172.17.0.4:37815, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35248") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43858->172.17.0.4:35248, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37925") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37832->172.17.0.4:37925, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32570") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:45642->172.17.0.4:32570, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34538") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57362->172.17.0.4:34538, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39351") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52798->172.17.0.4:39351, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30044") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44836->172.17.0.4:30044, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32584") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46164->172.17.0.4:32584, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37604") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47978->172.17.0.4:37604, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30416") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49698->172.17.0.4:30416, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35067") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60702->172.17.0.4:35067, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33052") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55750->172.17.0.4:33052, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39797") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46754->172.17.0.4:39797, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32759") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60430->172.17.0.4:32759, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36652") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44132->172.17.0.4:36652, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38342") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48586->172.17.0.4:38342, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35320") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49096->172.17.0.4:35320, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2090: 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:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2211: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:39964") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43764->172.17.0.4:39964, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35884") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:39722->172.17.0.4:35884, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:33485") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:47112->172.17.0.4:33485, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32222") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:58308->172.17.0.4:32222, err= 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36537") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:35648->172.17.0.4:36537, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2367: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36893") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:53644->172.17.0.4:36893, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38582") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:52684->172.17.0.4:38582, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/29 02:36:21 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-xahicuq0suwi" 2026/09/29 02:36:21 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:21 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:21 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:21 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:21 DEBUG : TestFTPPureftpd: detected overridden config - adding "{30Urm}" suffix to name 2026/09/29 02:36:21 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:21 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:21 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Connecting to FTP server 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:21 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:55326->172.17.0.4:21, err= 2026/09/29 02:36:24 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30455") 2026/09/29 02:36:24 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:35474->172.17.0.4:30455, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2452: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32835") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:45364->172.17.0.4:32835, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32886") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:43684->172.17.0.4:32886, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2697: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32747") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51686->172.17.0.4:32747, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2828: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2870: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30348") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:40822->172.17.0.4:30348, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36124") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57830->172.17.0.4:36124, err= 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34573") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:41050->172.17.0.4:34573, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/29 02:36:25 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xahicuq0suwi/deeper/nonexisting/directory" 2026/09/29 02:36:25 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/29 02:36:25 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:25 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:25 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:25 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:25 DEBUG : TestFTPPureftpd: detected overridden config - adding "{pMk8B}" suffix to name 2026/09/29 02:36:25 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/29 02:36:25 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/29 02:36:25 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/29 02:36:25 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/deeper/nonexisting/directory: Connecting to FTP server 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/09/29 02:36:25 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:55330->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3119: FS has no Directory methods and doesn't Wrap 2026/09/29 02:36:29 DEBUG : Waiting for deletions to finish 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38779") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38878->172.17.0.4:38779, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:32642") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51256->172.17.0.4:32642, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30634") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:50748->172.17.0.4:30634, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:38890") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38162->172.17.0.4:38890, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34581") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:57824->172.17.0.4:34581, err= 2026/09/29 02:36:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:31350") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:51624->172.17.0.4:31350, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:35723") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:42546->172.17.0.4:35723, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36643") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:46412->172.17.0.4:36643, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:30208") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:52738->172.17.0.4:30208, err= 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37897") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:45780->172.17.0.4:37897, err= 2026/09/29 02:36:29 DEBUG : removing 1 level 4 directories 2026/09/29 02:36:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/29 02:36:29 DEBUG : removing 1 level 3 directories 2026/09/29 02:36:29 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/29 02:36:29 DEBUG : removing 1 level 2 directories 2026/09/29 02:36:29 INFO : hello? sausage/êé: Removing directory 2026/09/29 02:36:29 DEBUG : removing 1 level 1 directories 2026/09/29 02:36:29 INFO : hello? sausage: Removing directory 2026/09/29 02:36:29 DEBUG : removing 1 level 0 directories 2026/09/29 02:36:29 INFO : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Removing directory 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:37971") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:59198->172.17.0.4:37971, err= 2026/09/29 02:36:29 ERROR : error listing: directory not found 2026/09/29 02:36:29 DEBUG : Waiting for deletions to finish 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:34524") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:38946->172.17.0.4:34524, err= 2026/09/29 02:36:29 ERROR : error listing: directory not found 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: dial("tcp","172.17.0.4:36754") 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: > dial: conn=172.17.0.1:45156->172.17.0.4:36754, err= 2026/09/29 02:36:29 ERROR : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Failed to list "": directory not found 2026/09/29 02:36:29 DEBUG : removing 1 level 0 directories 2026/09/29 02:36:29 INFO : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: Removing directory 2026/09/29 02:36:29 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/29 02:36:29 DEBUG : ftp://172.17.0.4:21/rclone-test-xahicuq0suwi: closing 2 unused connections 2026/09/29 02:36:29 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (41.03s) --- 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/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (36.39s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- 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.13s) --- 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 (4.16s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (28.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (2.78s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- 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 (6.31s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (3.20s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (3.22s) --- 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 (3.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (2.86s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.00s) --- 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 (3.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (3.49s) --- 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.00s) --- 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 (3.69s) --- 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 41.048s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 42.330574569s (try 1/5)