"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/09 01:02:36 NOTICE: TestFTPPureftpd: Starting server 2026/09/09 01:02:37 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.5:21" try 1/100 2026/09/09 01:02:37 DEBUG : TestFTPPureftpd: Read 1, error: 2026/09/09 01:02:37 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.5:21" 2026/09/09 01:02:37 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henizof6nage" 2026/09/09 01:02:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/09 01:02:37 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:02:37 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:37 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:37 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:37 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:37 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:02:37 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:37 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:37 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:37 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:37 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: Connecting to FTP server 2026/09/09 01:02:37 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:37 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47046->172.17.0.5:21, err= 2026/09/09 01:02:40 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/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30394") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43600->172.17.0.5:30394, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36322") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45968->172.17.0.5:36322, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/09 01:02:40 INFO : dir/subdir: Making directory 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37671") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:49986->172.17.0.5:37671, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39042") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59068->172.17.0.5:39042, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32399") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56638->172.17.0.5:32399, err= 2026/09/09 01:02:40 INFO : dir/subdir: Removing directory 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35829") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:34582->172.17.0.5:35829, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35625") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45516->172.17.0.5:35625, err= 2026/09/09 01:02:40 INFO : dir: Removing directory 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33989") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35512->172.17.0.5:33989, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36879") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50526->172.17.0.5:36879, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33835") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36106->172.17.0.5:33835, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35003") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37880->172.17.0.5:35003, err= 2026/09/09 01:02:40 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/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35106") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57034->172.17.0.5:35106, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35851") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:38488->172.17.0.5:35851, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35868") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:48798->172.17.0.5:35868, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30277") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:39500->172.17.0.5:30277, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36885") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54242->172.17.0.5:36885, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33564") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33518->172.17.0.5:33564, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34070") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54922->172.17.0.5:34070, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39464") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55432->172.17.0.5:39464, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35701") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:49298->172.17.0.5:35701, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37182") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54006->172.17.0.5:37182, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38826") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54352->172.17.0.5:38826, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34357") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33476->172.17.0.5:34357, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33732") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57800->172.17.0.5:33732, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33293") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45282->172.17.0.5:33293, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33974") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59554->172.17.0.5:33974, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38890") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52956->172.17.0.5:38890, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37903") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53232->172.17.0.5:37903, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34401") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57094->172.17.0.5:34401, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37019") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:48706->172.17.0.5:37019, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34309") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37238->172.17.0.5:34309, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39116") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40412->172.17.0.5:39116, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38603") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:60212->172.17.0.5:38603, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37135") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47864->172.17.0.5:37135, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30498") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55394->172.17.0.5:30498, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30577") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54182->172.17.0.5:30577, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37455") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44326->172.17.0.5:37455, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33467") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43362->172.17.0.5:33467, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37601") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40042->172.17.0.5:37601, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31403") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41880->172.17.0.5:31403, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31899") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40972->172.17.0.5:31899, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31411") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40478->172.17.0.5:31411, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30407") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45544->172.17.0.5:30407, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32025") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59880->172.17.0.5:32025, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39359") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56100->172.17.0.5:39359, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39983") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36976->172.17.0.5:39983, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35049") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50302->172.17.0.5:35049, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30895") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40730->172.17.0.5:30895, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35194") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53536->172.17.0.5:35194, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34949") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57568->172.17.0.5:34949, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30765") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42514->172.17.0.5:30765, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38704") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:46770->172.17.0.5:38704, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37405") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33722->172.17.0.5:37405, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30630") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58768->172.17.0.5:30630, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33372") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36808->172.17.0.5:33372, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33087") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:46444->172.17.0.5:33087, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39813") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58684->172.17.0.5:39813, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35593") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53846->172.17.0.5:35593, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35048") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:39720->172.17.0.5:35048, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32207") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51906->172.17.0.5:32207, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33970") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50330->172.17.0.5:33970, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35380") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41044->172.17.0.5:35380, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37958") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37156->172.17.0.5:37958, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38672") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53724->172.17.0.5:38672, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38066") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40906->172.17.0.5:38066, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35056") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45526->172.17.0.5:35056, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39212") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41426->172.17.0.5:39212, err= 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38298") 2026/09/09 01:02:40 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58910->172.17.0.5:38298, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30555") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37938->172.17.0.5:30555, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39890") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44338->172.17.0.5:39890, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30159") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47030->172.17.0.5:30159, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30664") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37174->172.17.0.5:30664, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33187") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51860->172.17.0.5:33187, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31316") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59056->172.17.0.5:31316, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34332") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57898->172.17.0.5:34332, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34835") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:34472->172.17.0.5:34835, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38333") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33634->172.17.0.5:38333, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32956") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44280->172.17.0.5:32956, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38881") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57974->172.17.0.5:38881, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33754") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52046->172.17.0.5:33754, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37610") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59088->172.17.0.5:37610, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30646") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50802->172.17.0.5:30646, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39892") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41134->172.17.0.5:39892, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39778") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43420->172.17.0.5:39778, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39110") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35156->172.17.0.5:39110, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38852") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33948->172.17.0.5:38852, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33197") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:60002->172.17.0.5:33197, err= 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36511") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51980->172.17.0.5:36511, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31087") 2026/09/09 01:02:41 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42320->172.17.0.5:31087, err= 2026/09/09 01:02:42 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: Connecting to FTP server 2026/09/09 01:02:42 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:42 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41548->172.17.0.5:21, err= 2026/09/09 01:02:45 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35580") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50040->172.17.0.5:35580, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33021") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:38012->172.17.0.5:33021, 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/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36668") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:39046->172.17.0.5:36668, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36144") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56660->172.17.0.5:36144, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36190") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40406->172.17.0.5:36190, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33111") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47742->172.17.0.5:33111, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35142") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:46520->172.17.0.5:35142, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34549") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51744->172.17.0.5:34549, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33136") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56254->172.17.0.5:33136, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38390") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:49462->172.17.0.5:38390, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33325") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54634->172.17.0.5:33325, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30375") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:48884->172.17.0.5:30375, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31727") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41452->172.17.0.5:31727, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39350") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55988->172.17.0.5:39350, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39172") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57512->172.17.0.5:39172, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32759") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56774->172.17.0.5:32759, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37224") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50432->172.17.0.5:37224, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32865") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57250->172.17.0.5:32865, err= 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32784") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:38598->172.17.0.5:32784, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/09 01:02:45 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/09 01:02:45 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:02:45 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:45 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:45 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:45 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:45 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:02:45 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:45 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:45 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:45 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:45 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:41558->172.17.0.5:21, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32955") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:53366->172.17.0.5:32955, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36878") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36436->172.17.0.5:36878, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37057") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52898->172.17.0.5:37057, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38962") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52820->172.17.0.5:38962, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30024") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37536->172.17.0.5:30024, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30198") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43882->172.17.0.5:30198, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30186") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:34358->172.17.0.5:30186, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35149") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52162->172.17.0.5:35149, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39809") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40898->172.17.0.5:39809, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31124") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50106->172.17.0.5:31124, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34537") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:33100->172.17.0.5:34537, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34096") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47620->172.17.0.5:34096, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39539") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41312->172.17.0.5:39539, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35921") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35934->172.17.0.5:35921, err= 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38034") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52088->172.17.0.5:38034, 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/09 01:02:48 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henizof6nage/hello? sausage/êé" 2026/09/09 01:02:48 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:02:48 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:48 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:48 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:48 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:48 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:02:48 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:48 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:48 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:48 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: Connecting to FTP server 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:48 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:41572->172.17.0.5:21, err= 2026/09/09 01:02:51 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-henizof6nage/hello? sausage/êé" to be canonical "TestFTPPureftpd{Jr6oJ}:rclone-test-henizof6nage/hello? sausage/êé" 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:35282") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:38238->172.17.0.5:35282, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:36743") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:47668->172.17.0.5:36743, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: Connecting to FTP server 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:57336->172.17.0.5:21, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:32335") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:54112->172.17.0.5:32335, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:33094") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:36276->172.17.0.5:33094, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:33506") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:39814->172.17.0.5:33506, err= 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:30458") 2026/09/09 01:02:51 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:60816->172.17.0.5:30458, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:31761") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:33302->172.17.0.5:31761, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:35866") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:33896->172.17.0.5:35866, err= 2026/09/09 01:02:54 DEBUG : Waiting for deletions to finish 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:33050") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:52652->172.17.0.5:33050, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:39083") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:57418->172.17.0.5:39083, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:34737") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:59738->172.17.0.5:34737, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:35357") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:56702->172.17.0.5:35357, err= 2026/09/09 01:02:54 INFO : a/b/c/d/e.txt: Deleted 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:32190") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:57656->172.17.0.5:32190, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:36542") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:36644->172.17.0.5:36542, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:39386") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:47428->172.17.0.5:39386, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: dial("tcp","172.17.0.5:32680") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé: > dial: conn=172.17.0.1:58576->172.17.0.5:32680, err= 2026/09/09 01:02:54 DEBUG : removing 1 level 4 directories 2026/09/09 01:02:54 INFO : a/b/c/d: Removing directory 2026/09/09 01:02:54 DEBUG : removing 1 level 3 directories 2026/09/09 01:02:54 INFO : a/b/c: Removing directory 2026/09/09 01:02:54 DEBUG : removing 1 level 2 directories 2026/09/09 01:02:54 INFO : a/b: Removing directory 2026/09/09 01:02:54 DEBUG : removing 1 level 1 directories 2026/09/09 01:02:54 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35452") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53234->172.17.0.5:35452, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32123") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50542->172.17.0.5:32123, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33216") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58904->172.17.0.5:33216, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33573") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51490->172.17.0.5:33573, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33456") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42226->172.17.0.5:33456, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34787") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41130->172.17.0.5:34787, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: Connecting to FTP server 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37180") 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55318->172.17.0.5:37180, err= 2026/09/09 01:02:54 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:57344->172.17.0.5:21, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30264") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58066->172.17.0.5:30264, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36593") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:34830->172.17.0.5:36593, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32340") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44076->172.17.0.5:32340, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37724") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41380->172.17.0.5:37724, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30285") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:48236->172.17.0.5:30285, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39250") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35193") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54354->172.17.0.5:39250, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53128->172.17.0.5:35193, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30706") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35270->172.17.0.5:30706, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35889") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52484->172.17.0.5:35889, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35439") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44692->172.17.0.5:35439, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39071") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:49134->172.17.0.5:39071, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31282") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35648->172.17.0.5:31282, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34574") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36138->172.17.0.5:34574, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35356") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40680->172.17.0.5:35356, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31269") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:60612->172.17.0.5:31269, err= 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31724") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44600->172.17.0.5:31724, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/09 01:02:57 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cexejeg5tofe" 2026/09/09 01:02:57 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:02:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:57 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:02:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:02:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:02:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:02:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: Connecting to FTP server 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:21") 2026/09/09 01:02:57 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:57352->172.17.0.5:21, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34967") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44892->172.17.0.5:34967, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:38086") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:59238->172.17.0.5:38086, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:34738") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:36586->172.17.0.5:34738, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:37429") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:51226->172.17.0.5:37429, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:39430") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:34746->172.17.0.5:39430, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:35234") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:33332->172.17.0.5:35234, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:30322") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:36572->172.17.0.5:30322, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:34768") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:47728->172.17.0.5:34768, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35841") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43618->172.17.0.5:35841, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30961") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:48840->172.17.0.5:30961, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36824") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:34284->172.17.0.5:36824, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31228") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53156->172.17.0.5:31228, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39181") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35852->172.17.0.5:39181, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:33331") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:48338->172.17.0.5:33331, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:37509") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:57736->172.17.0.5:37509, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:38229") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:42328->172.17.0.5:38229, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: dial("tcp","172.17.0.5:32966") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: > dial: conn=172.17.0.1:43546->172.17.0.5:32966, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: Purge dir "new_name" 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-cexejeg5tofe: 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/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30151") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:59944->172.17.0.5:30151, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31869") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52028->172.17.0.5:31869, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34171") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37988->172.17.0.5:34171, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31491") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55562->172.17.0.5:31491, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34717") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:58158->172.17.0.5:34717, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35978") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47446->172.17.0.5:35978, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36057") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:37204->172.17.0.5:36057, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38256") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42978->172.17.0.5:38256, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32567") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:54474->172.17.0.5:32567, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38833") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43982->172.17.0.5:38833, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39403") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:41816->172.17.0.5:39403, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36121") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47718->172.17.0.5:36121, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39106") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42952->172.17.0.5:39106, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33639") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53556->172.17.0.5:33639, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32717") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47730->172.17.0.5:32717, err= 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:34048") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:40098->172.17.0.5:34048, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/09 01:03:00 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/09 01:03:00 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:03:00 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:00 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:00 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:00 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:03:00 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:00 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:00 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:21") 2026/09/09 01:03:00 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:57358->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/09 01:03:03 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:31700") 2026/09/09 01:03:03 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60326->172.17.0.5:31700, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/09 01:03:03 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henizof6nage/not found.txt" 2026/09/09 01:03:03 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:03:03 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:03 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:03 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:03 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:03 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:03:03 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:03 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:03 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:03 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:03 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/not found.txt: Connecting to FTP server 2026/09/09 01:03:03 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/not found.txt: dial("tcp","172.17.0.5:21") 2026/09/09 01:03:03 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/not found.txt: > dial: conn=172.17.0.1:35444->172.17.0.5:21, err= 2026/09/09 01:03:06 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/not found.txt: dial("tcp","172.17.0.5:36713") 2026/09/09 01:03:06 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/not found.txt: > dial: conn=172.17.0.1:57674->172.17.0.5:36713, err= 2026/09/09 01:03:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPPureftpd:" path "rclone-test-henizof6nage" from "TestFTPPureftpd:rclone-test-henizof6nage" 2026/09/09 01:03:06 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/09 01:03:06 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:03:06 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:06 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:06 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:03:06 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:06 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:06 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:06 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/09/09 01:03:06 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/09/09 01:03:06 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:35448->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32894") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39858->172.17.0.5:32894, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:36384") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:33994->172.17.0.5:36384, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32471") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:48478->172.17.0.5:32471, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:30934") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:46312->172.17.0.5:30934, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:38779") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:44804->172.17.0.5:38779, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:34285") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:59456->172.17.0.5:34285, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:37877") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:42742->172.17.0.5:37877, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:31134") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45760->172.17.0.5:31134, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32321") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39474->172.17.0.5:32321, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:36800") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:37422->172.17.0.5:36800, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:30074") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:43438->172.17.0.5:30074, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:38176") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:54494->172.17.0.5:38176, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:35962") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:44076->172.17.0.5:35962, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:31942") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:60538->172.17.0.5:31942, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:35040") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:51312->172.17.0.5:35040, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:38621") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:55654->172.17.0.5:38621, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:36179") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:57902->172.17.0.5:36179, 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/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38441") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:45564->172.17.0.5:38441, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36248") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52190->172.17.0.5:36248, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38505") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44020->172.17.0.5:38505, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36198") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44434->172.17.0.5:36198, err= 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30372") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:50038->172.17.0.5:30372, 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/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31734") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47284->172.17.0.5:31734, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31869") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47320->172.17.0.5:31869, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/09 01:03:08 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-henizof6nage" 2026/09/09 01:03:08 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:03:08 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:08 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:08 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:08 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:08 DEBUG : TestFTPPureftpd: detected overridden config - adding "{uGsLd}" suffix to name 2026/09/09 01:03:08 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:08 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:08 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:08 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: Connecting to FTP server 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:21") 2026/09/09 01:03:08 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:35464->172.17.0.5:21, err= 2026/09/09 01:03:11 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32484") 2026/09/09 01:03:11 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47332->172.17.0.5:32484, 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/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38809") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:43168->172.17.0.5:38809, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39378") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:46786->172.17.0.5:39378, 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/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33267") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53082->172.17.0.5:33267, 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/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38750") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:56002->172.17.0.5:38750, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33716") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44044->172.17.0.5:33716, err= 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36507") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52158->172.17.0.5:36507, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/09 01:03:12 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-henizof6nage/deeper/nonexisting/directory" 2026/09/09 01:03:12 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/09 01:03:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:12 DEBUG : TestFTPPureftpd: detected overridden config - adding "{Jr6oJ}" suffix to name 2026/09/09 01:03:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/09 01:03:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/09 01:03:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/09 01:03:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/deeper/nonexisting/directory: Connecting to FTP server 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/deeper/nonexisting/directory: dial("tcp","172.17.0.5:21") 2026/09/09 01:03:12 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage/deeper/nonexisting/directory: > dial: conn=172.17.0.1:35320->172.17.0.5: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/09 01:03:15 DEBUG : Waiting for deletions to finish 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39958") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:39122->172.17.0.5:39958, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32409") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:52414->172.17.0.5:32409, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30156") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:38364->172.17.0.5:30156, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:37610") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:53490->172.17.0.5:37610, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:36740") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36848->172.17.0.5:36740, err= 2026/09/09 01:03:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:30100") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36824->172.17.0.5:30100, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:35333") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51824->172.17.0.5:35333, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:32551") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:55834->172.17.0.5:32551, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:39490") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:44062->172.17.0.5:39490, err= 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:38274") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:47186->172.17.0.5:38274, err= 2026/09/09 01:03:15 DEBUG : removing 1 level 4 directories 2026/09/09 01:03:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/09 01:03:15 DEBUG : removing 1 level 3 directories 2026/09/09 01:03:15 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/09 01:03:15 DEBUG : removing 1 level 2 directories 2026/09/09 01:03:15 INFO : hello? sausage/êé: Removing directory 2026/09/09 01:03:15 DEBUG : removing 1 level 1 directories 2026/09/09 01:03:15 INFO : hello? sausage: Removing directory 2026/09/09 01:03:15 DEBUG : removing 1 level 0 directories 2026/09/09 01:03:15 INFO : ftp://172.17.0.5:21/rclone-test-henizof6nage: Removing directory 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31719") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:51016->172.17.0.5:31719, err= 2026/09/09 01:03:15 ERROR : error listing: directory not found 2026/09/09 01:03:15 DEBUG : Waiting for deletions to finish 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:33913") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:36082->172.17.0.5:33913, err= 2026/09/09 01:03:15 ERROR : error listing: directory not found 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: dial("tcp","172.17.0.5:31243") 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: > dial: conn=172.17.0.1:42846->172.17.0.5:31243, err= 2026/09/09 01:03:15 ERROR : ftp://172.17.0.5:21/rclone-test-henizof6nage: Failed to list "": directory not found 2026/09/09 01:03:15 DEBUG : removing 1 level 0 directories 2026/09/09 01:03:15 INFO : ftp://172.17.0.5:21/rclone-test-henizof6nage: Removing directory 2026/09/09 01:03:15 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/09 01:03:15 DEBUG : ftp://172.17.0.5:21/rclone-test-henizof6nage: closing 2 unused connections 2026/09/09 01:03:15 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (38.87s) --- 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 (34.57s) --- 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.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.00s) --- 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.62s) --- 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 (26.74s) --- 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.75s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (6.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (3.15s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (3.17s) --- 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.07s) --- 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 (2.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (2.35s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (3.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (3.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.06s) --- 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 38.894s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 40.425925441s (try 1/5)