"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/06/23 06:39:31 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kofejet0jeda" 2025/06/23 06:39:31 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/23 06:39:31 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:31 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:31 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:31 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:31 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:31 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:31 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:31 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:31 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:31 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Connecting to FTP server 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44950->172.17.0.3:21, err= 2025/06/23 06:39:31 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38416") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41974->172.17.0.3:38416, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35472") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:37750->172.17.0.3:35472, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/06/23 06:39:31 INFO : dir/subdir: Making directory 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35524") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52846->172.17.0.3:35524, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34723") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55364->172.17.0.3:34723, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33354") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39490->172.17.0.3:33354, err= 2025/06/23 06:39:31 INFO : dir/subdir: Removing directory 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34597") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52404->172.17.0.3:34597, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36870") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:35972->172.17.0.3:36870, err= 2025/06/23 06:39:31 INFO : dir: Removing directory 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35574") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47282->172.17.0.3:35574, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38217") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52990->172.17.0.3:38217, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30690") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57342->172.17.0.3:30690, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35169") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48258->172.17.0.3:35169, err= 2025/06/23 06:39:31 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/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30900") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46716->172.17.0.3:30900, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36590") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:37642->172.17.0.3:36590, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31350") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49882->172.17.0.3:31350, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31185") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54872->172.17.0.3:31185, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39690") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59188->172.17.0.3:39690, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38022") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53960->172.17.0.3:38022, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31117") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:50306->172.17.0.3:31117, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33469") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59808->172.17.0.3:33469, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33871") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48538->172.17.0.3:33871, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30144") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:56152->172.17.0.3:30144, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30653") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36664->172.17.0.3:30653, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30448") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47926->172.17.0.3:30448, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35043") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:35896->172.17.0.3:35043, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36473") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51824->172.17.0.3:36473, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34568") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49752->172.17.0.3:34568, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30086") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51752->172.17.0.3:30086, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39871") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34920->172.17.0.3:39871, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39258") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58888->172.17.0.3:39258, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31245") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58358->172.17.0.3:31245, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36921") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:35226->172.17.0.3:36921, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31305") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55416->172.17.0.3:31305, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37796") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51148->172.17.0.3:37796, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31173") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46766->172.17.0.3:31173, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33565") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:40896->172.17.0.3:33565, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35857") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47566->172.17.0.3:35857, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37085") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59928->172.17.0.3:37085, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30513") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42992->172.17.0.3:30513, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39672") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51868->172.17.0.3:39672, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32210") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42526->172.17.0.3:32210, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37601") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59212->172.17.0.3:37601, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35287") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57584->172.17.0.3:35287, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37146") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:33078->172.17.0.3:37146, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35844") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39586->172.17.0.3:35844, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32258") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:56782->172.17.0.3:32258, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35915") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53380->172.17.0.3:35915, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34704") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47354->172.17.0.3:34704, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36778") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53246->172.17.0.3:36778, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36930") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60734->172.17.0.3:36930, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33829") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45038->172.17.0.3:33829, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37081") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48646->172.17.0.3:37081, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38620") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53168->172.17.0.3:38620, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33164") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:56466->172.17.0.3:33164, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32146") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57780->172.17.0.3:32146, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35181") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45600->172.17.0.3:35181, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36217") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57912->172.17.0.3:36217, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33309") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55910->172.17.0.3:33309, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37287") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:37444->172.17.0.3:37287, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35298") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57038->172.17.0.3:35298, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30212") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46836->172.17.0.3:30212, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38647") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45548->172.17.0.3:38647, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37658") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43900->172.17.0.3:37658, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33015") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60044->172.17.0.3:33015, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37537") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54274->172.17.0.3:37537, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34657") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39578->172.17.0.3:34657, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30062") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45016->172.17.0.3:30062, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38861") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44024->172.17.0.3:38861, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31728") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47232->172.17.0.3:31728, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30622") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60102->172.17.0.3:30622, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36305") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58562->172.17.0.3:36305, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35800") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:40268->172.17.0.3:35800, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32051") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53312->172.17.0.3:32051, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36945") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51848->172.17.0.3:36945, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32552") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54402->172.17.0.3:32552, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37326") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46930->172.17.0.3:37326, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34616") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48198->172.17.0.3:34616, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33631") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34398->172.17.0.3:33631, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36867") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53350->172.17.0.3:36867, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35619") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43470->172.17.0.3:35619, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38450") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39558->172.17.0.3:38450, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32591") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45486->172.17.0.3:32591, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39043") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60902->172.17.0.3:39043, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33085") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42726->172.17.0.3:33085, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34786") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41726->172.17.0.3:34786, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38235") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39472->172.17.0.3:38235, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31178") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60900->172.17.0.3:31178, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31200") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52438->172.17.0.3:31200, err= 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35999") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:38640->172.17.0.3:35999, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33657") 2025/06/23 06:39:31 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36380->172.17.0.3:33657, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44952->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30453") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41440->172.17.0.3:30453, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30839") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46688->172.17.0.3:30839, 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/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39675") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47674->172.17.0.3:39675, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33394") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44770->172.17.0.3:33394, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39164") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43810->172.17.0.3:39164, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30672") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55238->172.17.0.3:30672, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32596") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47230->172.17.0.3:32596, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36627") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45158->172.17.0.3:36627, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33220") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41686->172.17.0.3:33220, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33088") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41084->172.17.0.3:33088, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33857") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47270->172.17.0.3:33857, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30665") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48392->172.17.0.3:30665, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32046") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58438->172.17.0.3:32046, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38433") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:38854->172.17.0.3:38433, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34594") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55156->172.17.0.3:34594, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30113") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34290->172.17.0.3:30113, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35492") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36164->172.17.0.3:35492, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34400") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:35164->172.17.0.3:34400, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38251") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:50286->172.17.0.3:38251, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44968->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33533") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41738->172.17.0.3:33533, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38034") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54382->172.17.0.3:38034, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33407") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59918->172.17.0.3:33407, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39652") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42152->172.17.0.3:39652, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38350") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49624->172.17.0.3:38350, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36627") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45174->172.17.0.3:36627, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30797") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58590->172.17.0.3:30797, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33740") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49006->172.17.0.3:33740, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34167") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39430->172.17.0.3:34167, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30053") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59472->172.17.0.3:30053, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37450") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:38248->172.17.0.3:37450, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33311") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48634->172.17.0.3:33311, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30906") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51738->172.17.0.3:30906, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34470") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52068->172.17.0.3:34470, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35441") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51654->172.17.0.3:35441, 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/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kofejet0jeda/hello? sausage/êé" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:44972->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-kofejet0jeda/hello? sausage/êé" to be canonical "TestFTPPureftpd{g1f6h}:rclone-test-kofejet0jeda/hello? sausage/êé" 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:39730") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:40702->172.17.0.3:39730, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:37102") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:51430->172.17.0.3:37102, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:35597") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:44974->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:43666->172.17.0.3:35597, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:32717") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:35628->172.17.0.3:32717, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:32801") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:41822->172.17.0.3:32801, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:36762") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:52778->172.17.0.3:36762, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:32306") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:54318->172.17.0.3:32306, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:36577") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:37322->172.17.0.3:36577, err= 2025/06/23 06:39:32 DEBUG : Waiting for deletions to finish 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:32603") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:33282->172.17.0.3:32603, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:38924") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:37138->172.17.0.3:38924, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:37721") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:33606->172.17.0.3:37721, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:38376") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:44808->172.17.0.3:38376, err= 2025/06/23 06:39:32 INFO : a/b/c/d/e.txt: Deleted 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:33299") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:38658->172.17.0.3:33299, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:30755") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:36236->172.17.0.3:30755, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:30504") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:57930->172.17.0.3:30504, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: dial("tcp","172.17.0.3:33534") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé: > dial: conn=172.17.0.1:60152->172.17.0.3:33534, err= 2025/06/23 06:39:32 DEBUG : removing 1 level 4 directories 2025/06/23 06:39:32 INFO : a/b/c/d: Removing directory 2025/06/23 06:39:32 DEBUG : removing 1 level 3 directories 2025/06/23 06:39:32 INFO : a/b/c: Removing directory 2025/06/23 06:39:32 DEBUG : removing 1 level 2 directories 2025/06/23 06:39:32 INFO : a/b: Removing directory 2025/06/23 06:39:32 DEBUG : removing 1 level 1 directories 2025/06/23 06:39:32 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32383") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:52548->172.17.0.3:32383, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39041") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42940->172.17.0.3:39041, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34232") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:51730->172.17.0.3:34232, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31844") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43968->172.17.0.3:31844, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33561") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46434->172.17.0.3:33561, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38154") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43012->172.17.0.3:38154, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39479") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44990->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:37134->172.17.0.3:39479, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33520") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48324->172.17.0.3:33520, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36132") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55726->172.17.0.3:36132, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34461") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48820->172.17.0.3:34461, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36725") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36866->172.17.0.3:36725, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34747") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:39080->172.17.0.3:34747, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37833") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32631") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:37960->172.17.0.3:37833, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53744->172.17.0.3:32631, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30062") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45020->172.17.0.3:30062, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37909") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44800->172.17.0.3:37909, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32688") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44978->172.17.0.3:32688, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30841") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59296->172.17.0.3:30841, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31492") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30132") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41344->172.17.0.3:31492, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54262->172.17.0.3:30132, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32902") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49244->172.17.0.3:32902, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35041") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58850->172.17.0.3:35041, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34084") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49652->172.17.0.3:34084, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-boxesuz1limo" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:44998->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31859") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36986->172.17.0.3:31859, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:34151") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:43684->172.17.0.3:34151, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:35690") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:38796->172.17.0.3:35690, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:37395") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:40266->172.17.0.3:37395, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:38641") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:38664->172.17.0.3:38641, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:34233") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:53922->172.17.0.3:34233, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:38865") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:54650->172.17.0.3:38865, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:38906") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:54274->172.17.0.3:38906, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36083") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:44726->172.17.0.3:36083, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38919") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60228->172.17.0.3:38919, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38992") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:35160->172.17.0.3:38992, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34005") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55762->172.17.0.3:34005, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35915") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:53382->172.17.0.3:35915, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:33759") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:42848->172.17.0.3:33759, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:37343") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:47894->172.17.0.3:37343, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:34360") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:53610->172.17.0.3:34360, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: dial("tcp","172.17.0.3:37929") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: > dial: conn=172.17.0.1:45384->172.17.0.3:37929, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: Purge dir "new_name" 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-boxesuz1limo: 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/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37780") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34618->172.17.0.3:37780, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35761") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43334->172.17.0.3:35761, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39944") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34560->172.17.0.3:39944, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33555") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:47126->172.17.0.3:33555, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32183") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58176->172.17.0.3:32183, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39631") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55100->172.17.0.3:39631, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34565") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:40250->172.17.0.3:34565, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37436") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57374->172.17.0.3:37436, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39384") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:58776->172.17.0.3:39384, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:45010->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:36480") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47602->172.17.0.3:36480, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kofejet0jeda/not found.txt" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/not found.txt: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/not found.txt: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/not found.txt: > dial: conn=172.17.0.1:45014->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/not found.txt: dial("tcp","172.17.0.3:36864") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/not found.txt: > dial: conn=172.17.0.1:54640->172.17.0.3:36864, err= 2025/06/23 06:39:32 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-kofejet0jeda" from "TestFTPPureftpd:rclone-test-kofejet0jeda" 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45022->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34537") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39646->172.17.0.3:34537, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33526") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56514->172.17.0.3:33526, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31805") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36532->172.17.0.3:31805, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35997") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48310->172.17.0.3:35997, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38732") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39906->172.17.0.3:38732, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33435") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51908->172.17.0.3:33435, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31501") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48238->172.17.0.3:31501, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36926") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54986->172.17.0.3:36926, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38149") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39142->172.17.0.3:38149, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35732") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38144->172.17.0.3:35732, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35411") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35604->172.17.0.3:35411, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37574") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42574->172.17.0.3:37574, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:32071") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48758->172.17.0.3:32071, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33820") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34784->172.17.0.3:33820, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37434") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46060->172.17.0.3:37434, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37633") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48882->172.17.0.3:37633, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33911") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58116->172.17.0.3:33911, 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/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30178") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41736->172.17.0.3:30178, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31392") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:59960->172.17.0.3:31392, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39547") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:56414->172.17.0.3:39547, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32419") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:57030->172.17.0.3:32419, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37587") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55068->172.17.0.3:37587, 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/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:39232") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:49040->172.17.0.3:39232, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35969") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:56380->172.17.0.3:35969, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/06/23 06:39:32 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-kofejet0jeda" 2025/06/23 06:39:32 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : TestFTPPureftpd: detected overridden config - adding "{09f4I}" suffix to name 2025/06/23 06:39:32 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:32 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:32 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:32 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Connecting to FTP server 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:45032->172.17.0.3:21, err= 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36606") 2025/06/23 06:39:32 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46718->172.17.0.3:36606, 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/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31859") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:48780->172.17.0.3:31859, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33879") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41608->172.17.0.3:33879, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35254") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:36034->172.17.0.3:35254, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/06/23 06:39:33 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kofejet0jeda/deeper/nonexisting/directory" 2025/06/23 06:39:33 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/06/23 06:39:33 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:33 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:33 DEBUG : TestFTPPureftpd: detected overridden config - adding "{g1f6h}" suffix to name 2025/06/23 06:39:33 DEBUG : Setting host="172.17.0.3" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/06/23 06:39:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/06/23 06:39:33 DEBUG : Setting pass="8eNQfDV_0wC4vO-zXrok4GI3AXRDNLyeVv7toDKmXkI" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/06/23 06:39:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/deeper/nonexisting/directory: Connecting to FTP server 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda/deeper/nonexisting/directory: > dial: conn=172.17.0.1:47314->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/06/23 06:39:33 DEBUG : Waiting for deletions to finish 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:30769") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55394->172.17.0.3:30769, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:34233") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:41344->172.17.0.3:34233, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37983") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:50728->172.17.0.3:37983, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:31625") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:54022->172.17.0.3:31625, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38396") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:50164->172.17.0.3:38396, err= 2025/06/23 06:39:33 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:32632") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:42804->172.17.0.3:32632, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:36205") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:55662->172.17.0.3:36205, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38002") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:46032->172.17.0.3:38002, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35623") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:33986->172.17.0.3:35623, err= 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:35941") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:34748->172.17.0.3:35941, err= 2025/06/23 06:39:33 DEBUG : removing 1 level 4 directories 2025/06/23 06:39:33 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/06/23 06:39:33 DEBUG : removing 1 level 3 directories 2025/06/23 06:39:33 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/06/23 06:39:33 DEBUG : removing 1 level 2 directories 2025/06/23 06:39:33 INFO : hello? sausage/êé: Removing directory 2025/06/23 06:39:33 DEBUG : removing 1 level 1 directories 2025/06/23 06:39:33 INFO : hello? sausage: Removing directory 2025/06/23 06:39:33 DEBUG : removing 1 level 0 directories 2025/06/23 06:39:33 INFO : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Removing directory 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:33264") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:60902->172.17.0.3:33264, err= 2025/06/23 06:39:33 ERROR : error listing: directory not found 2025/06/23 06:39:33 DEBUG : Waiting for deletions to finish 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:37712") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43270->172.17.0.3:37712, err= 2025/06/23 06:39:33 ERROR : error listing: directory not found 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: dial("tcp","172.17.0.3:38197") 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: > dial: conn=172.17.0.1:43108->172.17.0.3:38197, err= 2025/06/23 06:39:33 ERROR : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Failed to list "": directory not found 2025/06/23 06:39:33 DEBUG : removing 1 level 0 directories 2025/06/23 06:39:33 INFO : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: Removing directory 2025/06/23 06:39:33 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/06/23 06:39:33 DEBUG : ftp://172.17.0.3:21/rclone-test-kofejet0jeda: closing 2 unused connections --- PASS: TestIntegration (2.44s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.37s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.455s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 3.296210149s (try 1/5)