"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/07/12 04:15:53 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nitexum3luwo" 2025/07/12 04:15:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/12 04:15:53 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:53 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:53 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:53 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:53 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:53 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:53 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:53 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:53 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:53 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Connecting to FTP server 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48444->172.17.0.4:21, err= 2025/07/12 04:15:53 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/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30738") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51286->172.17.0.4:30738, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38963") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56260->172.17.0.4:38963, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/12 04:15:53 INFO : dir/subdir: Making directory 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39892") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48280->172.17.0.4:39892, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37375") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36388->172.17.0.4:37375, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31083") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54128->172.17.0.4:31083, err= 2025/07/12 04:15:53 INFO : dir/subdir: Removing directory 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38267") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37304->172.17.0.4:38267, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35296") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53690->172.17.0.4:35296, err= 2025/07/12 04:15:53 INFO : dir: Removing directory 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35548") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49250->172.17.0.4:35548, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30890") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:45842->172.17.0.4:30890, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34442") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56190->172.17.0.4:34442, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33201") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:60406->172.17.0.4:33201, err= 2025/07/12 04:15:53 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/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39044") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34178->172.17.0.4:39044, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39467") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59616->172.17.0.4:39467, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30806") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40528->172.17.0.4:30806, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37980") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54190->172.17.0.4:37980, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30681") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:50580->172.17.0.4:30681, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36616") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:57066->172.17.0.4:36616, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35747") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39474->172.17.0.4:35747, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33409") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38638->172.17.0.4:33409, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34623") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34602->172.17.0.4:34623, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39441") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49044->172.17.0.4:39441, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32488") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58898->172.17.0.4:32488, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35861") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38752->172.17.0.4:35861, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38231") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44892->172.17.0.4:38231, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33184") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55858->172.17.0.4:33184, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30298") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:32836->172.17.0.4:30298, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39637") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59946->172.17.0.4:39637, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33701") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36968->172.17.0.4:33701, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34481") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:32918->172.17.0.4:34481, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37247") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34522->172.17.0.4:37247, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33145") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35580->172.17.0.4:33145, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30321") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48976->172.17.0.4:30321, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37985") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59262->172.17.0.4:37985, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36450") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:47776->172.17.0.4:36450, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39391") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48444->172.17.0.4:39391, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35350") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51848->172.17.0.4:35350, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30998") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41212->172.17.0.4:30998, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34944") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:46522->172.17.0.4:34944, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37536") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42860->172.17.0.4:37536, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36306") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34660->172.17.0.4:36306, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31369") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58048->172.17.0.4:31369, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31442") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55294->172.17.0.4:31442, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37922") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42898->172.17.0.4:37922, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39207") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35032->172.17.0.4:39207, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36226") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35020->172.17.0.4:36226, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34057") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37022->172.17.0.4:34057, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30038") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37354->172.17.0.4:30038, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33116") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40790->172.17.0.4:33116, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37203") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41238->172.17.0.4:37203, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36973") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:45086->172.17.0.4:36973, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31478") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44386->172.17.0.4:31478, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31641") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56314->172.17.0.4:31641, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39355") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56494->172.17.0.4:39355, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35901") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41592->172.17.0.4:35901, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35533") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54092->172.17.0.4:35533, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33689") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59298->172.17.0.4:33689, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38858") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:45104->172.17.0.4:38858, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37066") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48926->172.17.0.4:37066, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33682") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53224->172.17.0.4:33682, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31053") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34466->172.17.0.4:31053, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31576") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38916->172.17.0.4:31576, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37193") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:50954->172.17.0.4:37193, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34082") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:43100->172.17.0.4:34082, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30148") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49124->172.17.0.4:30148, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31527") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48922->172.17.0.4:31527, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35388") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59780->172.17.0.4:35388, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32061") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49022->172.17.0.4:32061, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33343") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34358->172.17.0.4:33343, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39132") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58380->172.17.0.4:39132, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35751") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41928->172.17.0.4:35751, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31654") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:52058->172.17.0.4:31654, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36024") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40196->172.17.0.4:36024, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38394") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36428->172.17.0.4:38394, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35047") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34580->172.17.0.4:35047, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32930") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39308->172.17.0.4:32930, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35092") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58740->172.17.0.4:35092, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39183") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:33258->172.17.0.4:39183, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32081") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44458->172.17.0.4:32081, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33322") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49432->172.17.0.4:33322, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32011") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36448->172.17.0.4:32011, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38103") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41934->172.17.0.4:38103, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30369") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41102->172.17.0.4:30369, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34732") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55950->172.17.0.4:34732, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34209") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42282->172.17.0.4:34209, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33546") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:52836->172.17.0.4:33546, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38821") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44562->172.17.0.4:38821, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37520") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:43318->172.17.0.4:37520, err= 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30581") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49502->172.17.0.4:30581, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35355") 2025/07/12 04:15:53 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59858->172.17.0.4:35355, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Connecting to FTP server 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34332->172.17.0.4:21, err= 2025/07/12 04:15:54 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36574") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55802->172.17.0.4:36574, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38903") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42496->172.17.0.4:38903, 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/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30132") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53388->172.17.0.4:30132, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39843") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:57248->172.17.0.4:39843, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35789") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55810->172.17.0.4:35789, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36368") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44066->172.17.0.4:36368, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38030") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40300->172.17.0.4:38030, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34570") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37342->172.17.0.4:34570, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37798") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38534->172.17.0.4:37798, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36121") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55302->172.17.0.4:36121, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37461") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55728->172.17.0.4:37461, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32254") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53456->172.17.0.4:32254, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39037") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51836->172.17.0.4:39037, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39641") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44156->172.17.0.4:39641, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38265") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51710->172.17.0.4:38265, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36258") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:33066->172.17.0.4:36258, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38067") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54128->172.17.0.4:38067, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35139") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40264->172.17.0.4:35139, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32901") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48256->172.17.0.4:32901, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/07/12 04:15:54 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/07/12 04:15:54 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:54 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:54 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:54 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:54 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:54 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:54 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:54 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34344->172.17.0.4:21, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33232") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34002->172.17.0.4:33232, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34835") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40738->172.17.0.4:34835, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37010") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36740->172.17.0.4:37010, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30408") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:59094->172.17.0.4:30408, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35958") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58628->172.17.0.4:35958, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30644") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:43112->172.17.0.4:30644, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36550") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:60544->172.17.0.4:36550, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30663") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35300->172.17.0.4:30663, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38740") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:45364->172.17.0.4:38740, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30682") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56286->172.17.0.4:30682, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38170") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:57454->172.17.0.4:38170, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37748") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:50786->172.17.0.4:37748, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38407") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:43390->172.17.0.4:38407, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33815") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39740->172.17.0.4:33815, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38626") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56600->172.17.0.4:38626, 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/12 04:15:54 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nitexum3luwo/hello? sausage/êé" 2025/07/12 04:15:54 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:54 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:54 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:54 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:54 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:54 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:54 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:54 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: Connecting to FTP server 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:34348->172.17.0.4:21, err= 2025/07/12 04:15:54 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-nitexum3luwo/hello? sausage/êé" to be canonical "TestFTPPureftpd{fuOXz}:rclone-test-nitexum3luwo/hello? sausage/êé" 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:35656") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:51448->172.17.0.4:35656, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:37705") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:42016->172.17.0.4:37705, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: Connecting to FTP server 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:36621") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:34358->172.17.0.4:21, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:43508->172.17.0.4:36621, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:33686") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:50840->172.17.0.4:33686, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:39749") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:59336->172.17.0.4:39749, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:39028") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:58672->172.17.0.4:39028, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:39818") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:58754->172.17.0.4:39818, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:35762") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:37882->172.17.0.4:35762, err= 2025/07/12 04:15:54 DEBUG : Waiting for deletions to finish 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:36836") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:53234->172.17.0.4:36836, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:37517") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:40582->172.17.0.4:37517, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:31669") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:38860->172.17.0.4:31669, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:38967") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:43522->172.17.0.4:38967, err= 2025/07/12 04:15:54 INFO : a/b/c/d/e.txt: Deleted 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:32652") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:48634->172.17.0.4:32652, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:30453") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:36668->172.17.0.4:30453, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:32093") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:41090->172.17.0.4:32093, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: dial("tcp","172.17.0.4:31866") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé: > dial: conn=172.17.0.1:49638->172.17.0.4:31866, err= 2025/07/12 04:15:54 DEBUG : removing 1 level 4 directories 2025/07/12 04:15:54 INFO : a/b/c/d: Removing directory 2025/07/12 04:15:54 DEBUG : removing 1 level 3 directories 2025/07/12 04:15:54 INFO : a/b/c: Removing directory 2025/07/12 04:15:54 DEBUG : removing 1 level 2 directories 2025/07/12 04:15:54 INFO : a/b: Removing directory 2025/07/12 04:15:54 DEBUG : removing 1 level 1 directories 2025/07/12 04:15:54 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38876") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39106->172.17.0.4:38876, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32672") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:46936->172.17.0.4:32672, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30334") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51130->172.17.0.4:30334, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33545") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37110->172.17.0.4:33545, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33834") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34262->172.17.0.4:33834, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30638") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53586->172.17.0.4:30638, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Connecting to FTP server 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35869") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34366->172.17.0.4:21, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40100->172.17.0.4:35869, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39708") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42466->172.17.0.4:39708, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31903") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53210->172.17.0.4:31903, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34631") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54690->172.17.0.4:34631, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38787") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38338->172.17.0.4:38787, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34659") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:33196->172.17.0.4:34659, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32225") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35067") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39448->172.17.0.4:32225, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58632->172.17.0.4:35067, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35469") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34632->172.17.0.4:35469, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33269") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:49200->172.17.0.4:33269, err= 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35309") 2025/07/12 04:15:54 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40996->172.17.0.4:35309, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37797") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:57958->172.17.0.4:37797, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37772") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36748") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48824->172.17.0.4:37772, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34954->172.17.0.4:36748, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31442") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:47500->172.17.0.4:31442, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30459") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54662->172.17.0.4:30459, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34770") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:52628->172.17.0.4:34770, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/07/12 04:15:55 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nuhokac2momi" 2025/07/12 04:15:55 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: Connecting to FTP server 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:34372->172.17.0.4:21, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36003") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38890->172.17.0.4:36003, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:33179") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:58660->172.17.0.4:33179, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:31093") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:54784->172.17.0.4:31093, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:32843") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:54676->172.17.0.4:32843, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:37851") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:44086->172.17.0.4:37851, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:35328") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:39016->172.17.0.4:35328, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:33853") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:51502->172.17.0.4:33853, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:34345") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:39456->172.17.0.4:34345, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36577") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:46924->172.17.0.4:36577, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34913") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38758->172.17.0.4:34913, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30208") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:58772->172.17.0.4:30208, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35601") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:55282->172.17.0.4:35601, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36964") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:53954->172.17.0.4:36964, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:38277") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:59070->172.17.0.4:38277, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:35659") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:44500->172.17.0.4:35659, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:35704") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:46448->172.17.0.4:35704, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: dial("tcp","172.17.0.4:31962") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: > dial: conn=172.17.0.1:34022->172.17.0.4:31962, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: Purge dir "new_name" 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nuhokac2momi: 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/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39922") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39006->172.17.0.4:39922, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33594") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39460->172.17.0.4:33594, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35204") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:41740->172.17.0.4:35204, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30807") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48552->172.17.0.4:30807, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31660") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:33268->172.17.0.4:31660, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33263") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:51432->172.17.0.4:33263, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30646") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35530->172.17.0.4:30646, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33150") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:50404->172.17.0.4:33150, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31817") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39560->172.17.0.4:31817, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/12 04:15:55 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/12 04:15:55 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:34388->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:33279") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52110->172.17.0.4:33279, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/12 04:15:55 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nitexum3luwo/not found.txt" 2025/07/12 04:15:55 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/not found.txt: Connecting to FTP server 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/not found.txt: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/not found.txt: > dial: conn=172.17.0.1:34396->172.17.0.4:21, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/not found.txt: dial("tcp","172.17.0.4:39538") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/not found.txt: > dial: conn=172.17.0.1:51986->172.17.0.4:39538, err= 2025/07/12 04:15:55 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-nitexum3luwo" from "TestFTPPureftpd:rclone-test-nitexum3luwo" 2025/07/12 04:15:55 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/07/12 04:15:55 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34408->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38788") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60314->172.17.0.4:38788, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33954") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44166->172.17.0.4:33954, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31297") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43238->172.17.0.4:31297, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30280") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50300->172.17.0.4:30280, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37037") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35044->172.17.0.4:37037, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32390") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58446->172.17.0.4:32390, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38824") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44162->172.17.0.4:38824, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35505") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58114->172.17.0.4:35505, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31598") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50970->172.17.0.4:31598, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30408") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59096->172.17.0.4:30408, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35037") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52084->172.17.0.4:35037, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30204") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60838->172.17.0.4:30204, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35827") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:45576->172.17.0.4:35827, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34022") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44898->172.17.0.4:34022, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34345") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39472->172.17.0.4:34345, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35839") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44648->172.17.0.4:35839, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34424") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34040->172.17.0.4:34424, 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/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:39738") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48046->172.17.0.4:39738, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38093") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56382->172.17.0.4:38093, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:36741") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:37650->172.17.0.4:36741, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37449") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39960->172.17.0.4:37449, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30106") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34016->172.17.0.4:30106, 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/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34591") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:47322->172.17.0.4:34591, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:31071") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39264->172.17.0.4:31071, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/07/12 04:15:55 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-nitexum3luwo" 2025/07/12 04:15:55 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : TestFTPPureftpd: detected overridden config - adding "{25Mx6}" suffix to name 2025/07/12 04:15:55 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:55 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:55 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:55 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Connecting to FTP server 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:34410->172.17.0.4:21, err= 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:37776") 2025/07/12 04:15:55 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:48098->172.17.0.4:37776, 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/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:38571") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39022->172.17.0.4:38571, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30444") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:56384->172.17.0.4:30444, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34942") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:45452->172.17.0.4:34942, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/12 04:15:56 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nitexum3luwo/deeper/nonexisting/directory" 2025/07/12 04:15:56 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/07/12 04:15:56 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:56 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:56 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:56 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:56 DEBUG : TestFTPPureftpd: detected overridden config - adding "{fuOXz}" suffix to name 2025/07/12 04:15:56 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/07/12 04:15:56 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/07/12 04:15:56 DEBUG : Setting pass="9aWcqSvgwA_sYu8DnjUVoSXntWqrFmHUEigGlMz7MQk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/07/12 04:15:56 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/deeper/nonexisting/directory: Connecting to FTP server 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:34420->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/12 04:15:56 DEBUG : Waiting for deletions to finish 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30876") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:44550->172.17.0.4:30876, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34445") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:42208->172.17.0.4:34445, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32076") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:33356->172.17.0.4:32076, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35383") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36482->172.17.0.4:35383, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:34427") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35592->172.17.0.4:34427, err= 2025/07/12 04:15:56 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30799") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35422->172.17.0.4:30799, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33160") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:38880->172.17.0.4:33160, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30647") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39386->172.17.0.4:30647, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33095") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:54230->172.17.0.4:33095, err= 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:35178") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:36224->172.17.0.4:35178, err= 2025/07/12 04:15:56 DEBUG : removing 1 level 4 directories 2025/07/12 04:15:56 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/07/12 04:15:56 DEBUG : removing 1 level 3 directories 2025/07/12 04:15:56 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/07/12 04:15:56 DEBUG : removing 1 level 2 directories 2025/07/12 04:15:56 INFO : hello? sausage/êé: Removing directory 2025/07/12 04:15:56 DEBUG : removing 1 level 1 directories 2025/07/12 04:15:56 INFO : hello? sausage: Removing directory 2025/07/12 04:15:56 DEBUG : removing 1 level 0 directories 2025/07/12 04:15:56 INFO : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Removing directory 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:30824") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:40180->172.17.0.4:30824, err= 2025/07/12 04:15:56 ERROR : error listing: directory not found 2025/07/12 04:15:56 DEBUG : Waiting for deletions to finish 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:33604") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:35274->172.17.0.4:33604, err= 2025/07/12 04:15:56 ERROR : error listing: directory not found 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: dial("tcp","172.17.0.4:32510") 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: > dial: conn=172.17.0.1:39146->172.17.0.4:32510, err= 2025/07/12 04:15:56 ERROR : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Failed to list "": directory not found 2025/07/12 04:15:56 DEBUG : removing 1 level 0 directories 2025/07/12 04:15:56 INFO : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: Removing directory 2025/07/12 04:15:56 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/07/12 04:15:56 DEBUG : ftp://172.17.0.4:21/rclone-test-nitexum3luwo: closing 2 unused connections --- PASS: TestIntegration (2.58s) --- 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.52s) --- 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.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.28s) --- 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.03s) --- 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.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.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.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.80s) --- 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.604s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.44587675s (try 1/5)