"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/09/09 05:02:32 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zihohoq6vagi" 2025/09/09 05:02:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/09 05:02:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:32 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:32 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Connecting to FTP server 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45296->172.17.0.3:21, err= 2025/09/09 05:02:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37491") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:55100->172.17.0.3:37491, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32662") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40364->172.17.0.3:32662, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/09 05:02:32 INFO : dir/subdir: Making directory 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37986") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38306->172.17.0.3:37986, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35624") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:42022->172.17.0.3:35624, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31258") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60524->172.17.0.3:31258, err= 2025/09/09 05:02:32 INFO : dir/subdir: Removing directory 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30354") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:46896->172.17.0.3:30354, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37119") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44364->172.17.0.3:37119, err= 2025/09/09 05:02:32 INFO : dir: Removing directory 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37114") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35804->172.17.0.3:37114, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35474") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:46382->172.17.0.3:35474, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32628") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:53738->172.17.0.3:32628, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30375") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59474->172.17.0.3:30375, err= 2025/09/09 05:02:32 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31912") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40432->172.17.0.3:31912, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36844") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51660->172.17.0.3:36844, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33646") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52978->172.17.0.3:33646, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38637") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:54424->172.17.0.3:38637, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33541") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:55582->172.17.0.3:33541, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35789") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45064->172.17.0.3:35789, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35122") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35366->172.17.0.3:35122, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31471") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60232->172.17.0.3:31471, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34847") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44370->172.17.0.3:34847, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39064") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52040->172.17.0.3:39064, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31861") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37190->172.17.0.3:31861, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38008") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:46100->172.17.0.3:38008, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37436") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:54752->172.17.0.3:37436, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31139") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:41060->172.17.0.3:31139, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30446") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:36604->172.17.0.3:30446, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34751") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60570->172.17.0.3:34751, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35932") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50608->172.17.0.3:35932, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38436") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56736->172.17.0.3:38436, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37325") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60584->172.17.0.3:37325, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37086") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43176->172.17.0.3:37086, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32870") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60986->172.17.0.3:32870, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32295") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43300->172.17.0.3:32295, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38603") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:32788->172.17.0.3:38603, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38582") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56526->172.17.0.3:38582, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30197") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:46418->172.17.0.3:30197, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38136") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:46154->172.17.0.3:38136, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32032") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59334->172.17.0.3:32032, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38519") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:58326->172.17.0.3:38519, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38047") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:49286->172.17.0.3:38047, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32677") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40922->172.17.0.3:32677, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33255") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:41926->172.17.0.3:33255, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38267") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59274->172.17.0.3:38267, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38884") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33552->172.17.0.3:38884, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30229") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56392->172.17.0.3:30229, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37010") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34144->172.17.0.3:37010, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30478") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43588->172.17.0.3:30478, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37021") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:47644->172.17.0.3:37021, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31283") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37922->172.17.0.3:31283, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36655") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51378->172.17.0.3:36655, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33501") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:39622->172.17.0.3:33501, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30904") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:54810->172.17.0.3:30904, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39014") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35002->172.17.0.3:39014, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32317") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59528->172.17.0.3:32317, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34427") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44664->172.17.0.3:34427, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33302") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37580->172.17.0.3:33302, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36260") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43380->172.17.0.3:36260, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35853") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:58338->172.17.0.3:35853, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32200") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57298->172.17.0.3:32200, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34120") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50934->172.17.0.3:34120, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33815") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57266->172.17.0.3:33815, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33564") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57210->172.17.0.3:33564, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39226") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38442->172.17.0.3:39226, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39630") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60984->172.17.0.3:39630, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38642") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59068->172.17.0.3:38642, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35470") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56338->172.17.0.3:35470, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38145") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43636->172.17.0.3:38145, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35367") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34774->172.17.0.3:35367, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36765") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34718->172.17.0.3:36765, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35896") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52400->172.17.0.3:35896, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35789") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45074->172.17.0.3:35789, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34491") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57344->172.17.0.3:34491, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37063") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:36592->172.17.0.3:37063, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35722") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37132->172.17.0.3:35722, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38574") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50920->172.17.0.3:38574, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38943") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48516->172.17.0.3:38943, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34737") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:39308->172.17.0.3:34737, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36407") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:55026->172.17.0.3:36407, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39111") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52892->172.17.0.3:39111, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30338") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56336->172.17.0.3:30338, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33143") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44030->172.17.0.3:33143, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31295") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51420->172.17.0.3:31295, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33166") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50600->172.17.0.3:33166, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38244") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38220->172.17.0.3:38244, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36988") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35138->172.17.0.3:36988, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34431") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56198->172.17.0.3:34431, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35899") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57868->172.17.0.3:35899, err= 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32232") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37078->172.17.0.3:32232, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39277") 2025/09/09 05:02:32 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48164->172.17.0.3:39277, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Connecting to FTP server 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45312->172.17.0.3:21, err= 2025/09/09 05:02:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38799") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38274->172.17.0.3:38799, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35610") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48014->172.17.0.3:35610, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35790") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33488->172.17.0.3:35790, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32663") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51770->172.17.0.3:32663, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31187") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:42184->172.17.0.3:31187, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39322") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33248->172.17.0.3:39322, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31782") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52080->172.17.0.3:31782, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32823") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59940->172.17.0.3:32823, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39437") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34218->172.17.0.3:39437, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37652") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:36964->172.17.0.3:37652, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37166") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35176->172.17.0.3:37166, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33127") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56360->172.17.0.3:33127, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33700") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35466->172.17.0.3:33700, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30689") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57716->172.17.0.3:30689, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39463") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57034->172.17.0.3:39463, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34949") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:49138->172.17.0.3:34949, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39495") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48510->172.17.0.3:39495, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37870") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56736->172.17.0.3:37870, err= 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37317") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:39824->172.17.0.3:37317, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/09 05:02:33 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/09 05:02:33 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:33 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:33 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:33 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:33 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:33 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:33 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45324->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39211") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60642->172.17.0.3:39211, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30426") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:49710->172.17.0.3:30426, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36375") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:42526->172.17.0.3:36375, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32611") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:42014->172.17.0.3:32611, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34010") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43694->172.17.0.3:34010, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32354") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33070->172.17.0.3:32354, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37704") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57188->172.17.0.3:37704, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37251") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33380->172.17.0.3:37251, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30030") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40956->172.17.0.3:30030, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30344") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38764->172.17.0.3:30344, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33331") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50690->172.17.0.3:33331, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30566") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34628->172.17.0.3:30566, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33986") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:54736->172.17.0.3:33986, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35247") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59392->172.17.0.3:35247, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39996") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:55686->172.17.0.3:39996, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zihohoq6vagi/hello? sausage/êé" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:45338->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-zihohoq6vagi/hello? sausage/êé" to be canonical "TestFTPPureftpd{gQ4mT}:rclone-test-zihohoq6vagi/hello? sausage/êé" 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:33858") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:56494->172.17.0.3:33858, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:35058") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:41648->172.17.0.3:35058, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:34255") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:37656->172.17.0.3:34255, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:45354->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:39226") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:38448->172.17.0.3:39226, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:36072") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:46272->172.17.0.3:36072, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:38441") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:59018->172.17.0.3:38441, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:34745") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:36042->172.17.0.3:34745, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:39228") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:54760->172.17.0.3:39228, err= 2025/09/09 05:02:34 DEBUG : Waiting for deletions to finish 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:33384") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:37924->172.17.0.3:33384, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:39449") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:44024->172.17.0.3:39449, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:34209") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:39496->172.17.0.3:34209, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:36393") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:57972->172.17.0.3:36393, err= 2025/09/09 05:02:34 INFO : a/b/c/d/e.txt: Deleted 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:32074") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:34626->172.17.0.3:32074, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:39770") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:46492->172.17.0.3:39770, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:30790") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:38426->172.17.0.3:30790, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: dial("tcp","172.17.0.3:35177") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé: > dial: conn=172.17.0.1:40606->172.17.0.3:35177, err= 2025/09/09 05:02:34 DEBUG : removing 1 level 4 directories 2025/09/09 05:02:34 INFO : a/b/c/d: Removing directory 2025/09/09 05:02:34 DEBUG : removing 1 level 3 directories 2025/09/09 05:02:34 INFO : a/b/c: Removing directory 2025/09/09 05:02:34 DEBUG : removing 1 level 2 directories 2025/09/09 05:02:34 INFO : a/b: Removing directory 2025/09/09 05:02:34 DEBUG : removing 1 level 1 directories 2025/09/09 05:02:34 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36239") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37420->172.17.0.3:36239, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36162") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38698->172.17.0.3:36162, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37119") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44370->172.17.0.3:37119, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34449") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43328->172.17.0.3:34449, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35310") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43736->172.17.0.3:35310, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34020") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45076->172.17.0.3:34020, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45360->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35184") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:59690->172.17.0.3:35184, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36047") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34174->172.17.0.3:36047, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32950") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33932->172.17.0.3:32950, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39374") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45860->172.17.0.3:39374, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38696") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48060->172.17.0.3:38696, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37267") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43484->172.17.0.3:37267, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36773") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:39676->172.17.0.3:36773, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35900") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33484->172.17.0.3:35900, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32393") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:44554->172.17.0.3:32393, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36988") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35152->172.17.0.3:36988, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38113") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51792->172.17.0.3:38113, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39781") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45894->172.17.0.3:39781, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36898") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:52148->172.17.0.3:36898, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31561") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:41428->172.17.0.3:31561, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30274") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50238->172.17.0.3:30274, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32090") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48044->172.17.0.3:32090, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33999") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40792->172.17.0.3:33999, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-bedehub2toyu" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:45372->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30338") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:56340->172.17.0.3:30338, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:34594") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:34708->172.17.0.3:34594, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:35610") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:48016->172.17.0.3:35610, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:35958") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:50060->172.17.0.3:35958, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:35069") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:51794->172.17.0.3:35069, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:36584") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:51580->172.17.0.3:36584, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:32986") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:43940->172.17.0.3:32986, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:34054") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:36226->172.17.0.3:34054, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35710") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:35280->172.17.0.3:35710, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30423") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48262->172.17.0.3:30423, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30298") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:40166->172.17.0.3:30298, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32344") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:41024->172.17.0.3:32344, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35193") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:42654->172.17.0.3:35193, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:31786") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:58158->172.17.0.3:31786, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:34972") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:57946->172.17.0.3:34972, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:31433") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:35648->172.17.0.3:31433, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: dial("tcp","172.17.0.3:35483") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: > dial: conn=172.17.0.1:52544->172.17.0.3:35483, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: Purge dir "new_name" 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-bedehub2toyu: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36348") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33054->172.17.0.3:36348, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37716") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57232->172.17.0.3:37716, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38272") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51786->172.17.0.3:38272, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35457") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38570->172.17.0.3:35457, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33248") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45604->172.17.0.3:33248, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31491") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51386->172.17.0.3:31491, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32238") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45060->172.17.0.3:32238, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37495") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37416->172.17.0.3:37495, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37030") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:47120->172.17.0.3:37030, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:45384->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:30209") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:43100->172.17.0.3:30209, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zihohoq6vagi/not found.txt" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/not found.txt: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/not found.txt: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/not found.txt: > dial: conn=172.17.0.1:45388->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/not found.txt: dial("tcp","172.17.0.3:34148") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/not found.txt: > dial: conn=172.17.0.1:33954->172.17.0.3:34148, err= 2025/09/09 05:02:34 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-zihohoq6vagi" from "TestFTPPureftpd:rclone-test-zihohoq6vagi" 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45402->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37102") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:32918->172.17.0.3:37102, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38492") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47296->172.17.0.3:38492, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33737") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54728->172.17.0.3:33737, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36221") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53660->172.17.0.3:36221, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37465") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46432->172.17.0.3:37465, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34638") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50922->172.17.0.3:34638, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37821") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60762->172.17.0.3:37821, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36540") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40452->172.17.0.3:36540, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33715") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56806->172.17.0.3:33715, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33822") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37122->172.17.0.3:33822, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36620") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59386->172.17.0.3:36620, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39253") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56410->172.17.0.3:39253, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31374") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40054->172.17.0.3:31374, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35589") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49612->172.17.0.3:35589, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38817") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51642->172.17.0.3:38817, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36580") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46464->172.17.0.3:36580, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30123") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38978->172.17.0.3:30123, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31013") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:39616->172.17.0.3:31013, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39908") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:60354->172.17.0.3:39908, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33345") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:47900->172.17.0.3:33345, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33195") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:38974->172.17.0.3:33195, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35772") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:58140->172.17.0.3:35772, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37893") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:49842->172.17.0.3:37893, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:35882") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:50600->172.17.0.3:35882, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/09 05:02:34 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-zihohoq6vagi" 2025/09/09 05:02:34 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : TestFTPPureftpd: detected overridden config - adding "{2EL4l}" suffix to name 2025/09/09 05:02:34 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:34 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:34 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:34 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Connecting to FTP server 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:45412->172.17.0.3:21, err= 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39387") 2025/09/09 05:02:34 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:58366->172.17.0.3:39387, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:31932") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:53642->172.17.0.3:31932, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34411") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57506->172.17.0.3:34411, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32219") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34616->172.17.0.3:32219, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/09 05:02:35 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zihohoq6vagi/deeper/nonexisting/directory" 2025/09/09 05:02:35 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/09 05:02:35 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:35 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:35 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:35 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:35 DEBUG : TestFTPPureftpd: detected overridden config - adding "{gQ4mT}" suffix to name 2025/09/09 05:02:35 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/09 05:02:35 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/09 05:02:35 DEBUG : Setting pass="RktS26joCXi_tg_aQmuyAnQTyR0a_YB8M-6ppBXorSw" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/09 05:02:35 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/deeper/nonexisting/directory: Connecting to FTP server 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:45426->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/09/09 05:02:35 DEBUG : Waiting for deletions to finish 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36711") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:36756->172.17.0.3:36711, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:34197") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33274->172.17.0.3:34197, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33866") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43236->172.17.0.3:33866, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:30621") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:51180->172.17.0.3:30621, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:36852") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48460->172.17.0.3:36852, err= 2025/09/09 05:02:35 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:33316") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37192->172.17.0.3:33316, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:39788") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:53312->172.17.0.3:39788, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37403") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:57680->172.17.0.3:37403, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32388") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:43746->172.17.0.3:32388, err= 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38230") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:48038->172.17.0.3:38230, err= 2025/09/09 05:02:35 DEBUG : removing 1 level 4 directories 2025/09/09 05:02:35 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/09 05:02:35 DEBUG : removing 1 level 3 directories 2025/09/09 05:02:35 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/09 05:02:35 DEBUG : removing 1 level 2 directories 2025/09/09 05:02:35 INFO : hello? sausage/êé: Removing directory 2025/09/09 05:02:35 DEBUG : removing 1 level 1 directories 2025/09/09 05:02:35 INFO : hello? sausage: Removing directory 2025/09/09 05:02:35 DEBUG : removing 1 level 0 directories 2025/09/09 05:02:35 INFO : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Removing directory 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:38411") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:33618->172.17.0.3:38411, err= 2025/09/09 05:02:35 ERROR : error listing: directory not found 2025/09/09 05:02:35 DEBUG : Waiting for deletions to finish 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:32696") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:34252->172.17.0.3:32696, err= 2025/09/09 05:02:35 ERROR : error listing: directory not found 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: dial("tcp","172.17.0.3:37507") 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: > dial: conn=172.17.0.1:37874->172.17.0.3:37507, err= 2025/09/09 05:02:35 ERROR : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Failed to list "": directory not found 2025/09/09 05:02:35 DEBUG : removing 1 level 0 directories 2025/09/09 05:02:35 INFO : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: Removing directory 2025/09/09 05:02:35 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/09 05:02:35 DEBUG : ftp://172.17.0.3:21/rclone-test-zihohoq6vagi: closing 2 unused connections --- PASS: TestIntegration (2.41s) --- 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.12s) --- 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.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.01s) --- 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.13s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- 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.07s) --- 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.03s) --- 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.02s) --- 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.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.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.78s) --- 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.438s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.328125433s (try 1/5)