"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/09/29 02:19:51 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-sabeweh6dalo" 2025/09/29 02:19:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/29 02:19:51 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:51 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:51 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:51 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:51 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:51 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:51 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:51 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:51 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:51 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Connecting to FTP server 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42068->172.17.0.3:21, err= 2025/09/29 02:19:51 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/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37601") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52686->172.17.0.3:37601, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30936") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48254->172.17.0.3:30936, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/29 02:19:51 INFO : dir/subdir: Making directory 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38472") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40354->172.17.0.3:38472, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39168") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54598->172.17.0.3:39168, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39872") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:44236->172.17.0.3:39872, err= 2025/09/29 02:19:51 INFO : dir/subdir: Removing directory 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34409") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43994->172.17.0.3:34409, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30898") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58048->172.17.0.3:30898, err= 2025/09/29 02:19:51 INFO : dir: Removing directory 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30251") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:39404->172.17.0.3:30251, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30350") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37700->172.17.0.3:30350, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34073") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49112->172.17.0.3:34073, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30445") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42178->172.17.0.3:30445, err= 2025/09/29 02:19:51 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/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34968") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37154->172.17.0.3:34968, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31760") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49984->172.17.0.3:31760, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39352") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55758->172.17.0.3:39352, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36698") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:45408->172.17.0.3:36698, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31810") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53784->172.17.0.3:31810, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31142") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56370->172.17.0.3:31142, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34470") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:36318->172.17.0.3:34470, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39819") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35192->172.17.0.3:39819, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33310") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51532->172.17.0.3:33310, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39207") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42792->172.17.0.3:39207, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32517") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41388->172.17.0.3:32517, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36123") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51274->172.17.0.3:36123, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35353") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35536->172.17.0.3:35353, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38506") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:60320->172.17.0.3:38506, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35610") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43192->172.17.0.3:35610, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30862") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57716->172.17.0.3:30862, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37051") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54612->172.17.0.3:37051, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34378") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54494->172.17.0.3:34378, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35612") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:60646->172.17.0.3:35612, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36779") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33812->172.17.0.3:36779, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35803") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49488->172.17.0.3:35803, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38299") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35232->172.17.0.3:38299, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33534") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:50578->172.17.0.3:33534, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30082") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:50446->172.17.0.3:30082, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36241") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58120->172.17.0.3:36241, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34533") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54216->172.17.0.3:34533, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39738") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51872->172.17.0.3:39738, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31381") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46826->172.17.0.3:31381, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34688") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40778->172.17.0.3:34688, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38356") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57664->172.17.0.3:38356, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37486") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37352->172.17.0.3:37486, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38095") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46068->172.17.0.3:38095, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34134") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:38410->172.17.0.3:34134, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38232") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33884->172.17.0.3:38232, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33529") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49608->172.17.0.3:33529, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39365") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57996->172.17.0.3:39365, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32703") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:44888->172.17.0.3:32703, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32585") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:32796->172.17.0.3:32585, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31151") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58664->172.17.0.3:31151, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32229") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42986->172.17.0.3:32229, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34524") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49290->172.17.0.3:34524, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34703") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:44616->172.17.0.3:34703, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38697") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:36678->172.17.0.3:38697, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39199") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:44314->172.17.0.3:39199, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38313") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53122->172.17.0.3:38313, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36656") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:34828->172.17.0.3:36656, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31270") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52028->172.17.0.3:31270, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39546") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41344->172.17.0.3:39546, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39632") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43188->172.17.0.3:39632, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38675") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46064->172.17.0.3:38675, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36624") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48362->172.17.0.3:36624, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33624") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52632->172.17.0.3:33624, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31389") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55796->172.17.0.3:31389, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30482") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:39180->172.17.0.3:30482, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32073") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54996->172.17.0.3:32073, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37013") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:50180->172.17.0.3:37013, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38380") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33782->172.17.0.3:38380, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36616") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57230->172.17.0.3:36616, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38358") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:47790->172.17.0.3:38358, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36352") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48530->172.17.0.3:36352, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30209") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:39904->172.17.0.3:30209, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36930") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35396->172.17.0.3:36930, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38652") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48904->172.17.0.3:38652, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37733") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51550->172.17.0.3:37733, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39973") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:47522->172.17.0.3:39973, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33199") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49548->172.17.0.3:33199, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36252") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41518->172.17.0.3:36252, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35110") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49976->172.17.0.3:35110, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34501") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49876->172.17.0.3:34501, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32495") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33192->172.17.0.3:32495, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34763") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52450->172.17.0.3:34763, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38858") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40114->172.17.0.3:38858, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32958") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49790->172.17.0.3:32958, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34251") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:60676->172.17.0.3:34251, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34329") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37408->172.17.0.3:34329, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32384") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:47562->172.17.0.3:32384, err= 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38934") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58526->172.17.0.3:38934, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30789") 2025/09/29 02:19:51 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37304->172.17.0.3:30789, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42074->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37743") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:39552->172.17.0.3:37743, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32771") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:36662->172.17.0.3:32771, 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/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35140") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52234->172.17.0.3:35140, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37005") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48814->172.17.0.3:37005, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31544") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56546->172.17.0.3:31544, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30135") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:34658->172.17.0.3:30135, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31094") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35496->172.17.0.3:31094, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32246") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53830->172.17.0.3:32246, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36013") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:38736->172.17.0.3:36013, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35317") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40910->172.17.0.3:35317, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37493") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51908->172.17.0.3:37493, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38546") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43646->172.17.0.3:38546, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33866") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54864->172.17.0.3:33866, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39685") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40728->172.17.0.3:39685, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38956") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33272->172.17.0.3:38956, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34642") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56992->172.17.0.3:34642, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31861") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59470->172.17.0.3:31861, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35545") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48630->172.17.0.3:35545, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37617") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:45412->172.17.0.3:37617, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42090->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37147") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44982->172.17.0.3:37147, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39700") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43806->172.17.0.3:39700, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33500") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56720->172.17.0.3:33500, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35383") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40912->172.17.0.3:35383, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31526") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48348->172.17.0.3:31526, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36428") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54906->172.17.0.3:36428, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32486") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56366->172.17.0.3:32486, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38700") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:47156->172.17.0.3:38700, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30572") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:52220->172.17.0.3:30572, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33480") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48822->172.17.0.3:33480, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39206") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49734->172.17.0.3:39206, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32741") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:38994->172.17.0.3:32741, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33667") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42934->172.17.0.3:33667, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37383") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53772->172.17.0.3:37383, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32332") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46200->172.17.0.3:32332, 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/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-sabeweh6dalo/hello? sausage/êé" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:42098->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-sabeweh6dalo/hello? sausage/êé" to be canonical "TestFTPPureftpd{PZqN5}:rclone-test-sabeweh6dalo/hello? sausage/êé" 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:32276") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:47618->172.17.0.3:32276, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:36334") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:52692->172.17.0.3:36334, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:42106->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:37675") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:55194->172.17.0.3:37675, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:36935") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:35568->172.17.0.3:36935, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:38548") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:38820->172.17.0.3:38548, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:35624") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:54872->172.17.0.3:35624, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:37121") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:57542->172.17.0.3:37121, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:30070") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:36416->172.17.0.3:30070, err= 2025/09/29 02:19:52 DEBUG : Waiting for deletions to finish 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:31627") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:59342->172.17.0.3:31627, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:31394") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:44624->172.17.0.3:31394, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:38493") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:53908->172.17.0.3:38493, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:30015") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:60680->172.17.0.3:30015, err= 2025/09/29 02:19:52 INFO : a/b/c/d/e.txt: Deleted 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:34824") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:46340->172.17.0.3:34824, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:35049") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:34578->172.17.0.3:35049, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:33337") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:33530->172.17.0.3:33337, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: dial("tcp","172.17.0.3:36707") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé: > dial: conn=172.17.0.1:38464->172.17.0.3:36707, err= 2025/09/29 02:19:52 DEBUG : removing 1 level 4 directories 2025/09/29 02:19:52 INFO : a/b/c/d: Removing directory 2025/09/29 02:19:52 DEBUG : removing 1 level 3 directories 2025/09/29 02:19:52 INFO : a/b/c: Removing directory 2025/09/29 02:19:52 DEBUG : removing 1 level 2 directories 2025/09/29 02:19:52 INFO : a/b: Removing directory 2025/09/29 02:19:52 DEBUG : removing 1 level 1 directories 2025/09/29 02:19:52 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31453") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58032->172.17.0.3:31453, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36003") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56102->172.17.0.3:36003, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39550") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43844->172.17.0.3:39550, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31510") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53460->172.17.0.3:31510, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36099") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:58978->172.17.0.3:36099, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39908") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56700->172.17.0.3:39908, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42112->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37181") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41070->172.17.0.3:37181, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39015") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42534->172.17.0.3:39015, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33585") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41858->172.17.0.3:33585, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34921") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:50404->172.17.0.3:34921, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38024") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49352->172.17.0.3:38024, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31308") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41212->172.17.0.3:31308, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36194") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40414->172.17.0.3:36194, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33040") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53212->172.17.0.3:33040, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30780") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59278->172.17.0.3:30780, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35943") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:38738->172.17.0.3:35943, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31520") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55038->172.17.0.3:31520, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32736") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59600->172.17.0.3:32736, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34345") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32758") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40492->172.17.0.3:34345, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43848->172.17.0.3:32758, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33451") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:60612->172.17.0.3:33451, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39667") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55210->172.17.0.3:39667, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34249") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:48740->172.17.0.3:34249, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xoqixeh0wedi" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:42126->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30557") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35874->172.17.0.3:30557, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:30027") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:56974->172.17.0.3:30027, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:36225") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:37178->172.17.0.3:36225, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:38969") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:46272->172.17.0.3:38969, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:39128") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:55108->172.17.0.3:39128, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:37826") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:48872->172.17.0.3:37826, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:36020") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:33626->172.17.0.3:36020, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:30944") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:54278->172.17.0.3:30944, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36081") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59104->172.17.0.3:36081, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:33914") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35144->172.17.0.3:33914, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32430") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57374->172.17.0.3:32430, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:37800") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37468->172.17.0.3:37800, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30231") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:47426->172.17.0.3:30231, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:37511") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:38574->172.17.0.3:37511, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:30223") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:41432->172.17.0.3:30223, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:34593") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:56570->172.17.0.3:34593, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: dial("tcp","172.17.0.3:32221") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: > dial: conn=172.17.0.1:44870->172.17.0.3:32221, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: Purge dir "new_name" 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-xoqixeh0wedi: 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/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30947") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:34340->172.17.0.3:30947, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32354") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:60626->172.17.0.3:32354, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35089") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33870->172.17.0.3:35089, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38900") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46888->172.17.0.3:38900, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38673") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:46638->172.17.0.3:38673, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30777") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:54274->172.17.0.3:30777, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39344") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35448->172.17.0.3:39344, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32857") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37792->172.17.0.3:32857, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34739") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55510->172.17.0.3:34739, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:42128->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:30416") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39610->172.17.0.3:30416, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-sabeweh6dalo/not found.txt" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/not found.txt: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/not found.txt: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/not found.txt: > dial: conn=172.17.0.1:42136->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/not found.txt: dial("tcp","172.17.0.3:32120") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/not found.txt: > dial: conn=172.17.0.1:38848->172.17.0.3:32120, err= 2025/09/29 02:19:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-sabeweh6dalo" from "TestFTPPureftpd:rclone-test-sabeweh6dalo" 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42148->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35403") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39448->172.17.0.3:35403, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34239") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:55646->172.17.0.3:34239, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33444") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35704->172.17.0.3:33444, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39357") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60250->172.17.0.3:39357, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35165") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58488->172.17.0.3:35165, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:32618") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36216->172.17.0.3:32618, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33821") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60660->172.17.0.3:33821, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35015") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56068->172.17.0.3:35015, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31393") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48406->172.17.0.3:31393, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38618") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56372->172.17.0.3:38618, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34004") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53042->172.17.0.3:34004, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:32800") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45340->172.17.0.3:32800, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37479") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37598->172.17.0.3:37479, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:32981") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59434->172.17.0.3:32981, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36143") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34630->172.17.0.3:36143, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31121") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35948->172.17.0.3:31121, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34459") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39318->172.17.0.3:34459, 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/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38858") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40118->172.17.0.3:38858, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31576") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:32804->172.17.0.3:31576, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38908") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35666->172.17.0.3:38908, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:34097") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56684->172.17.0.3:34097, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39487") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57446->172.17.0.3:39487, 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/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38863") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51634->172.17.0.3:38863, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:31484") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37040->172.17.0.3:31484, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/29 02:19:52 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-sabeweh6dalo" 2025/09/29 02:19:52 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : TestFTPPureftpd: detected overridden config - adding "{R8afM}" suffix to name 2025/09/29 02:19:52 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:52 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:52 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:52 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Connecting to FTP server 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:42162->172.17.0.3:21, err= 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38533") 2025/09/29 02:19:52 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59062->172.17.0.3:38533, 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/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36732") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:59438->172.17.0.3:36732, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39457") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:57528->172.17.0.3:39457, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38185") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:37260->172.17.0.3:38185, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/29 02:19:53 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-sabeweh6dalo/deeper/nonexisting/directory" 2025/09/29 02:19:53 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/09/29 02:19:53 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:53 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:53 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:53 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:53 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PZqN5}" suffix to name 2025/09/29 02:19:53 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/09/29 02:19:53 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/09/29 02:19:53 DEBUG : Setting pass="QfGPakr3UaRFMWp-o7qqBSk9daklhl7N9V3QQeUj81g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/09/29 02:19:53 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/deeper/nonexisting/directory: Connecting to FTP server 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:42164->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/29 02:19:53 DEBUG : Waiting for deletions to finish 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35522") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:49078->172.17.0.3:35522, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36941") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:35878->172.17.0.3:36941, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30979") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:36240->172.17.0.3:30979, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32436") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:55252->172.17.0.3:32436, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32471") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:56502->172.17.0.3:32471, err= 2025/09/29 02:19:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:38086") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:40128->172.17.0.3:38086, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:36777") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:33886->172.17.0.3:36777, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:39956") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:43622->172.17.0.3:39956, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:35214") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:53776->172.17.0.3:35214, err= 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32449") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:41152->172.17.0.3:32449, err= 2025/09/29 02:19:53 DEBUG : removing 1 level 4 directories 2025/09/29 02:19:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/29 02:19:53 DEBUG : removing 1 level 3 directories 2025/09/29 02:19:53 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/29 02:19:53 DEBUG : removing 1 level 2 directories 2025/09/29 02:19:53 INFO : hello? sausage/êé: Removing directory 2025/09/29 02:19:53 DEBUG : removing 1 level 1 directories 2025/09/29 02:19:53 INFO : hello? sausage: Removing directory 2025/09/29 02:19:53 DEBUG : removing 1 level 0 directories 2025/09/29 02:19:53 INFO : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Removing directory 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32960") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:44916->172.17.0.3:32960, err= 2025/09/29 02:19:53 ERROR : error listing: directory not found 2025/09/29 02:19:53 DEBUG : Waiting for deletions to finish 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:30964") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:51110->172.17.0.3:30964, err= 2025/09/29 02:19:53 ERROR : error listing: directory not found 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: dial("tcp","172.17.0.3:32741") 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: > dial: conn=172.17.0.1:39006->172.17.0.3:32741, err= 2025/09/29 02:19:53 ERROR : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Failed to list "": directory not found 2025/09/29 02:19:53 DEBUG : removing 1 level 0 directories 2025/09/29 02:19:53 INFO : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: Removing directory 2025/09/29 02:19:53 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/29 02:19:53 DEBUG : ftp://172.17.0.3:21/rclone-test-sabeweh6dalo: closing 2 unused connections --- PASS: TestIntegration (2.44s) --- 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.37s) --- 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.14s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.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.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.77s) --- 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.00s) --- 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.458s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.31637018s (try 1/5)