"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/07/08 01:42:09 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xozidiy4nuva" 2025/07/08 01:42:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/08 01:42:09 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:09 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:09 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:09 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:09 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:09 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:09 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:09 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Connecting to FTP server 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58064->172.17.0.2:21, err= 2025/07/08 01:42:09 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/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21206") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46544->172.17.0.2:21206, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:7299") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37104->172.17.0.2:7299, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/08 01:42:09 INFO : dir/subdir: Making directory 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:27127") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58686->172.17.0.2:27127, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:8330") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34548->172.17.0.2:8330, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:58070") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42564->172.17.0.2:58070, err= 2025/07/08 01:42:09 INFO : dir/subdir: Removing directory 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:15644") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37314->172.17.0.2:15644, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:61228") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60792->172.17.0.2:61228, err= 2025/07/08 01:42:09 INFO : dir: Removing directory 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:60890") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42600->172.17.0.2:60890, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:2079") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53586->172.17.0.2:2079, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:16063") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:57252->172.17.0.2:16063, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:64230") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36174->172.17.0.2:64230, err= 2025/07/08 01:42:09 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/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:63231") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58950->172.17.0.2:63231, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59170") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60508->172.17.0.2:59170, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:22361") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:41086->172.17.0.2:22361, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:40391") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:33310->172.17.0.2:40391, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:31341") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34208->172.17.0.2:31341, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:36102") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38820->172.17.0.2:36102, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:64612") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50612->172.17.0.2:64612, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:60801") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53724->172.17.0.2:60801, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:42525") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40504->172.17.0.2:42525, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10532") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44308->172.17.0.2:10532, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:54041") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45184->172.17.0.2:54041, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:16343") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48018->172.17.0.2:16343, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:30064") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40260->172.17.0.2:30064, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:53697") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42316->172.17.0.2:53697, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:42296") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34818->172.17.0.2:42296, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:49143") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45034->172.17.0.2:49143, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:54068") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38168->172.17.0.2:54068, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62303") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53748->172.17.0.2:62303, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10421") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50094->172.17.0.2:10421, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:48792") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40618->172.17.0.2:48792, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:17974") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:59788->172.17.0.2:17974, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:16697") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37038->172.17.0.2:16697, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10384") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35256->172.17.0.2:10384, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:25281") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55028->172.17.0.2:25281, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:9232") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55310->172.17.0.2:9232, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:25005") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42120->172.17.0.2:25005, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20974") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35632->172.17.0.2:20974, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:4588") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45158->172.17.0.2:4588, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:26060") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:47080->172.17.0.2:26060, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:36013") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52880->172.17.0.2:36013, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3283") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:41722->172.17.0.2:3283, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:23757") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36798->172.17.0.2:23757, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:29648") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39286->172.17.0.2:29648, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:24620") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55904->172.17.0.2:24620, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:63124") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:43770->172.17.0.2:63124, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59965") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38510->172.17.0.2:59965, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59698") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60914->172.17.0.2:59698, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62201") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50040->172.17.0.2:62201, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55232") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35726->172.17.0.2:55232, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:36689") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60232->172.17.0.2:36689, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:7199") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:47864->172.17.0.2:7199, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:43738") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34082->172.17.0.2:43738, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:52008") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:43298->172.17.0.2:52008, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:36240") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46248->172.17.0.2:36240, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:31901") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42578->172.17.0.2:31901, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:28769") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60306->172.17.0.2:28769, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:19848") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38932->172.17.0.2:19848, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20434") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:33194->172.17.0.2:20434, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:25537") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40972->172.17.0.2:25537, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:29246") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58100->172.17.0.2:29246, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3691") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37032->172.17.0.2:3691, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:42488") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38082->172.17.0.2:42488, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:44919") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37006->172.17.0.2:44919, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:13052") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46482->172.17.0.2:13052, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:2234") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:33838->172.17.0.2:2234, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:53128") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38784->172.17.0.2:53128, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:37033") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40642->172.17.0.2:37033, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:22184") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44862->172.17.0.2:22184, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:56692") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36414->172.17.0.2:56692, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62070") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53870->172.17.0.2:62070, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:57174") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35360->172.17.0.2:57174, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:58951") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39286->172.17.0.2:58951, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20292") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:49258->172.17.0.2:20292, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21288") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37124->172.17.0.2:21288, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:18037") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55752->172.17.0.2:18037, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:17882") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44856->172.17.0.2:17882, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:15719") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48096->172.17.0.2:15719, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:12200") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46558->172.17.0.2:12200, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:14549") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38774->172.17.0.2:14549, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:5416") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40590->172.17.0.2:5416, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:47865") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44364->172.17.0.2:47865, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20724") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52962->172.17.0.2:20724, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:48131") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:51410->172.17.0.2:48131, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:34339") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:49356->172.17.0.2:34339, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55940") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40486->172.17.0.2:55940, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:14497") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:40066->172.17.0.2:14497, err= 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62084") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45648->172.17.0.2:62084, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10254") 2025/07/08 01:42:09 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52222->172.17.0.2:10254, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58066->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62314") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45736->172.17.0.2:62314, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3826") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45110->172.17.0.2:3826, 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/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:22549") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50758->172.17.0.2:22549, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:4416") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60318->172.17.0.2:4416, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:33460") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:57994->172.17.0.2:33460, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:18740") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55768->172.17.0.2:18740, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:39156") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:49960->172.17.0.2:39156, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:5081") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53498->172.17.0.2:5081, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:25276") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50268->172.17.0.2:25276, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:53407") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34582->172.17.0.2:53407, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:11851") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:33582->172.17.0.2:11851, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:17308") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:54522->172.17.0.2:17308, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:54964") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48420->172.17.0.2:54964, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3904") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48570->172.17.0.2:3904, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:42506") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60742->172.17.0.2:42506, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:42108") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48376->172.17.0.2:42108, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55151") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:54162->172.17.0.2:55151, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:41821") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:51658->172.17.0.2:41821, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20083") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37956->172.17.0.2:20083, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/07/08 01:42:10 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/08 01:42:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58072->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:56074") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39980->172.17.0.2:56074, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:49059") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38118->172.17.0.2:49059, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:41102") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53284->172.17.0.2:41102, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3669") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58360->172.17.0.2:3669, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:11799") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37212->172.17.0.2:11799, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:17072") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:47446->172.17.0.2:17072, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:15827") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60152->172.17.0.2:15827, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:57534") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53650->172.17.0.2:57534, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:2220") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55790->172.17.0.2:2220, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:31092") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52154->172.17.0.2:31092, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:33603") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53954->172.17.0.2:33603, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:48512") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45808->172.17.0.2:48512, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:46431") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36394->172.17.0.2:46431, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:30383") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34880->172.17.0.2:30383, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:51315") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35454->172.17.0.2:51315, 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/07/08 01:42:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xozidiy4nuva/hello? sausage/êé" 2025/07/08 01:42:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:58084->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-xozidiy4nuva/hello? sausage/êé" to be canonical "TestFTPProftpd{G42OY}:rclone-test-xozidiy4nuva/hello? sausage/êé" 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:36969") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:40374->172.17.0.2:36969, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:27230") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:42624->172.17.0.2:27230, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:60156") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:58100->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:47442->172.17.0.2:60156, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:5437") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:39380->172.17.0.2:5437, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:1105") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:47686->172.17.0.2:1105, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:25544") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:42518->172.17.0.2:25544, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:63113") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:34826->172.17.0.2:63113, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:43391") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:44040->172.17.0.2:43391, err= 2025/07/08 01:42:10 DEBUG : Waiting for deletions to finish 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:16813") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:50772->172.17.0.2:16813, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:54201") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:35304->172.17.0.2:54201, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:1308") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:34974->172.17.0.2:1308, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:15787") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:59460->172.17.0.2:15787, err= 2025/07/08 01:42:10 INFO : a/b/c/d/e.txt: Deleted 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:26085") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:50224->172.17.0.2:26085, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:41012") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:47956->172.17.0.2:41012, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:12462") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:57326->172.17.0.2:12462, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: dial("tcp","172.17.0.2:17116") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé: > dial: conn=172.17.0.1:46108->172.17.0.2:17116, err= 2025/07/08 01:42:10 DEBUG : removing 1 level 4 directories 2025/07/08 01:42:10 INFO : a/b/c/d: Removing directory 2025/07/08 01:42:10 DEBUG : removing 1 level 3 directories 2025/07/08 01:42:10 INFO : a/b/c: Removing directory 2025/07/08 01:42:10 DEBUG : removing 1 level 2 directories 2025/07/08 01:42:10 INFO : a/b: Removing directory 2025/07/08 01:42:10 DEBUG : removing 1 level 1 directories 2025/07/08 01:42:10 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:3446") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39818->172.17.0.2:3446, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:33775") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37710->172.17.0.2:33775, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:19240") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35676->172.17.0.2:19240, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21162") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:59248->172.17.0.2:21162, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:7396") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52220->172.17.0.2:7396, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:23298") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34322->172.17.0.2:23298, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58110->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:45414") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53690->172.17.0.2:45414, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:18381") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:43816->172.17.0.2:18381, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59780") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38040->172.17.0.2:59780, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:65467") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46468->172.17.0.2:65467, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:34125") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:51934->172.17.0.2:34125, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:38614") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42100->172.17.0.2:38614, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:61699") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34518->172.17.0.2:61699, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:65515") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44996->172.17.0.2:65515, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:49209") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53778->172.17.0.2:49209, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:64564") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36970->172.17.0.2:64564, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:37006") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45032->172.17.0.2:37006, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:15249") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42670->172.17.0.2:15249, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:38671") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39826->172.17.0.2:38671, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:38801") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:54974->172.17.0.2:38801, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:25782") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45582->172.17.0.2:25782, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:6261") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39398->172.17.0.2:6261, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:26623") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42214->172.17.0.2:26623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/07/08 01:42:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-turifab3yeca" 2025/07/08 01:42:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:10 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:10 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: Connecting to FTP server 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:58120->172.17.0.2:21, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:28472") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60498->172.17.0.2:28472, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:5624") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:44946->172.17.0.2:5624, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:8126") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:53176->172.17.0.2:8126, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:6785") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:39764->172.17.0.2:6785, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:27234") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:50320->172.17.0.2:27234, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:44814") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:33034->172.17.0.2:44814, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:1286") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:35314->172.17.0.2:1286, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:8061") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:34872->172.17.0.2:8061, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:14957") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36068->172.17.0.2:14957, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:54615") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:59544->172.17.0.2:54615, err= 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:44842") 2025/07/08 01:42:10 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:44620->172.17.0.2:44842, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:61890") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37014->172.17.0.2:61890, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10147") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52334->172.17.0.2:10147, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:1433") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:57684->172.17.0.2:1433, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:4758") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:44684->172.17.0.2:4758, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:43460") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:55462->172.17.0.2:43460, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: dial("tcp","172.17.0.2:57469") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: > dial: conn=172.17.0.1:55766->172.17.0.2:57469, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: Purge dir "new_name" 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-turifab3yeca: 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/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55951") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46792->172.17.0.2:55951, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62011") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:51314->172.17.0.2:62011, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59167") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45160->172.17.0.2:59167, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55035") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53330->172.17.0.2:55035, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:41359") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37976->172.17.0.2:41359, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:47487") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37860->172.17.0.2:47487, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20923") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53506->172.17.0.2:20923, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:6573") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:49162->172.17.0.2:6573, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:62291") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:46572->172.17.0.2:62291, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/08 01:42:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/08 01:42:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:58124->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:47536") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:50120->172.17.0.2:47536, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/08 01:42:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xozidiy4nuva/not found.txt" 2025/07/08 01:42:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/not found.txt: Connecting to FTP server 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/not found.txt: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/not found.txt: > dial: conn=172.17.0.1:58130->172.17.0.2:21, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/not found.txt: dial("tcp","172.17.0.2:51175") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/not found.txt: > dial: conn=172.17.0.1:36704->172.17.0.2:51175, err= 2025/07/08 01:42:11 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-xozidiy4nuva" from "TestFTPProftpd:rclone-test-xozidiy4nuva" 2025/07/08 01:42:11 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/08 01:42:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58146->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:42589") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43794->172.17.0.2:42589, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:54680") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44818->172.17.0.2:54680, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:49366") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46394->172.17.0.2:49366, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:46895") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50716->172.17.0.2:46895, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:10895") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57128->172.17.0.2:10895, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:6826") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59776->172.17.0.2:6826, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:5448") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44916->172.17.0.2:5448, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:35192") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41562->172.17.0.2:35192, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:53680") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45668->172.17.0.2:53680, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:48927") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:54326->172.17.0.2:48927, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33287") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60152->172.17.0.2:33287, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:13397") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41196->172.17.0.2:13397, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:48491") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38842->172.17.0.2:48491, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:60789") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45408->172.17.0.2:60789, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34048") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36762->172.17.0.2:34048, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36774") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48790->172.17.0.2:36774, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:9237") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55588->172.17.0.2:9237, 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/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:17142") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45410->172.17.0.2:17142, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:12922") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:45074->172.17.0.2:12922, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21406") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48166->172.17.0.2:21406, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:7769") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:51654->172.17.0.2:7769, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:15075") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:36442->172.17.0.2:15075, 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/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:48699") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:43904->172.17.0.2:48699, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:27848") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:43066->172.17.0.2:27848, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/07/08 01:42:11 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-xozidiy4nuva" 2025/07/08 01:42:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{3uf8a}" suffix to name 2025/07/08 01:42:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:11 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Connecting to FTP server 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:58148->172.17.0.2:21, err= 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:5725") 2025/07/08 01:42:11 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:48394->172.17.0.2:5725, 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/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:12384") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:50046->172.17.0.2:12384, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:54461") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35988->172.17.0.2:54461, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:45502") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:52218->172.17.0.2:45502, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/08 01:42:12 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xozidiy4nuva/deeper/nonexisting/directory" 2025/07/08 01:42:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/08 01:42:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:12 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{G42OY}" suffix to name 2025/07/08 01:42:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/08 01:42:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/08 01:42:12 DEBUG : Setting pass="qxIDjEQX6IjoBEzhTuGTO4jhBBfiZOrGKIY_RqReogv2AQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/08 01:42:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/deeper/nonexisting/directory: Connecting to FTP server 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva/deeper/nonexisting/directory: > dial: conn=172.17.0.1:58156->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/07/08 01:42:12 DEBUG : Waiting for deletions to finish 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:46622") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:53186->172.17.0.2:46622, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:55258") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:57100->172.17.0.2:55258, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:20575") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:34984->172.17.0.2:20575, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:8744") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:49650->172.17.0.2:8744, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:57943") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:37552->172.17.0.2:57943, err= 2025/07/08 01:42:12 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:10350") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:55284->172.17.0.2:10350, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:24448") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:38066->172.17.0.2:24448, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:41038") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:35818->172.17.0.2:41038, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:63006") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:39618->172.17.0.2:63006, err= 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:11167") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42960->172.17.0.2:11167, err= 2025/07/08 01:42:12 DEBUG : removing 1 level 4 directories 2025/07/08 01:42:12 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/07/08 01:42:12 DEBUG : removing 1 level 3 directories 2025/07/08 01:42:12 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/07/08 01:42:12 DEBUG : removing 1 level 2 directories 2025/07/08 01:42:12 INFO : hello? sausage/êé: Removing directory 2025/07/08 01:42:12 DEBUG : removing 1 level 1 directories 2025/07/08 01:42:12 INFO : hello? sausage: Removing directory 2025/07/08 01:42:12 DEBUG : removing 1 level 0 directories 2025/07/08 01:42:12 INFO : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Removing directory 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:43102") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:42196->172.17.0.2:43102, err= 2025/07/08 01:42:12 ERROR : error listing: directory not found 2025/07/08 01:42:12 DEBUG : Waiting for deletions to finish 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:57767") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:33116->172.17.0.2:57767, err= 2025/07/08 01:42:12 ERROR : error listing: directory not found 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: dial("tcp","172.17.0.2:59255") 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: > dial: conn=172.17.0.1:60546->172.17.0.2:59255, err= 2025/07/08 01:42:12 ERROR : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Failed to list "": directory not found 2025/07/08 01:42:12 DEBUG : removing 1 level 0 directories 2025/07/08 01:42:12 INFO : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: Removing directory 2025/07/08 01:42:12 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/07/08 01:42:12 DEBUG : ftp://172.17.0.2:21/rclone-test-xozidiy4nuva: closing 2 unused connections --- PASS: TestIntegration (3.00s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.92s) --- 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.31s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.02s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.02s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.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.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.86s) --- 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 3.016s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.215506351s (try 1/5)