"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/07/16 02:21:05 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nikixug9qaqu" 2025/07/16 02:21:05 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/16 02:21:05 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:05 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:05 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:05 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:05 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:05 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Connecting to FTP server 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:47514->172.17.0.4:21, err= 2025/07/16 02:21:05 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/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38395") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38864->172.17.0.4:38395, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30647") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56632->172.17.0.4:30647, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/16 02:21:05 INFO : dir/subdir: Making directory 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35073") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:35724->172.17.0.4:35073, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33292") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42804->172.17.0.4:33292, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32347") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:49354->172.17.0.4:32347, err= 2025/07/16 02:21:05 INFO : dir/subdir: Removing directory 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30990") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:60936->172.17.0.4:30990, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37920") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33624->172.17.0.4:37920, err= 2025/07/16 02:21:05 INFO : dir: Removing directory 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37230") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44700->172.17.0.4:37230, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36110") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58986->172.17.0.4:36110, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32212") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38668->172.17.0.4:32212, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33335") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57602->172.17.0.4:33335, err= 2025/07/16 02:21:05 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/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38917") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46344->172.17.0.4:38917, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39244") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:47202->172.17.0.4:39244, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31536") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43228->172.17.0.4:31536, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38806") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44088->172.17.0.4:38806, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31594") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55356->172.17.0.4:31594, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39405") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:41092->172.17.0.4:39405, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32833") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50612->172.17.0.4:32833, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30383") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59760->172.17.0.4:30383, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38942") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58544->172.17.0.4:38942, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33308") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33592->172.17.0.4:33308, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33643") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:52416->172.17.0.4:33643, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33873") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58362->172.17.0.4:33873, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37969") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44908->172.17.0.4:37969, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35895") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56958->172.17.0.4:35895, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39420") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40858->172.17.0.4:39420, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32749") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46926->172.17.0.4:32749, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33884") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40068->172.17.0.4:33884, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36730") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34774->172.17.0.4:36730, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33870") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:32798->172.17.0.4:33870, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33608") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43976->172.17.0.4:33608, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37799") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42176->172.17.0.4:37799, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33761") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55492->172.17.0.4:33761, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39735") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50360->172.17.0.4:39735, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34686") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56912->172.17.0.4:34686, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33690") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48702->172.17.0.4:33690, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35334") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59456->172.17.0.4:35334, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36359") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:45208->172.17.0.4:36359, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39602") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51048->172.17.0.4:39602, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31273") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48936->172.17.0.4:31273, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34518") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42940->172.17.0.4:34518, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34615") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33450->172.17.0.4:34615, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39892") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:60886->172.17.0.4:39892, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36837") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48598->172.17.0.4:36837, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31178") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57242->172.17.0.4:31178, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38375") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43254->172.17.0.4:38375, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30895") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50594->172.17.0.4:30895, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32254") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38730->172.17.0.4:32254, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35794") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33702->172.17.0.4:35794, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35744") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58836->172.17.0.4:35744, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38723") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40964->172.17.0.4:38723, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34929") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56518->172.17.0.4:34929, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31422") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:35150->172.17.0.4:31422, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35416") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55016->172.17.0.4:35416, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36530") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:36986->172.17.0.4:36530, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34674") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40316->172.17.0.4:34674, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33209") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58712->172.17.0.4:33209, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33342") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57624->172.17.0.4:33342, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30752") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38300->172.17.0.4:30752, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39024") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51832->172.17.0.4:39024, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36924") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38474->172.17.0.4:36924, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39590") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40046->172.17.0.4:39590, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32017") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58836->172.17.0.4:32017, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39260") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51288->172.17.0.4:39260, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36985") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34706->172.17.0.4:36985, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33753") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58552->172.17.0.4:33753, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39005") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:35532->172.17.0.4:39005, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32328") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44672->172.17.0.4:32328, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35466") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:49768->172.17.0.4:35466, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36786") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:52626->172.17.0.4:36786, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38619") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51996->172.17.0.4:38619, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32846") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:58406->172.17.0.4:32846, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39298") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56096->172.17.0.4:39298, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32964") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56996->172.17.0.4:32964, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35378") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34634->172.17.0.4:35378, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30202") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:36138->172.17.0.4:30202, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34812") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48230->172.17.0.4:34812, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33676") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51100->172.17.0.4:33676, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39107") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42298->172.17.0.4:39107, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39424") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:37368->172.17.0.4:39424, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37661") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44210->172.17.0.4:37661, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33208") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46262->172.17.0.4:33208, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30672") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46658->172.17.0.4:30672, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33533") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55244->172.17.0.4:33533, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38468") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:53928->172.17.0.4:38468, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31912") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33086->172.17.0.4:31912, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31197") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43870->172.17.0.4:31197, err= 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32701") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34560->172.17.0.4:32701, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31723") 2025/07/16 02:21:05 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56884->172.17.0.4:31723, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:47518->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39157") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56618->172.17.0.4:39157, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31359") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:52016->172.17.0.4:31359, 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/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37836") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56846->172.17.0.4:37836, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38512") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:45668->172.17.0.4:38512, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32062") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34916->172.17.0.4:32062, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32952") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56210->172.17.0.4:32952, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36704") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33898->172.17.0.4:36704, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35397") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50178->172.17.0.4:35397, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31991") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:37608->172.17.0.4:31991, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32487") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40182->172.17.0.4:32487, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31172") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43366->172.17.0.4:31172, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30031") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33274->172.17.0.4:30031, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32135") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:39948->172.17.0.4:32135, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33436") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42454->172.17.0.4:33436, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37730") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:60094->172.17.0.4:37730, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38492") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40180->172.17.0.4:38492, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39718") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57886->172.17.0.4:39718, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37442") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42910->172.17.0.4:37442, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39737") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54940->172.17.0.4:39737, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47520->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33806") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49634->172.17.0.4:33806, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37547") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:36996->172.17.0.4:37547, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38609") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51036->172.17.0.4:38609, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31007") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48974->172.17.0.4:31007, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32597") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57834->172.17.0.4:32597, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34891") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55058->172.17.0.4:34891, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38789") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40420->172.17.0.4:38789, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30495") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:36648->172.17.0.4:30495, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37794") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54058->172.17.0.4:37794, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38200") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33534->172.17.0.4:38200, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37025") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59120->172.17.0.4:37025, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38671") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:45502->172.17.0.4:38671, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36874") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33584->172.17.0.4:36874, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30497") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54082->172.17.0.4:30497, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33809") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42340->172.17.0.4:33809, 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/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nikixug9qaqu/hello? sausage/êé" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:47522->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-nikixug9qaqu/hello? sausage/êé" to be canonical "TestFTPPureftpd{4Ytj4}:rclone-test-nikixug9qaqu/hello? sausage/êé" 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:37458") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:43952->172.17.0.4:37458, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:38592") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:41544->172.17.0.4:38592, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:47524->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:34514") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:54544->172.17.0.4:34514, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:34401") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:53916->172.17.0.4:34401, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:35025") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:47702->172.17.0.4:35025, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:31785") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:57870->172.17.0.4:31785, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:35917") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:41488->172.17.0.4:35917, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:30567") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:39340->172.17.0.4:30567, err= 2025/07/16 02:21:06 DEBUG : Waiting for deletions to finish 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:35384") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:37388->172.17.0.4:35384, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:37243") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:54778->172.17.0.4:37243, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:38070") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:56522->172.17.0.4:38070, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:39555") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:38438->172.17.0.4:39555, err= 2025/07/16 02:21:06 INFO : a/b/c/d/e.txt: Deleted 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:37908") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:35086->172.17.0.4:37908, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:30950") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:48382->172.17.0.4:30950, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:30139") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:33540->172.17.0.4:30139, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: dial("tcp","172.17.0.4:35985") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé: > dial: conn=172.17.0.1:50840->172.17.0.4:35985, err= 2025/07/16 02:21:06 DEBUG : removing 1 level 4 directories 2025/07/16 02:21:06 INFO : a/b/c/d: Removing directory 2025/07/16 02:21:06 DEBUG : removing 1 level 3 directories 2025/07/16 02:21:06 INFO : a/b/c: Removing directory 2025/07/16 02:21:06 DEBUG : removing 1 level 2 directories 2025/07/16 02:21:06 INFO : a/b: Removing directory 2025/07/16 02:21:06 DEBUG : removing 1 level 1 directories 2025/07/16 02:21:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31932") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:45078->172.17.0.4:31932, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39514") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43666->172.17.0.4:39514, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35320") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44654->172.17.0.4:35320, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38849") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:45108->172.17.0.4:38849, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32039") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59208->172.17.0.4:32039, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33115") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50480->172.17.0.4:33115, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:47530->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30394") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55418->172.17.0.4:30394, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35182") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54672->172.17.0.4:35182, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33382") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44028->172.17.0.4:33382, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30885") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50754->172.17.0.4:30885, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32168") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33198->172.17.0.4:32168, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36508") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56692->172.17.0.4:36508, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34937") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36514") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:49544->172.17.0.4:34937, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38148->172.17.0.4:36514, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38561") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46220->172.17.0.4:38561, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34921") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:53828->172.17.0.4:34921, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36707") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44374->172.17.0.4:36707, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34063") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38582->172.17.0.4:34063, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38843") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31117") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:49116->172.17.0.4:31117, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:39338->172.17.0.4:38843, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39307") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48982->172.17.0.4:39307, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38332") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43316->172.17.0.4:38332, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31992") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48368->172.17.0.4:31992, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nazejeh4suha" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:47540->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35417") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57318->172.17.0.4:35417, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:32337") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:55644->172.17.0.4:32337, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:38876") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:34572->172.17.0.4:38876, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:30205") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:37348->172.17.0.4:30205, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:32431") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:38344->172.17.0.4:32431, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:39900") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:56564->172.17.0.4:39900, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:33251") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:47824->172.17.0.4:33251, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:33331") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:59700->172.17.0.4:33331, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31426") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43916->172.17.0.4:31426, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37391") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:57110->172.17.0.4:37391, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30394") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:55422->172.17.0.4:30394, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38272") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42728->172.17.0.4:38272, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34559") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:60116->172.17.0.4:34559, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:39831") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:60866->172.17.0.4:39831, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:33060") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:51222->172.17.0.4:33060, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:39159") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:35872->172.17.0.4:39159, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: dial("tcp","172.17.0.4:36569") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: > dial: conn=172.17.0.1:47582->172.17.0.4:36569, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: Purge dir "new_name" 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nazejeh4suha: 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/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36623") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:40112->172.17.0.4:36623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34081") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:50818->172.17.0.4:34081, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35022") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34584->172.17.0.4:35022, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35770") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:37472->172.17.0.4:35770, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33773") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54674->172.17.0.4:33773, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39753") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44170->172.17.0.4:39753, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38175") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:41760->172.17.0.4:38175, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34900") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:60968->172.17.0.4:34900, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30688") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38684->172.17.0.4:30688, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47552->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:30647") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56644->172.17.0.4:30647, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nikixug9qaqu/not found.txt" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/not found.txt: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/not found.txt: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/not found.txt: > dial: conn=172.17.0.1:47568->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/not found.txt: dial("tcp","172.17.0.4:38546") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/not found.txt: > dial: conn=172.17.0.1:53796->172.17.0.4:38546, err= 2025/07/16 02:21:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-nikixug9qaqu" from "TestFTPPureftpd:rclone-test-nikixug9qaqu" 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47580->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30852") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37718->172.17.0.4:30852, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31721") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40380->172.17.0.4:31721, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37111") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50104->172.17.0.4:37111, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32067") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55656->172.17.0.4:32067, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38468") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53934->172.17.0.4:38468, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38378") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52526->172.17.0.4:38378, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32865") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60738->172.17.0.4:32865, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30675") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57966->172.17.0.4:30675, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38535") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40776->172.17.0.4:38535, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38695") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56276->172.17.0.4:38695, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31431") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56622->172.17.0.4:31431, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31313") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59800->172.17.0.4:31313, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35681") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42190->172.17.0.4:35681, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39409") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43042->172.17.0.4:39409, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38834") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41246->172.17.0.4:38834, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31329") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54976->172.17.0.4:31329, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32627") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38996->172.17.0.4:32627, 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/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31273") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48950->172.17.0.4:31273, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36357") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:53062->172.17.0.4:36357, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36846") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51964->172.17.0.4:36846, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30331") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:32808->172.17.0.4:30331, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30622") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:33354->172.17.0.4:30622, 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/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39186") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51400->172.17.0.4:39186, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30924") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:49346->172.17.0.4:30924, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/07/16 02:21:06 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-nikixug9qaqu" 2025/07/16 02:21:06 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b5EP_}" suffix to name 2025/07/16 02:21:06 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:06 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:06 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Connecting to FTP server 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:47586->172.17.0.4:21, err= 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37884") 2025/07/16 02:21:06 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:54510->172.17.0.4:37884, 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/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30595") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56666->172.17.0.4:30595, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:37319") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48292->172.17.0.4:37319, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:35683") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:39600->172.17.0.4:35683, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/16 02:21:07 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nikixug9qaqu/deeper/nonexisting/directory" 2025/07/16 02:21:07 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/16 02:21:07 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:07 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:07 DEBUG : TestFTPPureftpd: detected overridden config - adding "{4Ytj4}" suffix to name 2025/07/16 02:21:07 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/16 02:21:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/16 02:21:07 DEBUG : Setting pass="KNnvIlkpt_5OgE6b-tIN5FDrK3KtbmLfhIriZcX0JTk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/16 02:21:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/deeper/nonexisting/directory: Connecting to FTP server 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:47592->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/07/16 02:21:07 DEBUG : Waiting for deletions to finish 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34044") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:34180->172.17.0.4:34044, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38259") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59544->172.17.0.4:38259, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:30365") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:44066->172.17.0.4:30365, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36426") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:38950->172.17.0.4:36426, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38658") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:52014->172.17.0.4:38658, err= 2025/07/16 02:21:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34223") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:42440->172.17.0.4:34223, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:32706") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48784->172.17.0.4:32706, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:33730") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:51220->172.17.0.4:33730, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:34371") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:43914->172.17.0.4:34371, err= 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:39523") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:59984->172.17.0.4:39523, err= 2025/07/16 02:21:07 DEBUG : removing 1 level 4 directories 2025/07/16 02:21:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/07/16 02:21:07 DEBUG : removing 1 level 3 directories 2025/07/16 02:21:07 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/07/16 02:21:07 DEBUG : removing 1 level 2 directories 2025/07/16 02:21:07 INFO : hello? sausage/êé: Removing directory 2025/07/16 02:21:07 DEBUG : removing 1 level 1 directories 2025/07/16 02:21:07 INFO : hello? sausage: Removing directory 2025/07/16 02:21:07 DEBUG : removing 1 level 0 directories 2025/07/16 02:21:07 INFO : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Removing directory 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:38265") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:46686->172.17.0.4:38265, err= 2025/07/16 02:21:07 ERROR : error listing: directory not found 2025/07/16 02:21:07 DEBUG : Waiting for deletions to finish 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:36480") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:48924->172.17.0.4:36480, err= 2025/07/16 02:21:07 ERROR : error listing: directory not found 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: dial("tcp","172.17.0.4:31409") 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: > dial: conn=172.17.0.1:56606->172.17.0.4:31409, err= 2025/07/16 02:21:07 ERROR : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Failed to list "": directory not found 2025/07/16 02:21:07 DEBUG : removing 1 level 0 directories 2025/07/16 02:21:07 INFO : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: Removing directory 2025/07/16 02:21:07 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/07/16 02:21:07 DEBUG : ftp://172.17.0.4:21/rclone-test-nikixug9qaqu: closing 2 unused connections --- PASS: TestIntegration (2.40s) --- 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.33s) --- 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.09s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- 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.14s) --- 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 (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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.05s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.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 (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.413s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.502327343s (try 1/5)