"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2026/02/27 05:18:11 NOTICE: TestFTPProftpd: Starting server 2026/02/27 05:18:12 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2026/02/27 05:18:12 DEBUG : TestFTPProftpd: Read 1, error: 2026/02/27 05:18:12 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.7:21" 2026/02/27 05:18:12 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuqicoy9yevu" 2026/02/27 05:18:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/27 05:18:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:12 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:12 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:12 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:12 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Connecting to FTP server 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59962->172.17.0.7:21, err= 2026/02/27 05:18:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:1738") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35570->172.17.0.7:1738, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:46466") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44630->172.17.0.7:46466, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/02/27 05:18:12 INFO : dir/subdir: Making directory 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:42170") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58150->172.17.0.7:42170, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:45099") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36018->172.17.0.7:45099, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:18814") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41130->172.17.0.7:18814, err= 2026/02/27 05:18:12 INFO : dir/subdir: Removing directory 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:9854") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35508->172.17.0.7:9854, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:14235") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:40592->172.17.0.7:14235, err= 2026/02/27 05:18:12 INFO : dir: Removing directory 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:3215") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41208->172.17.0.7:3215, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62529") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58704->172.17.0.7:62529, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:51320") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:52412->172.17.0.7:51320, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22788") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34662->172.17.0.7:22788, err= 2026/02/27 05:18:12 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:11621") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53722->172.17.0.7:11621, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22479") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43606->172.17.0.7:22479, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:2462") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:42938->172.17.0.7:2462, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21639") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43358->172.17.0.7:21639, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:3000") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44394->172.17.0.7:3000, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "." 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:33992") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:42508->172.17.0.7:33992, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24315") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55260->172.17.0.7:24315, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:19486") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54254->172.17.0.7:19486, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:43365") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43192->172.17.0.7:43365, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing ".." 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:26434") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37150->172.17.0.7:26434, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:29651") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:50902->172.17.0.7:29651, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:44810") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58472->172.17.0.7:44810, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47476") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59382->172.17.0.7:47476, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:29083") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53708->172.17.0.7:29083, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:40704") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58420->172.17.0.7:40704, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:2576") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54064->172.17.0.7:2576, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:54827") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41978->172.17.0.7:54827, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:45325") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46300->172.17.0.7:45325, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:35423") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53212->172.17.0.7:35423, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50647") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54690->172.17.0.7:50647, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:46039") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51886->172.17.0.7:46039, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:16355") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:39420->172.17.0.7:16355, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:27283") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55724->172.17.0.7:27283, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:25604") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54396->172.17.0.7:25604, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:34146") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:48612->172.17.0.7:34146, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:36113") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51448->172.17.0.7:36113, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:38816") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54438->172.17.0.7:38816, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:36337") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58166->172.17.0.7:36337, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:33108") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51876->172.17.0.7:33108, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24601") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:52628->172.17.0.7:24601, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:58102") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34586->172.17.0.7:58102, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:43705") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:57388->172.17.0.7:43705, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:46056") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:45622->172.17.0.7:46056, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:59540") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56202->172.17.0.7:59540, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:64320") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35398->172.17.0.7:64320, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:48033") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47094->172.17.0.7:48033, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:27998") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58272->172.17.0.7:27998, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:23101") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41544->172.17.0.7:23101, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:1985") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43640->172.17.0.7:1985, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:5828") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:52482->172.17.0.7:5828, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:48511") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:45722->172.17.0.7:48511, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:30612") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:39490->172.17.0.7:30612, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:49615") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37836->172.17.0.7:49615, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:30452") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54860->172.17.0.7:30452, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:58672") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:50688->172.17.0.7:58672, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24785") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37492->172.17.0.7:24785, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:32005") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53216->172.17.0.7:32005, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47964") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60396->172.17.0.7:47964, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:4575") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34316->172.17.0.7:4575, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:1894") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49990->172.17.0.7:1894, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:33077") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54880->172.17.0.7:33077, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:49590") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47756->172.17.0.7:49590, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:17226") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43226->172.17.0.7:17226, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:59336") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53624->172.17.0.7:59336, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:9660") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36976->172.17.0.7:9660, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50348") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55040->172.17.0.7:50348, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:29915") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51014->172.17.0.7:29915, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47452") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:39416->172.17.0.7:47452, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21151") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34370->172.17.0.7:21151, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:61999") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53034->172.17.0.7:61999, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:6518") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53666->172.17.0.7:6518, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:13718") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:57558->172.17.0.7:13718, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:40170") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:57194->172.17.0.7:40170, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:51551") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:57078->172.17.0.7:51551, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:7723") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34834->172.17.0.7:7723, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:38955") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60042->172.17.0.7:38955, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:34050") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41588->172.17.0.7:34050, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:34697") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49098->172.17.0.7:34697, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:61033") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38888->172.17.0.7:61033, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:35011") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43198->172.17.0.7:35011, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:39502") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43494->172.17.0.7:39502, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:44009") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44560->172.17.0.7:44009, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:64600") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56964->172.17.0.7:64600, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:23582") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:42066->172.17.0.7:23582, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:8927") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49514->172.17.0.7:8927, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:57737") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60946->172.17.0.7:57737, err= 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47344") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54970->172.17.0.7:47344, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:39908") 2026/02/27 05:18:12 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38608->172.17.0.7:39908, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Connecting to FTP server 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59976->172.17.0.7:21, err= 2026/02/27 05:18:13 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:23029") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37160->172.17.0.7:23029, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:32532") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60816->172.17.0.7:32532, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:869: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22812") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43700->172.17.0.7:22812, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:58451") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54620->172.17.0.7:58451, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:26750") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38722->172.17.0.7:26750, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:8718") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58994->172.17.0.7:8718, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:56400") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:48156->172.17.0.7:56400, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21628") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:42926->172.17.0.7:21628, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:7870") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56252->172.17.0.7:7870, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50298") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44906->172.17.0.7:50298, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:42743") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54630->172.17.0.7:42743, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:60347") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53550->172.17.0.7:60347, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:18989") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36244->172.17.0.7:18989, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:45946") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:42412->172.17.0.7:45946, err= 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:6395") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34576->172.17.0.7:6395, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:51995") 2026/02/27 05:18:13 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:33300->172.17.0.7:51995, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:5412") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53764->172.17.0.7:5412, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:61327") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:52630->172.17.0.7:61327, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:49423") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60986->172.17.0.7:49423, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:59980->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:12752") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:49362->172.17.0.7:12752, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:19680") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44510->172.17.0.7:19680, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50528") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:40950->172.17.0.7:50528, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50666") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49114->172.17.0.7:50666, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:13903") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56402->172.17.0.7:13903, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21844") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51530->172.17.0.7:21844, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:27585") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47620->172.17.0.7:27585, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:11190") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37132->172.17.0.7:11190, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47643") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56794->172.17.0.7:47643, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:43600") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34994->172.17.0.7:43600, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1122: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:33810") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58236->172.17.0.7:33810, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22672") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:41268->172.17.0.7:22672, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:56260") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:44118->172.17.0.7:56260, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:55815") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37306->172.17.0.7:55815, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:54180") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34634->172.17.0.7:54180, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1154: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1191: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuqicoy9yevu/hello? sausage/êé" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:59984->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-kuqicoy9yevu/hello? sausage/êé" to be canonical "TestFTPProftpd{8gfDu}:rclone-test-kuqicoy9yevu/hello? sausage/êé" 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:51531") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:56450->172.17.0.7:51531, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:30717") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:60248->172.17.0.7:30717, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:27678") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:59996->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:45730->172.17.0.7:27678, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:14028") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:60928->172.17.0.7:14028, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:14964") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:42480->172.17.0.7:14964, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:37913") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:36754->172.17.0.7:37913, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:53617") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:50672->172.17.0.7:53617, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:27636") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:32874->172.17.0.7:27636, err= 2026/02/27 05:18:14 DEBUG : Waiting for deletions to finish 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:44493") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:33896->172.17.0.7:44493, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:13202") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:48328->172.17.0.7:13202, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:11226") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:57012->172.17.0.7:11226, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:36382") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:52298->172.17.0.7:36382, err= 2026/02/27 05:18:14 INFO : a/b/c/d/e.txt: Deleted 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:35501") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:60108->172.17.0.7:35501, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:59431") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:41702->172.17.0.7:59431, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:6766") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:40708->172.17.0.7:6766, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: dial("tcp","172.17.0.7:9839") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé: > dial: conn=172.17.0.1:56412->172.17.0.7:9839, err= 2026/02/27 05:18:14 DEBUG : removing 1 level 4 directories 2026/02/27 05:18:14 INFO : a/b/c/d: Removing directory 2026/02/27 05:18:14 DEBUG : removing 1 level 3 directories 2026/02/27 05:18:14 INFO : a/b/c: Removing directory 2026/02/27 05:18:14 DEBUG : removing 1 level 2 directories 2026/02/27 05:18:14 INFO : a/b: Removing directory 2026/02/27 05:18:14 DEBUG : removing 1 level 1 directories 2026/02/27 05:18:14 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1255: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:13537") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36814->172.17.0.7:13537, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:48731") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34264->172.17.0.7:48731, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:15396") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53102->172.17.0.7:15396, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21232") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53812->172.17.0.7:21232, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:39597") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:33792->172.17.0.7:39597, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:36000") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49758->172.17.0.7:36000, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59998->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:28079") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55244->172.17.0.7:28079, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:32856") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34384->172.17.0.7:32856, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24361") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:53606->172.17.0.7:24361, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:3353") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51946->172.17.0.7:3353, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:13208") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:39578->172.17.0.7:13208, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:49139") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51600->172.17.0.7:49139, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22891") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47268") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47042->172.17.0.7:22891, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46078->172.17.0.7:47268, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:42326") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38500->172.17.0.7:42326, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:36111") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60188->172.17.0.7:36111, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:58131") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58246->172.17.0.7:58131, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:63080") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60202->172.17.0.7:63080, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:48947") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60684->172.17.0.7:48947, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:28262") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47382->172.17.0.7:28262, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:32284") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54356->172.17.0.7:32284, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:28786") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:56600->172.17.0.7:28786, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:2003") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38718->172.17.0.7:2003, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1403: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xihidun0mite" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:60000->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62519") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46484->172.17.0.7:62519, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:44424") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:49768->172.17.0.7:44424, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:58954") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:35588->172.17.0.7:58954, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:55087") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:54342->172.17.0.7:55087, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:59150") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:35088->172.17.0.7:59150, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:33158") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:60284->172.17.0.7:33158, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:55692") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:39654->172.17.0.7:55692, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:21335") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:42932->172.17.0.7:21335, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62329") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55084->172.17.0.7:62329, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24055") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38502->172.17.0.7:24055, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:58758") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:60804->172.17.0.7:58758, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:12674") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55186->172.17.0.7:12674, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:4542") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34536->172.17.0.7:4542, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:17489") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:55444->172.17.0.7:17489, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:10970") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:46202->172.17.0.7:10970, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:40807") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:42080->172.17.0.7:40807, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: dial("tcp","172.17.0.7:5324") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: > dial: conn=172.17.0.1:45078->172.17.0.7:5324, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: Purge dir "new_name" 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-xihidun0mite: 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:1597: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1628: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1699: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:16664") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:33372->172.17.0.7:16664, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:9048") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34122->172.17.0.7:9048, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62317") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46814->172.17.0.7:62317, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:55963") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:50394->172.17.0.7:55963, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:29544") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38466->172.17.0.7:29544, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:8425") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:37112->172.17.0.7:8425, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:27825") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58570->172.17.0.7:27825, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50883") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:43008->172.17.0.7:50883, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:38612") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:50314->172.17.0.7:38612, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51484->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:35181") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:41540->172.17.0.7:35181, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuqicoy9yevu/not found.txt" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/not found.txt: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/not found.txt: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/not found.txt: > dial: conn=172.17.0.1:51496->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/not found.txt: dial("tcp","172.17.0.7:46706") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/not found.txt: > dial: conn=172.17.0.1:34770->172.17.0.7:46706, err= 2026/02/27 05:18:14 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1916: Opening root remote "TestFTPProftpd:" path "rclone-test-kuqicoy9yevu" from "TestFTPProftpd:rclone-test-kuqicoy9yevu" 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:51508->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:49341") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:56762->172.17.0.7:49341, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:4986") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60018->172.17.0.7:4986, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:51608") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:36288->172.17.0.7:51608, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:23045") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:57202->172.17.0.7:23045, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:47522") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:44128->172.17.0.7:47522, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:64903") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42390->172.17.0.7:64903, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1953: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:37734") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53942->172.17.0.7:37734, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:23890") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60922->172.17.0.7:23890, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:24230") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53980->172.17.0.7:24230, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:49046") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:39804->172.17.0.7:49046, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:6333") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:46390->172.17.0.7:6333, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:62347") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52464->172.17.0.7:62347, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:40299") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:49828->172.17.0.7:40299, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:5805") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:57292->172.17.0.7:5805, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:52015") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58844->172.17.0.7:52015, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:50620") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:43836->172.17.0.7:50620, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:46715") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:38656->172.17.0.7:46715, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2012: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2117: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2133: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:29869") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59910->172.17.0.7:29869, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:34963") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:38098->172.17.0.7:34963, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:24368") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58954->172.17.0.7:24368, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:20203") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35546->172.17.0.7:20203, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:39711") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:49966->172.17.0.7:39711, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2289: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:11977") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:34600->172.17.0.7:11977, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47511") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:33500->172.17.0.7:47511, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/02/27 05:18:14 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-kuqicoy9yevu" 2026/02/27 05:18:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{g18yh}" suffix to name 2026/02/27 05:18:14 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:14 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Connecting to FTP server 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51518->172.17.0.7:21, err= 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:48819") 2026/02/27 05:18:14 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:54744->172.17.0.7:48819, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2372: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2484: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:2434") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36844->172.17.0.7:2434, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:7986") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46812->172.17.0.7:7986, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62675") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58138->172.17.0.7:62675, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/02/27 05:18:15 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuqicoy9yevu/deeper/nonexisting/directory" 2026/02/27 05:18:15 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/02/27 05:18:15 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:15 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:15 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:15 DEBUG : TestFTPProftpd: detected overridden config - adding "{8gfDu}" suffix to name 2026/02/27 05:18:15 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/02/27 05:18:15 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/02/27 05:18:15 DEBUG : Setting pass="_TdiTDyElZyxWPqoVa_hUnQJIayeLeaarwqwDB2Vgb9_Hg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/02/27 05:18:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/deeper/nonexisting/directory: Connecting to FTP server 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:51528->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2633: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2676: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2733: FS has no Directory methods and doesn't Wrap 2026/02/27 05:18:15 DEBUG : Waiting for deletions to finish 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:33625") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:33358->172.17.0.7:33625, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:47810") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:59410->172.17.0.7:47810, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:57670") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:47100->172.17.0.7:57670, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:50565") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35136->172.17.0.7:50565, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62778") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51274->172.17.0.7:62778, err= 2026/02/27 05:18:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:62355") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:36110->172.17.0.7:62355, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:22271") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:55896->172.17.0.7:22271, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:63095") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:58762->172.17.0.7:63095, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:5673") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:52414->172.17.0.7:5673, err= 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:41988") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:40218->172.17.0.7:41988, err= 2026/02/27 05:18:15 DEBUG : removing 1 level 4 directories 2026/02/27 05:18:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/02/27 05:18:15 DEBUG : removing 1 level 3 directories 2026/02/27 05:18:15 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/02/27 05:18:15 DEBUG : removing 1 level 2 directories 2026/02/27 05:18:15 INFO : hello? sausage/êé: Removing directory 2026/02/27 05:18:15 DEBUG : removing 1 level 1 directories 2026/02/27 05:18:15 INFO : hello? sausage: Removing directory 2026/02/27 05:18:15 DEBUG : removing 1 level 0 directories 2026/02/27 05:18:15 INFO : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Removing directory 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:21750") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:35454->172.17.0.7:21750, err= 2026/02/27 05:18:15 ERROR : error listing: directory not found 2026/02/27 05:18:15 DEBUG : Waiting for deletions to finish 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:45974") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:46350->172.17.0.7:45974, err= 2026/02/27 05:18:15 ERROR : error listing: directory not found 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: dial("tcp","172.17.0.7:19673") 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: > dial: conn=172.17.0.1:51466->172.17.0.7:19673, err= 2026/02/27 05:18:15 ERROR : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Failed to list "": directory not found 2026/02/27 05:18:15 DEBUG : removing 1 level 0 directories 2026/02/27 05:18:15 INFO : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: Removing directory 2026/02/27 05:18:15 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/02/27 05:18:15 DEBUG : ftp://172.17.0.7:21/rclone-test-kuqicoy9yevu: closing 2 unused connections 2026/02/27 05:18:15 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.00s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.68s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- 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.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- 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 4.017s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.795937179s (try 1/5)