"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPPureftpd:" 2026/09/04 04:28:45 NOTICE: TestFTPPureftpd: Starting server 2026/09/04 04:28:47 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2026/09/04 04:28:47 DEBUG : TestFTPPureftpd: Read 1, error: 2026/09/04 04:28:47 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.3:21" 2026/09/04 04:28:47 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nanirom5ceco" 2026/09/04 04:28:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/04 04:28:47 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:28:47 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:47 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:47 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:47 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:47 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:28:47 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:47 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:47 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:47 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:47 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Connecting to FTP server 2026/09/04 04:28:47 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:21") 2026/09/04 04:28:47 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52536->172.17.0.3:21, err= 2026/09/04 04:28:50 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31298") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55964->172.17.0.3:31298, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31351") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52820->172.17.0.3:31351, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/04 04:28:50 INFO : dir/subdir: Making directory 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35990") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44976->172.17.0.3:35990, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31326") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40396->172.17.0.3:31326, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35716") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40582->172.17.0.3:35716, err= 2026/09/04 04:28:50 INFO : dir/subdir: Removing directory 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37575") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40082->172.17.0.3:37575, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32355") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33072->172.17.0.3:32355, err= 2026/09/04 04:28:50 INFO : dir: Removing directory 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31272") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:46590->172.17.0.3:31272, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32403") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44464->172.17.0.3:32403, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31455") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60018->172.17.0.3:31455, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35584") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58648->172.17.0.3:35584, err= 2026/09/04 04:28:50 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34942") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47538->172.17.0.3:34942, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34704") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:32978->172.17.0.3:34704, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36135") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59664->172.17.0.3:36135, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32111") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59420->172.17.0.3:32111, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36691") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58012->172.17.0.3:36691, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "." 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33241") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47268->172.17.0.3:33241, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33354") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36274->172.17.0.3:33354, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34138") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59558->172.17.0.3:34138, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35159") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39866->172.17.0.3:35159, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing ".." 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35611") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45332->172.17.0.3:35611, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37124") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40996->172.17.0.3:37124, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35641") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50002->172.17.0.3:35641, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31255") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34090->172.17.0.3:31255, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38106") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44870->172.17.0.3:38106, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38612") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:46400->172.17.0.3:38612, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32507") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:41114->172.17.0.3:32507, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32700") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45798->172.17.0.3:32700, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32541") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33820->172.17.0.3:32541, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33677") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52192->172.17.0.3:33677, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35822") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47766->172.17.0.3:35822, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38850") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38174->172.17.0.3:38850, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37539") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39510->172.17.0.3:37539, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37784") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59056->172.17.0.3:37784, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33327") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56052->172.17.0.3:33327, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39889") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47288->172.17.0.3:39889, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35728") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33670->172.17.0.3:35728, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30663") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59082->172.17.0.3:30663, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34316") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44694->172.17.0.3:34316, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36634") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49328->172.17.0.3:36634, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37847") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50046->172.17.0.3:37847, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36017") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56764->172.17.0.3:36017, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36353") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59456->172.17.0.3:36353, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37748") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49584->172.17.0.3:37748, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39729") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50936->172.17.0.3:39729, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38029") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36844->172.17.0.3:38029, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33021") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39546->172.17.0.3:33021, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32630") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58106->172.17.0.3:32630, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35870") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:43028->172.17.0.3:35870, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33699") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:42612->172.17.0.3:33699, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37794") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47326->172.17.0.3:37794, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38394") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57308->172.17.0.3:38394, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33802") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60284->172.17.0.3:33802, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36388") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49394->172.17.0.3:36388, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35242") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50014->172.17.0.3:35242, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35039") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39338->172.17.0.3:35039, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34021") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56074->172.17.0.3:34021, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36691") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58018->172.17.0.3:36691, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33495") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56990->172.17.0.3:33495, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39291") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33354->172.17.0.3:39291, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33440") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38758->172.17.0.3:33440, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34070") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35260->172.17.0.3:34070, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36911") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50568->172.17.0.3:36911, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39874") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:53214->172.17.0.3:39874, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32561") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59318->172.17.0.3:32561, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35864") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59612->172.17.0.3:35864, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33945") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44182->172.17.0.3:33945, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34936") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33274->172.17.0.3:34936, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36227") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59702->172.17.0.3:36227, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32006") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36344->172.17.0.3:32006, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35696") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60550->172.17.0.3:35696, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30050") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40342->172.17.0.3:30050, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39334") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33222->172.17.0.3:39334, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31076") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34798->172.17.0.3:31076, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33744") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:53396->172.17.0.3:33744, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39089") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:51692->172.17.0.3:39089, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38882") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38378->172.17.0.3:38882, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37879") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38622->172.17.0.3:37879, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38727") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45118->172.17.0.3:38727, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35985") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47544->172.17.0.3:35985, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37219") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:54688->172.17.0.3:37219, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37517") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45894->172.17.0.3:37517, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37877") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57378->172.17.0.3:37877, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37451") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35724->172.17.0.3:37451, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33200") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52244->172.17.0.3:33200, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38970") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50280->172.17.0.3:38970, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39461") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45772->172.17.0.3:39461, err= 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36962") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49146->172.17.0.3:36962, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38503") 2026/09/04 04:28:50 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55876->172.17.0.3:38503, err= 2026/09/04 04:28:51 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Connecting to FTP server 2026/09/04 04:28:51 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:21") 2026/09/04 04:28:51 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52550->172.17.0.3:21, err= 2026/09/04 04:28:54 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37785") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52840->172.17.0.3:37785, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35351") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58572->172.17.0.3:35351, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33021") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:53616->172.17.0.3:33021, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38523") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35398->172.17.0.3:38523, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38450") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48708->172.17.0.3:38450, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33022") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44020->172.17.0.3:33022, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39613") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36000->172.17.0.3:39613, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38071") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55606->172.17.0.3:38071, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33636") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59998->172.17.0.3:33636, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36193") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36576->172.17.0.3:36193, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33823") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56054->172.17.0.3:33823, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32164") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35672->172.17.0.3:32164, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39402") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34784->172.17.0.3:39402, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35493") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36024->172.17.0.3:35493, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33352") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56306->172.17.0.3:33352, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37417") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33126->172.17.0.3:37417, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38146") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47268->172.17.0.3:38146, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32356") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57270->172.17.0.3:32356, err= 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31413") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34618->172.17.0.3:31413, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/04 04:28:54 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/04 04:28:54 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:28:54 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:54 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:54 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:54 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:28:54 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:54 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:54 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:54 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/09/04 04:28:54 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48292->172.17.0.3:21, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38935") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58898->172.17.0.3:38935, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31087") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:42764->172.17.0.3:31087, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35079") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:46464->172.17.0.3:35079, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37172") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38292->172.17.0.3:37172, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34978") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48984->172.17.0.3:34978, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32269") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39012->172.17.0.3:32269, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37276") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40704->172.17.0.3:37276, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33970") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:43094->172.17.0.3:33970, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31294") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47146->172.17.0.3:31294, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36373") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50656->172.17.0.3:36373, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39771") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58802->172.17.0.3:39771, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39002") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35468->172.17.0.3:39002, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35877") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34454->172.17.0.3:35877, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39361") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35754->172.17.0.3:39361, err= 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35426") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60222->172.17.0.3:35426, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/09/04 04:28:57 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nanirom5ceco/hello? sausage/êé" 2026/09/04 04:28:57 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:28:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:57 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:28:57 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:28:57 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:28:57 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:28:57 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: Connecting to FTP server 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/09/04 04:28:57 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:48304->172.17.0.3:21, err= 2026/09/04 04:29:01 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-nanirom5ceco/hello? sausage/êé" to be canonical "TestFTPPureftpd{vbvdG}:rclone-test-nanirom5ceco/hello? sausage/êé" 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:36293") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:56186->172.17.0.3:36293, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:30251") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:36990->172.17.0.3:30251, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: Connecting to FTP server 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:48308->172.17.0.3:21, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:31367") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:51734->172.17.0.3:31367, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:39445") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:40970->172.17.0.3:39445, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:30541") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:44018->172.17.0.3:30541, err= 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:31606") 2026/09/04 04:29:01 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:47392->172.17.0.3:31606, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:37637") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:57142->172.17.0.3:37637, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:38510") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:60858->172.17.0.3:38510, err= 2026/09/04 04:29:04 DEBUG : Waiting for deletions to finish 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:34622") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:60414->172.17.0.3:34622, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:32866") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:56282->172.17.0.3:32866, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:30688") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:57094->172.17.0.3:30688, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:31241") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:50646->172.17.0.3:31241, err= 2026/09/04 04:29:04 INFO : a/b/c/d/e.txt: Deleted 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:34490") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:54958->172.17.0.3:34490, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:37821") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:38106->172.17.0.3:37821, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:36313") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:43410->172.17.0.3:36313, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: dial("tcp","172.17.0.3:31656") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé: > dial: conn=172.17.0.1:41528->172.17.0.3:31656, err= 2026/09/04 04:29:04 DEBUG : removing 1 level 4 directories 2026/09/04 04:29:04 INFO : a/b/c/d: Removing directory 2026/09/04 04:29:04 DEBUG : removing 1 level 3 directories 2026/09/04 04:29:04 INFO : a/b/c: Removing directory 2026/09/04 04:29:04 DEBUG : removing 1 level 2 directories 2026/09/04 04:29:04 INFO : a/b: Removing directory 2026/09/04 04:29:04 DEBUG : removing 1 level 1 directories 2026/09/04 04:29:04 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33252") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48614->172.17.0.3:33252, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36922") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:45864->172.17.0.3:36922, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33212") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44924->172.17.0.3:33212, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31776") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:34394->172.17.0.3:31776, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35132") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60560->172.17.0.3:35132, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38586") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55214->172.17.0.3:38586, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Connecting to FTP server 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48222->172.17.0.3:21, err= 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33002") 2026/09/04 04:29:04 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33452->172.17.0.3:33002, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32636") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55410->172.17.0.3:32636, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38364") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36940->172.17.0.3:38364, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36959") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47444->172.17.0.3:36959, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34661") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56132->172.17.0.3:34661, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34355") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:47486->172.17.0.3:34355, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37269") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57434->172.17.0.3:37269, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30417") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52272->172.17.0.3:30417, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37665") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58990->172.17.0.3:37665, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32251") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48174->172.17.0.3:32251, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32505") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:46886->172.17.0.3:32505, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35246") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55538->172.17.0.3:35246, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32387") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39534") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56394->172.17.0.3:32387, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56090->172.17.0.3:39534, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30264") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38322->172.17.0.3:30264, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35808") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58832->172.17.0.3:35808, err= 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39839") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38798->172.17.0.3:39839, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/04 04:29:06 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-keyuvog5robe" 2026/09/04 04:29:06 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:06 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:06 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:06 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:06 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:29:06 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:06 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:06 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:06 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: Connecting to FTP server 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:06 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:48236->172.17.0.3:21, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35621") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:42680->172.17.0.3:35621, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:39011") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:37628->172.17.0.3:39011, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:34481") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:54340->172.17.0.3:34481, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:38278") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:51792->172.17.0.3:38278, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:38779") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:59828->172.17.0.3:38779, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:39705") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:60924->172.17.0.3:39705, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:34678") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:52702->172.17.0.3:34678, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:38007") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:44218->172.17.0.3:38007, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30231") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:54392->172.17.0.3:30231, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38542") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50406->172.17.0.3:38542, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32822") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35102->172.17.0.3:32822, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30923") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:37546->172.17.0.3:30923, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34150") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49516->172.17.0.3:34150, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:33801") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:55794->172.17.0.3:33801, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:33301") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:51018->172.17.0.3:33301, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:38736") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:49398->172.17.0.3:38736, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: dial("tcp","172.17.0.3:39614") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: > dial: conn=172.17.0.1:57638->172.17.0.3:39614, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: Purge dir "new_name" 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-keyuvog5robe: 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:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1664: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35345") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:41058->172.17.0.3:35345, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30171") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:53112->172.17.0.3:30171, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32844") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36150->172.17.0.3:32844, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34111") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40592->172.17.0.3:34111, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36933") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:37498->172.17.0.3:36933, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38062") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:37126->172.17.0.3:38062, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38948") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:35318->172.17.0.3:38948, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39723") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:51342->172.17.0.3:39723, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32167") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59818->172.17.0.3:32167, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:39782") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:40912->172.17.0.3:39782, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36372") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:44722->172.17.0.3:36372, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36672") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49598->172.17.0.3:36672, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30646") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49380->172.17.0.3:30646, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34812") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60586->172.17.0.3:34812, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38841") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:33330->172.17.0.3:38841, err= 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31437") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60478->172.17.0.3:31437, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/04 04:29:09 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/04 04:29:09 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:09 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:09 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:09 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:09 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:09 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:29:09 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:09 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:09 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:09 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:09 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:48246->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/04 04:29:12 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:32696") 2026/09/04 04:29:12 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:45710->172.17.0.3:32696, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/04 04:29:12 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nanirom5ceco/not found.txt" 2026/09/04 04:29:12 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:12 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:29:12 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:12 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:12 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:12 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:12 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/not found.txt: Connecting to FTP server 2026/09/04 04:29:12 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/not found.txt: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:12 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/not found.txt: > dial: conn=172.17.0.1:60536->172.17.0.3:21, err= 2026/09/04 04:29:14 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/not found.txt: dial("tcp","172.17.0.3:35728") 2026/09/04 04:29:14 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/not found.txt: > dial: conn=172.17.0.1:41844->172.17.0.3:35728, err= 2026/09/04 04:29:14 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPPureftpd:" path "rclone-test-nanirom5ceco" from "TestFTPPureftpd:rclone-test-nanirom5ceco" 2026/09/04 04:29:14 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/09/04 04:29:14 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:14 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:14 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:14 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:14 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:14 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:29:14 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:14 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:14 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:14 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:14 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/09/04 04:29:14 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:14 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60546->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34361") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38988->172.17.0.3:34361, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30756") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58400->172.17.0.3:30756, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:32695") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49232->172.17.0.3:32695, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37066") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42824->172.17.0.3:37066, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36537") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42912->172.17.0.3:36537, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37007") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:32800->172.17.0.3:37007, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33464") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37208->172.17.0.3:33464, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37483") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60312->172.17.0.3:37483, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33980") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42196->172.17.0.3:33980, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38937") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43468->172.17.0.3:38937, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36149") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51448->172.17.0.3:36149, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36516") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34174->172.17.0.3:36516, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39960") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47974->172.17.0.3:39960, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30235") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38302->172.17.0.3:30235, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36167") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44730->172.17.0.3:36167, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31114") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39194->172.17.0.3:31114, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31428") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60978->172.17.0.3:31428, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2090: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2211: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31236") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56960->172.17.0.3:31236, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30648") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:32942->172.17.0.3:30648, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34119") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:48694->172.17.0.3:34119, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34875") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58878->172.17.0.3:34875, err= 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34859") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:58896->172.17.0.3:34859, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2367: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37342") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:55358->172.17.0.3:37342, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34397") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57878->172.17.0.3:34397, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/04 04:29:17 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-nanirom5ceco" 2026/09/04 04:29:17 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:17 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:17 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:17 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:17 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:17 DEBUG : TestFTPPureftpd: detected overridden config - adding "{IF579}" suffix to name 2026/09/04 04:29:17 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:17 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:17 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:17 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Connecting to FTP server 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:17 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60562->172.17.0.3:21, err= 2026/09/04 04:29:20 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37903") 2026/09/04 04:29:20 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50702->172.17.0.3:37903, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2452: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:34403") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:50460->172.17.0.3:34403, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:30822") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:56984->172.17.0.3:30822, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2697: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31381") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36548->172.17.0.3:31381, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2828: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2870: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:31712") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:39036->172.17.0.3:31712, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35660") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:51988->172.17.0.3:35660, err= 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36163") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:32968->172.17.0.3:36163, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/04 04:29:21 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-nanirom5ceco/deeper/nonexisting/directory" 2026/09/04 04:29:21 DEBUG : Setting type=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/09/04 04:29:21 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:21 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:21 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:21 DEBUG : TestFTPPureftpd: detected overridden config - adding "{vbvdG}" suffix to name 2026/09/04 04:29:21 DEBUG : Setting host=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/09/04 04:29:21 DEBUG : Setting user=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/09/04 04:29:21 DEBUG : Setting pass=XXX for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/09/04 04:29:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/deeper/nonexisting/directory: Connecting to FTP server 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2026/09/04 04:29:21 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco/deeper/nonexisting/directory: > dial: conn=172.17.0.1:44360->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3119: FS has no Directory methods and doesn't Wrap 2026/09/04 04:29:24 DEBUG : Waiting for deletions to finish 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35395") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:53002->172.17.0.3:35395, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37428") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:42856->172.17.0.3:37428, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:36937") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52066->172.17.0.3:36937, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:32844") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:36136->172.17.0.3:32844, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33249") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:51012->172.17.0.3:33249, err= 2026/09/04 04:29:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:37521") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:57898->172.17.0.3:37521, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38817") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:60996->172.17.0.3:38817, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33282") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38600->172.17.0.3:33282, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35307") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:38138->172.17.0.3:35307, err= 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33222") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:32878->172.17.0.3:33222, err= 2026/09/04 04:29:24 DEBUG : removing 1 level 4 directories 2026/09/04 04:29:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/04 04:29:24 DEBUG : removing 1 level 3 directories 2026/09/04 04:29:24 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/04 04:29:24 DEBUG : removing 1 level 2 directories 2026/09/04 04:29:24 INFO : hello? sausage/êé: Removing directory 2026/09/04 04:29:24 DEBUG : removing 1 level 1 directories 2026/09/04 04:29:24 INFO : hello? sausage: Removing directory 2026/09/04 04:29:24 DEBUG : removing 1 level 0 directories 2026/09/04 04:29:24 INFO : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Removing directory 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:33614") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:49624->172.17.0.3:33614, err= 2026/09/04 04:29:24 ERROR : error listing: directory not found 2026/09/04 04:29:24 DEBUG : Waiting for deletions to finish 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:35010") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:59288->172.17.0.3:35010, err= 2026/09/04 04:29:24 ERROR : error listing: directory not found 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: dial("tcp","172.17.0.3:38581") 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: > dial: conn=172.17.0.1:52598->172.17.0.3:38581, err= 2026/09/04 04:29:24 ERROR : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Failed to list "": directory not found 2026/09/04 04:29:24 DEBUG : removing 1 level 0 directories 2026/09/04 04:29:24 INFO : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: Removing directory 2026/09/04 04:29:24 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/04 04:29:24 DEBUG : ftp://172.17.0.3:21/rclone-test-nanirom5ceco: closing 2 unused connections 2026/09/04 04:29:24 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (38.37s) --- 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 (34.16s) --- 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.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 (4.05s) --- 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 (27.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (3.21s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (6.46s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (2.90s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (2.33s) --- 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/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (2.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (3.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (3.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (3.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (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 (2.83s) --- 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 38.391s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 39.654541187s (try 1/5)