"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/09/18 01:35:37 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-pegodib6lufi" 2025/09/18 01:35:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/18 01:35:37 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:37 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:37 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:37 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:37 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:37 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:37 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:37 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:37 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:37 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Connecting to FTP server 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58854->172.17.0.4:21, err= 2025/09/18 01:35:37 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31081") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58378->172.17.0.4:31081, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39766") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59074->172.17.0.4:39766, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/18 01:35:37 INFO : dir/subdir: Making directory 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30932") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35910->172.17.0.4:30932, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30763") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:44778->172.17.0.4:30763, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36821") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49310->172.17.0.4:36821, err= 2025/09/18 01:35:37 INFO : dir/subdir: Removing directory 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31282") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51600->172.17.0.4:31282, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36294") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45020->172.17.0.4:36294, err= 2025/09/18 01:35:37 INFO : dir: Removing directory 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39745") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41418->172.17.0.4:39745, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34643") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:53192->172.17.0.4:34643, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39659") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49878->172.17.0.4:39659, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34283") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35132->172.17.0.4:34283, err= 2025/09/18 01:35:37 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30658") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49256->172.17.0.4:30658, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31908") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36574->172.17.0.4:31908, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33759") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35330->172.17.0.4:33759, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37712") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:38796->172.17.0.4:37712, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34814") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58278->172.17.0.4:34814, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38651") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35052->172.17.0.4:38651, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33426") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:60446->172.17.0.4:33426, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36619") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45168->172.17.0.4:36619, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34405") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41582->172.17.0.4:34405, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36287") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:32938->172.17.0.4:36287, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35494") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48166->172.17.0.4:35494, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33454") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:44602->172.17.0.4:33454, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31988") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40618->172.17.0.4:31988, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39070") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47050->172.17.0.4:39070, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33382") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40184->172.17.0.4:33382, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35159") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47294->172.17.0.4:35159, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35031") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46848->172.17.0.4:35031, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31380") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57200->172.17.0.4:31380, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39133") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:42726->172.17.0.4:39133, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38245") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35198->172.17.0.4:38245, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31835") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:54144->172.17.0.4:31835, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35985") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49430->172.17.0.4:35985, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38011") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:42686->172.17.0.4:38011, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35060") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47466->172.17.0.4:35060, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39126") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47204->172.17.0.4:39126, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32030") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45114->172.17.0.4:32030, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33633") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34130->172.17.0.4:33633, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36766") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43048->172.17.0.4:36766, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33252") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43672->172.17.0.4:33252, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37736") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51728->172.17.0.4:37736, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34108") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41736->172.17.0.4:34108, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32878") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59072->172.17.0.4:32878, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33543") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:50792->172.17.0.4:33543, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31517") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36448->172.17.0.4:31517, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37095") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48000->172.17.0.4:37095, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34157") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39956->172.17.0.4:34157, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38792") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36486->172.17.0.4:38792, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30743") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52628->172.17.0.4:30743, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32395") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:53790->172.17.0.4:32395, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38206") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33232->172.17.0.4:38206, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36214") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:42134->172.17.0.4:36214, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30116") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41476->172.17.0.4:30116, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35446") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39394->172.17.0.4:35446, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34029") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46382->172.17.0.4:34029, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38880") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45058->172.17.0.4:38880, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34067") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40608->172.17.0.4:34067, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39561") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55424->172.17.0.4:39561, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37419") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46062->172.17.0.4:37419, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34076") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34660->172.17.0.4:34076, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33929") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:54052->172.17.0.4:33929, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36729") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51860->172.17.0.4:36729, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31290") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36124->172.17.0.4:31290, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30132") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33712->172.17.0.4:30132, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35943") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52730->172.17.0.4:35943, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39349") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:37804->172.17.0.4:39349, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34824") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36642->172.17.0.4:34824, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33838") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45022->172.17.0.4:33838, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30472") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:38844->172.17.0.4:30472, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33363") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58492->172.17.0.4:33363, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36158") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:60484->172.17.0.4:36158, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33084") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59702->172.17.0.4:33084, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32441") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48442->172.17.0.4:32441, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32660") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36244->172.17.0.4:32660, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37823") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55856->172.17.0.4:37823, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31502") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57600->172.17.0.4:31502, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34099") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40676->172.17.0.4:34099, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34313") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56262->172.17.0.4:34313, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37472") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48280->172.17.0.4:37472, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34551") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47406->172.17.0.4:34551, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32764") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55080->172.17.0.4:32764, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30818") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59308->172.17.0.4:30818, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34365") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59738->172.17.0.4:34365, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30435") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57622->172.17.0.4:30435, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31369") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52820->172.17.0.4:31369, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35722") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43564->172.17.0.4:35722, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35273") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:50830->172.17.0.4:35273, err= 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31911") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:37808->172.17.0.4:31911, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31943") 2025/09/18 01:35:37 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40992->172.17.0.4:31943, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58862->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34770") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39316->172.17.0.4:34770, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34513") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51034->172.17.0.4:34513, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31586") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34084->172.17.0.4:31586, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38765") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46560->172.17.0.4:38765, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30219") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:37006->172.17.0.4:30219, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36536") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39094->172.17.0.4:36536, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36027") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56976->172.17.0.4:36027, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31357") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55684->172.17.0.4:31357, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35089") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57148->172.17.0.4:35089, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33509") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58248->172.17.0.4:33509, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31345") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49588->172.17.0.4:31345, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30125") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:42610->172.17.0.4:30125, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32724") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34230->172.17.0.4:32724, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33559") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55558->172.17.0.4:33559, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39448") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49754->172.17.0.4:39448, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32379") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:44364->172.17.0.4:32379, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39464") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33216->172.17.0.4:39464, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39479") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52428->172.17.0.4:39479, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31623") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45436->172.17.0.4:31623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58872->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33557") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36732->172.17.0.4:33557, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32176") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43632->172.17.0.4:32176, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32441") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48450->172.17.0.4:32441, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30323") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52666->172.17.0.4:30323, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32322") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39736->172.17.0.4:32322, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33006") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49836->172.17.0.4:33006, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35574") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46610->172.17.0.4:35574, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32273") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56570->172.17.0.4:32273, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30080") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51028->172.17.0.4:30080, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30809") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33142->172.17.0.4:30809, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37879") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58178->172.17.0.4:37879, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30393") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:60926->172.17.0.4:30393, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39548") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:49672->172.17.0.4:39548, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38736") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35038->172.17.0.4:38736, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32905") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:38438->172.17.0.4:32905, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-pegodib6lufi/hello? sausage/êé" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:58886->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-pegodib6lufi/hello? sausage/êé" to be canonical "TestFTPPureftpd{ubQ9f}:rclone-test-pegodib6lufi/hello? sausage/êé" 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:37001") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:44422->172.17.0.4:37001, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:35255") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:56468->172.17.0.4:35255, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:31992") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:58890->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:45020->172.17.0.4:31992, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:36627") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:52850->172.17.0.4:36627, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:37998") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:38620->172.17.0.4:37998, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:34082") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:35708->172.17.0.4:34082, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:39462") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:37292->172.17.0.4:39462, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:30700") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:44130->172.17.0.4:30700, err= 2025/09/18 01:35:38 DEBUG : Waiting for deletions to finish 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:35441") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:43066->172.17.0.4:35441, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:36935") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:45296->172.17.0.4:36935, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:32709") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:59206->172.17.0.4:32709, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:33771") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:49130->172.17.0.4:33771, err= 2025/09/18 01:35:38 INFO : a/b/c/d/e.txt: Deleted 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:31725") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:56278->172.17.0.4:31725, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:33738") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:53576->172.17.0.4:33738, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:31981") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:59848->172.17.0.4:31981, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: dial("tcp","172.17.0.4:32383") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé: > dial: conn=172.17.0.1:36214->172.17.0.4:32383, err= 2025/09/18 01:35:38 DEBUG : removing 1 level 4 directories 2025/09/18 01:35:38 INFO : a/b/c/d: Removing directory 2025/09/18 01:35:38 DEBUG : removing 1 level 3 directories 2025/09/18 01:35:38 INFO : a/b/c: Removing directory 2025/09/18 01:35:38 DEBUG : removing 1 level 2 directories 2025/09/18 01:35:38 INFO : a/b: Removing directory 2025/09/18 01:35:38 DEBUG : removing 1 level 1 directories 2025/09/18 01:35:38 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39931") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40728->172.17.0.4:39931, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39406") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56202->172.17.0.4:39406, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31380") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57206->172.17.0.4:31380, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33903") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:32824->172.17.0.4:33903, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31980") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:37382->172.17.0.4:31980, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30198") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36910->172.17.0.4:30198, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37286") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58900->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:53554->172.17.0.4:37286, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35347") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:47286->172.17.0.4:35347, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35151") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:53934->172.17.0.4:35151, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30487") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:44622->172.17.0.4:30487, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34778") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40118->172.17.0.4:34778, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32246") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59514->172.17.0.4:32246, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32992") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46118->172.17.0.4:32992, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32071") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45112->172.17.0.4:32071, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32890") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57020->172.17.0.4:32890, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30417") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40688->172.17.0.4:30417, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37762") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:54176->172.17.0.4:37762, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37915") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43368->172.17.0.4:37915, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39028") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36464") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:39232->172.17.0.4:39028, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:37022->172.17.0.4:36464, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38207") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:36390->172.17.0.4:38207, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37917") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:54746->172.17.0.4:37917, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38596") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46576->172.17.0.4:38596, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-purenuy6zawe" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:58912->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36766") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43052->172.17.0.4:36766, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:37537") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:47624->172.17.0.4:37537, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:34910") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:37234->172.17.0.4:34910, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:38212") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:34736->172.17.0.4:38212, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:35768") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:43746->172.17.0.4:35768, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:30313") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:57380->172.17.0.4:30313, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:36904") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:46418->172.17.0.4:36904, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:38145") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:42064->172.17.0.4:38145, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30599") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:43982->172.17.0.4:30599, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35204") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41946->172.17.0.4:35204, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:37892") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55384->172.17.0.4:37892, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:39938") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48478->172.17.0.4:39938, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38704") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48084->172.17.0.4:38704, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:32537") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:45296->172.17.0.4:32537, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:33338") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:57374->172.17.0.4:33338, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:39419") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:59894->172.17.0.4:39419, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: dial("tcp","172.17.0.4:38378") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: > dial: conn=172.17.0.1:36538->172.17.0.4:38378, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: Purge dir "new_name" 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-purenuy6zawe: 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:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32727") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55054->172.17.0.4:32727, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30928") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:50174->172.17.0.4:30928, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30586") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55120->172.17.0.4:30586, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32517") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34348->172.17.0.4:32517, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33992") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52774->172.17.0.4:33992, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30086") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51138->172.17.0.4:30086, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30650") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:53280->172.17.0.4:30650, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32793") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45996->172.17.0.4:32793, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32043") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:32912->172.17.0.4:32043, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:58914->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:33682") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56784->172.17.0.4:33682, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-pegodib6lufi/not found.txt" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/not found.txt: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/not found.txt: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/not found.txt: > dial: conn=172.17.0.1:58930->172.17.0.4:21, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/not found.txt: dial("tcp","172.17.0.4:39353") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/not found.txt: > dial: conn=172.17.0.1:45640->172.17.0.4:39353, err= 2025/09/18 01:35:38 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-pegodib6lufi" from "TestFTPPureftpd:rclone-test-pegodib6lufi" 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58940->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36888") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56592->172.17.0.4:36888, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32226") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37690->172.17.0.4:32226, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33132") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54262->172.17.0.4:33132, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31648") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55164->172.17.0.4:31648, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30448") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59240->172.17.0.4:30448, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39361") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60984->172.17.0.4:39361, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34092") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39384->172.17.0.4:34092, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39835") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56924->172.17.0.4:39835, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35710") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39440->172.17.0.4:35710, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37485") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56726->172.17.0.4:37485, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39166") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34804->172.17.0.4:39166, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37056") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47482->172.17.0.4:37056, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39613") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58500->172.17.0.4:39613, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39749") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56004->172.17.0.4:39749, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32174") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:45346->172.17.0.4:32174, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36108") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50122->172.17.0.4:36108, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34893") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46822->172.17.0.4:34893, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33684") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:44738->172.17.0.4:33684, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35219") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:35028->172.17.0.4:35219, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32994") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33938->172.17.0.4:32994, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32394") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56598->172.17.0.4:32394, err= 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33000") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52780->172.17.0.4:33000, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35727") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:52010->172.17.0.4:35727, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36802") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:46978->172.17.0.4:36802, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/18 01:35:38 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-pegodib6lufi" 2025/09/18 01:35:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{9oUaq}" suffix to name 2025/09/18 01:35:38 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:38 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Connecting to FTP server 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:38 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58950->172.17.0.4:21, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36671") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58246->172.17.0.4:36671, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:31289") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:32890->172.17.0.4:31289, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34654") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:55308->172.17.0.4:34654, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33435") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:40156->172.17.0.4:33435, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/18 01:35:39 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-pegodib6lufi/deeper/nonexisting/directory" 2025/09/18 01:35:39 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/18 01:35:39 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:39 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:39 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:39 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:39 DEBUG : TestFTPPureftpd: detected overridden config - adding "{ubQ9f}" suffix to name 2025/09/18 01:35:39 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/18 01:35:39 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/18 01:35:39 DEBUG : Setting pass="uJ9Kck8rkrEtrcyEI4xuTYpi4P4Cx9jfx1iRTtA2PN4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/18 01:35:39 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/deeper/nonexisting/directory: Connecting to FTP server 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:58960->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/09/18 01:35:39 DEBUG : Waiting for deletions to finish 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30713") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34350->172.17.0.4:30713, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:38326") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:59664->172.17.0.4:38326, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34717") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51510->172.17.0.4:34717, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30569") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:34672->172.17.0.4:30569, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30378") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:57948->172.17.0.4:30378, err= 2025/09/18 01:35:39 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35245") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:56002->172.17.0.4:35245, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:33727") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:41018->172.17.0.4:33727, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:32784") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:48470->172.17.0.4:32784, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:36626") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33124->172.17.0.4:36626, err= 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:35695") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:51454->172.17.0.4:35695, err= 2025/09/18 01:35:39 DEBUG : removing 1 level 4 directories 2025/09/18 01:35:39 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/18 01:35:39 DEBUG : removing 1 level 3 directories 2025/09/18 01:35:39 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/18 01:35:39 DEBUG : removing 1 level 2 directories 2025/09/18 01:35:39 INFO : hello? sausage/êé: Removing directory 2025/09/18 01:35:39 DEBUG : removing 1 level 1 directories 2025/09/18 01:35:39 INFO : hello? sausage: Removing directory 2025/09/18 01:35:39 DEBUG : removing 1 level 0 directories 2025/09/18 01:35:39 INFO : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Removing directory 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30747") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:45196->172.17.0.4:30747, err= 2025/09/18 01:35:39 ERROR : error listing: directory not found 2025/09/18 01:35:39 DEBUG : Waiting for deletions to finish 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:30301") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:58578->172.17.0.4:30301, err= 2025/09/18 01:35:39 ERROR : error listing: directory not found 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: dial("tcp","172.17.0.4:34879") 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: > dial: conn=172.17.0.1:33492->172.17.0.4:34879, err= 2025/09/18 01:35:39 ERROR : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Failed to list "": directory not found 2025/09/18 01:35:39 DEBUG : removing 1 level 0 directories 2025/09/18 01:35:39 INFO : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: Removing directory 2025/09/18 01:35:39 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/18 01:35:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pegodib6lufi: closing 2 unused connections --- PASS: TestIntegration (2.50s) --- 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 (2.44s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- 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 (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (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 (0.02s) --- 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 2.517s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.381065104s (try 1/5)