"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/27 05:07:25 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mafezaz8yoqi" 2025/09/27 05:07:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/27 05:07:25 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:25 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:25 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:25 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:25 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:25 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:25 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:25 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:25 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:25 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Connecting to FTP server 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60466->172.17.0.2:21, err= 2025/09/27 05:07:25 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 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56214") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59104->172.17.0.2:56214, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:20217") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:37656->172.17.0.2:20217, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/27 05:07:25 INFO : dir/subdir: Making directory 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:7712") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:50768->172.17.0.2:7712, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:3642") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56268->172.17.0.2:3642, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:5581") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:47288->172.17.0.2:5581, err= 2025/09/27 05:07:25 INFO : dir/subdir: Removing directory 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:62179") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59760->172.17.0.2:62179, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:53873") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48956->172.17.0.2:53873, err= 2025/09/27 05:07:25 INFO : dir: Removing directory 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:47021") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35338->172.17.0.2:47021, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:62981") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52444->172.17.0.2:62981, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:10792") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46050->172.17.0.2:10792, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:48709") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56174->172.17.0.2:48709, err= 2025/09/27 05:07:25 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27058") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60470->172.17.0.2:27058, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:19761") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:47946->172.17.0.2:19761, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:54776") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46440->172.17.0.2:54776, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27043") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:55320->172.17.0.2:27043, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46890") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:45448->172.17.0.2:46890, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:14456") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48070->172.17.0.2:14456, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:6234") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35016->172.17.0.2:6234, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:43317") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60572->172.17.0.2:43317, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:16542") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:36860->172.17.0.2:16542, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34925") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59992->172.17.0.2:34925, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:26404") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39772->172.17.0.2:26404, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:62096") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41000->172.17.0.2:62096, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:61719") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43138->172.17.0.2:61719, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34810") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44950->172.17.0.2:34810, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:19617") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34032->172.17.0.2:19617, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56862") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38484->172.17.0.2:56862, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:33994") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52018->172.17.0.2:33994, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:1645") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35170->172.17.0.2:1645, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56835") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:57402->172.17.0.2:56835, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11066") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52850->172.17.0.2:11066, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56836") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52498->172.17.0.2:56836, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11517") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59800->172.17.0.2:11517, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:17754") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52406->172.17.0.2:17754, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:59454") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:54904->172.17.0.2:59454, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:16075") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:32952->172.17.0.2:16075, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:14399") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:37566->172.17.0.2:14399, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:47793") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34202->172.17.0.2:47793, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:62072") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:36468->172.17.0.2:62072, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11846") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44992->172.17.0.2:11846, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:57562") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35354->172.17.0.2:57562, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:45247") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38066->172.17.0.2:45247, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:37880") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39832->172.17.0.2:37880, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11788") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58746->172.17.0.2:11788, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34488") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:40684->172.17.0.2:34488, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:63899") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:57826->172.17.0.2:63899, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:57655") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56018->172.17.0.2:57655, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:47921") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42126->172.17.0.2:47921, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:4598") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38020->172.17.0.2:4598, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:35437") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33996->172.17.0.2:35437, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:63440") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56960->172.17.0.2:63440, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38500") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35364->172.17.0.2:38500, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:60818") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56432->172.17.0.2:60818, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:60001") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:54396->172.17.0.2:60001, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34684") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41054->172.17.0.2:34684, err= 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:30093") 2025/09/27 05:07:25 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:36722->172.17.0.2:30093, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:14084") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39662->172.17.0.2:14084, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:26011") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:55554->172.17.0.2:26011, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:63063") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:50956->172.17.0.2:63063, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:14706") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56202->172.17.0.2:14706, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:17311") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:55028->172.17.0.2:17311, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:8594") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:36130->172.17.0.2:8594, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:6007") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42282->172.17.0.2:6007, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27805") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:54134->172.17.0.2:27805, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:25325") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39388->172.17.0.2:25325, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:64438") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58646->172.17.0.2:64438, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:42856") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48202->172.17.0.2:42856, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38700") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:51422->172.17.0.2:38700, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46696") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:55786->172.17.0.2:46696, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:39394") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46360->172.17.0.2:39394, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:49522") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41846->172.17.0.2:49522, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38724") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44346->172.17.0.2:38724, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:19106") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:57302->172.17.0.2:19106, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21867") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:53106->172.17.0.2:21867, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:49488") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39498->172.17.0.2:49488, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:52571") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48600->172.17.0.2:52571, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:20232") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:45038->172.17.0.2:20232, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:41609") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:40190->172.17.0.2:41609, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34958") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44846->172.17.0.2:34958, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:23807") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:50968->172.17.0.2:23807, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11511") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:53494->172.17.0.2:11511, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:32863") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56250->172.17.0.2:32863, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:61284") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:57016->172.17.0.2:61284, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:6795") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56754->172.17.0.2:6795, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27330") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42854->172.17.0.2:27330, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:30433") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43298->172.17.0.2:30433, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:35864") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52264->172.17.0.2:35864, err= 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:40391") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:32952->172.17.0.2:40391, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:55421") 2025/09/27 05:07:26 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:36174->172.17.0.2:55421, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60476->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:30961") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:40930->172.17.0.2:30961, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:22995") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58336->172.17.0.2:22995, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:23427") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34046->172.17.0.2:23427, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46182") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38104->172.17.0.2:46182, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:28290") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60906->172.17.0.2:28290, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:48338") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:51988->172.17.0.2:48338, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:42343") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56148->172.17.0.2:42343, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:45747") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48600->172.17.0.2:45747, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:40020") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60160->172.17.0.2:40020, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:23894") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43074->172.17.0.2:23894, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:1697") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46192->172.17.0.2:1697, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:1255") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35106->172.17.0.2:1255, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21979") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42284->172.17.0.2:21979, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:10456") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39334->172.17.0.2:10456, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:63529") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52162->172.17.0.2:63529, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:54920") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42890->172.17.0.2:54920, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:33786") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:54352->172.17.0.2:33786, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:53961") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58288->172.17.0.2:53961, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:2065") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33046->172.17.0.2:2065, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60482->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:40396") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36472->172.17.0.2:40396, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:1454") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34582->172.17.0.2:1454, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:41598") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:32826->172.17.0.2:41598, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:58400") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48860->172.17.0.2:58400, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:61220") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43830->172.17.0.2:61220, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:26333") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:53076->172.17.0.2:26333, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:18260") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56046->172.17.0.2:18260, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:49263") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39224->172.17.0.2:49263, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46964") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41594->172.17.0.2:46964, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:45364") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:55580->172.17.0.2:45364, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:24567") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:37046->172.17.0.2:24567, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:16651") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:49430->172.17.0.2:16651, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:51639") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46176->172.17.0.2:51639, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:54505") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:32970->172.17.0.2:54505, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38623") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41548->172.17.0.2:38623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mafezaz8yoqi/hello? sausage/êé" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:60498->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-mafezaz8yoqi/hello? sausage/êé" to be canonical "TestFTPProftpd{xHGgu}:rclone-test-mafezaz8yoqi/hello? sausage/êé" 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:3768") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:38082->172.17.0.2:3768, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:12528") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:47560->172.17.0.2:12528, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:60500->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:57287") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:34374->172.17.0.2:57287, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:59640") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:45576->172.17.0.2:59640, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:65439") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:60844->172.17.0.2:65439, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:16814") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:46774->172.17.0.2:16814, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:45388") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:50146->172.17.0.2:45388, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:31697") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:37726->172.17.0.2:31697, err= 2025/09/27 05:07:27 DEBUG : Waiting for deletions to finish 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:33971") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:54094->172.17.0.2:33971, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:46417") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:40926->172.17.0.2:46417, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:61581") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:46680->172.17.0.2:61581, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:17004") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:55292->172.17.0.2:17004, err= 2025/09/27 05:07:27 INFO : a/b/c/d/e.txt: Deleted 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:54583") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:59380->172.17.0.2:54583, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:45887") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:38986->172.17.0.2:45887, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:31384") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:55674->172.17.0.2:31384, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: dial("tcp","172.17.0.2:62560") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé: > dial: conn=172.17.0.1:33482->172.17.0.2:62560, err= 2025/09/27 05:07:27 DEBUG : removing 1 level 4 directories 2025/09/27 05:07:27 INFO : a/b/c/d: Removing directory 2025/09/27 05:07:27 DEBUG : removing 1 level 3 directories 2025/09/27 05:07:27 INFO : a/b/c: Removing directory 2025/09/27 05:07:27 DEBUG : removing 1 level 2 directories 2025/09/27 05:07:27 INFO : a/b: Removing directory 2025/09/27 05:07:27 DEBUG : removing 1 level 1 directories 2025/09/27 05:07:27 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:9531") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35020->172.17.0.2:9531, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:35152") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:50648->172.17.0.2:35152, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:1378") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59190->172.17.0.2:1378, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56846") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42080->172.17.0.2:56846, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:11961") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42026->172.17.0.2:11961, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46102") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43564->172.17.0.2:46102, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60508->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:31332") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48486->172.17.0.2:31332, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34630") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58568->172.17.0.2:34630, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:34832") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:53584->172.17.0.2:34832, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27075") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43630->172.17.0.2:27075, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46775") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:51060->172.17.0.2:46775, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:41165") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:51654->172.17.0.2:41165, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:31563") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33852->172.17.0.2:31563, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38440") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33208->172.17.0.2:38440, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:55788") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:47176->172.17.0.2:55788, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:50325") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39152->172.17.0.2:50325, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56207") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44796->172.17.0.2:56207, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:53704") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:40946->172.17.0.2:53704, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:47506") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:29557") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60754->172.17.0.2:47506, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:49178->172.17.0.2:29557, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:59121") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35372->172.17.0.2:59121, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:45173") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:50492->172.17.0.2:45173, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:3858") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52366->172.17.0.2:3858, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cofimep4lifo" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:60518->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:24459") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34530->172.17.0.2:24459, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:23697") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:35350->172.17.0.2:23697, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:63430") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:37766->172.17.0.2:63430, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:3895") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:42402->172.17.0.2:3895, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:36518") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:59702->172.17.0.2:36518, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:64820") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:35160->172.17.0.2:64820, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:6997") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:50902->172.17.0.2:6997, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:18351") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:39654->172.17.0.2:18351, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27144") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58784->172.17.0.2:27144, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:17984") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:43996->172.17.0.2:17984, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38829") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58394->172.17.0.2:38829, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:46215") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35128->172.17.0.2:46215, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:4392") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44366->172.17.0.2:4392, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:51058") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:33284->172.17.0.2:51058, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:36251") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:50604->172.17.0.2:36251, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:58015") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:41744->172.17.0.2:58015, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: dial("tcp","172.17.0.2:1878") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: > dial: conn=172.17.0.1:47798->172.17.0.2:1878, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: Purge dir "new_name" 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-cofimep4lifo: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:24890") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:51758->172.17.0.2:24890, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:58559") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:57888->172.17.0.2:58559, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:39080") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:59650->172.17.0.2:39080, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:41946") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52234->172.17.0.2:41946, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:20575") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44016->172.17.0.2:20575, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:26962") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:32768->172.17.0.2:26962, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:48407") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:58476->172.17.0.2:48407, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21475") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:45482->172.17.0.2:21475, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:63700") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38746->172.17.0.2:63700, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60524->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:44933") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:34528->172.17.0.2:44933, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mafezaz8yoqi/not found.txt" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/not found.txt: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/not found.txt: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/not found.txt: > dial: conn=172.17.0.1:60530->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/not found.txt: dial("tcp","172.17.0.2:13129") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/not found.txt: > dial: conn=172.17.0.1:52232->172.17.0.2:13129, err= 2025/09/27 05:07:27 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-mafezaz8yoqi" from "TestFTPProftpd:rclone-test-mafezaz8yoqi" 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60538->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:64709") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:47888->172.17.0.2:64709, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34108") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39920->172.17.0.2:34108, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36225") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43952->172.17.0.2:36225, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11708") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46576->172.17.0.2:11708, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38962") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51774->172.17.0.2:38962, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:47027") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45254->172.17.0.2:47027, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:45640") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33816->172.17.0.2:45640, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:53750") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48752->172.17.0.2:53750, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:19083") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43556->172.17.0.2:19083, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:25187") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42926->172.17.0.2:25187, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:52233") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50296->172.17.0.2:52233, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30685") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35528->172.17.0.2:30685, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36384") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36334->172.17.0.2:36384, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:13717") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52780->172.17.0.2:13717, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:51366") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46088->172.17.0.2:51366, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34028") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44164->172.17.0.2:34028, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:62590") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:47104->172.17.0.2:62590, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:19357") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56386->172.17.0.2:19357, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:35431") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:53264->172.17.0.2:35431, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:56317") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52940->172.17.0.2:56317, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:20702") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33314->172.17.0.2:20702, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:4304") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44428->172.17.0.2:4304, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:65298") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:40290->172.17.0.2:65298, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:38497") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:34192->172.17.0.2:38497, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/27 05:07:27 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-mafezaz8yoqi" 2025/09/27 05:07:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{v7zGn}" suffix to name 2025/09/27 05:07:27 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:27 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Connecting to FTP server 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:60550->172.17.0.2:21, err= 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:60778") 2025/09/27 05:07:27 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:42848->172.17.0.2:60778, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:36147") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52528->172.17.0.2:36147, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:27847") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:54328->172.17.0.2:27847, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:20677") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46076->172.17.0.2:20677, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/27 05:07:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mafezaz8yoqi/deeper/nonexisting/directory" 2025/09/27 05:07:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/27 05:07:28 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:28 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{xHGgu}" suffix to name 2025/09/27 05:07:28 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/27 05:07:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/27 05:07:28 DEBUG : Setting pass="xg0zLJw2lO4xIQoau1yiOoVJzlvm0H3ClRt9UfRJPjTCDA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/27 05:07:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/deeper/nonexisting/directory: Connecting to FTP server 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:60556->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/09/27 05:07:28 DEBUG : Waiting for deletions to finish 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:16414") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:33116->172.17.0.2:16414, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:47514") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:38782->172.17.0.2:47514, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:22251") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:56102->172.17.0.2:22251, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:21574") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:37890->172.17.0.2:21574, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:16818") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:41492->172.17.0.2:16818, err= 2025/09/27 05:07:28 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:3425") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:35348->172.17.0.2:3425, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:54014") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:47606->172.17.0.2:54014, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:30109") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:52018->172.17.0.2:30109, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:30758") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:46100->172.17.0.2:30758, err= 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:3605") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:48216->172.17.0.2:3605, err= 2025/09/27 05:07:28 DEBUG : removing 1 level 4 directories 2025/09/27 05:07:28 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/27 05:07:28 DEBUG : removing 1 level 3 directories 2025/09/27 05:07:28 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/27 05:07:28 DEBUG : removing 1 level 2 directories 2025/09/27 05:07:28 INFO : hello? sausage/êé: Removing directory 2025/09/27 05:07:28 DEBUG : removing 1 level 1 directories 2025/09/27 05:07:28 INFO : hello? sausage: Removing directory 2025/09/27 05:07:28 DEBUG : removing 1 level 0 directories 2025/09/27 05:07:28 INFO : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Removing directory 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:14351") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:44184->172.17.0.2:14351, err= 2025/09/27 05:07:28 ERROR : error listing: directory not found 2025/09/27 05:07:28 DEBUG : Waiting for deletions to finish 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:50946") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:47246->172.17.0.2:50946, err= 2025/09/27 05:07:28 ERROR : error listing: directory not found 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: dial("tcp","172.17.0.2:48141") 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: > dial: conn=172.17.0.1:39154->172.17.0.2:48141, err= 2025/09/27 05:07:28 ERROR : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Failed to list "": directory not found 2025/09/27 05:07:28 DEBUG : removing 1 level 0 directories 2025/09/27 05:07:28 INFO : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: Removing directory 2025/09/27 05:07:28 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/27 05:07:28 DEBUG : ftp://172.17.0.2:21/rclone-test-mafezaz8yoqi: closing 2 unused connections --- PASS: TestIntegration (2.72s) --- 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.64s) --- 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.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.05s) --- 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.01s) --- 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.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.76s) --- 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 2.742s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.571166325s (try 1/5)